builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1463979332.81 results: success (0) buildid: 20160522191132 builduid: ee1b1afa3303464fb76a34e193d4d1b2 revision: cb42beedc07e7fd7a13b76081cf3252543626f05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:32.805863) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:32.806372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:32.806809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:32.852379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:32.852692) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-22 21:55:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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.3M=0s 2016-05-22 21:55:35 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.389918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:33.259343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:33.260112) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014937 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:33.313889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-22 21:55:33.314794) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cb42beedc07e7fd7a13b76081cf3252543626f05 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cb42beedc07e7fd7a13b76081cf3252543626f05 --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=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-22 21:55:35,786 truncating revision to first 12 chars 2016-05-22 21:55:35,786 Setting DEBUG logging. 2016-05-22 21:55:35,786 attempt 1/10 2016-05-22 21:55:35,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cb42beedc07e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-22 21:55:36,976 unpacking tar archive at: mozilla-aurora-cb42beedc07e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.466428 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-22 21:55:34.799747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:34.800138) ========= script_repo_revision: cb42beedc07e7fd7a13b76081cf3252543626f05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:34.800640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:34.800996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 21:55:34.811425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-22 21:55:34.811768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:37 INFO - MultiFileLogger online at 20160522 21:55:37 in /builds/slave/test 21:55:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:55:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:37 INFO - {'append_to_log': False, 21:55:37 INFO - 'base_work_dir': '/builds/slave/test', 21:55:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:55:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:37 INFO - 'branch': 'Mozilla-Aurora', 21:55:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:37 INFO - 'config_files': ('talos/linux_config.py',), 21:55:37 INFO - 'default_actions': ('clobber', 21:55:37 INFO - 'read-buildbot-config', 21:55:37 INFO - 'download-and-extract', 21:55:37 INFO - 'populate-webroot', 21:55:37 INFO - 'create-virtualenv', 21:55:37 INFO - 'install', 21:55:37 INFO - 'run-tests'), 21:55:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:37 INFO - 'download_minidump_stackwalk': True, 21:55:37 INFO - 'download_symbols': 'ondemand', 21:55:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:37 INFO - 'installer_path': 'installer.exe', 21:55:37 INFO - 'log_level': 'info', 21:55:37 INFO - 'log_name': 'talos', 21:55:37 INFO - 'log_to_console': True, 21:55:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:37 INFO - 'opt_config_files': (), 21:55:37 INFO - 'pip_index': False, 21:55:37 INFO - 'sps_profile': False, 21:55:37 INFO - 'sps_profile_interval': 0, 21:55:37 INFO - 'suite': 'dromaeojs', 21:55:37 INFO - 'system_bits': '32', 21:55:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:37 INFO - 'title': 'talos-linux64-ix-062', 21:55:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:37 INFO - 'use_talos_json': True, 21:55:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:37 INFO - 'work_dir': 'build'} 21:55:37 INFO - ##### 21:55:37 INFO - ##### Running clobber step. 21:55:37 INFO - ##### 21:55:37 INFO - Running pre-action listener: _resource_record_pre_action 21:55:37 INFO - Running main action method: clobber 21:55:37 INFO - rmtree: /builds/slave/test/build 21:55:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:37 INFO - Running post-action listener: _resource_record_post_action 21:55:37 INFO - ##### 21:55:37 INFO - ##### Running read-buildbot-config step. 21:55:37 INFO - ##### 21:55:37 INFO - Running pre-action listener: _resource_record_pre_action 21:55:37 INFO - Running main action method: read_buildbot_config 21:55:37 INFO - Using buildbot properties: 21:55:37 INFO - { 21:55:37 INFO - "project": "", 21:55:37 INFO - "product": "firefox", 21:55:37 INFO - "script_repo_revision": "production", 21:55:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:55:37 INFO - "repository": "", 21:55:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:55:37 INFO - "buildid": "20160522191132", 21:55:37 INFO - "pgo_build": "True", 21:55:37 INFO - "basedir": "/builds/slave/test", 21:55:37 INFO - "buildnumber": 338, 21:55:37 INFO - "slavename": "talos-linux64-ix-062", 21:55:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:55:37 INFO - "platform": "ubuntu64_hw", 21:55:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:55:37 INFO - "branch": "mozilla-aurora", 21:55:37 INFO - "repo_path": "releases/mozilla-aurora", 21:55:37 INFO - "revision": "cb42beedc07e7fd7a13b76081cf3252543626f05", 21:55:37 INFO - "stage_platform": "linux64-pgo", 21:55:37 INFO - "builduid": "ee1b1afa3303464fb76a34e193d4d1b2", 21:55:37 INFO - "slavebuilddir": "test" 21:55:37 INFO - } 21:55:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:55:37 INFO - Running post-action listener: _resource_record_post_action 21:55:37 INFO - ##### 21:55:37 INFO - ##### Running download-and-extract step. 21:55:37 INFO - ##### 21:55:37 INFO - Running pre-action listener: _resource_record_pre_action 21:55:37 INFO - Running main action method: download_and_extract 21:55:37 INFO - mkdir: /builds/slave/test/build/tests 21:55: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')]} 21:55:37 INFO - https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:55:49 INFO - Downloaded 1361 bytes. 21:55:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:55:49 INFO - Using the following test package requirements: 21:55:49 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:55:49 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:55:49 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:55:49 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'jsshell-linux-x86_64.zip'], 21:55:49 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:55:49 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:55:49 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:55:49 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:55:49 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:55:49 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:55:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:55:49 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')]} 21:55:49 INFO - https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:57 INFO - Downloaded 23812096 bytes. 21:55:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:55:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:55:58 INFO - Return code: 0 21:55:58 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:58 INFO - https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:00 INFO - Downloaded 23812096 bytes. 21:56:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:56:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:56:01 INFO - Return code: 0 21:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:01 INFO - https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:56:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:56:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:56:02 INFO - Downloaded 10840145 bytes. 21:56:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:56:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:56:03 INFO - Return code: 0 21:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:03 INFO - https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:56:04 INFO - Downloaded 62727439 bytes. 21:56:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:56:04 INFO - mkdir: /builds/slave/test/properties 21:56:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:04 INFO - Contents: 21:56:04 INFO - build_url:https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:56:05 INFO - Running post-action listener: _resource_record_post_action 21:56:05 INFO - Running post-action listener: set_extra_try_arguments 21:56:05 INFO - ##### 21:56:05 INFO - ##### Running populate-webroot step. 21:56:05 INFO - ##### 21:56:05 INFO - Running pre-action listener: _resource_record_pre_action 21:56:05 INFO - Running main action method: populate_webroot 21:56:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:05 INFO - '--tppagecycles', 21:56:05 INFO - '7'], 21:56:05 INFO - 'tests': ['tsvgm']}}, 21:56:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['damp', 'tps']}, 21:56:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'tests': ['damp', 'tps']}, 21:56:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['dromaeo_dom']}, 21:56:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['a11yr', 21:56:05 INFO - 'ts_paint', 21:56:05 INFO - 'tpaint', 21:56:05 INFO - 'sessionrestore', 21:56:05 INFO - 'sessionrestore_no_auto_restore', 21:56:05 INFO - 'tabpaint']}, 21:56:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['tsvgx', 21:56:05 INFO - 'tsvgr_opacity', 21:56:05 INFO - 'tart', 21:56:05 INFO - 'tscrollx', 21:56:05 INFO - 'cart']}, 21:56:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:05 INFO - 'tsvgr_opacity', 21:56:05 INFO - 'tart', 21:56:05 INFO - 'tscrollx', 21:56:05 INFO - 'cart']}, 21:56:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'talos_options': ['--disable-e10s'], 21:56:05 INFO - 'tests': ['tp5o']}, 21:56:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'tests': ['tp5o']}, 21:56:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'talos_options': ['--disable-e10s', 21:56:05 INFO - '--xperf_path', 21:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:05 INFO - 'tests': ['tp5n']}, 21:56:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:05 INFO - 'talos_options': ['--xperf_path', 21:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:05 INFO - 'tests': ['tp5n']}}, 21:56:05 INFO - 'talos.zip': {'path': '', 21:56:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:05 INFO - Running post-action listener: _resource_record_post_action 21:56:05 INFO - ##### 21:56:05 INFO - ##### Running create-virtualenv step. 21:56:05 INFO - ##### 21:56:05 INFO - Running pre-action listener: _resource_record_pre_action 21:56:05 INFO - Running main action method: create_virtualenv 21:56:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:56:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:05 INFO - Using real prefix '/usr' 21:56:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:07 INFO - Installing pip.................done. 21:56:07 INFO - Return code: 0 21:56:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:07 INFO - Using env: {'DISPLAY': ':0', 21:56:07 INFO - 'HOME': '/home/cltbld', 21:56:07 INFO - 'LANG': 'en_US.UTF-8', 21:56:07 INFO - 'LANGUAGE': 'en_US:en', 21:56:07 INFO - 'LOGNAME': 'cltbld', 21:56:07 INFO - 'MAIL': '/var/mail/cltbld', 21:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:07 INFO - 'MOZ_NO_REMOTE': '1', 21:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:07 INFO - 'NO_EM_RESTART': '1', 21:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:07 INFO - 'PWD': '/builds/slave/test', 21:56:07 INFO - 'SHELL': '/bin/bash', 21:56:07 INFO - 'SHLVL': '1', 21:56:07 INFO - 'TERM': 'linux', 21:56:07 INFO - 'TMOUT': '86400', 21:56:07 INFO - 'USER': 'cltbld', 21:56:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:07 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:56:08 INFO - Cleaning up... 21:56:08 INFO - Return code: 0 21:56:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:56:08 INFO - Using env: {'DISPLAY': ':0', 21:56:08 INFO - 'HOME': '/home/cltbld', 21:56:08 INFO - 'LANG': 'en_US.UTF-8', 21:56:08 INFO - 'LANGUAGE': 'en_US:en', 21:56:08 INFO - 'LOGNAME': 'cltbld', 21:56:08 INFO - 'MAIL': '/var/mail/cltbld', 21:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:08 INFO - 'MOZ_NO_REMOTE': '1', 21:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:08 INFO - 'NO_EM_RESTART': '1', 21:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:08 INFO - 'PWD': '/builds/slave/test', 21:56:08 INFO - 'SHELL': '/bin/bash', 21:56:08 INFO - 'SHLVL': '1', 21:56:08 INFO - 'TERM': 'linux', 21:56:08 INFO - 'TMOUT': '86400', 21:56:08 INFO - 'USER': 'cltbld', 21:56:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:08 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Downloading/unpacking psutil>=0.7.1 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:10 INFO - Installing collected packages: psutil 21:56:10 INFO - Running setup.py install for psutil 21:56:10 INFO - building 'psutil._psutil_linux' extension 21:56:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:56:10 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 21:56:10 INFO - building 'psutil._psutil_posix' extension 21:56:10 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 21:56:10 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 21:56:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:10 INFO - Successfully installed psutil 21:56:10 INFO - Cleaning up... 21:56:10 INFO - Return code: 0 21:56:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:56:10 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')]} 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:10 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')]} 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:10 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 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:10 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 21:56:10 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 21:56:10 INFO - Using env: {'DISPLAY': ':0', 21:56:10 INFO - 'HOME': '/home/cltbld', 21:56:10 INFO - 'LANG': 'en_US.UTF-8', 21:56:10 INFO - 'LANGUAGE': 'en_US:en', 21:56:10 INFO - 'LOGNAME': 'cltbld', 21:56:10 INFO - 'MAIL': '/var/mail/cltbld', 21:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:10 INFO - 'MOZ_NO_REMOTE': '1', 21:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:10 INFO - 'NO_EM_RESTART': '1', 21:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:10 INFO - 'PWD': '/builds/slave/test', 21:56:10 INFO - 'SHELL': '/bin/bash', 21:56:10 INFO - 'SHLVL': '1', 21:56:10 INFO - 'TERM': 'linux', 21:56:10 INFO - 'TMOUT': '86400', 21:56:10 INFO - 'USER': 'cltbld', 21:56:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:10 INFO - '_': '/tools/buildbot/bin/python'} 21:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:56:12 INFO - Installing collected packages: mozsystemmonitor 21:56:12 INFO - Running setup.py install for mozsystemmonitor 21:56:13 INFO - Successfully installed mozsystemmonitor 21:56:13 INFO - Cleaning up... 21:56:13 INFO - Return code: 0 21:56:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:56:13 INFO - Using env: {'DISPLAY': ':0', 21:56:13 INFO - 'HOME': '/home/cltbld', 21:56:13 INFO - 'LANG': 'en_US.UTF-8', 21:56:13 INFO - 'LANGUAGE': 'en_US:en', 21:56:13 INFO - 'LOGNAME': 'cltbld', 21:56:13 INFO - 'MAIL': '/var/mail/cltbld', 21:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:13 INFO - 'MOZ_NO_REMOTE': '1', 21:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:13 INFO - 'NO_EM_RESTART': '1', 21:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:13 INFO - 'PWD': '/builds/slave/test', 21:56:13 INFO - 'SHELL': '/bin/bash', 21:56:13 INFO - 'SHLVL': '1', 21:56:13 INFO - 'TERM': 'linux', 21:56:13 INFO - 'TMOUT': '86400', 21:56:13 INFO - 'USER': 'cltbld', 21:56:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:13 INFO - '_': '/tools/buildbot/bin/python'} 21:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:15 INFO - Downloading docopt-0.6.1.tar.gz 21:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:15 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:15 INFO - Running setup.py install for blobuploader 21:56:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:16 INFO - Running setup.py install for requests 21:56:16 INFO - Running setup.py install for docopt 21:56:16 INFO - Successfully installed blobuploader requests docopt 21:56:16 INFO - Cleaning up... 21:56:16 INFO - Return code: 0 21:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:16 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 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:16 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 21:56:16 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 21:56:16 INFO - Using env: {'DISPLAY': ':0', 21:56:16 INFO - 'HOME': '/home/cltbld', 21:56:16 INFO - 'LANG': 'en_US.UTF-8', 21:56:16 INFO - 'LANGUAGE': 'en_US:en', 21:56:16 INFO - 'LOGNAME': 'cltbld', 21:56:16 INFO - 'MAIL': '/var/mail/cltbld', 21:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:16 INFO - 'MOZ_NO_REMOTE': '1', 21:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:16 INFO - 'NO_EM_RESTART': '1', 21:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:16 INFO - 'PWD': '/builds/slave/test', 21:56:16 INFO - 'SHELL': '/bin/bash', 21:56:16 INFO - 'SHLVL': '1', 21:56:16 INFO - 'TERM': 'linux', 21:56:16 INFO - 'TMOUT': '86400', 21:56:16 INFO - 'USER': 'cltbld', 21:56:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:16 INFO - '_': '/tools/buildbot/bin/python'} 21:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:16 INFO - Running setup.py (path:/tmp/pip-KgfBJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:16 INFO - Running setup.py (path:/tmp/pip-oQ7L_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:16 INFO - Running setup.py (path:/tmp/pip-Uv0HBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:17 INFO - Running setup.py (path:/tmp/pip-SsyZBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:17 INFO - Running setup.py (path:/tmp/pip-zHPsDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:17 INFO - Running setup.py (path:/tmp/pip-WOGyOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:17 INFO - Running setup.py (path:/tmp/pip-0Lu745-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:17 INFO - Running setup.py (path:/tmp/pip-OCb3tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:17 INFO - Running setup.py (path:/tmp/pip-dROORt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:17 INFO - Running setup.py (path:/tmp/pip-67mdDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:17 INFO - Running setup.py (path:/tmp/pip-XqDmHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:17 INFO - Running setup.py (path:/tmp/pip-zs4TMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:17 INFO - Running setup.py (path:/tmp/pip-R7hf4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:17 INFO - Running setup.py (path:/tmp/pip-zRM5c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:17 INFO - Running setup.py (path:/tmp/pip-P8KT9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:17 INFO - Running setup.py (path:/tmp/pip-kVz6_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:17 INFO - Running setup.py (path:/tmp/pip-Rh0TiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:18 INFO - Running setup.py install for manifestparser 21:56:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Running setup.py install for mozcrash 21:56:18 INFO - Running setup.py install for mozdebug 21:56:18 INFO - Running setup.py install for mozdevice 21:56:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Running setup.py install for mozfile 21:56:18 INFO - Running setup.py install for mozhttpd 21:56:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Running setup.py install for mozinfo 21:56:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Running setup.py install for mozInstall 21:56:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:18 INFO - Running setup.py install for mozleak 21:56:18 INFO - Running setup.py install for mozlog 21:56:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Running setup.py install for moznetwork 21:56:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Running setup.py install for mozprocess 21:56:19 INFO - Running setup.py install for mozprofile 21:56:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Running setup.py install for mozrunner 21:56:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Running setup.py install for mozscreenshot 21:56:19 INFO - Running setup.py install for moztest 21:56:19 INFO - Running setup.py install for mozversion 21:56:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:19 INFO - Cleaning up... 21:56:19 INFO - Return code: 0 21:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:19 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 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:19 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 21:56:19 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 21:56:19 INFO - Using env: {'DISPLAY': ':0', 21:56:19 INFO - 'HOME': '/home/cltbld', 21:56:19 INFO - 'LANG': 'en_US.UTF-8', 21:56:19 INFO - 'LANGUAGE': 'en_US:en', 21:56:19 INFO - 'LOGNAME': 'cltbld', 21:56:19 INFO - 'MAIL': '/var/mail/cltbld', 21:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:19 INFO - 'MOZ_NO_REMOTE': '1', 21:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:19 INFO - 'NO_EM_RESTART': '1', 21:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:19 INFO - 'PWD': '/builds/slave/test', 21:56:19 INFO - 'SHELL': '/bin/bash', 21:56:19 INFO - 'SHLVL': '1', 21:56:19 INFO - 'TERM': 'linux', 21:56:19 INFO - 'TMOUT': '86400', 21:56:19 INFO - 'USER': 'cltbld', 21:56:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:19 INFO - '_': '/tools/buildbot/bin/python'} 21:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:20 INFO - Running setup.py (path:/tmp/pip-MPNYS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:20 INFO - Running setup.py (path:/tmp/pip-LDAQ5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:20 INFO - Running setup.py (path:/tmp/pip-V4HuUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:20 INFO - Running setup.py (path:/tmp/pip-cU1ZC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:20 INFO - Running setup.py (path:/tmp/pip-Zevx_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:20 INFO - Running setup.py (path:/tmp/pip-pAEdlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:20 INFO - Running setup.py (path:/tmp/pip-fL8CYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:20 INFO - Running setup.py (path:/tmp/pip-GLISqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:20 INFO - Running setup.py (path:/tmp/pip-Yd7Qf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:20 INFO - Running setup.py (path:/tmp/pip-wX9D7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:20 INFO - Running setup.py (path:/tmp/pip-4RkhPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:20 INFO - Running setup.py (path:/tmp/pip-QXEkab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:20 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)) 21:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:20 INFO - Running setup.py (path:/tmp/pip-vvfnvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:21 INFO - Running setup.py (path:/tmp/pip-azyNQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:21 INFO - Running setup.py (path:/tmp/pip-hO6U3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:21 INFO - Running setup.py (path:/tmp/pip-DhKU7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:21 INFO - Running setup.py (path:/tmp/pip-nLkbpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:23 INFO - Downloading blessings-1.6.tar.gz 21:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:23 INFO - Installing collected packages: blessings 21:56:23 INFO - Running setup.py install for blessings 21:56:23 INFO - Successfully installed blessings 21:56:23 INFO - Cleaning up... 21:56:23 INFO - Return code: 0 21:56:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:23 INFO - Reading from file tmpfile_stdout 21:56:23 INFO - Current package versions: 21:56:23 INFO - argparse == 1.2.1 21:56:23 INFO - blessings == 1.6 21:56:23 INFO - blobuploader == 1.2.4 21:56:23 INFO - docopt == 0.6.1 21:56:23 INFO - manifestparser == 1.1 21:56:23 INFO - mozInstall == 1.12 21:56:23 INFO - mozcrash == 0.17 21:56:23 INFO - mozdebug == 0.1 21:56:23 INFO - mozdevice == 0.48 21:56:23 INFO - mozfile == 1.2 21:56:23 INFO - mozhttpd == 0.7 21:56:23 INFO - mozinfo == 0.9 21:56:23 INFO - mozleak == 0.1 21:56:23 INFO - mozlog == 3.1 21:56:23 INFO - moznetwork == 0.27 21:56:23 INFO - mozprocess == 0.22 21:56:23 INFO - mozprofile == 0.28 21:56:23 INFO - mozrunner == 6.11 21:56:23 INFO - mozscreenshot == 0.1 21:56:23 INFO - mozsystemmonitor == 0.0 21:56:23 INFO - moztest == 0.7 21:56:23 INFO - mozversion == 1.4 21:56:23 INFO - psutil == 3.1.1 21:56:23 INFO - requests == 1.2.3 21:56:23 INFO - wsgiref == 0.1.2 21:56:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:23 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 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:23 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 21:56:23 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 21:56:23 INFO - Using env: {'DISPLAY': ':0', 21:56:23 INFO - 'HOME': '/home/cltbld', 21:56:23 INFO - 'LANG': 'en_US.UTF-8', 21:56:23 INFO - 'LANGUAGE': 'en_US:en', 21:56:23 INFO - 'LOGNAME': 'cltbld', 21:56:23 INFO - 'MAIL': '/var/mail/cltbld', 21:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:23 INFO - 'MOZ_NO_REMOTE': '1', 21:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:23 INFO - 'NO_EM_RESTART': '1', 21:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:23 INFO - 'PWD': '/builds/slave/test', 21:56:23 INFO - 'SHELL': '/bin/bash', 21:56:23 INFO - 'SHLVL': '1', 21:56:23 INFO - 'TERM': 'linux', 21:56:23 INFO - 'TMOUT': '86400', 21:56:23 INFO - 'USER': 'cltbld', 21:56:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:23 INFO - '_': '/tools/buildbot/bin/python'} 21:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 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)) 21:56:23 INFO - Cleaning up... 21:56:23 INFO - Return code: 0 21:56:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:23 INFO - Using env: {'DISPLAY': ':0', 21:56:23 INFO - 'HOME': '/home/cltbld', 21:56:23 INFO - 'LANG': 'en_US.UTF-8', 21:56:23 INFO - 'LANGUAGE': 'en_US:en', 21:56:23 INFO - 'LOGNAME': 'cltbld', 21:56:23 INFO - 'MAIL': '/var/mail/cltbld', 21:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:23 INFO - 'MOZ_NO_REMOTE': '1', 21:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:23 INFO - 'NO_EM_RESTART': '1', 21:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:23 INFO - 'PWD': '/builds/slave/test', 21:56:23 INFO - 'SHELL': '/bin/bash', 21:56:23 INFO - 'SHLVL': '1', 21:56:23 INFO - 'TERM': 'linux', 21:56:23 INFO - 'TMOUT': '86400', 21:56:23 INFO - 'USER': 'cltbld', 21:56:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:23 INFO - '_': '/tools/buildbot/bin/python'} 21:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:24 INFO - Downloading/unpacking jsonschema 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:25 INFO - Downloading/unpacking functools32 (from jsonschema) 21:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:26 INFO - warning: no files found matching '*.txt' 21:56:26 INFO - no previously-included directories found matching 'build' 21:56:26 INFO - no previously-included directories found matching 'dist' 21:56:26 INFO - no previously-included directories found matching '.git*' 21:56:26 INFO - Installing collected packages: jsonschema, functools32 21:56:26 INFO - Running setup.py install for functools32 21:56:26 INFO - warning: no files found matching '*.txt' 21:56:26 INFO - no previously-included directories found matching 'build' 21:56:26 INFO - no previously-included directories found matching 'dist' 21:56:26 INFO - no previously-included directories found matching '.git*' 21:56:26 INFO - Successfully installed jsonschema functools32 21:56:26 INFO - Cleaning up... 21:56:26 INFO - Return code: 0 21:56:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc0ad2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', '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 21:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:56:26 INFO - Using env: {'DISPLAY': ':0', 21:56:26 INFO - 'HOME': '/home/cltbld', 21:56:26 INFO - 'LANG': 'en_US.UTF-8', 21:56:26 INFO - 'LANGUAGE': 'en_US:en', 21:56:26 INFO - 'LOGNAME': 'cltbld', 21:56:26 INFO - 'MAIL': '/var/mail/cltbld', 21:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:26 INFO - 'MOZ_NO_REMOTE': '1', 21:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:26 INFO - 'NO_EM_RESTART': '1', 21:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:26 INFO - 'PWD': '/builds/slave/test', 21:56:26 INFO - 'SHELL': '/bin/bash', 21:56:26 INFO - 'SHLVL': '1', 21:56:26 INFO - 'TERM': 'linux', 21:56:26 INFO - 'TMOUT': '86400', 21:56:26 INFO - 'USER': 'cltbld', 21:56:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:26 INFO - '_': '/tools/buildbot/bin/python'} 21:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:26 INFO - Downloading/unpacking flake8 21:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:56:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:56:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:28 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 21:56:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:29 INFO - no previously-included directories found matching 'docs/_build' 21:56:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:56:29 INFO - Running setup.py install for pep8 21:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:29 INFO - no previously-included directories found matching 'docs/_build' 21:56:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:56:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:56:29 INFO - Cleaning up... 21:56:29 INFO - Return code: 0 21:56:29 INFO - Running post-action listener: _resource_record_post_action 21:56:29 INFO - Running post-action listener: _start_resource_monitoring 21:56:29 INFO - Starting resource monitoring. 21:56:29 INFO - ##### 21:56:29 INFO - ##### Running install step. 21:56:29 INFO - ##### 21:56:29 INFO - Running pre-action listener: _resource_record_pre_action 21:56:29 INFO - Running main action method: install 21:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:29 INFO - Reading from file tmpfile_stdout 21:56:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:29 INFO - Reading from file tmpfile_stdout 21:56:29 INFO - Output received: 21:56:29 INFO - Usage: mozinstall [options] installer 21:56:29 INFO - Options: 21:56:29 INFO - -h, --help show this help message and exit 21:56:29 INFO - -d DEST, --destination=DEST 21:56:29 INFO - Directory to install application into. [default: 21:56:29 INFO - "/builds/slave/test"] 21:56:29 INFO - --app=APP Application being installed. [default: firefox] 21:56:29 INFO - mkdir: /builds/slave/test/build/application 21:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:56:45 INFO - Reading from file tmpfile_stdout 21:56:45 INFO - Output received: 21:56:45 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:45 INFO - Running post-action listener: _resource_record_post_action 21:56:45 INFO - ##### 21:56:45 INFO - ##### Running run-tests step. 21:56:45 INFO - ##### 21:56:45 INFO - Running pre-action listener: _resource_record_pre_action 21:56:45 INFO - Running main action method: run_tests 21:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:45 INFO - Python 2.7.3 21:56:45 INFO - Return code: 0 21:56:45 INFO - grabbing minidump binary from tooltool 21:56: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')]} 21:56:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1436640>, '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 0x1437540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14379d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:56:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:56:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:45 INFO - Return code: 0 21:56:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:56:46 INFO - Return code: 0 21:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 21:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 21:56:46 INFO - Using env: {'DISPLAY': ':0', 21:56:46 INFO - 'HOME': '/home/cltbld', 21:56:46 INFO - 'LANG': 'en_US.UTF-8', 21:56:46 INFO - 'LANGUAGE': 'en_US:en', 21:56:46 INFO - 'LOGNAME': 'cltbld', 21:56:46 INFO - 'MAIL': '/var/mail/cltbld', 21:56:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:46 INFO - 'MOZ_NO_REMOTE': '1', 21:56:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:46 INFO - 'NO_EM_RESTART': '1', 21:56:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:46 INFO - 'PWD': '/builds/slave/test', 21:56:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:46 INFO - 'SHELL': '/bin/bash', 21:56:46 INFO - 'SHLVL': '1', 21:56:46 INFO - 'TERM': 'linux', 21:56:46 INFO - 'TMOUT': '86400', 21:56:46 INFO - 'USER': 'cltbld', 21:56:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281', 21:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:46 INFO - '_': '/tools/buildbot/bin/python'} 21:56:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 21:56:46 INFO - mozversion application_buildid: 20160522191132 21:56:46 INFO - mozversion application_changeset: cb42beedc07e7fd7a13b76081cf3252543626f05 21:56:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:56:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:46 INFO - mozversion application_name: Firefox 21:56:46 INFO - mozversion application_remotingname: firefox-dev 21:56:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:56:46 INFO - mozversion application_vendor: Mozilla 21:56:46 INFO - mozversion application_version: 48.0a2 21:56:46 INFO - mozversion platform_buildid: 20160522191132 21:56:46 INFO - mozversion platform_changeset: cb42beedc07e7fd7a13b76081cf3252543626f05 21:56:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:56:46 INFO - mozversion platform_version: 48.0a2 21:56:46 INFO - using testdate: 1463979406 21:56:46 INFO - actual date: 1463979406 21:56:46 INFO - starting webserver on 'localhost:49351' 21:56:46 INFO - SUITE-START | Running 2 tests 21:56:46 INFO - TEST-START | dromaeo_css 21:56:46 INFO - operating with platform_type : linux_ 21:56:46 INFO - Initialising browser for dromaeo_css test... 21:56:46 INFO - TEST-INFO | started process 28272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB5hzqp/profile http://localhost:49351/getInfo.html) 21:56:50 INFO - PROCESS | 28272 | __metrics Screen width/height:1600/1200 21:56:50 INFO - PROCESS | 28272 | colorDepth:24 21:56:50 INFO - PROCESS | 28272 | Browser inner width/height: 1024/697 21:56:50 INFO - PROCESS | 28272 | __metrics 21:56:51 ERROR - PROCESS | 28272 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:56:51 INFO - TEST-INFO | 28272: exit 0 21:56:51 INFO - Browser initialized. 21:56:51 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:51 INFO - TEST-INFO | started process 28365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB5hzqp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:03 INFO - PROCESS | 28365 | RSS: Main: 141758464 21:57:03 INFO - PROCESS | 28365 | 21:57:55 INFO - PROCESS | 28365 | 1463979475389 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] 22:00:02 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49351/tests/dromaeo/cssquery-ext.html) 22:00:03 INFO - PROCESS | 28365 | RSS: Main: 256655360 22:00:03 INFO - PROCESS | 28365 | 22:03:06 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-ext.html (next: http://localhost:49351/tests/dromaeo/cssquery-jquery.html) 22:03:06 INFO - PROCESS | 28365 | RSS: Main: 225026048 22:03:06 INFO - PROCESS | 28365 | 22:06:08 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49351/tests/dromaeo/cssquery-mootools.html) 22:06:09 INFO - PROCESS | 28365 | RSS: Main: 223277056 22:06:09 INFO - PROCESS | 28365 | 22:09:10 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49351/tests/dromaeo/cssquery-prototype.html) 22:09:11 INFO - PROCESS | 28365 | RSS: Main: 220168192 22:09:11 INFO - PROCESS | 28365 | 22:12:14 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49351/tests/dromaeo/cssquery-yui.html) 22:12:14 INFO - PROCESS | 28365 | RSS: Main: 213639168 22:12:14 INFO - PROCESS | 28365 | 22:15:16 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:49351/tests/dromaeo/cssquery-yui.html (next: http://localhost:49351/tests/dromaeo/cssquery-dojo.html) 22:15:17 INFO - PROCESS | 28365 | RSS: Main: 253702144 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | __start_tp_report 22:15:17 INFO - PROCESS | 28365 | _x_x_mozilla_page_load 22:15:17 INFO - PROCESS | 28365 | _x_x_mozilla_page_load_details 22:15:17 INFO - PROCESS | 28365 | |i|pagename|runs| 22:15:17 INFO - PROCESS | 28365 | |0;dojo.html;3222.8227447490385;3313.7680362374635;3329.567156269685;3343.414902392081;3367.0403934878564;5491.176323551469;5495.697736624484;5501.147322165066;5509.311336082989;5537.529310008649;5466.753996070176;5500.3949565547855;5501.394846566875;5508.55931525478;5543.390227075019;4918.901621967559;4940.209566469365;5024.497550244982;5038.6724862883975;5080.263361812535;4910.901781964359;4970.428400733907;4988.526090021461;5043;5050.924236136461;5090.261912022755;5117.232415137722;5132.358455193101;5138.023775482665;5154.716490593016;5118.360204974379;5142.228665700175;5142.922856157142;5152.046871328816;5155.123628983082;4822.300766388854;4835.540623640749;4883.5604795568215;4973.751312434364;5030.144875371159;5284.735763211824;5379.946200537984;5395.78416863325;5427.755750991215;5491.258680078178;5880.176775251468;5916.083007133858;5918.852028699274;5920.727043685628;5937;5753.597248192628;5981.641101533878;5984.820455386302;5992.981193197167;5997.7001149942325;5516.338039435253;5543.916841247385;5568.443155684399;5581.581381396411;5592.3009623797025;6030.6129590194505;6049.1833602463985;6073.878522429527;6081.087836824512;6085.726142323518;5748.655080695172;5783.508401785895;5822.039363505059;5822.243108395882;5855.590108692436;5919.822405327847;5941.524678025748;5941.851453713692;5952.523798096142;5975.611585247032;5869.119632055226;5870.26621672291;5872.119182122716;5872.207252020922;5873.647581145145;5676.8864622707315;5768.682722450221;5776.711164441761;5892.234009578728;5895.35151133375;4369.453818272716;4415.646748260131;4415.757133357632;4417.646588272931;4423.248047831877;4012.3580227163516;4041.5958404159937;4048.919021619551;4085.9387109193385;4086.693497987663;5541.445855414427;5546.639468434539;5565.9721701392045;5566.610337276352;5574.16387541872;5741.483266506035;5787.131930210502;5789.768409263583;5793.478586927196;5803.419658034247;5647.407022262685;5683.744231509592;5710.514606258432;5750.482456578844;5760.683162426023;4861.173600487926;4879.804807807648;4881.755912204376;4884.633652476078;4925.21196608541;6061.909071363933;6106.358832322542;6123.112148738408;6125.142480052797;6135.538906165067;5909.52723782105;5911.645301281937;5916.585838991229;5929.733162007634;5930.644161350333;6099.359567245376;6116.8776624468155;6127.019676851683;6127.540434467343;6137.570370074231;5726.685032323262;5727.656340619576;5808;5809.5933284671355;5853.531717462508;5848.298204215522;5885.705714714161;5901.380355062656;5902.61632993854;5929.110633405024;5708.200851880823;5747.7413516391025;5751.166080918327;5751.597388182787;5752.050911599539;5547.084731019337;5639.746211420578;5720.48515633595;5760.481556659921;5782.5663075268685;5642.802501912413;5659.03796354629;5678.14827775837;5678.290213723285;5682.403347648437;5740.942590574041;5766.394528574439;5777.480026797609;5785.913211301918;5794.159846822272;5532.972335138298;5546.639468434539;5618.410066943075;5703;5731.799387021434 22:15:17 INFO - PROCESS | 28365 | |1;ext.html;600.9429104235099;656.9014647802829;661.9040239165321;666.3436515032691;670.8222321084917;40424;41520.58479415205;41583.37624935628;41587;41592.58407415925;44110.55889441105;44884.326735099;44890.32664510035;44906;45025;8184.058833234165;8761.25529330006;8962.417442866226;10415;10635.202359823044;10301.175905927508;10419.583216671324;10424.739381515446;10457.633982810603;10471.319364241339;10448.947755261213;10474.633387831427;10477.842832357483;10514.316569422963;10524.526396312185;8421.957890210571;10719.464026798629;11011.504482298316;11020;11035.39305338206;10415;10490.05589496949;10509;10511.054005139498;10525.947370263177;40236.59763402387;40438.797806011076;40528.392074118914;40670;40686.18627627431;3903.394973779069;3949.5458022327225;3965.20695860829;4000.139969906455;4029.7985100744845;30117;30445.391092178255;30524;30824.53763193554;31621.20946976344;4639.838753130633;4760.8571742847425;4765.428148622187;4782.880427989293;4812.205986012304;236643;238774;238839;240249;240266.7986660073;57154.42845571491;58281.4171858276;58307.12539311914;58338.41661583415;58345;69986;71193.28806711867;71248;71339;71349.6432517834;18129.45611631653;18924.810751892306;19350.806491935182;19391.709124363148;19401.126949287314;15036.774448383283;15261.542153735405;15276.465323713617;15291.847081529264;15437.38250469991;19916;20638.277660282118;21014.264500742705;21062.368128956157;21141.89429052845;7376.409887209011;7400.185979542246;7493.812654683677;7610.8097297568;7798.805029874298;1056.1128651932413;1163.2787671643634;1171.976560468786;1175.4325621737985;1190.9940450297865;33648;33758;34277;34616.826915865764;35077.64922350795;1209.4013463335705;1210.2315029956042;1250.781113305168;1268.892144167756;1357.178906761415;18093.819061809478;18117;18298.45104646863;18328.892177399503;18405;527186;531516;533492;534597;538048;63116.368836311965;63393.68303158547;64073;64134.35865641377;64166.187535934994;1288.6649471137384;1429.5639829851787;1521.5891709238444;1534.5779910524695;1622.164585238603;31316.217094572818;32812.507812382355;33380;33465.330693385506;34468;44148;44206;44408;44552.77723611361;44622.3306650394;314543;316554;317266;317703;742711;30242.395152097273;30768.00007999473;30817.69182308148;30877.38245235038;31037.68962310348;47646.761766190946;50112.74943625258;50172.498275016784;51012.74493627508;51350.486495136065;41405.37891931563;41559.792201040014;42190.789046054575;42191;43348;40507.1898562033;41636;42028.78985605053;42783;42907;43064;43779.78110109429;44137.11725765531;44275.557244427146;44287.335689964035;36745.448818267214;37407.81296093502;37764.81117594394;37920;38100.23799523938;28738.568921466613;28828.279293017844;28945.42109157847;29100.854495727384;29297 22:15:17 INFO - PROCESS | 28365 | |2;jquery.html;411.56374243302093;420.12404137373574;424.65815018909785;431.3594312446017;434.9695521313508;18219;18503.722444163348;18679.4396168115;18738.4378468646;20137.29519466819;18831.435056948314;19025.2389904404;19181.56138289627;20277.290294839684;20312.289069882558;5526.778928842861;5527.143292789624;5678.687672178028;5711.885762284752;5797.159411885295;5747.798827041054;5752.2234498342605;5767.884642307151;5793.884122317551;5794.217780599628;5467.9453205468035;5742.79900203493;5749.0514065179195;5769.971150144243;5770.509506691937;5618.12918997552;5681.7727290908315;5703.7148142592705;5709.65742055478;5715.428457154293;5073.188289873602;5125.8718532037;5135.897282054375;5142.1772516397195;5153.6907785532985;13146.737065258641;13747.38136783847;22898.885505572365;23436.296911092693;23546.411339716473;2332.650102484624;2349.8237632177656;2507.924762257135;2929.399473108008;3151.795133316327;9872.555734991942;10194;10269.845952310721;10421.218408619385;10536.525856336406;2022.888741119238;2093.005822234442;2118.353902059871;2123.2568600989684;2145.3349461666776;76068;76578;78772.21227787706;79080.20919790785;80326;10985.725356866142;11162.274452160584;11202.21584489078;11310.717232069099;11313.434328283718;15389.692206155814;15455.768163477556;15583.142927139117;15619;15630.9218453907;8673.956630216808;8796.252318552866;8852.64589416429;8943.37396382247;9106.225970792424;8423.915760842436;8480.279176270085;8507.787305317293;8538.658453661908;8851.645934162561;4832.51674832521;4860.805567777249;4873.585745211697;4899.681520701143;4905.092557876733;1929.1704567036309;2016.2942969960397;2021.8887961162277;2024.1903238704342;2040.734704488407;977.8142152991052;1033.943133127685;1037.5434808684154;1040.5369610523396;1134.6142311613926;18083;19131.13909874059;19269.036548172535;19277.614447710966;19454.359383970022;1067;1083.3824719909733;1083.918706097046;1101.1466113761899;1102.7794441111648;10478.266521343432;10955.726106847233;10975.945120274348;10989.06592939593;11055.557777688802;572225;577666;579817;583315;584756;101859.54540007119;102208.48895755623;102292;106485.46757266164;107063;1163.33689796815;1193.1767080714453;1209.3348658237935;1231.1628092896917;1238.7832129377323;17115.14424278806;17561.385351512636;17690.292388304322;17800.020998845186;18077.548061298046;39515.01212469596;39543;40247.1950560993;40673;41137.1772564553;56401.71799140978;59025.40974590371;59108.70445647744;59450;59590.40409596022;8960.507172105597;8998.415103018282;9048.366614336934;9156.221721153777;9208;10103.949480252551;13451;13698.589042328347;13887.513937012156;14046.648833779238;11309.377984210618;11380.772384552429;11560.537578496765;11943.566771987416;12039.879601203877;11392.658220253406;11659.417029148679;11732;12205.511779528719;12587.74824503523;11761.647150585497;11876.703082422662;11948.223365481215;12128.332941688292;12283.508659653513;8889.866652000355;8940.642374304955;9061.637534498546;9065.728028159167;9118.316126290687;11278.436078196222;11830.112741544246;11857.34784586856;11874.821877672015;11936.701582460508 22:15:17 INFO - PROCESS | 28365 | |3;mootools.html;1354.2280899887069;1551.7439622462293;1570.842915708429;1760.8063113057563;1872.185599264321;8180.386471014675;8298.419110662257;8307.12775158608;8319.251267385927;8330.250277475026;7973.880391794113;8115.188481151897;8161.632726527306;8185.467944583598;8189.754307370774;2116.1323857218545;2405.6872606561124;2418.830681852271;2429.7327293997646;2491.9377015574664;2461.704595448549;2485.2171565956755;2490.713567939683;2491.950160996779;2497.163450244161;2430.0765709030543;2448.6449464827588;2458.766417190364;2459.3359792855917;2463.5935070713313;2097.695834104054;2349.4713689419914;2395.377201927494;2406.6510355998457;2408.1330720940446;2309.8960546775265;2339.7660233976635;2345.542619189259;2346.8474549154253;2368.7039120109985;8388.83222335556;8391.790205244857;8440.57797110142;8447.070822209553;8460.238578527962;5175.482451754832;5236.581073514109;5295.7881684732565;5307.071262529081;5356.9732151339385;3484.9303013939834;3587.2466781975554;3625.148090198801;3628.256207477461;3665.120371110914;1160.2632328471398;1177.4760231696898;1210.2194084815333;1225.8345123408315;1267.8605353411117;12005.279683218947;12034.51861925522;12042.337671428068;12042.578509752117;12093.45579448927;4629.675922685447;4702.318163866289;4720.881977950578;4771.665983381199;4777.617790576745;10161.898381016243;10177.949110254402;10183.388996660224;10194.43930583825;10199.643012494527;4776.5701086902345;5437.374701909252;5438.293021907127;5442.591805614595;5446.291982042309;4745.359376484131;4748.074125545554;4765.070811191854;4776.641751868554;4812;4030.6775457963295;4049.8987525311513;4109.321961876317;4115.053537686349;4168.687348448879;1311.6655252910448;1343.3887581150552;1358.9388477518535;1359.0449954086357;1361.9910631818186;892.1925657280171;900.617237673986;985.531557978621;1000.8848982366975;1017.572619499797;5797.304323481209;5851.356350801409;5858.47273745365;5996.790112346134;6004.819855404345;496.95278948499833;500.5745116650818;505.71427143663715;507.8806480477085;512.8487096306599;4109.835606575763;4154.335306351029;4175.645070169009;4187.874363769091;4226.640735537514;10210.948945255226;10617.893821061845;10651.946740266249;10699;10704.625338113128;10352.482375881176;10504;10516.1061309788;10527.473626318806;10530;7902.17027212146;8124.471909325875;8157.592120394075;8171.63227654757;8179.100298967109;5759.39526349744;5784.248047753765;5850.531957443309;5928.614640048383;5977.462028417463;8896.733098007071;8901.51041692713;8928.464292142493;8975.371723979259;9035.45787252767;9079.68221112258;9182.862257066015;9220.077992200726;9230.400023998687;9234.076592340713;6788.355106264897;7269.709211631687;7302.160251571137;7419.183889772229;7440.7023719052795;7948.443608947549;7980.521168729895;8025.9598702006115;8037.357011438954;8042.477238979448;7251.8187045324285;7384.18773934856;7411.4070874328845;7558.697652093854;7560.281773231534;7238.0952380952385;7255.963720181366;7279.090113735783;7351.338379545867;7378.077740282465;6867.07294515234;6918.0314755935215;7001.194862590663;7034.120734908137;7045.365917067488;5029.74851257443;5229.320188375486;5261.947380526299;5323.547498462674;5354.866128346823;5069.138246498031;5230.241614965885;5240.921386179134;5247.114087252073;5352.892942141213 22:15:17 INFO - PROCESS | 28365 | |4;prototype.html;341.6805287056602;356.4848793493403;358.13331737195983;358.4157822748919;361.65461983805466;6320.873582528347;6328.746850126001;6338.271098823637;6338.587991780531;6355.618662880231;6242.7190776415055;6247.593906396081;6258.499320054396;6268.561200715941;6272.68636568172;4577.977110114453;4660.927986563092;4730.574248317651;4815.638827087965;4820.87947801306;4764.2615394613895;4801.831935882245;4812.157872372339;4813.302071199674;4815.5906747926465;4584.472785629662;4766;4775.044991001796;4789.688670236424;4790.712557246577;4628.583427491509;4711.999999999983;4728.810847566093;4738.170820106502;4771.475137734847;4187.078842654611;4221.092465119983;4224.8732538023605;4238.978805105955;4239.215745087169;6014.188084608566;6023.126646636213;6031.24609423822;6035.396460353973;6043.758249670008;5573.164025396223;5575.247341608912;5590.972045139789;5600.4959553640365;5602.831915042555;6435.581687190364;6609.074729537869;6615.900761488581;6621.602703837785;6628.734850606018;4684.882877928045;4694.882627934295;4698.553637404441;4703.247480403119;4706.1999460091865;6898.1377327834025;6930.099087118642;6937.7224911003495;6939.375456208915;6943.375096241362;4794.5924596408995;4794.640401969867;4799.136155492045;4802.207635740064;4807.471178170398;4829.1790395632825;4849.878753031132;4856.1016212000895;4857.222844344888;4867;5554.50009499147;5561.277033985637;5568.1091025435735;5571.804986825523;5596.3284405871555;6502.382273683992;6604.735810567524;6639.502037347218;6663.36698013688;6676.46588272937;1690.4421540891476;1705.9744103838452;1720.7418887167025;1723.448496481114;1726.6719323328527;1077.455884778182;1138.7836311100864;1141.1213365708359;1155.2317708723772;1166.5683697031982;6496.935030649727;6497.837554061186;6541.803745887631;6546.639934803537;6550.312217217123;6918.792436226921;6950.270221626757;6964.477664175207;6966.3730264276455;6976.267491913378;6578.736850525926;6621.238557565942;6664.233613134552;6667.933320666828;6671.933280667131;3707.8516859325323;3732.6267373263;3744.344739670547;3746.438034294823;3763.4354846773203;7047.083879095685;7211.206767255598;7225.1329840419485;7239.819004524824;7240.384567311732;6994.650267486605;7056.682449289794;7063.328983746535;7067.187273463617;7070.787876363717;7215.711371545184;7216.097987751531;7220.602866842269;7227.457940654367;7232.819179520448;6891.827704307232;6922.757703480354;6933.2026816916705;6938.722451102101;6941.826454338682;6593.406593406617;6851.2121106071445;6860.211075726355;6861.073755043005;6865.862682746218;7188.317109874553;7192.136943566806;7214.89177662346;7215.386692131227;7230.42156627458;4800.591949684176;4847.975760121177;4851.29656199842;4852.053849499313;4856.028794241237;6799.388055075067;6799.762008329685;6804.285550017375;6821.693023813841;6826.317368263134;6551.967240163769;6690.665466726547;6736.360045795642;6758.648270345852;6776.220734615582;6683.4319082876555;6705.228898676714;6706.061151438705;6719.092922455406;6722.596644201363;6590.868182636416;6603.570767900071;6612.4710023198995;6621.1392518972225;6627.4698024158915;6745.797626071226;6768;6768.018637297466;6787.830304242433;6788.762393316408;6449.3873082057125;6555.475561954937;6588;6601.702923368556;6624.171978502687 22:15:17 INFO - PROCESS | 28365 | |5;yui.html;840.7771940435784;851.5188918261182;868.8870446841905;905.492923962581;914.6524320758119;14790.334434950426;14956.850431495695;14959;14992;15005.174715390649;12243.938780306109;13990.300484975762;14037;14054.508092216774;14061.71876562468;901.6799036342103;924.6116631014957;925.3245131054334;925.453982150531;926.8841394825647;912.8813254276968;917.4999625204247;920.986185207219;921.0605182713628;921.2445794448555;786.881967704846;960.1790469148882;961.2070042215165;962.2782912815388;962.7785609309863;938.2353381993687;965.4593427680521;966.1690945786618;966.8211380894522;967.2310513142033;704.0952376196562;704.7427688893517;706.1138271469324;707.3916431868589;708.1785129250045;14417.85582144186;14497.275136243146;14514.274286285749;14526.418943242257;14527.78208326876;13921.930390348085;14153.363098660586;14383.424663013468;14983.625409364744;14991.250437478082;11017.177265794016;11136.665900023012;11345.319280843094;11352.82970755431;11458.713532161762;3798.2213646202463;3815.4467602197524;3831.8467261309793;3832.7891965941863;3923.372260438316;53929.46070539323;54358;54474.18288725672;55481.72259138679;56481.71759141219;11274.436278186058;11305.26515776472;11420.086393088533;11531.192816502764;11565.190436669352;18405.079746012914;18459.538511537317;18461.1692473839;18476.168572414274;18564.628707425774;8464.365172612079;8701.129887011375;8890.73327800167;9024.458532488072;9054.049324820931;5089.236614507853;5103.209002604603;5128.615353848476;5161.690298582097;5205.687658740488;3473.583170019563;3540.8760693376125;3543.1496440854007;3545.804980726033;3552.2185119273718;581.9679917604487;598.437468779346;601.2994860986988;601.6420229963165;607.1014897950969;626.5864529410567;759.6467642546243;805.90732065812;806.4072906413782;816.8121332093651;9537.952310238405;9830.557624906896;9977.551010204557;10053.59785608582;10077.143442807297;727.7525641281884;762.4053238473999;780.9101953275446;796.6932730898529;816.9264766171074;4131.421600975866;4196.916061678749;4212.68404869636;4228.957710422918;4250.851220207278;64483;66147.33852661411;66863.66568167225;66919.33080669228;67012.66493667598;51199.23201151986;52018.21972670413;52058;55854.72072639692;56782;52570.73714631479;52626.47373526292;53119.73440132775;53791;54130.18804717853;10038.49807509607;10358.378497290187;10384.688459346231;10452.111570516592;10462.424566648908;39305.82082537528;39398.212035759694;39807.601923980386;40317.992050198976;41224.175516490104;50814.74592627161;51488.22767658413;52037.21944170916;53047.46952530425;53594;11921.582744603897;11991.479243039523;12790.424430900446;13019.549246669158;13097;13998;14256.209603526082;14299.785503217252;14568.708625827636;15064.096154230781;9621.374610650286;12040.518379264731;12229.205101668364;13593.796093058414;13822.30888455553;13060.477580897037;13102.606921792361;13253.204807711569;13453.865461345262;13837.169769813843;12846.807297890726;13271.535496257971;13347.66630834237;13435;13557.034230036392;10625.628103016357;10714.571417143226;10791.082757965662;10800;11064.778704425706;11455.942720286344;11519.963203311741;11804.70488237801;11929.224600400947;12027.518899243933 22:15:17 INFO - PROCESS | 28365 | __end_tp_report 22:15:17 INFO - PROCESS | 28365 | __start_cc_report 22:15:17 INFO - PROCESS | 28365 | _x_x_mozilla_cycle_collect,948 22:15:17 INFO - PROCESS | 28365 | __end_cc_report 22:15:17 INFO - PROCESS | 28365 | __startTimestamp1463980517156__endTimestamp 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | ------- Summary: start ------- 22:15:17 INFO - PROCESS | 28365 | Number of tests: 6 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#0] dojo.html Cycles:165 Average:5470.71 Median:5683.74 stddev:612.92 (10.8%) stddev-sans-first:588.89 22:15:17 INFO - PROCESS | 28365 | Values: 3222.8 3313.8 3329.6 3343.4 3367.0 5491.2 5495.7 5501.1 5509.3 5537.5 5466.8 5500.4 5501.4 5508.6 5543.4 4918.9 4940.2 5024.5 5038.7 5080.3 4910.9 4970.4 4988.5 5043.0 5050.9 5090.3 5117.2 5132.4 5138.0 5154.7 5118.4 5142.2 5142.9 5152.0 5155.1 4822.3 4835.5 4883.6 4973.8 5030.1 5284.7 5379.9 5395.8 5427.8 5491.3 5880.2 5916.1 5918.9 5920.7 5937.0 5753.6 5981.6 5984.8 5993.0 5997.7 5516.3 5543.9 5568.4 5581.6 5592.3 6030.6 6049.2 6073.9 6081.1 6085.7 5748.7 5783.5 5822.0 5822.2 5855.6 5919.8 5941.5 5941.9 5952.5 5975.6 5869.1 5870.3 5872.1 5872.2 5873.6 5676.9 5768.7 5776.7 5892.2 5895.4 4369.5 4415.6 4415.8 4417.6 4423.2 4012.4 4041.6 4048.9 4085.9 4086.7 5541.4 5546.6 5566.0 5566.6 5574.2 5741.5 5787.1 5789.8 5793.5 5803.4 5647.4 5683.7 5710.5 5750.5 5760.7 4861.2 4879.8 4881.8 4884.6 4925.2 6061.9 6106.4 6123.1 6125.1 6135.5 5909.5 5911.6 5916.6 5929.7 5930.6 6099.4 6116.9 6127.0 6127.5 6137.6 5726.7 5727.7 5808.0 5809.6 5853.5 5848.3 5885.7 5901.4 5902.6 5929.1 5708.2 5747.7 5751.2 5751.6 5752.1 5547.1 5639.7 5720.5 5760.5 5782.6 5642.8 5659.0 5678.1 5678.3 5682.4 5740.9 5766.4 5777.5 5785.9 5794.2 5533.0 5546.6 5618.4 5703.0 5731.8 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#1] ext.html Cycles:180 Average:57121.23 Median:37076.63 stddev:112160.59 (302.5%) stddev-sans-first:112394.95 22:15:17 INFO - PROCESS | 28365 | Values: 600.9 656.9 661.9 666.3 670.8 40424.0 41520.6 41583.4 41587.0 41592.6 44110.6 44884.3 44890.3 44906.0 45025.0 8184.1 8761.3 8962.4 10415.0 10635.2 10301.2 10419.6 10424.7 10457.6 10471.3 10448.9 10474.6 10477.8 10514.3 10524.5 8422.0 10719.5 11011.5 11020.0 11035.4 10415.0 10490.1 10509.0 10511.1 10525.9 40236.6 40438.8 40528.4 40670.0 40686.2 3903.4 3949.5 3965.2 4000.1 4029.8 30117.0 30445.4 30524.0 30824.5 31621.2 4639.8 4760.9 4765.4 4782.9 4812.2 236643.0 238774.0 238839.0 240249.0 240266.8 57154.4 58281.4 58307.1 58338.4 58345.0 69986.0 71193.3 71248.0 71339.0 71349.6 18129.5 18924.8 19350.8 19391.7 19401.1 15036.8 15261.5 15276.5 15291.8 15437.4 19916.0 20638.3 21014.3 21062.4 21141.9 7376.4 7400.2 7493.8 7610.8 7798.8 1056.1 1163.3 1172.0 1175.4 1191.0 33648.0 33758.0 34277.0 34616.8 35077.6 1209.4 1210.2 1250.8 1268.9 1357.2 18093.8 18117.0 18298.5 18328.9 18405.0 527186.0 531516.0 533492.0 534597.0 538048.0 63116.4 63393.7 64073.0 64134.4 64166.2 1288.7 1429.6 1521.6 1534.6 1622.2 31316.2 32812.5 33380.0 33465.3 34468.0 44148.0 44206.0 44408.0 44552.8 44622.3 314543.0 316554.0 317266.0 317703.0 742711.0 30242.4 30768.0 30817.7 30877.4 31037.7 47646.8 50112.7 50172.5 51012.7 51350.5 41405.4 41559.8 42190.8 42191.0 43348.0 40507.2 41636.0 42028.8 42783.0 42907.0 43064.0 43779.8 44137.1 44275.6 44287.3 36745.4 37407.8 37764.8 37920.0 38100.2 28738.6 28828.3 28945.4 29100.9 29297.0 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#2] jquery.html Cycles:180 Average:31726.67 Median:2066.87 stddev:95325.52 (4612.1%) stddev-sans-first:95563.93 22:15:17 INFO - PROCESS | 28365 | Values: 411.6 420.1 424.7 431.4 435.0 18219.0 18503.7 18679.4 18738.4 20137.3 18831.4 19025.2 19181.6 20277.3 20312.3 5526.8 5527.1 5678.7 5711.9 5797.2 5747.8 5752.2 5767.9 5793.9 5794.2 5467.9 5742.8 5749.1 5770.0 5770.5 5618.1 5681.8 5703.7 5709.7 5715.4 5073.2 5125.9 5135.9 5142.2 5153.7 13146.7 13747.4 22898.9 23436.3 23546.4 2332.7 2349.8 2507.9 2929.4 3151.8 9872.6 10194.0 10269.8 10421.2 10536.5 2022.9 2093.0 2118.4 2123.3 2145.3 76068.0 76578.0 78772.2 79080.2 80326.0 10985.7 11162.3 11202.2 11310.7 11313.4 15389.7 15455.8 15583.1 15619.0 15630.9 8674.0 8796.3 8852.6 8943.4 9106.2 8423.9 8480.3 8507.8 8538.7 8851.6 4832.5 4860.8 4873.6 4899.7 4905.1 1929.2 2016.3 2021.9 2024.2 2040.7 977.8 1033.9 1037.5 1040.5 1134.6 18083.0 19131.1 19269.0 19277.6 19454.4 1067.0 1083.4 1083.9 1101.1 1102.8 10478.3 10955.7 10975.9 10989.1 11055.6 572225.0 577666.0 579817.0 583315.0 584756.0 101859.5 102208.5 102292.0 106485.5 107063.0 1163.3 1193.2 1209.3 1231.2 1238.8 17115.1 17561.4 17690.3 17800.0 18077.5 39515.0 39543.0 40247.2 40673.0 41137.2 56401.7 59025.4 59108.7 59450.0 59590.4 8960.5 8998.4 9048.4 9156.2 9208.0 10103.9 13451.0 13698.6 13887.5 14046.6 11309.4 11380.8 11560.5 11943.6 12039.9 11392.7 11659.4 11732.0 12205.5 12587.7 11761.6 11876.7 11948.2 12128.3 12283.5 8889.9 8940.6 9061.6 9065.7 9118.3 11278.4 11830.1 11857.3 11874.8 11936.7 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#3] mootools.html Cycles:180 Average:5642.24 Median:2767.73 stddev:3092.84 (111.7%) stddev-sans-first:3084.73 22:15:17 INFO - PROCESS | 28365 | Values: 1354.2 1551.7 1570.8 1760.8 1872.2 8180.4 8298.4 8307.1 8319.3 8330.3 7973.9 8115.2 8161.6 8185.5 8189.8 2116.1 2405.7 2418.8 2429.7 2491.9 2461.7 2485.2 2490.7 2492.0 2497.2 2430.1 2448.6 2458.8 2459.3 2463.6 2097.7 2349.5 2395.4 2406.7 2408.1 2309.9 2339.8 2345.5 2346.8 2368.7 8388.8 8391.8 8440.6 8447.1 8460.2 5175.5 5236.6 5295.8 5307.1 5357.0 3484.9 3587.2 3625.1 3628.3 3665.1 1160.3 1177.5 1210.2 1225.8 1267.9 12005.3 12034.5 12042.3 12042.6 12093.5 4629.7 4702.3 4720.9 4771.7 4777.6 10161.9 10177.9 10183.4 10194.4 10199.6 4776.6 5437.4 5438.3 5442.6 5446.3 4745.4 4748.1 4765.1 4776.6 4812.0 4030.7 4049.9 4109.3 4115.1 4168.7 1311.7 1343.4 1358.9 1359.0 1362.0 892.2 900.6 985.5 1000.9 1017.6 5797.3 5851.4 5858.5 5996.8 6004.8 497.0 500.6 505.7 507.9 512.8 4109.8 4154.3 4175.6 4187.9 4226.6 10210.9 10617.9 10651.9 10699.0 10704.6 10352.5 10504.0 10516.1 10527.5 10530.0 7902.2 8124.5 8157.6 8171.6 8179.1 5759.4 5784.2 5850.5 5928.6 5977.5 8896.7 8901.5 8928.5 8975.4 9035.5 9079.7 9182.9 9220.1 9230.4 9234.1 6788.4 7269.7 7302.2 7419.2 7440.7 7948.4 7980.5 8026.0 8037.4 8042.5 7251.8 7384.2 7411.4 7558.7 7560.3 7238.1 7256.0 7279.1 7351.3 7378.1 6867.1 6918.0 7001.2 7034.1 7045.4 5029.7 5229.3 5261.9 5323.5 5354.9 5069.1 5230.2 5240.9 5247.1 5352.9 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#4] prototype.html Cycles:180 Average:5609.55 Median:6442.48 stddev:1692.01 (26.3%) stddev-sans-first:1649.91 22:15:17 INFO - PROCESS | 28365 | Values: 341.7 356.5 358.1 358.4 361.7 6320.9 6328.7 6338.3 6338.6 6355.6 6242.7 6247.6 6258.5 6268.6 6272.7 4578.0 4660.9 4730.6 4815.6 4820.9 4764.3 4801.8 4812.2 4813.3 4815.6 4584.5 4766.0 4775.0 4789.7 4790.7 4628.6 4712.0 4728.8 4738.2 4771.5 4187.1 4221.1 4224.9 4239.0 4239.2 6014.2 6023.1 6031.2 6035.4 6043.8 5573.2 5575.2 5591.0 5600.5 5602.8 6435.6 6609.1 6615.9 6621.6 6628.7 4684.9 4694.9 4698.6 4703.2 4706.2 6898.1 6930.1 6937.7 6939.4 6943.4 4794.6 4794.6 4799.1 4802.2 4807.5 4829.2 4849.9 4856.1 4857.2 4867.0 5554.5 5561.3 5568.1 5571.8 5596.3 6502.4 6604.7 6639.5 6663.4 6676.5 1690.4 1706.0 1720.7 1723.4 1726.7 1077.5 1138.8 1141.1 1155.2 1166.6 6496.9 6497.8 6541.8 6546.6 6550.3 6918.8 6950.3 6964.5 6966.4 6976.3 6578.7 6621.2 6664.2 6667.9 6671.9 3707.9 3732.6 3744.3 3746.4 3763.4 7047.1 7211.2 7225.1 7239.8 7240.4 6994.7 7056.7 7063.3 7067.2 7070.8 7215.7 7216.1 7220.6 7227.5 7232.8 6891.8 6922.8 6933.2 6938.7 6941.8 6593.4 6851.2 6860.2 6861.1 6865.9 7188.3 7192.1 7214.9 7215.4 7230.4 4800.6 4848.0 4851.3 4852.1 4856.0 6799.4 6799.8 6804.3 6821.7 6826.3 6552.0 6690.7 6736.4 6758.6 6776.2 6683.4 6705.2 6706.1 6719.1 6722.6 6590.9 6603.6 6612.5 6621.1 6627.5 6745.8 6768.0 6768.0 6787.8 6788.8 6449.4 6555.5 6588.0 6601.7 6624.2 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - PROCESS | 28365 | [#5] yui.html Cycles:180 Average:15574.68 Median:22677.80 stddev:18031.20 (79.5%) stddev-sans-first:18047.83 22:15:17 INFO - PROCESS | 28365 | Values: 840.8 851.5 868.9 905.5 914.7 14790.3 14956.9 14959.0 14992.0 15005.2 12243.9 13990.3 14037.0 14054.5 14061.7 901.7 924.6 925.3 925.5 926.9 912.9 917.5 921.0 921.1 921.2 786.9 960.2 961.2 962.3 962.8 938.2 965.5 966.2 966.8 967.2 704.1 704.7 706.1 707.4 708.2 14417.9 14497.3 14514.3 14526.4 14527.8 13921.9 14153.4 14383.4 14983.6 14991.3 11017.2 11136.7 11345.3 11352.8 11458.7 3798.2 3815.4 3831.8 3832.8 3923.4 53929.5 54358.0 54474.2 55481.7 56481.7 11274.4 11305.3 11420.1 11531.2 11565.2 18405.1 18459.5 18461.2 18476.2 18564.6 8464.4 8701.1 8890.7 9024.5 9054.0 5089.2 5103.2 5128.6 5161.7 5205.7 3473.6 3540.9 3543.1 3545.8 3552.2 582.0 598.4 601.3 601.6 607.1 626.6 759.6 805.9 806.4 816.8 9538.0 9830.6 9977.6 10053.6 10077.1 727.8 762.4 780.9 796.7 816.9 4131.4 4196.9 4212.7 4229.0 4250.9 64483.0 66147.3 66863.7 66919.3 67012.7 51199.2 52018.2 52058.0 55854.7 56782.0 52570.7 52626.5 53119.7 53791.0 54130.2 10038.5 10358.4 10384.7 10452.1 10462.4 39305.8 39398.2 39807.6 40318.0 41224.2 50814.7 51488.2 52037.2 53047.5 53594.0 11921.6 11991.5 12790.4 13019.5 13097.0 13998.0 14256.2 14299.8 14568.7 15064.1 9621.4 12040.5 12229.2 13593.8 13822.3 13060.5 13102.6 13253.2 13453.9 13837.2 12846.8 13271.5 13347.7 13435.0 13557.0 10625.6 10714.6 10791.1 10800.0 11064.8 11455.9 11520.0 11804.7 11929.2 12027.5 22:15:17 INFO - PROCESS | 28365 | -------- Summary: end -------- 22:15:17 INFO - PROCESS | 28365 | 22:15:17 INFO - TEST-INFO | 28365: exit 0 22:15:17 INFO - TEST-OK | dromaeo_css | took 1111159ms 22:15:17 INFO - TEST-START | kraken 22:15:17 INFO - operating with platform_type : linux_ 22:15:17 INFO - Initialising browser for kraken test... 22:15:17 INFO - TEST-INFO | started process 28551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6XftD/profile http://localhost:49351/getInfo.html) 22:15:21 INFO - PROCESS | 28551 | __metrics Screen width/height:1600/1200 22:15:21 INFO - PROCESS | 28551 | colorDepth:24 22:15:21 INFO - PROCESS | 28551 | Browser inner width/height: 1024/697 22:15:21 INFO - PROCESS | 28551 | __metrics 22:15:22 ERROR - PROCESS | 28551 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:15:23 INFO - TEST-INFO | 28551: exit 0 22:15:23 INFO - Browser initialized. 22:15:23 INFO - Running cycle 1/1 for kraken test... 22:15:23 INFO - TEST-INFO | started process 28641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6XftD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:34 INFO - PROCESS | 28641 | RSS: Main: 142274560 22:15:34 INFO - PROCESS | 28641 | 22:15:37 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49351/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:38 INFO - PROCESS | 28641 | RSS: Main: 197275648 22:15:38 INFO - PROCESS | 28641 | 22:15:40 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49351/tests/kraken/driver.html?testName=audio-dft) 22:15:41 INFO - PROCESS | 28641 | RSS: Main: 182644736 22:15:41 INFO - PROCESS | 28641 | 22:15:44 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49351/tests/kraken/driver.html?testName=audio-fft) 22:15:44 INFO - PROCESS | 28641 | RSS: Main: 273666048 22:15:44 INFO - PROCESS | 28641 | 22:15:46 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49351/tests/kraken/driver.html?testName=audio-oscillator) 22:15:47 INFO - PROCESS | 28641 | RSS: Main: 178991104 22:15:47 INFO - PROCESS | 28641 | 22:15:49 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:50 INFO - PROCESS | 28641 | RSS: Main: 177930240 22:15:50 INFO - PROCESS | 28641 | 22:15:53 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49351/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:53 INFO - PROCESS | 28641 | RSS: Main: 212553728 22:15:53 INFO - PROCESS | 28641 | 22:15:57 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49351/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:57 INFO - PROCESS | 28641 | RSS: Main: 212463616 22:15:57 INFO - PROCESS | 28641 | 22:16:00 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49351/tests/kraken/driver.html?testName=json-parse-financial) 22:16:01 INFO - PROCESS | 28641 | RSS: Main: 212389888 22:16:01 INFO - PROCESS | 28641 | 22:16:02 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:03 INFO - PROCESS | 28641 | RSS: Main: 192520192 22:16:03 INFO - PROCESS | 28641 | 22:16:05 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:05 INFO - PROCESS | 28641 | RSS: Main: 197287936 22:16:05 INFO - PROCESS | 28641 | 22:16:07 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:08 INFO - PROCESS | 28641 | RSS: Main: 210358272 22:16:08 INFO - PROCESS | 28641 | 22:16:10 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:11 INFO - PROCESS | 28641 | RSS: Main: 212410368 22:16:11 INFO - PROCESS | 28641 | 22:16:14 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:14 INFO - PROCESS | 28641 | RSS: Main: 211709952 22:16:14 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | Cycle 1(1): loaded http://localhost:49351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49351/tests/kraken/driver.html?testName=ai-astar) 22:16:16 INFO - PROCESS | 28641 | RSS: Main: 275169280 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | __start_tp_report 22:16:16 INFO - PROCESS | 28641 | _x_x_mozilla_page_load 22:16:16 INFO - PROCESS | 28641 | _x_x_mozilla_page_load_details 22:16:16 INFO - PROCESS | 28641 | |i|pagename|runs| 22:16:16 INFO - PROCESS | 28641 | |0;ai-astar;114;111;110;112;112;111;104;110;109;111 22:16:16 INFO - PROCESS | 28641 | |1;audio-beat-detection;155;126;163;176;130;161;160;129;182;128 22:16:16 INFO - PROCESS | 28641 | |2;audio-dft;162;161;163;161;161;161;163;163;162;161 22:16:16 INFO - PROCESS | 28641 | |3;audio-fft;76;77;76;178;78;78;76;75;169;77 22:16:16 INFO - PROCESS | 28641 | |4;audio-oscillator;93;92;150;93;93;92;147;93;92;154 22:16:16 INFO - PROCESS | 28641 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;116;117;116 22:16:16 INFO - PROCESS | 28641 | |6;imaging-darkroom;147;145;145;146;147;146;145;146;147;146 22:16:16 INFO - PROCESS | 28641 | |7;imaging-desaturate;95;95;94;95;95;95;96;95;95;95 22:16:16 INFO - PROCESS | 28641 | |8;json-parse-financial;57;55;57;56;59;56;58;78;55;54 22:16:16 INFO - PROCESS | 28641 | |9;json-stringify-tinderbox;74;58;58;57;58;59;57;59;59;60 22:16:16 INFO - PROCESS | 28641 | |10;stanford-crypto-aes;74;73;73;71;73;81;73;75;74;72 22:16:16 INFO - PROCESS | 28641 | |11;stanford-crypto-ccm;116;113;112;111;110;111;112;114;162;130 22:16:16 INFO - PROCESS | 28641 | |12;stanford-crypto-pbkdf2;163;159;157;160;158;161;159;162;156;161 22:16:16 INFO - PROCESS | 28641 | |13;stanford-crypto-sha256-iterative;69;67;65;68;64;65;64;68;65;66 22:16:16 INFO - PROCESS | 28641 | __end_tp_report 22:16:16 INFO - PROCESS | 28641 | __start_cc_report 22:16:16 INFO - PROCESS | 28641 | _x_x_mozilla_cycle_collect,1624 22:16:16 INFO - PROCESS | 28641 | __end_cc_report 22:16:16 INFO - PROCESS | 28641 | __startTimestamp1463980576593__endTimestamp 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | ------- Summary: start ------- 22:16:16 INFO - PROCESS | 28641 | Number of tests: 14 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.45 22:16:16 INFO - PROCESS | 28641 | Values: 114.0 111.0 110.0 112.0 112.0 111.0 104.0 110.0 109.0 111.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:160.50 stddev:21.10 (13.1%) stddev-sans-first:22.33 22:16:16 INFO - PROCESS | 28641 | Values: 155.0 126.0 163.0 176.0 130.0 161.0 160.0 129.0 182.0 128.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:16:16 INFO - PROCESS | 28641 | Values: 162.0 161.0 163.0 161.0 161.0 161.0 163.0 163.0 162.0 161.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.50 stddev:40.91 (53.5%) stddev-sans-first:42.75 22:16:16 INFO - PROCESS | 28641 | Values: 76.0 77.0 76.0 178.0 78.0 78.0 76.0 75.0 169.0 77.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:27.95 (30.2%) stddev-sans-first:28.97 22:16:16 INFO - PROCESS | 28641 | Values: 93.0 92.0 150.0 93.0 93.0 92.0 147.0 93.0 92.0 154.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:16:16 INFO - PROCESS | 28641 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 116.0 117.0 116.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 22:16:16 INFO - PROCESS | 28641 | Values: 147.0 145.0 145.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:16:16 INFO - PROCESS | 28641 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.00 stddev:7.01 (12.3%) stddev-sans-first:7.42 22:16:16 INFO - PROCESS | 28641 | Values: 57.0 55.0 57.0 56.0 59.0 56.0 58.0 78.0 55.0 54.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.00 stddev:5.04 (8.5%) stddev-sans-first:1.00 22:16:16 INFO - PROCESS | 28641 | Values: 74.0 58.0 58.0 57.0 58.0 59.0 57.0 59.0 59.0 60.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.73 (3.7%) stddev-sans-first:2.89 22:16:16 INFO - PROCESS | 28641 | Values: 74.0 73.0 73.0 71.0 73.0 81.0 73.0 75.0 74.0 72.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:113.50 stddev:16.15 (14.2%) stddev-sans-first:17.09 22:16:16 INFO - PROCESS | 28641 | Values: 116.0 113.0 112.0 111.0 110.0 111.0 112.0 114.0 162.0 130.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.50 stddev:2.22 (1.4%) stddev-sans-first:1.99 22:16:16 INFO - PROCESS | 28641 | Values: 163.0 159.0 157.0 160.0 158.0 161.0 159.0 162.0 156.0 161.0 22:16:16 INFO - PROCESS | 28641 | 22:16:16 INFO - PROCESS | 28641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.79 (2.7%) stddev-sans-first:1.56 22:16:16 INFO - PROCESS | 28641 | Values: 69.0 67.0 65.0 68.0 64.0 65.0 64.0 68.0 65.0 66.0 22:16:16 INFO - PROCESS | 28641 | -------- Summary: end -------- 22:16:16 INFO - PROCESS | 28641 | 22:16:17 INFO - TEST-INFO | 28641: exit 0 22:16:17 INFO - TEST-OK | kraken | took 59792ms 22:16:17 INFO - SUITE-END | took 1170s 22:16:17 INFO - Completed test suite (00:19:31) 22:16:17 INFO - javascript benchmark 22:16:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.8227447490385, 3313.7680362374635, 3329.567156269685, 3343.414902392081, 3367.0403934878564, 5491.176323551469, 5495.697736624484, 5501.147322165066, 5509.311336082989, 5537.529310008649, 5466.753996070176, 5500.3949565547855, 5501.394846566875, 5508.55931525478, 5543.390227075019, 4918.901621967559, 4940.209566469365, 5024.497550244982, 5038.6724862883975, 5080.263361812535, 4910.901781964359, 4970.428400733907, 4988.526090021461, 5043.0, 5050.924236136461, 5090.261912022755, 5117.232415137722, 5132.358455193101, 5138.023775482665, 5154.716490593016, 5118.360204974379, 5142.228665700175, 5142.922856157142, 5152.046871328816, 5155.123628983082, 4822.300766388854, 4835.540623640749, 4883.5604795568215, 4973.751312434364, 5030.144875371159, 5284.735763211824, 5379.946200537984, 5395.78416863325, 5427.755750991215, 5491.258680078178, 5880.176775251468, 5916.083007133858, 5918.852028699274, 5920.727043685628, 5937.0, 5753.597248192628, 5981.641101533878, 5984.820455386302, 5992.981193197167, 5997.7001149942325, 5516.338039435253, 5543.916841247385, 5568.443155684399, 5581.581381396411, 5592.3009623797025, 6030.6129590194505, 6049.1833602463985, 6073.878522429527, 6081.087836824512, 6085.726142323518, 5748.655080695172, 5783.508401785895, 5822.039363505059, 5822.243108395882, 5855.590108692436, 5919.822405327847, 5941.524678025748, 5941.851453713692, 5952.523798096142, 5975.611585247032, 5869.119632055226, 5870.26621672291, 5872.119182122716, 5872.207252020922, 5873.647581145145, 5676.8864622707315, 5768.682722450221, 5776.711164441761, 5892.234009578728, 5895.35151133375, 4369.453818272716, 4415.646748260131, 4415.757133357632, 4417.646588272931, 4423.248047831877, 4012.3580227163516, 4041.5958404159937, 4048.919021619551, 4085.9387109193385, 4086.693497987663, 5541.445855414427, 5546.639468434539, 5565.9721701392045, 5566.610337276352, 5574.16387541872, 5741.483266506035, 5787.131930210502, 5789.768409263583, 5793.478586927196, 5803.419658034247, 5647.407022262685, 5683.744231509592, 5710.514606258432, 5750.482456578844, 5760.683162426023, 4861.173600487926, 4879.804807807648, 4881.755912204376, 4884.633652476078, 4925.21196608541, 6061.909071363933, 6106.358832322542, 6123.112148738408, 6125.142480052797, 6135.538906165067, 5909.52723782105, 5911.645301281937, 5916.585838991229, 5929.733162007634, 5930.644161350333, 6099.359567245376, 6116.8776624468155, 6127.019676851683, 6127.540434467343, 6137.570370074231, 5726.685032323262, 5727.656340619576, 5808.0, 5809.5933284671355, 5853.531717462508, 5848.298204215522, 5885.705714714161, 5901.380355062656, 5902.61632993854, 5929.110633405024, 5708.200851880823, 5747.7413516391025, 5751.166080918327, 5751.597388182787, 5752.050911599539, 5547.084731019337, 5639.746211420578, 5720.48515633595, 5760.481556659921, 5782.5663075268685, 5642.802501912413, 5659.03796354629, 5678.14827775837, 5678.290213723285, 5682.403347648437, 5740.942590574041, 5766.394528574439, 5777.480026797609, 5785.913211301918, 5794.159846822272, 5532.972335138298, 5546.639468434539, 5618.410066943075, 5703.0, 5731.799387021434], "value": 5430.627305679966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9429104235099, 656.9014647802829, 661.9040239165321, 666.3436515032691, 670.8222321084917, 40424.0, 41520.58479415205, 41583.37624935628, 41587.0, 41592.58407415925, 44110.55889441105, 44884.326735099, 44890.32664510035, 44906.0, 45025.0, 8184.058833234165, 8761.25529330006, 8962.417442866226, 10415.0, 10635.202359823044, 10301.175905927508, 10419.583216671324, 10424.739381515446, 10457.633982810603, 10471.319364241339, 10448.947755261213, 10474.633387831427, 10477.842832357483, 10514.316569422963, 10524.526396312185, 8421.957890210571, 10719.464026798629, 11011.504482298316, 11020.0, 11035.39305338206, 10415.0, 10490.05589496949, 10509.0, 10511.054005139498, 10525.947370263177, 40236.59763402387, 40438.797806011076, 40528.392074118914, 40670.0, 40686.18627627431, 3903.394973779069, 3949.5458022327225, 3965.20695860829, 4000.139969906455, 4029.7985100744845, 30117.0, 30445.391092178255, 30524.0, 30824.53763193554, 31621.20946976344, 4639.838753130633, 4760.8571742847425, 4765.428148622187, 4782.880427989293, 4812.205986012304, 236643.0, 238774.0, 238839.0, 240249.0, 240266.7986660073, 57154.42845571491, 58281.4171858276, 58307.12539311914, 58338.41661583415, 58345.0, 69986.0, 71193.28806711867, 71248.0, 71339.0, 71349.6432517834, 18129.45611631653, 18924.810751892306, 19350.806491935182, 19391.709124363148, 19401.126949287314, 15036.774448383283, 15261.542153735405, 15276.465323713617, 15291.847081529264, 15437.38250469991, 19916.0, 20638.277660282118, 21014.264500742705, 21062.368128956157, 21141.89429052845, 7376.409887209011, 7400.185979542246, 7493.812654683677, 7610.8097297568, 7798.805029874298, 1056.1128651932413, 1163.2787671643634, 1171.976560468786, 1175.4325621737985, 1190.9940450297865, 33648.0, 33758.0, 34277.0, 34616.826915865764, 35077.64922350795, 1209.4013463335705, 1210.2315029956042, 1250.781113305168, 1268.892144167756, 1357.178906761415, 18093.819061809478, 18117.0, 18298.45104646863, 18328.892177399503, 18405.0, 527186.0, 531516.0, 533492.0, 534597.0, 538048.0, 63116.368836311965, 63393.68303158547, 64073.0, 64134.35865641377, 64166.187535934994, 1288.6649471137384, 1429.5639829851787, 1521.5891709238444, 1534.5779910524695, 1622.164585238603, 31316.217094572818, 32812.507812382355, 33380.0, 33465.330693385506, 34468.0, 44148.0, 44206.0, 44408.0, 44552.77723611361, 44622.3306650394, 314543.0, 316554.0, 317266.0, 317703.0, 742711.0, 30242.395152097273, 30768.00007999473, 30817.69182308148, 30877.38245235038, 31037.68962310348, 47646.761766190946, 50112.74943625258, 50172.498275016784, 51012.74493627508, 51350.486495136065, 41405.37891931563, 41559.792201040014, 42190.789046054575, 42191.0, 43348.0, 40507.1898562033, 41636.0, 42028.78985605053, 42783.0, 42907.0, 43064.0, 43779.78110109429, 44137.11725765531, 44275.557244427146, 44287.335689964035, 36745.448818267214, 37407.81296093502, 37764.81117594394, 37920.0, 38100.23799523938, 28738.568921466613, 28828.279293017844, 28945.42109157847, 29100.854495727384, 29297.0], "value": 21134.67534948157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.56374243302093, 420.12404137373574, 424.65815018909785, 431.3594312446017, 434.9695521313508, 18219.0, 18503.722444163348, 18679.4396168115, 18738.4378468646, 20137.29519466819, 18831.435056948314, 19025.2389904404, 19181.56138289627, 20277.290294839684, 20312.289069882558, 5526.778928842861, 5527.143292789624, 5678.687672178028, 5711.885762284752, 5797.159411885295, 5747.798827041054, 5752.2234498342605, 5767.884642307151, 5793.884122317551, 5794.217780599628, 5467.9453205468035, 5742.79900203493, 5749.0514065179195, 5769.971150144243, 5770.509506691937, 5618.12918997552, 5681.7727290908315, 5703.7148142592705, 5709.65742055478, 5715.428457154293, 5073.188289873602, 5125.8718532037, 5135.897282054375, 5142.1772516397195, 5153.6907785532985, 13146.737065258641, 13747.38136783847, 22898.885505572365, 23436.296911092693, 23546.411339716473, 2332.650102484624, 2349.8237632177656, 2507.924762257135, 2929.399473108008, 3151.795133316327, 9872.555734991942, 10194.0, 10269.845952310721, 10421.218408619385, 10536.525856336406, 2022.888741119238, 2093.005822234442, 2118.353902059871, 2123.2568600989684, 2145.3349461666776, 76068.0, 76578.0, 78772.21227787706, 79080.20919790785, 80326.0, 10985.725356866142, 11162.274452160584, 11202.21584489078, 11310.717232069099, 11313.434328283718, 15389.692206155814, 15455.768163477556, 15583.142927139117, 15619.0, 15630.9218453907, 8673.956630216808, 8796.252318552866, 8852.64589416429, 8943.37396382247, 9106.225970792424, 8423.915760842436, 8480.279176270085, 8507.787305317293, 8538.658453661908, 8851.645934162561, 4832.51674832521, 4860.805567777249, 4873.585745211697, 4899.681520701143, 4905.092557876733, 1929.1704567036309, 2016.2942969960397, 2021.8887961162277, 2024.1903238704342, 2040.734704488407, 977.8142152991052, 1033.943133127685, 1037.5434808684154, 1040.5369610523396, 1134.6142311613926, 18083.0, 19131.13909874059, 19269.036548172535, 19277.614447710966, 19454.359383970022, 1067.0, 1083.3824719909733, 1083.918706097046, 1101.1466113761899, 1102.7794441111648, 10478.266521343432, 10955.726106847233, 10975.945120274348, 10989.06592939593, 11055.557777688802, 572225.0, 577666.0, 579817.0, 583315.0, 584756.0, 101859.54540007119, 102208.48895755623, 102292.0, 106485.46757266164, 107063.0, 1163.33689796815, 1193.1767080714453, 1209.3348658237935, 1231.1628092896917, 1238.7832129377323, 17115.14424278806, 17561.385351512636, 17690.292388304322, 17800.020998845186, 18077.548061298046, 39515.01212469596, 39543.0, 40247.1950560993, 40673.0, 41137.1772564553, 56401.71799140978, 59025.40974590371, 59108.70445647744, 59450.0, 59590.40409596022, 8960.507172105597, 8998.415103018282, 9048.366614336934, 9156.221721153777, 9208.0, 10103.949480252551, 13451.0, 13698.589042328347, 13887.513937012156, 14046.648833779238, 11309.377984210618, 11380.772384552429, 11560.537578496765, 11943.566771987416, 12039.879601203877, 11392.658220253406, 11659.417029148679, 11732.0, 12205.511779528719, 12587.74824503523, 11761.647150585497, 11876.703082422662, 11948.223365481215, 12128.332941688292, 12283.508659653513, 8889.866652000355, 8940.642374304955, 9061.637534498546, 9065.728028159167, 9118.316126290687, 11278.436078196222, 11830.112741544246, 11857.34784586856, 11874.821877672015, 11936.701582460508], "value": 9472.209112397735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.2280899887069, 1551.7439622462293, 1570.842915708429, 1760.8063113057563, 1872.185599264321, 8180.386471014675, 8298.419110662257, 8307.12775158608, 8319.251267385927, 8330.250277475026, 7973.880391794113, 8115.188481151897, 8161.632726527306, 8185.467944583598, 8189.754307370774, 2116.1323857218545, 2405.6872606561124, 2418.830681852271, 2429.7327293997646, 2491.9377015574664, 2461.704595448549, 2485.2171565956755, 2490.713567939683, 2491.950160996779, 2497.163450244161, 2430.0765709030543, 2448.6449464827588, 2458.766417190364, 2459.3359792855917, 2463.5935070713313, 2097.695834104054, 2349.4713689419914, 2395.377201927494, 2406.6510355998457, 2408.1330720940446, 2309.8960546775265, 2339.7660233976635, 2345.542619189259, 2346.8474549154253, 2368.7039120109985, 8388.83222335556, 8391.790205244857, 8440.57797110142, 8447.070822209553, 8460.238578527962, 5175.482451754832, 5236.581073514109, 5295.7881684732565, 5307.071262529081, 5356.9732151339385, 3484.9303013939834, 3587.2466781975554, 3625.148090198801, 3628.256207477461, 3665.120371110914, 1160.2632328471398, 1177.4760231696898, 1210.2194084815333, 1225.8345123408315, 1267.8605353411117, 12005.279683218947, 12034.51861925522, 12042.337671428068, 12042.578509752117, 12093.45579448927, 4629.675922685447, 4702.318163866289, 4720.881977950578, 4771.665983381199, 4777.617790576745, 10161.898381016243, 10177.949110254402, 10183.388996660224, 10194.43930583825, 10199.643012494527, 4776.5701086902345, 5437.374701909252, 5438.293021907127, 5442.591805614595, 5446.291982042309, 4745.359376484131, 4748.074125545554, 4765.070811191854, 4776.641751868554, 4812.0, 4030.6775457963295, 4049.8987525311513, 4109.321961876317, 4115.053537686349, 4168.687348448879, 1311.6655252910448, 1343.3887581150552, 1358.9388477518535, 1359.0449954086357, 1361.9910631818186, 892.1925657280171, 900.617237673986, 985.531557978621, 1000.8848982366975, 1017.572619499797, 5797.304323481209, 5851.356350801409, 5858.47273745365, 5996.790112346134, 6004.819855404345, 496.95278948499833, 500.5745116650818, 505.71427143663715, 507.8806480477085, 512.8487096306599, 4109.835606575763, 4154.335306351029, 4175.645070169009, 4187.874363769091, 4226.640735537514, 10210.948945255226, 10617.893821061845, 10651.946740266249, 10699.0, 10704.625338113128, 10352.482375881176, 10504.0, 10516.1061309788, 10527.473626318806, 10530.0, 7902.17027212146, 8124.471909325875, 8157.592120394075, 8171.63227654757, 8179.100298967109, 5759.39526349744, 5784.248047753765, 5850.531957443309, 5928.614640048383, 5977.462028417463, 8896.733098007071, 8901.51041692713, 8928.464292142493, 8975.371723979259, 9035.45787252767, 9079.68221112258, 9182.862257066015, 9220.077992200726, 9230.400023998687, 9234.076592340713, 6788.355106264897, 7269.709211631687, 7302.160251571137, 7419.183889772229, 7440.7023719052795, 7948.443608947549, 7980.521168729895, 8025.9598702006115, 8037.357011438954, 8042.477238979448, 7251.8187045324285, 7384.18773934856, 7411.4070874328845, 7558.697652093854, 7560.281773231534, 7238.0952380952385, 7255.963720181366, 7279.090113735783, 7351.338379545867, 7378.077740282465, 6867.07294515234, 6918.0314755935215, 7001.194862590663, 7034.120734908137, 7045.365917067488, 5029.74851257443, 5229.320188375486, 5261.947380526299, 5323.547498462674, 5354.866128346823, 5069.138246498031, 5230.241614965885, 5240.921386179134, 5247.114087252073, 5352.892942141213], "value": 4530.973480112104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6805287056602, 356.4848793493403, 358.13331737195983, 358.4157822748919, 361.65461983805466, 6320.873582528347, 6328.746850126001, 6338.271098823637, 6338.587991780531, 6355.618662880231, 6242.7190776415055, 6247.593906396081, 6258.499320054396, 6268.561200715941, 6272.68636568172, 4577.977110114453, 4660.927986563092, 4730.574248317651, 4815.638827087965, 4820.87947801306, 4764.2615394613895, 4801.831935882245, 4812.157872372339, 4813.302071199674, 4815.5906747926465, 4584.472785629662, 4766.0, 4775.044991001796, 4789.688670236424, 4790.712557246577, 4628.583427491509, 4711.999999999983, 4728.810847566093, 4738.170820106502, 4771.475137734847, 4187.078842654611, 4221.092465119983, 4224.8732538023605, 4238.978805105955, 4239.215745087169, 6014.188084608566, 6023.126646636213, 6031.24609423822, 6035.396460353973, 6043.758249670008, 5573.164025396223, 5575.247341608912, 5590.972045139789, 5600.4959553640365, 5602.831915042555, 6435.581687190364, 6609.074729537869, 6615.900761488581, 6621.602703837785, 6628.734850606018, 4684.882877928045, 4694.882627934295, 4698.553637404441, 4703.247480403119, 4706.1999460091865, 6898.1377327834025, 6930.099087118642, 6937.7224911003495, 6939.375456208915, 6943.375096241362, 4794.5924596408995, 4794.640401969867, 4799.136155492045, 4802.207635740064, 4807.471178170398, 4829.1790395632825, 4849.878753031132, 4856.1016212000895, 4857.222844344888, 4867.0, 5554.50009499147, 5561.277033985637, 5568.1091025435735, 5571.804986825523, 5596.3284405871555, 6502.382273683992, 6604.735810567524, 6639.502037347218, 6663.36698013688, 6676.46588272937, 1690.4421540891476, 1705.9744103838452, 1720.7418887167025, 1723.448496481114, 1726.6719323328527, 1077.455884778182, 1138.7836311100864, 1141.1213365708359, 1155.2317708723772, 1166.5683697031982, 6496.935030649727, 6497.837554061186, 6541.803745887631, 6546.639934803537, 6550.312217217123, 6918.792436226921, 6950.270221626757, 6964.477664175207, 6966.3730264276455, 6976.267491913378, 6578.736850525926, 6621.238557565942, 6664.233613134552, 6667.933320666828, 6671.933280667131, 3707.8516859325323, 3732.6267373263, 3744.344739670547, 3746.438034294823, 3763.4354846773203, 7047.083879095685, 7211.206767255598, 7225.1329840419485, 7239.819004524824, 7240.384567311732, 6994.650267486605, 7056.682449289794, 7063.328983746535, 7067.187273463617, 7070.787876363717, 7215.711371545184, 7216.097987751531, 7220.602866842269, 7227.457940654367, 7232.819179520448, 6891.827704307232, 6922.757703480354, 6933.2026816916705, 6938.722451102101, 6941.826454338682, 6593.406593406617, 6851.2121106071445, 6860.211075726355, 6861.073755043005, 6865.862682746218, 7188.317109874553, 7192.136943566806, 7214.89177662346, 7215.386692131227, 7230.42156627458, 4800.591949684176, 4847.975760121177, 4851.29656199842, 4852.053849499313, 4856.028794241237, 6799.388055075067, 6799.762008329685, 6804.285550017375, 6821.693023813841, 6826.317368263134, 6551.967240163769, 6690.665466726547, 6736.360045795642, 6758.648270345852, 6776.220734615582, 6683.4319082876555, 6705.228898676714, 6706.061151438705, 6719.092922455406, 6722.596644201363, 6590.868182636416, 6603.570767900071, 6612.4710023198995, 6621.1392518972225, 6627.4698024158915, 6745.797626071226, 6768.0, 6768.018637297466, 6787.830304242433, 6788.762393316408, 6449.3873082057125, 6555.475561954937, 6588.0, 6601.702923368556, 6624.171978502687], "value": 5059.525509543618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.7771940435784, 851.5188918261182, 868.8870446841905, 905.492923962581, 914.6524320758119, 14790.334434950426, 14956.850431495695, 14959.0, 14992.0, 15005.174715390649, 12243.938780306109, 13990.300484975762, 14037.0, 14054.508092216774, 14061.71876562468, 901.6799036342103, 924.6116631014957, 925.3245131054334, 925.453982150531, 926.8841394825647, 912.8813254276968, 917.4999625204247, 920.986185207219, 921.0605182713628, 921.2445794448555, 786.881967704846, 960.1790469148882, 961.2070042215165, 962.2782912815388, 962.7785609309863, 938.2353381993687, 965.4593427680521, 966.1690945786618, 966.8211380894522, 967.2310513142033, 704.0952376196562, 704.7427688893517, 706.1138271469324, 707.3916431868589, 708.1785129250045, 14417.85582144186, 14497.275136243146, 14514.274286285749, 14526.418943242257, 14527.78208326876, 13921.930390348085, 14153.363098660586, 14383.424663013468, 14983.625409364744, 14991.250437478082, 11017.177265794016, 11136.665900023012, 11345.319280843094, 11352.82970755431, 11458.713532161762, 3798.2213646202463, 3815.4467602197524, 3831.8467261309793, 3832.7891965941863, 3923.372260438316, 53929.46070539323, 54358.0, 54474.18288725672, 55481.72259138679, 56481.71759141219, 11274.436278186058, 11305.26515776472, 11420.086393088533, 11531.192816502764, 11565.190436669352, 18405.079746012914, 18459.538511537317, 18461.1692473839, 18476.168572414274, 18564.628707425774, 8464.365172612079, 8701.129887011375, 8890.73327800167, 9024.458532488072, 9054.049324820931, 5089.236614507853, 5103.209002604603, 5128.615353848476, 5161.690298582097, 5205.687658740488, 3473.583170019563, 3540.8760693376125, 3543.1496440854007, 3545.804980726033, 3552.2185119273718, 581.9679917604487, 598.437468779346, 601.2994860986988, 601.6420229963165, 607.1014897950969, 626.5864529410567, 759.6467642546243, 805.90732065812, 806.4072906413782, 816.8121332093651, 9537.952310238405, 9830.557624906896, 9977.551010204557, 10053.59785608582, 10077.143442807297, 727.7525641281884, 762.4053238473999, 780.9101953275446, 796.6932730898529, 816.9264766171074, 4131.421600975866, 4196.916061678749, 4212.68404869636, 4228.957710422918, 4250.851220207278, 64483.0, 66147.33852661411, 66863.66568167225, 66919.33080669228, 67012.66493667598, 51199.23201151986, 52018.21972670413, 52058.0, 55854.72072639692, 56782.0, 52570.73714631479, 52626.47373526292, 53119.73440132775, 53791.0, 54130.18804717853, 10038.49807509607, 10358.378497290187, 10384.688459346231, 10452.111570516592, 10462.424566648908, 39305.82082537528, 39398.212035759694, 39807.601923980386, 40317.992050198976, 41224.175516490104, 50814.74592627161, 51488.22767658413, 52037.21944170916, 53047.46952530425, 53594.0, 11921.582744603897, 11991.479243039523, 12790.424430900446, 13019.549246669158, 13097.0, 13998.0, 14256.209603526082, 14299.785503217252, 14568.708625827636, 15064.096154230781, 9621.374610650286, 12040.518379264731, 12229.205101668364, 13593.796093058414, 13822.30888455553, 13060.477580897037, 13102.606921792361, 13253.204807711569, 13453.865461345262, 13837.169769813843, 12846.807297890726, 13271.535496257971, 13347.66630834237, 13435.0, 13557.034230036392, 10625.628103016357, 10714.571417143226, 10791.082757965662, 10800.0, 11064.778704425706, 11455.942720286344, 11519.963203311741, 11804.70488237801, 11929.224600400947, 12027.518899243933], "value": 7119.628351530801, "unit": "score"}], "name": "dromaeo_css", "value": 7496.343671419574, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 110.0, 112.0, 112.0, 111.0, 104.0, 110.0, 109.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 163.0, 176.0, 130.0, 161.0, 160.0, 129.0, 182.0, 128.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 161.0, 161.0, 163.0, 163.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 178.0, 78.0, 78.0, 76.0, 75.0, 169.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 93.0, 93.0, 92.0, 147.0, 93.0, 92.0, 154.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 59.0, 56.0, 58.0, 78.0, 55.0, 54.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 58.0, 58.0, 57.0, 58.0, 59.0, 57.0, 59.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 71.0, 73.0, 81.0, 73.0, 75.0, 74.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 112.0, 111.0, 110.0, 111.0, 112.0, 114.0, 162.0, 130.0], "value": 119.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 157.0, 160.0, 158.0, 161.0, 159.0, 162.0, 156.0, 161.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 68.0, 64.0, 65.0, 64.0, 68.0, 65.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1524.1999999999998, "alertThreshold": 2.0}]} 22:16:17 INFO - Return code: 0 22:16:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:17 ERROR - # TBPL SUCCESS # 22:16:17 INFO - Running post-action listener: _resource_record_post_action 22:16:17 INFO - Running post-run listener: _resource_record_post_run 22:16:18 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 501022720; Read time: 0; Write time: 487904 22:16:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248741888; Read time: 0; Write time: 312988 22:16:19 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 252186624; Read time: 0; Write time: 174896 22:16:19 INFO - Running post-run listener: _upload_blobber_files 22:16:19 INFO - Blob upload gear active. 22:16:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:19 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 22:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:16:19 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:20 INFO - (blobuploader) - INFO - Done attempting. 22:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:21 INFO - (blobuploader) - INFO - Done attempting. 22:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:21 INFO - Return code: 0 22:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed990e89a54dd75084febaffcf3908263c65f4832e1ec9959fe3ef25c668f1687901ef1ff50546daee7198fb99dd2ecbe691c5d663dd8834953f2886ac1803e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a667a6e8efb94c553b7a8eea4921a6305b692fca356b9a1b4d5822a1ef5937c24f00ebcb04df736f578bad60ae7fc9ddb0ce9136fdab1f34dbe1985d944741c"} 22:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:21 INFO - Contents: 22:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed990e89a54dd75084febaffcf3908263c65f4832e1ec9959fe3ef25c668f1687901ef1ff50546daee7198fb99dd2ecbe691c5d663dd8834953f2886ac1803e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a667a6e8efb94c553b7a8eea4921a6305b692fca356b9a1b4d5822a1ef5937c24f00ebcb04df736f578bad60ae7fc9ddb0ce9136fdab1f34dbe1985d944741c"} 22:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:21 INFO - Copying logs to upload dir... 22:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.868808 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-22 22:16:18.692395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 22:16:18.695825) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 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-Aurora/sha512/6ed990e89a54dd75084febaffcf3908263c65f4832e1ec9959fe3ef25c668f1687901ef1ff50546daee7198fb99dd2ecbe691c5d663dd8834953f2886ac1803e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a667a6e8efb94c553b7a8eea4921a6305b692fca356b9a1b4d5822a1ef5937c24f00ebcb04df736f578bad60ae7fc9ddb0ce9136fdab1f34dbe1985d944741c"} build_url:https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/fOGnC-nPSk227Ths8t8ZaA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed990e89a54dd75084febaffcf3908263c65f4832e1ec9959fe3ef25c668f1687901ef1ff50546daee7198fb99dd2ecbe691c5d663dd8834953f2886ac1803e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a667a6e8efb94c553b7a8eea4921a6305b692fca356b9a1b4d5822a1ef5937c24f00ebcb04df736f578bad60ae7fc9ddb0ce9136fdab1f34dbe1985d944741c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 22:16:18.721139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 22:16:18.721483) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463974567.916341-30556281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 22:16:18.806220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 22:16:18.806546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 22:16:18.806822) ========= ========= Total master_lag: 0.18 =========