builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1464196314.76 results: success (0) buildid: 20160525073114 builduid: a937a0487ae347e38285e1bd487108af revision: f887875e60c8738740089de8e85d6b68475de96e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.757373) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.757847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.758122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.769748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.770024) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 10:11:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-25 10:11:55 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.870422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.870884) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016656 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:54.921930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:11:54.922321) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f887875e60c8738740089de8e85d6b68475de96e --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 f887875e60c8738740089de8e85d6b68475de96e --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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 10:11:55,205 truncating revision to first 12 chars 2016-05-25 10:11:55,205 Setting DEBUG logging. 2016-05-25 10:11:55,205 attempt 1/10 2016-05-25 10:11:55,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f887875e60c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 10:11:55,782 unpacking tar archive at: mozilla-aurora-f887875e60c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.102745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:11:56.040044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:56.040393) ========= script_repo_revision: f887875e60c8738740089de8e85d6b68475de96e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:56.040824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:56.041092) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:11:56.053167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-25 10:11:56.053565) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:56 INFO - MultiFileLogger online at 20160525 10:11:56 in /builds/slave/test 10:11:56 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 10:11:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:56 INFO - {'append_to_log': False, 10:11:56 INFO - 'base_work_dir': '/builds/slave/test', 10:11:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:11:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:56 INFO - 'branch': 'Mozilla-Aurora', 10:11:56 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:56 INFO - 'config_files': ('talos/linux_config.py',), 10:11:56 INFO - 'default_actions': ('clobber', 10:11:56 INFO - 'read-buildbot-config', 10:11:56 INFO - 'download-and-extract', 10:11:56 INFO - 'populate-webroot', 10:11:56 INFO - 'create-virtualenv', 10:11:56 INFO - 'install', 10:11:56 INFO - 'run-tests'), 10:11:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:56 INFO - 'download_minidump_stackwalk': True, 10:11:56 INFO - 'download_symbols': 'ondemand', 10:11:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:56 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:56 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:56 INFO - 'installer_path': 'installer.exe', 10:11:56 INFO - 'log_level': 'info', 10:11:56 INFO - 'log_name': 'talos', 10:11:56 INFO - 'log_to_console': True, 10:11:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:56 INFO - 'opt_config_files': (), 10:11:56 INFO - 'pip_index': False, 10:11:56 INFO - 'sps_profile': False, 10:11:56 INFO - 'sps_profile_interval': 0, 10:11:56 INFO - 'suite': 'dromaeojs', 10:11:56 INFO - 'system_bits': '32', 10:11:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:56 INFO - 'title': 'talos-linux64-ix-033', 10:11:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:56 INFO - 'use_talos_json': True, 10:11:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:56 INFO - 'work_dir': 'build'} 10:11:56 INFO - ##### 10:11:56 INFO - ##### Running clobber step. 10:11:56 INFO - ##### 10:11:56 INFO - Running pre-action listener: _resource_record_pre_action 10:11:56 INFO - Running main action method: clobber 10:11:56 INFO - rmtree: /builds/slave/test/build 10:11:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:56 INFO - Running post-action listener: _resource_record_post_action 10:11:56 INFO - ##### 10:11:56 INFO - ##### Running read-buildbot-config step. 10:11:56 INFO - ##### 10:11:56 INFO - Running pre-action listener: _resource_record_pre_action 10:11:56 INFO - Running main action method: read_buildbot_config 10:11:56 INFO - Using buildbot properties: 10:11:56 INFO - { 10:11:56 INFO - "project": "", 10:11:56 INFO - "product": "firefox", 10:11:56 INFO - "script_repo_revision": "production", 10:11:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:11:56 INFO - "repository": "", 10:11:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:11:56 INFO - "buildid": "20160525073114", 10:11:56 INFO - "pgo_build": "True", 10:11:56 INFO - "basedir": "/builds/slave/test", 10:11:56 INFO - "buildnumber": 344, 10:11:56 INFO - "slavename": "talos-linux64-ix-033", 10:11:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:11:56 INFO - "platform": "ubuntu64_hw", 10:11:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:11:56 INFO - "branch": "mozilla-aurora", 10:11:56 INFO - "repo_path": "releases/mozilla-aurora", 10:11:56 INFO - "revision": "f887875e60c8738740089de8e85d6b68475de96e", 10:11:56 INFO - "stage_platform": "linux64-pgo", 10:11:56 INFO - "builduid": "a937a0487ae347e38285e1bd487108af", 10:11:56 INFO - "slavebuilddir": "test" 10:11:56 INFO - } 10:11:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:11:56 INFO - Running post-action listener: _resource_record_post_action 10:11:56 INFO - ##### 10:11:56 INFO - ##### Running download-and-extract step. 10:11:56 INFO - ##### 10:11:56 INFO - Running pre-action listener: _resource_record_pre_action 10:11:56 INFO - Running main action method: download_and_extract 10:11:56 INFO - mkdir: /builds/slave/test/build/tests 10:11:56 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')]} 10:11:56 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:11:57 INFO - Downloaded 1361 bytes. 10:11:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:57 INFO - Using the following test package requirements: 10:11:57 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:57 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:57 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:11:57 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'jsshell-linux-x86_64.zip'], 10:11:57 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:57 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:57 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:11:57 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:11:57 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:57 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:57 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:57 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:02 INFO - Downloaded 24134626 bytes. 10:12:02 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'] 10:12:02 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 10:12:03 INFO - Return code: 0 10:12:03 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 10:12: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')]} 10:12:03 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:06 INFO - Downloaded 24134626 bytes. 10:12:06 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'] 10:12:06 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 10:12:08 INFO - Return code: 0 10:12: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')]} 10:12:08 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:09 INFO - Downloaded 10840145 bytes. 10:12:09 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'] 10:12:09 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 10:12:09 INFO - Return code: 0 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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 10:12:11 INFO - Downloaded 62746659 bytes. 10:12:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:12:11 INFO - mkdir: /builds/slave/test/properties 10:12:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:11 INFO - Contents: 10:12:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:12:11 INFO - Running post-action listener: _resource_record_post_action 10:12:11 INFO - Running post-action listener: set_extra_try_arguments 10:12:11 INFO - ##### 10:12:11 INFO - ##### Running populate-webroot step. 10:12:11 INFO - ##### 10:12:11 INFO - Running pre-action listener: _resource_record_pre_action 10:12:11 INFO - Running main action method: populate_webroot 10:12:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:11 INFO - '--tppagecycles', 10:12:11 INFO - '7'], 10:12:11 INFO - 'tests': ['tsvgm']}}, 10:12:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['damp', 'tps']}, 10:12:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'tests': ['damp', 'tps']}, 10:12:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['dromaeo_dom']}, 10:12:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['a11yr', 10:12:11 INFO - 'ts_paint', 10:12:11 INFO - 'tpaint', 10:12:11 INFO - 'sessionrestore', 10:12:11 INFO - 'sessionrestore_no_auto_restore', 10:12:11 INFO - 'tabpaint']}, 10:12:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['tsvgx', 10:12:11 INFO - 'tsvgr_opacity', 10:12:11 INFO - 'tart', 10:12:11 INFO - 'tscrollx', 10:12:11 INFO - 'cart']}, 10:12:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:11 INFO - 'tsvgr_opacity', 10:12:11 INFO - 'tart', 10:12:11 INFO - 'tscrollx', 10:12:11 INFO - 'cart']}, 10:12:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'talos_options': ['--disable-e10s'], 10:12:11 INFO - 'tests': ['tp5o']}, 10:12:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'tests': ['tp5o']}, 10:12:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'talos_options': ['--disable-e10s', 10:12:11 INFO - '--xperf_path', 10:12:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:11 INFO - 'tests': ['tp5n']}, 10:12:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:11 INFO - 'talos_options': ['--xperf_path', 10:12:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:11 INFO - 'tests': ['tp5n']}}, 10:12:11 INFO - 'talos.zip': {'path': '', 10:12:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:11 INFO - Running post-action listener: _resource_record_post_action 10:12:11 INFO - ##### 10:12:11 INFO - ##### Running create-virtualenv step. 10:12:11 INFO - ##### 10:12:11 INFO - Running pre-action listener: _resource_record_pre_action 10:12:11 INFO - Running main action method: create_virtualenv 10:12:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:11 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 10:12:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:12 INFO - Using real prefix '/usr' 10:12:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:14 INFO - Installing pip.................done. 10:12:14 INFO - Return code: 0 10:12:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:14 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')]} 10:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 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')]} 10:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:14 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 10:12:14 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 10:12:14 INFO - Using env: {'DISPLAY': ':0', 10:12:14 INFO - 'HOME': '/home/cltbld', 10:12:14 INFO - 'LANG': 'en_US.UTF-8', 10:12:14 INFO - 'LANGUAGE': 'en_US:en', 10:12:14 INFO - 'LOGNAME': 'cltbld', 10:12:14 INFO - 'MAIL': '/var/mail/cltbld', 10:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:14 INFO - 'MOZ_NO_REMOTE': '1', 10:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:14 INFO - 'NO_EM_RESTART': '1', 10:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:14 INFO - 'PWD': '/builds/slave/test', 10:12:14 INFO - 'SHELL': '/bin/bash', 10:12:14 INFO - 'SHLVL': '1', 10:12:14 INFO - 'TERM': 'linux', 10:12:14 INFO - 'TMOUT': '86400', 10:12:14 INFO - 'USER': 'cltbld', 10:12:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:14 INFO - '_': '/tools/buildbot/bin/python'} 10:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:14 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 10:12:14 INFO - Cleaning up... 10:12:14 INFO - Return code: 0 10:12:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:14 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')]} 10:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 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')]} 10:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:14 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 10:12:14 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 10:12:14 INFO - Using env: {'DISPLAY': ':0', 10:12:14 INFO - 'HOME': '/home/cltbld', 10:12:14 INFO - 'LANG': 'en_US.UTF-8', 10:12:14 INFO - 'LANGUAGE': 'en_US:en', 10:12:14 INFO - 'LOGNAME': 'cltbld', 10:12:14 INFO - 'MAIL': '/var/mail/cltbld', 10:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:14 INFO - 'MOZ_NO_REMOTE': '1', 10:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:14 INFO - 'NO_EM_RESTART': '1', 10:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:14 INFO - 'PWD': '/builds/slave/test', 10:12:14 INFO - 'SHELL': '/bin/bash', 10:12:14 INFO - 'SHLVL': '1', 10:12:14 INFO - 'TERM': 'linux', 10:12:14 INFO - 'TMOUT': '86400', 10:12:14 INFO - 'USER': 'cltbld', 10:12:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:14 INFO - '_': '/tools/buildbot/bin/python'} 10:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:14 INFO - Downloading/unpacking psutil>=0.7.1 10:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:17 INFO - Installing collected packages: psutil 10:12:17 INFO - Running setup.py install for psutil 10:12:17 INFO - building 'psutil._psutil_linux' extension 10:12:17 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 10:12:17 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 10:12:17 INFO - building 'psutil._psutil_posix' extension 10:12:17 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 10:12:17 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 10:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:17 INFO - Successfully installed psutil 10:12:17 INFO - Cleaning up... 10:12:17 INFO - Return code: 0 10:12:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:12:17 INFO - Using env: {'DISPLAY': ':0', 10:12:17 INFO - 'HOME': '/home/cltbld', 10:12:17 INFO - 'LANG': 'en_US.UTF-8', 10:12:17 INFO - 'LANGUAGE': 'en_US:en', 10:12:17 INFO - 'LOGNAME': 'cltbld', 10:12:17 INFO - 'MAIL': '/var/mail/cltbld', 10:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:17 INFO - 'MOZ_NO_REMOTE': '1', 10:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:17 INFO - 'NO_EM_RESTART': '1', 10:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:17 INFO - 'PWD': '/builds/slave/test', 10:12:17 INFO - 'SHELL': '/bin/bash', 10:12:17 INFO - 'SHLVL': '1', 10:12:17 INFO - 'TERM': 'linux', 10:12:17 INFO - 'TMOUT': '86400', 10:12:17 INFO - 'USER': 'cltbld', 10:12:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:17 INFO - '_': '/tools/buildbot/bin/python'} 10:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:19 INFO - Installing collected packages: mozsystemmonitor 10:12:19 INFO - Running setup.py install for mozsystemmonitor 10:12:19 INFO - Successfully installed mozsystemmonitor 10:12:19 INFO - Cleaning up... 10:12:19 INFO - Return code: 0 10:12:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:19 INFO - Using env: {'DISPLAY': ':0', 10:12:19 INFO - 'HOME': '/home/cltbld', 10:12:19 INFO - 'LANG': 'en_US.UTF-8', 10:12:19 INFO - 'LANGUAGE': 'en_US:en', 10:12:19 INFO - 'LOGNAME': 'cltbld', 10:12:19 INFO - 'MAIL': '/var/mail/cltbld', 10:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:19 INFO - 'MOZ_NO_REMOTE': '1', 10:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:19 INFO - 'NO_EM_RESTART': '1', 10:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:19 INFO - 'PWD': '/builds/slave/test', 10:12:19 INFO - 'SHELL': '/bin/bash', 10:12:19 INFO - 'SHLVL': '1', 10:12:19 INFO - 'TERM': 'linux', 10:12:19 INFO - 'TMOUT': '86400', 10:12:19 INFO - 'USER': 'cltbld', 10:12:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:19 INFO - '_': '/tools/buildbot/bin/python'} 10:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:23 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 10:12:23 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 10:12:23 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 10:12:23 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 10:12:23 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 10:12:23 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 10:12:23 INFO - Downloading docopt-0.6.1.tar.gz 10:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:23 INFO - Running setup.py install for blobuploader 10:12:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:23 INFO - Running setup.py install for requests 10:12:23 INFO - Running setup.py install for docopt 10:12:24 INFO - Successfully installed blobuploader requests docopt 10:12:24 INFO - Cleaning up... 10:12:24 INFO - Return code: 0 10:12:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:24 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:24 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 10:12:24 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 10:12:24 INFO - Using env: {'DISPLAY': ':0', 10:12:24 INFO - 'HOME': '/home/cltbld', 10:12:24 INFO - 'LANG': 'en_US.UTF-8', 10:12:24 INFO - 'LANGUAGE': 'en_US:en', 10:12:24 INFO - 'LOGNAME': 'cltbld', 10:12:24 INFO - 'MAIL': '/var/mail/cltbld', 10:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:24 INFO - 'MOZ_NO_REMOTE': '1', 10:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:24 INFO - 'NO_EM_RESTART': '1', 10:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:24 INFO - 'PWD': '/builds/slave/test', 10:12:24 INFO - 'SHELL': '/bin/bash', 10:12:24 INFO - 'SHLVL': '1', 10:12:24 INFO - 'TERM': 'linux', 10:12:24 INFO - 'TMOUT': '86400', 10:12:24 INFO - 'USER': 'cltbld', 10:12:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:24 INFO - '_': '/tools/buildbot/bin/python'} 10:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:24 INFO - Running setup.py (path:/tmp/pip-hnTjS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:24 INFO - Running setup.py (path:/tmp/pip-iWAFoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:24 INFO - Running setup.py (path:/tmp/pip-0k7J_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:24 INFO - Running setup.py (path:/tmp/pip-Sc5djJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:24 INFO - Running setup.py (path:/tmp/pip-JVp8yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:24 INFO - Running setup.py (path:/tmp/pip-sdi0nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:24 INFO - Running setup.py (path:/tmp/pip-nhX4HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:24 INFO - Running setup.py (path:/tmp/pip-qrkMFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:24 INFO - Running setup.py (path:/tmp/pip-HwT63o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:24 INFO - Running setup.py (path:/tmp/pip-t_k8bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:24 INFO - Running setup.py (path:/tmp/pip-JF3hAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:25 INFO - Running setup.py (path:/tmp/pip-e11KHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:25 INFO - Running setup.py (path:/tmp/pip-feyYBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:25 INFO - Running setup.py (path:/tmp/pip-breOml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:25 INFO - Running setup.py (path:/tmp/pip-PIxxV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:25 INFO - Running setup.py (path:/tmp/pip-jWHdnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:25 INFO - Running setup.py (path:/tmp/pip-c0Teks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:25 INFO - Running setup.py install for manifestparser 10:12:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:25 INFO - Running setup.py install for mozcrash 10:12:25 INFO - Running setup.py install for mozdebug 10:12:25 INFO - Running setup.py install for mozdevice 10:12:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:25 INFO - Running setup.py install for mozfile 10:12:26 INFO - Running setup.py install for mozhttpd 10:12:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozinfo 10:12:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozInstall 10:12:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozleak 10:12:26 INFO - Running setup.py install for mozlog 10:12:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for moznetwork 10:12:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozprocess 10:12:26 INFO - Running setup.py install for mozprofile 10:12:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozrunner 10:12:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:26 INFO - Running setup.py install for mozscreenshot 10:12:27 INFO - Running setup.py install for moztest 10:12:27 INFO - Running setup.py install for mozversion 10:12:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:27 INFO - Cleaning up... 10:12:27 INFO - Return code: 0 10:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:27 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')]} 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 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')]} 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:27 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 10:12:27 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 10:12:27 INFO - Using env: {'DISPLAY': ':0', 10:12:27 INFO - 'HOME': '/home/cltbld', 10:12:27 INFO - 'LANG': 'en_US.UTF-8', 10:12:27 INFO - 'LANGUAGE': 'en_US:en', 10:12:27 INFO - 'LOGNAME': 'cltbld', 10:12:27 INFO - 'MAIL': '/var/mail/cltbld', 10:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:27 INFO - 'MOZ_NO_REMOTE': '1', 10:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:27 INFO - 'NO_EM_RESTART': '1', 10:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:27 INFO - 'PWD': '/builds/slave/test', 10:12:27 INFO - 'SHELL': '/bin/bash', 10:12:27 INFO - 'SHLVL': '1', 10:12:27 INFO - 'TERM': 'linux', 10:12:27 INFO - 'TMOUT': '86400', 10:12:27 INFO - 'USER': 'cltbld', 10:12:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:27 INFO - '_': '/tools/buildbot/bin/python'} 10:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:27 INFO - Running setup.py (path:/tmp/pip-PLkYEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:27 INFO - Running setup.py (path:/tmp/pip-Ymkn8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:27 INFO - Running setup.py (path:/tmp/pip-H4h7wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:27 INFO - Running setup.py (path:/tmp/pip-b6x2HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:27 INFO - Running setup.py (path:/tmp/pip-C5WXzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:27 INFO - Running setup.py (path:/tmp/pip-dob1qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:27 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)) 10:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:27 INFO - Running setup.py (path:/tmp/pip-_ddekR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:28 INFO - Running setup.py (path:/tmp/pip-zKuE6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:28 INFO - Running setup.py (path:/tmp/pip-xoQ_dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:28 INFO - Running setup.py (path:/tmp/pip-K7Go0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:28 INFO - Running setup.py (path:/tmp/pip-_rDdwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:28 INFO - Running setup.py (path:/tmp/pip-QdRBPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:28 INFO - Running setup.py (path:/tmp/pip-cYGaH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:28 INFO - Running setup.py (path:/tmp/pip-BEdipc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:28 INFO - Running setup.py (path:/tmp/pip-vNytCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:28 INFO - Running setup.py (path:/tmp/pip-_hoWRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:28 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)) 10:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:28 INFO - Running setup.py (path:/tmp/pip-bUYhwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:28 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)) 10:12:28 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)) 10:12:28 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)) 10:12:28 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)) 10:12:28 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)) 10:12:28 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)) 10:12:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:30 INFO - Downloading blessings-1.6.tar.gz 10:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:30 INFO - Installing collected packages: blessings 10:12:30 INFO - Running setup.py install for blessings 10:12:30 INFO - Successfully installed blessings 10:12:30 INFO - Cleaning up... 10:12:30 INFO - Return code: 0 10:12:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:31 INFO - Reading from file tmpfile_stdout 10:12:31 INFO - Current package versions: 10:12:31 INFO - argparse == 1.2.1 10:12:31 INFO - blessings == 1.6 10:12:31 INFO - blobuploader == 1.2.4 10:12:31 INFO - docopt == 0.6.1 10:12:31 INFO - manifestparser == 1.1 10:12:31 INFO - mozInstall == 1.12 10:12:31 INFO - mozcrash == 0.17 10:12:31 INFO - mozdebug == 0.1 10:12:31 INFO - mozdevice == 0.48 10:12:31 INFO - mozfile == 1.2 10:12:31 INFO - mozhttpd == 0.7 10:12:31 INFO - mozinfo == 0.9 10:12:31 INFO - mozleak == 0.1 10:12:31 INFO - mozlog == 3.1 10:12:31 INFO - moznetwork == 0.27 10:12:31 INFO - mozprocess == 0.22 10:12:31 INFO - mozprofile == 0.28 10:12:31 INFO - mozrunner == 6.11 10:12:31 INFO - mozscreenshot == 0.1 10:12:31 INFO - mozsystemmonitor == 0.0 10:12:31 INFO - moztest == 0.7 10:12:31 INFO - mozversion == 1.4 10:12:31 INFO - psutil == 3.1.1 10:12:31 INFO - requests == 1.2.3 10:12:31 INFO - wsgiref == 0.1.2 10:12:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:31 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 10:12:31 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 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 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)) 10:12:31 INFO - Cleaning up... 10:12:31 INFO - Return code: 0 10:12:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:31 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 10:12:31 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 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:31 INFO - Downloading/unpacking jsonschema 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:31 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 10:12:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:33 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:33 INFO - warning: no files found matching '*.txt' 10:12:33 INFO - no previously-included directories found matching 'build' 10:12:33 INFO - no previously-included directories found matching 'dist' 10:12:33 INFO - no previously-included directories found matching '.git*' 10:12:33 INFO - Installing collected packages: jsonschema, functools32 10:12:33 INFO - Running setup.py install for functools32 10:12:33 INFO - warning: no files found matching '*.txt' 10:12:33 INFO - no previously-included directories found matching 'build' 10:12:33 INFO - no previously-included directories found matching 'dist' 10:12:33 INFO - no previously-included directories found matching '.git*' 10:12:33 INFO - Successfully installed jsonschema functools32 10:12:33 INFO - Cleaning up... 10:12:33 INFO - Return code: 0 10:12:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 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 0x7fe4cc755f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', '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 10:12:33 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 10:12:33 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 10:12:33 INFO - Using env: {'DISPLAY': ':0', 10:12:33 INFO - 'HOME': '/home/cltbld', 10:12:33 INFO - 'LANG': 'en_US.UTF-8', 10:12:33 INFO - 'LANGUAGE': 'en_US:en', 10:12:33 INFO - 'LOGNAME': 'cltbld', 10:12:33 INFO - 'MAIL': '/var/mail/cltbld', 10:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:33 INFO - 'MOZ_NO_REMOTE': '1', 10:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:33 INFO - 'NO_EM_RESTART': '1', 10:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:33 INFO - 'PWD': '/builds/slave/test', 10:12:33 INFO - 'SHELL': '/bin/bash', 10:12:33 INFO - 'SHLVL': '1', 10:12:33 INFO - 'TERM': 'linux', 10:12:33 INFO - 'TMOUT': '86400', 10:12:33 INFO - 'USER': 'cltbld', 10:12:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:33 INFO - '_': '/tools/buildbot/bin/python'} 10:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:34 INFO - Downloading/unpacking flake8 10:12:34 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 10:12:34 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 10:12:34 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 10:12:34 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 10:12:34 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 10:12:34 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 10:12:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:36 INFO - no previously-included directories found matching 'docs/_build' 10:12:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:36 INFO - Running setup.py install for pep8 10:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:36 INFO - no previously-included directories found matching 'docs/_build' 10:12:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Running post-action listener: _resource_record_post_action 10:12:36 INFO - Running post-action listener: _start_resource_monitoring 10:12:37 INFO - Starting resource monitoring. 10:12:37 INFO - ##### 10:12:37 INFO - ##### Running install step. 10:12:37 INFO - ##### 10:12:37 INFO - Running pre-action listener: _resource_record_pre_action 10:12:37 INFO - Running main action method: install 10:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:37 INFO - Reading from file tmpfile_stdout 10:12:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:37 INFO - Reading from file tmpfile_stdout 10:12:37 INFO - Output received: 10:12:37 INFO - Usage: mozinstall [options] installer 10:12:37 INFO - Options: 10:12:37 INFO - -h, --help show this help message and exit 10:12:37 INFO - -d DEST, --destination=DEST 10:12:37 INFO - Directory to install application into. [default: 10:12:37 INFO - "/builds/slave/test"] 10:12:37 INFO - --app=APP Application being installed. [default: firefox] 10:12:37 INFO - mkdir: /builds/slave/test/build/application 10:12:37 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'] 10:12:37 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 10:12:52 INFO - Reading from file tmpfile_stdout 10:12:52 INFO - Output received: 10:12:52 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:52 INFO - Running post-action listener: _resource_record_post_action 10:12:52 INFO - ##### 10:12:52 INFO - ##### Running run-tests step. 10:12:52 INFO - ##### 10:12:52 INFO - Running pre-action listener: _resource_record_pre_action 10:12:52 INFO - Running main action method: run_tests 10:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:52 INFO - Python 2.7.3 10:12:52 INFO - Return code: 0 10:12:52 INFO - grabbing minidump binary from tooltool 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:52 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 0x1fec410>, '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 0x1fed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:52 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 10:12:52 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 10:12:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:52 INFO - Return code: 0 10:12:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:53 INFO - Return code: 0 10:12:53 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/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:12:53 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/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 10:12:53 INFO - Using env: {'DISPLAY': ':0', 10:12:53 INFO - 'HOME': '/home/cltbld', 10:12:53 INFO - 'LANG': 'en_US.UTF-8', 10:12:53 INFO - 'LANGUAGE': 'en_US:en', 10:12:53 INFO - 'LOGNAME': 'cltbld', 10:12:53 INFO - 'MAIL': '/var/mail/cltbld', 10:12:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:53 INFO - 'MOZ_NO_REMOTE': '1', 10:12:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:53 INFO - 'NO_EM_RESTART': '1', 10:12:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:53 INFO - 'PWD': '/builds/slave/test', 10:12:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:53 INFO - 'SHELL': '/bin/bash', 10:12:53 INFO - 'SHLVL': '1', 10:12:53 INFO - 'TERM': 'linux', 10:12:53 INFO - 'TMOUT': '86400', 10:12:53 INFO - 'USER': 'cltbld', 10:12:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135', 10:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:53 INFO - '_': '/tools/buildbot/bin/python'} 10:12:53 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/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:12:54 INFO - mozversion application_buildid: 20160525073114 10:12:54 INFO - mozversion application_changeset: f887875e60c8738740089de8e85d6b68475de96e 10:12:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:12:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:54 INFO - mozversion application_name: Firefox 10:12:54 INFO - mozversion application_remotingname: firefox-dev 10:12:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:54 INFO - mozversion application_vendor: Mozilla 10:12:54 INFO - mozversion application_version: 48.0a2 10:12:54 INFO - mozversion platform_buildid: 20160525073114 10:12:54 INFO - mozversion platform_changeset: f887875e60c8738740089de8e85d6b68475de96e 10:12:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:54 INFO - mozversion platform_version: 48.0a2 10:12:54 INFO - using testdate: 1464196374 10:12:54 INFO - actual date: 1464196374 10:12:54 INFO - starting webserver on 'localhost:37855' 10:12:54 INFO - SUITE-START | Running 2 tests 10:12:54 INFO - TEST-START | dromaeo_css 10:12:54 INFO - operating with platform_type : linux_ 10:12:54 INFO - Initialising browser for dromaeo_css test... 10:12:54 INFO - TEST-INFO | started process 31674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkszmc7/profile http://localhost:37855/getInfo.html) 10:12:58 INFO - PROCESS | 31674 | __metrics Screen width/height:1600/1200 10:12:58 INFO - PROCESS | 31674 | colorDepth:24 10:12:58 INFO - PROCESS | 31674 | Browser inner width/height: 1024/697 10:12:58 INFO - PROCESS | 31674 | __metrics 10:13:00 ERROR - PROCESS | 31674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:00 INFO - PROCESS | 31674 | console.error: PushService: 10:13:00 INFO - PROCESS | 31674 | stateChangeProcessEnqueue: Error transitioning state 10:13:00 INFO - PROCESS | 31674 | UnknownError 10:13:01 INFO - TEST-INFO | 31674: exit 0 10:13:01 INFO - Browser initialized. 10:13:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:01 INFO - TEST-INFO | started process 31767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkszmc7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:13 INFO - PROCESS | 31767 | RSS: Main: 141766656 10:13:13 INFO - PROCESS | 31767 | 10:14:04 INFO - PROCESS | 31767 | 1464196444086 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] 10:16:11 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37855/tests/dromaeo/cssquery-ext.html) 10:16:12 INFO - PROCESS | 31767 | RSS: Main: 248893440 10:16:12 INFO - PROCESS | 31767 | 10:19:14 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-ext.html (next: http://localhost:37855/tests/dromaeo/cssquery-jquery.html) 10:19:15 INFO - PROCESS | 31767 | RSS: Main: 224464896 10:19:15 INFO - PROCESS | 31767 | 10:22:17 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37855/tests/dromaeo/cssquery-mootools.html) 10:22:17 INFO - PROCESS | 31767 | RSS: Main: 222990336 10:22:17 INFO - PROCESS | 31767 | 10:25:19 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37855/tests/dromaeo/cssquery-prototype.html) 10:25:20 INFO - PROCESS | 31767 | RSS: Main: 219906048 10:25:20 INFO - PROCESS | 31767 | 10:28:22 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37855/tests/dromaeo/cssquery-yui.html) 10:28:23 INFO - PROCESS | 31767 | RSS: Main: 210284544 10:28:23 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-yui.html (next: http://localhost:37855/tests/dromaeo/cssquery-dojo.html) 10:31:25 INFO - PROCESS | 31767 | RSS: Main: 250429440 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | __start_tp_report 10:31:25 INFO - PROCESS | 31767 | _x_x_mozilla_page_load 10:31:25 INFO - PROCESS | 31767 | _x_x_mozilla_page_load_details 10:31:25 INFO - PROCESS | 31767 | |i|pagename|runs| 10:31:25 INFO - PROCESS | 31767 | |0;dojo.html;3213.9196520086994;3262.641109477957;3305.8181800001007;3309.172706823294;3326.168457885529;5431.809886653968;5447.237386765856;5457;5475.917861232085;5501.1748237764305;5441.319835020622;5472.1244600863865;5483.040467918118;5484.972575137119;5532.3637781655125;4860.562549370556;4955.430125535565;4986.177280748672;5045.697258164503;5101.336826212587;4967.875803104916;5036.068327359432;5036.445990940993;5039.647224694273;5042.495750424947;4959.851204463872;4996.650234483587;5036;5055.191169412895;5075.0357432087785;4997.100521906055;4999.625028122905;5004.499550045003;5029.1450453423;5044.949550504484;4840.927386089212;4848.806047758086;4919.3358896549225;4939.950600493985;4942.802287908479;5337.919931201035;5377.032134215879;5387.649802762808;5395.865103372408;5403.189521571757;5820.097884827858;5868.589198756089;5869.2369991901205;5877.882442351171;5880.147378630118;5861.970690146564;5888;5898.852528686774;5949.286085669704;5952.970235148797;5459.3994660587305;5476.2333273341765;5506.366767821712;5508.256385388001;5512.090505066619;5890.322612899486;5969.671668058211;5982.73077711504;5990.940090599125;5994.910076348859;5701.857453563611;5730.283714535683;5748.798792042258;5778.508826749689;5784.595078344475;5774.509166720792;5797.913031304533;5798.362180160179;5798.391168927202;5799.217105690762;5709.086546152679;5773.480386765212;5775.018246898037;5781.508571771446;5796.971015144982;5847.649141051551;5857.970710146507;5859.2382990211;5861.17943487912;5902.970485147633;4468.955310446919;4471.35165401015;4472.552744725566;4480.775961201927;4498.775061246924;3963.8612648557164;3984.2230765000545;4010.959890401117;4039.3537034074993;4079.1229885574744;5507.5593952483705;5525.723713814293;5530.668159910338;5534.501894829485;5558.722063896789;5888.941110588925;5916.112583112482;5918.141869428909;5919;5922.170896074553;5489.094299440628;5550.111982082847;5604.747786349542;5634.577406694514;5636;5036.823711170092;5071.670341427795;5075.365579302587;5076.060928728123;5077.898442031139;6045.909311360333;6088.330283668793;6102.870122236762;6107.4197951194565;6115.84710382244;5831.766729330864;5896.616719913192;5916.645001299936;5950.6132101415005;5994.550408719277;6084.513238940785;6100.328963813889;6100.420460056288;6104.11490333908;6117.663528505975;5794.884102318014;5795;5798.1302804579655;5800.883982320245;5804.100364443518;5795.7391917362975;5885.882282354414;5936.614120082181;5945.970270148621;5967.850803729942;5737.942620573908;5773.16289138081;5773.24947756789;5784.161296611884;5805.564582656233;5603.663780173202;5738.971305143447;5749.338826034892;5763.884722305446;5764.654120752768;5621.044422448275;5662.518685911744;5663.377028526941;5669.773209071756;5686.09022556389;5747.109198074305;5748.856278593069;5759.625624334405;5772.249607550992;5774.076147816497;5532.695701736443;5599.636023658449;5639.238702775073;5655.1517272409465;5685.346185188756 10:31:25 INFO - PROCESS | 31767 | |1;ext.html;660.9272979972205;664.8437617159966;673.605940524793;733.4499125655755;734.1483878700707;34163;34793.65206347939;41970.58029419709;42627.57372426275;42675.78662106685;47388.526114738845;48188.759056204755;48269;48273.517264827344;48278.758606207004;9143.862842057375;9322.394044387127;9329.860052099224;9352.672656457025;9358.859617105749;9131.178193962542;9263.027382124881;9266.721998340061;9269.582868770887;9272.67545635903;9148.405353651991;9225.630974761036;9226.492542910137;9229.077092290785;9232.67685631003;9245.676401325954;9297.814043719121;9307.72076837696;9314.534273286308;9316.301277404222;9055;9226.123518265755;9231.538423078819;9233.215176709988;9236.953815230881;43105.56894431047;43812.561874381165;43867.341989870176;43929;43956.78021609871;3936.448897154372;4193.6645068394455;4492.348609451611;4513.300438432048;4731.574158325767;33283.167920801934;33901.15247118817;34150.48774268388;35041.64958350409;35529.46705799415;4667.509911459316;4689.577937985564;4718.7168769873915;4741.407324084489;4766.094442055998;234467;234964;235059;235319;235386;39549.209015820095;63281.68359158175;64217.678911605144;64225.99999999907;64250.6787466069;38156.42765358522;38171.23657526834;38213.808930955165;38270.234595307935;38308.8084559581;15798.21008949571;15812.051276923421;15877.20613969297;15974.440894568634;16140.43508477221;13679.179249245077;13790.862091379158;13814.447422103205;13819.723605527834;13833.79249311261;9313.39462934907;9366.95316523413;9458.668946586837;9470.14768670823;9496.335256532115;3563.1270338767167;3576.7675101118343;3582.265635544707;3599.1901822090344;3630.40098383769;1078.6170909327234;1142.400239874056;1153.405995912106;1187.8099504079478;1288.3558220889556;34036.1490962723;34222.315553688786;34585.48121778175;34635.480467793;34809.65190348115;1192.5647138794452;1200.6638141320445;1244.0420875925486;1252.5490823303785;1359.299960520333;17474.65050698979;18119.818801812078;18120.818791812177;18229.7265541017;18254.817451825576;478271;481677;484331;484593;484597;59738.70130649406;61727.38272617306;61804.38195618076;61808;61814.072788908205;1339.3972712279513;1536.569760467071;1548.3110016042979;1617.5147455763224;1638.565780068283;29932.540925338155;33343.66656333405;33560.49659255162;33609.495857562644;34357;50125;50967;51051.744741277544;51081.23378149405;51101.744491277306;304336;310098;310644;310755;659059;32453.51319730159;32722.50916236306;32983.67016329806;33310.333793323516;33342;47961.28058079062;48639;48987.75506122447;49570.25644615261;50076.74961625168;40511.797441012604;40974.385384218665;41072.38391424191;41329.793351033055;42267.7886610565;39747.20505589814;40888;40991.180176396905;41146.38280425736;41785.582144178166;40289.79855100706;40768.1846363077;41360;41833.58166418419;42042.369364460166;35963.64036359708;36451.63548364482;37326.25347492981;37373.81313093417;37443.62556374401;28247.858760706065;28306.716932830408;28382.85808570944;28520.429591408472;28645.713542865138 10:31:25 INFO - PROCESS | 31767 | |2;jquery.html;423.705524660361;427.9786010699464;429.9355096735491;434.9499807522136;436.9453818272716;17697.203625836835;17981.19084641191;18543.258269669215;18616;18821.153048112832;16919.577010574743;17153.313867445286;18591.81408185918;19859.900700496477;19911.800881991177;5613.214150019001;5637.943620563783;5801.0428279333855;5860.472557469827;5888.793892213774;5713.8571535711735;5749.453801888814;5778.5377169826315;5797.507211886995;5803.2165657636315;5490.752916118764;5723.942760572382;5746.310442746855;5747.137929310595;5748.827535173951;5689.687067211302;5741.540676745851;5771.336296325892;5776.364599894008;5787.594868359217;5114.33513643224;5161.458046905096;5176.55999240065;5180.222966555009;5194.948050519484;13548.525801596898;14203.502877399242;22368.88815555928;22948.196813111626;23074.53850922989;2285.6800047993293;2362.0079566582076;2382.3906781226456;2415.3720032791425;2444.340028192396;10250.179985601135;10513.474326283731;13417.194968301934;13659.86340136596;13731.313434328244;1947.552063025498;2113.228671534894;2169.4359466538654;2238.3620668109675;2265.694131292271;74411.25588744097;78613;82140.17859821445;85130.57434712848;85495;10835;11236.325820450798;11288.492017859217;11569.38028675986;11585.478653460614;16230.594235144215;16235.350585976665;16247.268872900748;16358.672826543403;16396.344146234256;8207.7948051298;8279.296259817984;8422.494650321001;8477.915220847835;8637.179467950535;7969.6015199240965;8075.717349892843;8094.595270236465;8320.500769953822;8483.066862645104;4896.143174944371;4994.850154495298;5014.2979982802435;5031.245313202976;5092.28707980883;1881.8306352428347;1960.696092105726;1992.3026940570685;2027.929022484206;2096.706461095448;973.1484950668165;1017.6160421826311;1018.383877753963;1028.0798685176874;1043.0404028293988;18227.453176404728;19149.329773457863;19359.8064019358;19524.12141453638;19607.21571137167;1065.6057258814287;1085.7394225385851;1111.7998760223238;1127.194056249769;1129.4691494997337;10649.84025239622;10773.78452430947;10800;10955.83566246507;10967.83548246777;569063;578403;593839;606381;609852.8029439386;61955;95116.52441737747;95396;95985;96947.51526242464;1068.0974576482859;1070.710908054821;1085.8371244313257;1096.6874440784338;1101.058594901364;16759.32962681479;16951.57621059434;16989.66020679604;17198.398056067977;17198.742018869976;37292.25415491729;38253.80873095617;38913.805430972665;39221.8038909815;39733.80133099316;49922.500774991786;50852.745736271085;51456.48543514517;51821.7408912953;55074.44925550693;8241.546714930737;8563.272121869462;8798.780030499032;8970.37207395502;9135;12932.935335323264;13332.066755327034;13345.799813002619;13370.465181392636;13602.455901763818;11617.302961822317;11769.823452648046;11875.703107422038;11913.404329783649;12036.277823330629;11640.825387619361;11755.177137600627;11872.525098995944;11892.46483908209;11914.642560723192;11931.105167112328;11941.880581194077;11952;12011.399430028638;12161.756764864831;8789.165029322205;9033.503157326148;9078.863817042618;9302.48836313982;9315.767105822408;12006.339651318913;12282;12290.508379664714;12362.690932726753;12640.620781376574 10:31:25 INFO - PROCESS | 31767 | |3;mootools.html;1433.8351089624696;1562.3516240760084;1584.508802271296;1781.7861856577204;1904.1336192032618;8385.245327920486;8562.91437085629;8616.439931404462;8626.35302352323;8642.308615310776;8171.550564718938;8342.582870856464;8349.248567628912;8351.248387645112;8353.707620233294;2147.03383477435;2343.2033108743067;2369.7511761265077;2375.964360534593;2421.140495124232;2461.778439940405;2477.603583426652;2493.1897133431617;2493.264486976337;2494.077191439161;2405.518896220754;2426.235735743235;2435.5981263091567;2437.902483900642;2444.27893771337;2140.7217061782026;2372.774586414288;2413.553492603874;2414.8671823049726;2424.9693880100976;2317.606006978801;2347.8473899196497;2356.15178535727;2358.445765245166;2368.538135063663;8443.704470343508;8466.83066338676;8491.40560160789;8497.830043399159;8498;5414.566834653218;5495.818399044225;5543.113101903717;5546.112621980504;5552.639078459887;3617.276544691046;3621.3481573316794;3685.6130106338715;3701.574318953301;3718.7025037996896;1209.6612948374382;1215.2222577550374;1244.9066320025943;1347.4004068189658;2252.767278954705;12459.875401245961;12671.17637353569;12676.302803345812;12678.049146314062;12708.173968692097;4632.837850675211;4721.3390125382475;4725.125851717443;4750.7387093709485;4766.547178018082;9942.30403871722;9943.602255909682;9947.55236014381;9963.402195868126;9980.151687106532;4911.287863259808;5429.022775900296;5466.098093814556;5467.617266791366;5469.835904922858;4845.733484658307;4895.657303988758;4945.67853089548;4952.207646776498;4973.452920178777;3943.7633741975574;3985.701072419522;4044.6966477513715;4065.166640838621;4067.6949228807366;1245.5080243303844;1245.6698974771693;1257.9182353147016;1275.9808602870964;1295.1479384480283;1037.123630532199;1043.4521876015153;1044.5717255925035;1087.49975011494;1095.1567293184203;5725.77096916127;5874.118882167709;5996.100584912211;6002.09968504719;6167.167432396659;469.72051629280526;483.64935421819604;486.1662249242566;488.58470300244505;491.3170692737098;3825.598312177237;3883.417487376916;3957.0700885291935;3985.322495175827;4026.6979976501293;10433.426161561187;10744.516496757664;10814.35113893169;10881.401522916158;10889.891101089046;10419.322744021614;10607;10629.043386095134;10631.202659800545;10747.623833165802;8258.256756891788;8293.460925039853;8389.664413423518;8470.534120623424;8493.660253589787;5699.487046165865;5812.709364531841;5814.215080964185;5881.529477641864;5930.34766175729;9645.469499177612;9735.123838854537;9756.365836220906;9764.02359764018;9930.900690993287;9616.230701544;10008.099271065348;10009.499525023866;10011.699649010541;10113;6437.774677886251;7204.24355442671;7315.780526584211;7357.043584334002;7389.556626602421;8328.500289982621;8392.664293428195;8409.495430274203;8435.114312997048;8443.197896199852;7455.0681164854395;7617.619119043915;7664.770056898079;7719.768406947801;7756;7335.706571737284;7350.117985841734;7394.741184058532;7489.13874904393;7514.9624251878395;7052.624738176007;7105.538140020882;7218.458615603746;7259.455540834353;7266.564006159436;5130.307408499804;5266.052110620125;5339.813106541408;5389.1107967186545;5406.567474601944;5144.588432925432;5147.253648221062;5174.094533456705;5209.348831396075;5237.319148510669 10:31:25 INFO - PROCESS | 31767 | |4;prototype.html;356.09551738583997;356.93396721606507;357.93199292134494;370.05451072509726;372.9984990301042;5841.474267315941;6116.755329786809;6138.048602466619;6184.938150618504;6253.906191407121;6112.724927378267;6151;6162.907556386658;6166.475849552782;6172.981458059426;4543.750093744843;4624.699394539361;4723.0317784854105;4727.101850648366;4745.430548334188;4732.645051621143;4746;4747.7388743619085;4759.547842954914;4760.143174228638;4689.718616882998;4697.953020469803;4698.107359601665;4705.035467729124;4710.764461776897;4510.661700372452;4602.332661764059;4696.107739529479;4736.981548966972;4751.453582837983;4127.731697439687;4130.91738165238;4138.586141385837;4141.151064031867;4146.564610715892;5858.062709966385;5871.412858714137;5883.411658834125;5929.940700592982;5950.732217050243;5462.5083742462975;5476.069068258405;5479.835604931818;5481.068218402881;5486.972565137189;6439.581427207217;6444.967775161141;6445.065465507522;6446.903296450557;6448.322926092739;4402.911941761146;4540.296254080623;4604.986902881361;4608.400907881954;4617.953820461819;6673.132492775908;6717.865642687118;6719.7312107515645;6747.122874026394;6806;4607.170709272363;4613.976930115328;4614.492405835355;4618.03021365517;4629.3518907353;4566.794494247767;4638.257878739453;4643.024964757439;4643.767811609406;4653.022865198279;5340.839774806762;5351.839444816662;5354.089804733205;5354.9464505354445;5355.410904800468;6431.517636177306;6477.967610161919;6488.578242414228;6495.6752162391695;6501.187351581052;1622.756586512009;1645.9177041147896;1649.5381293237913;1653.1238443624898;1657.9253933573018;1071.4214324264965;1097.6784101625005;1107.2892381270956;1108.6064447121316;1115.938623375722;6150.78472253478;6192.040233763774;6273.749050037947;6287.937120628827;6367.936320636827;6731.932680673131;6735.831604209836;6747.527673062937;6749.0551322814845;6753.729850805913;6354.173957385603;6355.142055822497;6364.968175159187;6366.172397588377;6369.617822930639;3596.892093237207;3628.854845806138;3629.6551827576336;3635.1457407509215;3635.654612811779;6861.519693621499;6942.93057069433;6991.335823096798;6998.580085194904;7004.4396448284015;6831.863362732717;6872.450203983769;6876.140482439695;6881.346272104142;6885.518013739091;6962.477814163958;6978.337057979383;6980.581165130007;6983.476239282074;6988.79033628992;6729.798106056826;6735.595864248161;6741.865162696817;6743.696533656095;6755.4257888080065;6431.421172094534;6606.6366349849295;6616.636085015371;6620.139381880324;6653.73385064592;6960.37356637905;6978.47661425385;6983.755568555076;6990.61551614666;7001.544899581511;4623.838165664186;4626.398568186114;4627.282771170474;4628.259478483426;4638.026014536985;6706.195256569243;6706.396424321834;6709.731610735711;6720.1599800025;6727.159105111861;6379.3301703320485;6544.345565443417;6555.770548030796;6556.508261880283;6561.835954101186;6497.577657452251;6524.575902566318;6529.967350163219;6534.673266336569;6539.11721917535;6408.58344207625;6430.131932189094;6430.421262086435;6437.710303036468;6443.355664433707;6537.182852143482;6578.243501997332;6579.868402631825;6581.473482121323;6587.4071333580205;6049.30433000193;6161.84595385119;6415.294317624965;6422.389872962061;6424.93575064262 10:31:25 INFO - PROCESS | 31767 | |5;yui.html;879.271545878601;900.3382513852317;900.6217388696747;902.3863772634605;903.6397700365312;15191.164485953283;15307.464238751645;15354;15368.385264589417;16467.83532164681;15696.607584810385;15765.527034188965;15770.526884193463;15795.131267780267;15816.209189540534;761.231156531904;852.0499642898186;864.7838040489878;865.8701194820765;885.8759773631697;885.3890815337396;891.4339394484516;892.2326798952895;892.3575025981283;892.607252808762;936.676846487964;942.5004747483811;942.5334459442586;942.8821397325335;943.1370296178987;782.5148407987027;934.7055677461645;944;944.8582712593097;952.8332541805225;695.8573492434039;696.5507247825125;696.8118607975819;696.965151742416;697.0485287582464;14979.400823967027;15007.249637518189;15056.623584410368;15087.849121508863;15108.093514389062;14501.637459063502;14914.403423863032;14930.776038359434;14937.17845518496;14983.775243371358;11939.403029848472;12146;12169.330686812222;12215.206011609305;12352.752944941141;3923.4899463069905;3961.425593288986;3979.0251388410024;4004.3192657248046;4010.598940105995;59419.108713369336;59443.702781485816;59578.40421595772;59580.40419595792;59925.400745992854;11266.380349080715;11628.1860269782;11698.47356868943;11712;11889.624108103675;20755.68866467004;20781.792182078287;20800.583988320148;20818;20895.477613059797;8349.582520873932;8552.230299273095;8640.654373824977;8654.221120099095;8969.641214351353;4802.207635740064;4946.017721079106;4992.500749924979;5011.824586139468;5011.974940125349;3382.1713680148523;3446.8104254266254;3451.3960056989927;3456;3458.0317511096932;578.8032069096528;653.4054010850103;656.7373050779631;657.7073202424875;660.8347913021745;656.8620589676221;718.3283629806148;725.4595326481805;733.9119305683246;737.4284929179928;9313.20837728787;9697.660581879742;9919.65281215154;9971.501424928725;10031;726.887332463469;739.8557281330196;746.3842330077707;753.4236309223448;761.4289283037722;4109.4181235620235;4314.80583373749;4422.690411671152;4432.312991486325;4588;67215;67957.3204267951;67991.32008679949;68020.3197968014;68097.31902681009;58489;59398.70300648469;59945;61160;61252.69373653103;55056.724716376164;55380.72309638426;55531.72234138884;56179;56545.43454565484;8355.248027677539;8496.575171241537;8778.956105219433;8868.600912958804;8919.73240802777;39868.60131398649;40503.18993620052;41111.58888411077;41181.176376472904;41277.174456511304;48959.510404895496;51357.22964155615;53852.46147538631;54355.45644543504;54426.727866362;11544.191906566795;11633.709157271136;11680.182387232811;11733.237339572901;11806.586769463027;12815.102942793916;13252.072354935062;13288.601341959757;13306.866931330564;13696.726065478833;10415.323004004715;12580.559680411141;12997.935010325265;13032.47870085186;13419.396127174105;12933.676658083623;13031.152975056591;13106.868931310564;13128.146670466389;13295.601131966056;12981.221126732426;13169.53906613264;13228.338583071001;13326.200427974352;13406.262655554037;10742.462876856282;10976.725581860517;11110.388928609003;11163.162762792661;11206.43967801623;10906.102117061022;11083.889161108285;11109.333439993303;11135.610253641084;11276 10:31:25 INFO - PROCESS | 31767 | __end_tp_report 10:31:25 INFO - PROCESS | 31767 | __start_cc_report 10:31:25 INFO - PROCESS | 31767 | _x_x_mozilla_cycle_collect,802 10:31:25 INFO - PROCESS | 31767 | __end_cc_report 10:31:25 INFO - PROCESS | 31767 | __startTimestamp1464197485969__endTimestamp 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | ------- Summary: start ------- 10:31:25 INFO - PROCESS | 31767 | Number of tests: 6 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#0] dojo.html Cycles:165 Average:5452.01 Median:5663.38 stddev:606.44 (10.7%) stddev-sans-first:582.33 10:31:25 INFO - PROCESS | 31767 | Values: 3213.9 3262.6 3305.8 3309.2 3326.2 5431.8 5447.2 5457.0 5475.9 5501.2 5441.3 5472.1 5483.0 5485.0 5532.4 4860.6 4955.4 4986.2 5045.7 5101.3 4967.9 5036.1 5036.4 5039.6 5042.5 4959.9 4996.7 5036.0 5055.2 5075.0 4997.1 4999.6 5004.5 5029.1 5044.9 4840.9 4848.8 4919.3 4940.0 4942.8 5337.9 5377.0 5387.6 5395.9 5403.2 5820.1 5868.6 5869.2 5877.9 5880.1 5862.0 5888.0 5898.9 5949.3 5953.0 5459.4 5476.2 5506.4 5508.3 5512.1 5890.3 5969.7 5982.7 5990.9 5994.9 5701.9 5730.3 5748.8 5778.5 5784.6 5774.5 5797.9 5798.4 5798.4 5799.2 5709.1 5773.5 5775.0 5781.5 5797.0 5847.6 5858.0 5859.2 5861.2 5903.0 4469.0 4471.4 4472.6 4480.8 4498.8 3963.9 3984.2 4011.0 4039.4 4079.1 5507.6 5525.7 5530.7 5534.5 5558.7 5888.9 5916.1 5918.1 5919.0 5922.2 5489.1 5550.1 5604.7 5634.6 5636.0 5036.8 5071.7 5075.4 5076.1 5077.9 6045.9 6088.3 6102.9 6107.4 6115.8 5831.8 5896.6 5916.6 5950.6 5994.6 6084.5 6100.3 6100.4 6104.1 6117.7 5794.9 5795.0 5798.1 5800.9 5804.1 5795.7 5885.9 5936.6 5946.0 5967.9 5737.9 5773.2 5773.2 5784.2 5805.6 5603.7 5739.0 5749.3 5763.9 5764.7 5621.0 5662.5 5663.4 5669.8 5686.1 5747.1 5748.9 5759.6 5772.2 5774.1 5532.7 5599.6 5639.2 5655.2 5685.3 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#1] ext.html Cycles:180 Average:53628.73 Median:41109.38 stddev:103118.71 (250.8%) stddev-sans-first:103331.30 10:31:25 INFO - PROCESS | 31767 | Values: 660.9 664.8 673.6 733.4 734.1 34163.0 34793.7 41970.6 42627.6 42675.8 47388.5 48188.8 48269.0 48273.5 48278.8 9143.9 9322.4 9329.9 9352.7 9358.9 9131.2 9263.0 9266.7 9269.6 9272.7 9148.4 9225.6 9226.5 9229.1 9232.7 9245.7 9297.8 9307.7 9314.5 9316.3 9055.0 9226.1 9231.5 9233.2 9237.0 43105.6 43812.6 43867.3 43929.0 43956.8 3936.4 4193.7 4492.3 4513.3 4731.6 33283.2 33901.2 34150.5 35041.6 35529.5 4667.5 4689.6 4718.7 4741.4 4766.1 234467.0 234964.0 235059.0 235319.0 235386.0 39549.2 63281.7 64217.7 64226.0 64250.7 38156.4 38171.2 38213.8 38270.2 38308.8 15798.2 15812.1 15877.2 15974.4 16140.4 13679.2 13790.9 13814.4 13819.7 13833.8 9313.4 9367.0 9458.7 9470.1 9496.3 3563.1 3576.8 3582.3 3599.2 3630.4 1078.6 1142.4 1153.4 1187.8 1288.4 34036.1 34222.3 34585.5 34635.5 34809.7 1192.6 1200.7 1244.0 1252.5 1359.3 17474.7 18119.8 18120.8 18229.7 18254.8 478271.0 481677.0 484331.0 484593.0 484597.0 59738.7 61727.4 61804.4 61808.0 61814.1 1339.4 1536.6 1548.3 1617.5 1638.6 29932.5 33343.7 33560.5 33609.5 34357.0 50125.0 50967.0 51051.7 51081.2 51101.7 304336.0 310098.0 310644.0 310755.0 659059.0 32453.5 32722.5 32983.7 33310.3 33342.0 47961.3 48639.0 48987.8 49570.3 50076.7 40511.8 40974.4 41072.4 41329.8 42267.8 39747.2 40888.0 40991.2 41146.4 41785.6 40289.8 40768.2 41360.0 41833.6 42042.4 35963.6 36451.6 37326.3 37373.8 37443.6 28247.9 28306.7 28382.9 28520.4 28645.7 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#2] jquery.html Cycles:180 Average:31507.29 Median:2252.03 stddev:97014.67 (4307.9%) stddev-sans-first:97258.74 10:31:25 INFO - PROCESS | 31767 | Values: 423.7 428.0 429.9 434.9 436.9 17697.2 17981.2 18543.3 18616.0 18821.2 16919.6 17153.3 18591.8 19859.9 19911.8 5613.2 5637.9 5801.0 5860.5 5888.8 5713.9 5749.5 5778.5 5797.5 5803.2 5490.8 5723.9 5746.3 5747.1 5748.8 5689.7 5741.5 5771.3 5776.4 5787.6 5114.3 5161.5 5176.6 5180.2 5194.9 13548.5 14203.5 22368.9 22948.2 23074.5 2285.7 2362.0 2382.4 2415.4 2444.3 10250.2 10513.5 13417.2 13659.9 13731.3 1947.6 2113.2 2169.4 2238.4 2265.7 74411.3 78613.0 82140.2 85130.6 85495.0 10835.0 11236.3 11288.5 11569.4 11585.5 16230.6 16235.4 16247.3 16358.7 16396.3 8207.8 8279.3 8422.5 8477.9 8637.2 7969.6 8075.7 8094.6 8320.5 8483.1 4896.1 4994.9 5014.3 5031.2 5092.3 1881.8 1960.7 1992.3 2027.9 2096.7 973.1 1017.6 1018.4 1028.1 1043.0 18227.5 19149.3 19359.8 19524.1 19607.2 1065.6 1085.7 1111.8 1127.2 1129.5 10649.8 10773.8 10800.0 10955.8 10967.8 569063.0 578403.0 593839.0 606381.0 609852.8 61955.0 95116.5 95396.0 95985.0 96947.5 1068.1 1070.7 1085.8 1096.7 1101.1 16759.3 16951.6 16989.7 17198.4 17198.7 37292.3 38253.8 38913.8 39221.8 39733.8 49922.5 50852.7 51456.5 51821.7 55074.4 8241.5 8563.3 8798.8 8970.4 9135.0 12932.9 13332.1 13345.8 13370.5 13602.5 11617.3 11769.8 11875.7 11913.4 12036.3 11640.8 11755.2 11872.5 11892.5 11914.6 11931.1 11941.9 11952.0 12011.4 12161.8 8789.2 9033.5 9078.9 9302.5 9315.8 12006.3 12282.0 12290.5 12362.7 12640.6 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#3] mootools.html Cycles:180 Average:5762.70 Median:2701.30 stddev:3210.76 (118.9%) stddev-sans-first:3203.28 10:31:25 INFO - PROCESS | 31767 | Values: 1433.8 1562.4 1584.5 1781.8 1904.1 8385.2 8562.9 8616.4 8626.4 8642.3 8171.6 8342.6 8349.2 8351.2 8353.7 2147.0 2343.2 2369.8 2376.0 2421.1 2461.8 2477.6 2493.2 2493.3 2494.1 2405.5 2426.2 2435.6 2437.9 2444.3 2140.7 2372.8 2413.6 2414.9 2425.0 2317.6 2347.8 2356.2 2358.4 2368.5 8443.7 8466.8 8491.4 8497.8 8498.0 5414.6 5495.8 5543.1 5546.1 5552.6 3617.3 3621.3 3685.6 3701.6 3718.7 1209.7 1215.2 1244.9 1347.4 2252.8 12459.9 12671.2 12676.3 12678.0 12708.2 4632.8 4721.3 4725.1 4750.7 4766.5 9942.3 9943.6 9947.6 9963.4 9980.2 4911.3 5429.0 5466.1 5467.6 5469.8 4845.7 4895.7 4945.7 4952.2 4973.5 3943.8 3985.7 4044.7 4065.2 4067.7 1245.5 1245.7 1257.9 1276.0 1295.1 1037.1 1043.5 1044.6 1087.5 1095.2 5725.8 5874.1 5996.1 6002.1 6167.2 469.7 483.6 486.2 488.6 491.3 3825.6 3883.4 3957.1 3985.3 4026.7 10433.4 10744.5 10814.4 10881.4 10889.9 10419.3 10607.0 10629.0 10631.2 10747.6 8258.3 8293.5 8389.7 8470.5 8493.7 5699.5 5812.7 5814.2 5881.5 5930.3 9645.5 9735.1 9756.4 9764.0 9930.9 9616.2 10008.1 10009.5 10011.7 10113.0 6437.8 7204.2 7315.8 7357.0 7389.6 8328.5 8392.7 8409.5 8435.1 8443.2 7455.1 7617.6 7664.8 7719.8 7756.0 7335.7 7350.1 7394.7 7489.1 7515.0 7052.6 7105.5 7218.5 7259.5 7266.6 5130.3 5266.1 5339.8 5389.1 5406.6 5144.6 5147.3 5174.1 5209.3 5237.3 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#4] prototype.html Cycles:180 Average:5451.69 Median:6178.96 stddev:1640.11 (26.5%) stddev-sans-first:1599.50 10:31:25 INFO - PROCESS | 31767 | Values: 356.1 356.9 357.9 370.1 373.0 5841.5 6116.8 6138.0 6184.9 6253.9 6112.7 6151.0 6162.9 6166.5 6173.0 4543.8 4624.7 4723.0 4727.1 4745.4 4732.6 4746.0 4747.7 4759.5 4760.1 4689.7 4698.0 4698.1 4705.0 4710.8 4510.7 4602.3 4696.1 4737.0 4751.5 4127.7 4130.9 4138.6 4141.2 4146.6 5858.1 5871.4 5883.4 5929.9 5950.7 5462.5 5476.1 5479.8 5481.1 5487.0 6439.6 6445.0 6445.1 6446.9 6448.3 4402.9 4540.3 4605.0 4608.4 4618.0 6673.1 6717.9 6719.7 6747.1 6806.0 4607.2 4614.0 4614.5 4618.0 4629.4 4566.8 4638.3 4643.0 4643.8 4653.0 5340.8 5351.8 5354.1 5354.9 5355.4 6431.5 6478.0 6488.6 6495.7 6501.2 1622.8 1645.9 1649.5 1653.1 1657.9 1071.4 1097.7 1107.3 1108.6 1115.9 6150.8 6192.0 6273.7 6287.9 6367.9 6731.9 6735.8 6747.5 6749.1 6753.7 6354.2 6355.1 6365.0 6366.2 6369.6 3596.9 3628.9 3629.7 3635.1 3635.7 6861.5 6942.9 6991.3 6998.6 7004.4 6831.9 6872.5 6876.1 6881.3 6885.5 6962.5 6978.3 6980.6 6983.5 6988.8 6729.8 6735.6 6741.9 6743.7 6755.4 6431.4 6606.6 6616.6 6620.1 6653.7 6960.4 6978.5 6983.8 6990.6 7001.5 4623.8 4626.4 4627.3 4628.3 4638.0 6706.2 6706.4 6709.7 6720.2 6727.2 6379.3 6544.3 6555.8 6556.5 6561.8 6497.6 6524.6 6530.0 6534.7 6539.1 6408.6 6430.1 6430.4 6437.7 6443.4 6537.2 6578.2 6579.9 6581.5 6587.4 6049.3 6161.8 6415.3 6422.4 6424.9 10:31:25 INFO - PROCESS | 31767 | 10:31:25 INFO - PROCESS | 31767 | [#5] yui.html Cycles:180 Average:16096.33 Median:4695.10 stddev:19067.02 (406.1%) stddev-sans-first:19086.27 10:31:25 INFO - PROCESS | 31767 | Values: 879.3 900.3 900.6 902.4 903.6 15191.2 15307.5 15354.0 15368.4 16467.8 15696.6 15765.5 15770.5 15795.1 15816.2 761.2 852.0 864.8 865.9 885.9 885.4 891.4 892.2 892.4 892.6 936.7 942.5 942.5 942.9 943.1 782.5 934.7 944.0 944.9 952.8 695.9 696.6 696.8 697.0 697.0 14979.4 15007.2 15056.6 15087.8 15108.1 14501.6 14914.4 14930.8 14937.2 14983.8 11939.4 12146.0 12169.3 12215.2 12352.8 3923.5 3961.4 3979.0 4004.3 4010.6 59419.1 59443.7 59578.4 59580.4 59925.4 11266.4 11628.2 11698.5 11712.0 11889.6 20755.7 20781.8 20800.6 20818.0 20895.5 8349.6 8552.2 8640.7 8654.2 8969.6 4802.2 4946.0 4992.5 5011.8 5012.0 3382.2 3446.8 3451.4 3456.0 3458.0 578.8 653.4 656.7 657.7 660.8 656.9 718.3 725.5 733.9 737.4 9313.2 9697.7 9919.7 9971.5 10031.0 726.9 739.9 746.4 753.4 761.4 4109.4 4314.8 4422.7 4432.3 4588.0 67215.0 67957.3 67991.3 68020.3 68097.3 58489.0 59398.7 59945.0 61160.0 61252.7 55056.7 55380.7 55531.7 56179.0 56545.4 8355.2 8496.6 8779.0 8868.6 8919.7 39868.6 40503.2 41111.6 41181.2 41277.2 48959.5 51357.2 53852.5 54355.5 54426.7 11544.2 11633.7 11680.2 11733.2 11806.6 12815.1 13252.1 13288.6 13306.9 13696.7 10415.3 12580.6 12997.9 13032.5 13419.4 12933.7 13031.2 13106.9 13128.1 13295.6 12981.2 13169.5 13228.3 13326.2 13406.3 10742.5 10976.7 11110.4 11163.2 11206.4 10906.1 11083.9 11109.3 11135.6 11276.0 10:31:25 INFO - PROCESS | 31767 | -------- Summary: end -------- 10:31:25 INFO - PROCESS | 31767 | 10:31:26 INFO - TEST-INFO | 31767: exit 0 10:31:26 INFO - TEST-OK | dromaeo_css | took 1112607ms 10:31:26 INFO - TEST-START | kraken 10:31:26 INFO - operating with platform_type : linux_ 10:31:26 INFO - Initialising browser for kraken test... 10:31:26 INFO - TEST-INFO | started process 31957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsRjl5/profile http://localhost:37855/getInfo.html) 10:31:31 INFO - PROCESS | 31957 | __metrics Screen width/height:1600/1200 10:31:31 INFO - PROCESS | 31957 | colorDepth:24 10:31:31 INFO - PROCESS | 31957 | Browser inner width/height: 1024/697 10:31:31 INFO - PROCESS | 31957 | __metrics 10:31:32 ERROR - PROCESS | 31957 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:33 INFO - TEST-INFO | 31957: exit 0 10:31:33 INFO - Browser initialized. 10:31:33 INFO - Running cycle 1/1 for kraken test... 10:31:33 INFO - TEST-INFO | started process 32049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsRjl5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:45 INFO - PROCESS | 32049 | RSS: Main: 141660160 10:31:45 INFO - PROCESS | 32049 | 10:31:47 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:48 INFO - PROCESS | 32049 | RSS: Main: 197382144 10:31:48 INFO - PROCESS | 32049 | 10:31:51 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-dft) 10:31:52 INFO - PROCESS | 32049 | RSS: Main: 181252096 10:31:52 INFO - PROCESS | 32049 | 10:31:54 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-fft) 10:31:55 INFO - PROCESS | 32049 | RSS: Main: 272068608 10:31:55 INFO - PROCESS | 32049 | 10:31:57 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-oscillator) 10:31:58 INFO - PROCESS | 32049 | RSS: Main: 177991680 10:31:58 INFO - PROCESS | 32049 | 10:32:00 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:00 INFO - PROCESS | 32049 | RSS: Main: 176476160 10:32:00 INFO - PROCESS | 32049 | 10:32:03 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:04 INFO - PROCESS | 32049 | RSS: Main: 210935808 10:32:04 INFO - PROCESS | 32049 | 10:32:07 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:08 INFO - PROCESS | 32049 | RSS: Main: 211222528 10:32:08 INFO - PROCESS | 32049 | 10:32:11 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37855/tests/kraken/driver.html?testName=json-parse-financial) 10:32:11 INFO - PROCESS | 32049 | RSS: Main: 211681280 10:32:11 INFO - PROCESS | 32049 | 10:32:13 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:13 INFO - PROCESS | 32049 | RSS: Main: 191889408 10:32:13 INFO - PROCESS | 32049 | 10:32:15 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:16 INFO - PROCESS | 32049 | RSS: Main: 195792896 10:32:16 INFO - PROCESS | 32049 | 10:32:18 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:18 INFO - PROCESS | 32049 | RSS: Main: 210194432 10:32:18 INFO - PROCESS | 32049 | 10:32:21 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:21 INFO - PROCESS | 32049 | RSS: Main: 211259392 10:32:21 INFO - PROCESS | 32049 | 10:32:24 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:25 INFO - PROCESS | 32049 | RSS: Main: 209002496 10:32:25 INFO - PROCESS | 32049 | 10:32:26 INFO - PROCESS | 32049 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37855/tests/kraken/driver.html?testName=ai-astar) 10:32:27 INFO - PROCESS | 32049 | RSS: Main: 273162240 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | __start_tp_report 10:32:27 INFO - PROCESS | 32049 | _x_x_mozilla_page_load 10:32:27 INFO - PROCESS | 32049 | _x_x_mozilla_page_load_details 10:32:27 INFO - PROCESS | 32049 | |i|pagename|runs| 10:32:27 INFO - PROCESS | 32049 | |0;ai-astar;111;112;110;111;110;112;105;112;110;110 10:32:27 INFO - PROCESS | 32049 | |1;audio-beat-detection;155;125;173;171;127;169;159;141;184;128 10:32:27 INFO - PROCESS | 32049 | |2;audio-dft;166;162;161;160;162;161;161;161;162;161 10:32:27 INFO - PROCESS | 32049 | |3;audio-fft;75;77;73;177;77;76;76;78;177;76 10:32:27 INFO - PROCESS | 32049 | |4;audio-oscillator;93;92;143;93;91;92;148;92;93;153 10:32:27 INFO - PROCESS | 32049 | |5;imaging-gaussian-blur;116;119;117;117;117;117;116;117;117;118 10:32:27 INFO - PROCESS | 32049 | |6;imaging-darkroom;144;146;145;145;145;145;146;145;146;144 10:32:27 INFO - PROCESS | 32049 | |7;imaging-desaturate;94;95;95;94;95;94;94;95;94;96 10:32:27 INFO - PROCESS | 32049 | |8;json-parse-financial;52;52;53;56;54;54;56;71;53;51 10:32:27 INFO - PROCESS | 32049 | |9;json-stringify-tinderbox;58;58;57;58;58;58;57;58;57;57 10:32:27 INFO - PROCESS | 32049 | |10;stanford-crypto-aes;72;72;74;74;73;80;73;74;73;73 10:32:27 INFO - PROCESS | 32049 | |11;stanford-crypto-ccm;123;115;122;111;112;113;111;120;174;131 10:32:27 INFO - PROCESS | 32049 | |12;stanford-crypto-pbkdf2;168;160;165;166;159;164;157;155;157;158 10:32:27 INFO - PROCESS | 32049 | |13;stanford-crypto-sha256-iterative;66;66;65;68;65;67;66;67;67;66 10:32:27 INFO - PROCESS | 32049 | __end_tp_report 10:32:27 INFO - PROCESS | 32049 | __start_cc_report 10:32:27 INFO - PROCESS | 32049 | _x_x_mozilla_cycle_collect,1595 10:32:27 INFO - PROCESS | 32049 | __end_cc_report 10:32:27 INFO - PROCESS | 32049 | __startTimestamp1464197547033__endTimestamp 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | ------- Summary: start ------- 10:32:27 INFO - PROCESS | 32049 | Number of tests: 14 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.06 (1.9%) stddev-sans-first:2.17 10:32:27 INFO - PROCESS | 32049 | Values: 111.0 112.0 110.0 111.0 110.0 112.0 105.0 112.0 110.0 110.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:164.00 stddev:21.63 (13.2%) stddev-sans-first:22.93 10:32:27 INFO - PROCESS | 32049 | Values: 155.0 125.0 173.0 171.0 127.0 169.0 159.0 141.0 184.0 128.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.64 (1.0%) stddev-sans-first:0.67 10:32:27 INFO - PROCESS | 32049 | Values: 166.0 162.0 161.0 160.0 162.0 161.0 161.0 161.0 162.0 161.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.00 stddev:42.61 (56.1%) stddev-sans-first:44.49 10:32:27 INFO - PROCESS | 32049 | Values: 75.0 77.0 73.0 177.0 77.0 76.0 76.0 78.0 177.0 76.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:27.02 (29.4%) stddev-sans-first:28.03 10:32:27 INFO - PROCESS | 32049 | Values: 93.0 92.0 143.0 93.0 91.0 92.0 148.0 92.0 93.0 153.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 10:32:27 INFO - PROCESS | 32049 | Values: 116.0 119.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 10:32:27 INFO - PROCESS | 32049 | Values: 144.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 144.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:32:27 INFO - PROCESS | 32049 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 96.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:5.79 (10.7%) stddev-sans-first:6.02 10:32:27 INFO - PROCESS | 32049 | Values: 52.0 52.0 53.0 56.0 54.0 54.0 56.0 71.0 53.0 51.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:32:27 INFO - PROCESS | 32049 | Values: 58.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 57.0 57.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.50 stddev:2.30 (3.1%) stddev-sans-first:2.35 10:32:27 INFO - PROCESS | 32049 | Values: 72.0 72.0 74.0 74.0 73.0 80.0 73.0 74.0 73.0 73.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:121.00 stddev:19.00 (15.7%) stddev-sans-first:20.15 10:32:27 INFO - PROCESS | 32049 | Values: 123.0 115.0 122.0 111.0 112.0 113.0 111.0 120.0 174.0 131.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:4.48 (2.8%) stddev-sans-first:3.95 10:32:27 INFO - PROCESS | 32049 | Values: 168.0 160.0 165.0 166.0 159.0 164.0 157.0 155.0 157.0 158.0 10:32:27 INFO - PROCESS | 32049 | 10:32:27 INFO - PROCESS | 32049 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 10:32:27 INFO - PROCESS | 32049 | Values: 66.0 66.0 65.0 68.0 65.0 67.0 66.0 67.0 67.0 66.0 10:32:27 INFO - PROCESS | 32049 | -------- Summary: end -------- 10:32:27 INFO - PROCESS | 32049 | 10:32:28 INFO - TEST-INFO | 32049: exit 0 10:32:28 INFO - TEST-OK | kraken | took 61344ms 10:32:28 INFO - SUITE-END | took 1173s 10:32:28 INFO - Completed test suite (00:19:34) 10:32:28 INFO - javascript benchmark 10:32:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.9196520086994, 3262.641109477957, 3305.8181800001007, 3309.172706823294, 3326.168457885529, 5431.809886653968, 5447.237386765856, 5457.0, 5475.917861232085, 5501.1748237764305, 5441.319835020622, 5472.1244600863865, 5483.040467918118, 5484.972575137119, 5532.3637781655125, 4860.562549370556, 4955.430125535565, 4986.177280748672, 5045.697258164503, 5101.336826212587, 4967.875803104916, 5036.068327359432, 5036.445990940993, 5039.647224694273, 5042.495750424947, 4959.851204463872, 4996.650234483587, 5036.0, 5055.191169412895, 5075.0357432087785, 4997.100521906055, 4999.625028122905, 5004.499550045003, 5029.1450453423, 5044.949550504484, 4840.927386089212, 4848.806047758086, 4919.3358896549225, 4939.950600493985, 4942.802287908479, 5337.919931201035, 5377.032134215879, 5387.649802762808, 5395.865103372408, 5403.189521571757, 5820.097884827858, 5868.589198756089, 5869.2369991901205, 5877.882442351171, 5880.147378630118, 5861.970690146564, 5888.0, 5898.852528686774, 5949.286085669704, 5952.970235148797, 5459.3994660587305, 5476.2333273341765, 5506.366767821712, 5508.256385388001, 5512.090505066619, 5890.322612899486, 5969.671668058211, 5982.73077711504, 5990.940090599125, 5994.910076348859, 5701.857453563611, 5730.283714535683, 5748.798792042258, 5778.508826749689, 5784.595078344475, 5774.509166720792, 5797.913031304533, 5798.362180160179, 5798.391168927202, 5799.217105690762, 5709.086546152679, 5773.480386765212, 5775.018246898037, 5781.508571771446, 5796.971015144982, 5847.649141051551, 5857.970710146507, 5859.2382990211, 5861.17943487912, 5902.970485147633, 4468.955310446919, 4471.35165401015, 4472.552744725566, 4480.775961201927, 4498.775061246924, 3963.8612648557164, 3984.2230765000545, 4010.959890401117, 4039.3537034074993, 4079.1229885574744, 5507.5593952483705, 5525.723713814293, 5530.668159910338, 5534.501894829485, 5558.722063896789, 5888.941110588925, 5916.112583112482, 5918.141869428909, 5919.0, 5922.170896074553, 5489.094299440628, 5550.111982082847, 5604.747786349542, 5634.577406694514, 5636.0, 5036.823711170092, 5071.670341427795, 5075.365579302587, 5076.060928728123, 5077.898442031139, 6045.909311360333, 6088.330283668793, 6102.870122236762, 6107.4197951194565, 6115.84710382244, 5831.766729330864, 5896.616719913192, 5916.645001299936, 5950.6132101415005, 5994.550408719277, 6084.513238940785, 6100.328963813889, 6100.420460056288, 6104.11490333908, 6117.663528505975, 5794.884102318014, 5795.0, 5798.1302804579655, 5800.883982320245, 5804.100364443518, 5795.7391917362975, 5885.882282354414, 5936.614120082181, 5945.970270148621, 5967.850803729942, 5737.942620573908, 5773.16289138081, 5773.24947756789, 5784.161296611884, 5805.564582656233, 5603.663780173202, 5738.971305143447, 5749.338826034892, 5763.884722305446, 5764.654120752768, 5621.044422448275, 5662.518685911744, 5663.377028526941, 5669.773209071756, 5686.09022556389, 5747.109198074305, 5748.856278593069, 5759.625624334405, 5772.249607550992, 5774.076147816497, 5532.695701736443, 5599.636023658449, 5639.238702775073, 5655.1517272409465, 5685.346185188756], "value": 5412.390165735748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.9272979972205, 664.8437617159966, 673.605940524793, 733.4499125655755, 734.1483878700707, 34163.0, 34793.65206347939, 41970.58029419709, 42627.57372426275, 42675.78662106685, 47388.526114738845, 48188.759056204755, 48269.0, 48273.517264827344, 48278.758606207004, 9143.862842057375, 9322.394044387127, 9329.860052099224, 9352.672656457025, 9358.859617105749, 9131.178193962542, 9263.027382124881, 9266.721998340061, 9269.582868770887, 9272.67545635903, 9148.405353651991, 9225.630974761036, 9226.492542910137, 9229.077092290785, 9232.67685631003, 9245.676401325954, 9297.814043719121, 9307.72076837696, 9314.534273286308, 9316.301277404222, 9055.0, 9226.123518265755, 9231.538423078819, 9233.215176709988, 9236.953815230881, 43105.56894431047, 43812.561874381165, 43867.341989870176, 43929.0, 43956.78021609871, 3936.448897154372, 4193.6645068394455, 4492.348609451611, 4513.300438432048, 4731.574158325767, 33283.167920801934, 33901.15247118817, 34150.48774268388, 35041.64958350409, 35529.46705799415, 4667.509911459316, 4689.577937985564, 4718.7168769873915, 4741.407324084489, 4766.094442055998, 234467.0, 234964.0, 235059.0, 235319.0, 235386.0, 39549.209015820095, 63281.68359158175, 64217.678911605144, 64225.99999999907, 64250.6787466069, 38156.42765358522, 38171.23657526834, 38213.808930955165, 38270.234595307935, 38308.8084559581, 15798.21008949571, 15812.051276923421, 15877.20613969297, 15974.440894568634, 16140.43508477221, 13679.179249245077, 13790.862091379158, 13814.447422103205, 13819.723605527834, 13833.79249311261, 9313.39462934907, 9366.95316523413, 9458.668946586837, 9470.14768670823, 9496.335256532115, 3563.1270338767167, 3576.7675101118343, 3582.265635544707, 3599.1901822090344, 3630.40098383769, 1078.6170909327234, 1142.400239874056, 1153.405995912106, 1187.8099504079478, 1288.3558220889556, 34036.1490962723, 34222.315553688786, 34585.48121778175, 34635.480467793, 34809.65190348115, 1192.5647138794452, 1200.6638141320445, 1244.0420875925486, 1252.5490823303785, 1359.299960520333, 17474.65050698979, 18119.818801812078, 18120.818791812177, 18229.7265541017, 18254.817451825576, 478271.0, 481677.0, 484331.0, 484593.0, 484597.0, 59738.70130649406, 61727.38272617306, 61804.38195618076, 61808.0, 61814.072788908205, 1339.3972712279513, 1536.569760467071, 1548.3110016042979, 1617.5147455763224, 1638.565780068283, 29932.540925338155, 33343.66656333405, 33560.49659255162, 33609.495857562644, 34357.0, 50125.0, 50967.0, 51051.744741277544, 51081.23378149405, 51101.744491277306, 304336.0, 310098.0, 310644.0, 310755.0, 659059.0, 32453.51319730159, 32722.50916236306, 32983.67016329806, 33310.333793323516, 33342.0, 47961.28058079062, 48639.0, 48987.75506122447, 49570.25644615261, 50076.74961625168, 40511.797441012604, 40974.385384218665, 41072.38391424191, 41329.793351033055, 42267.7886610565, 39747.20505589814, 40888.0, 40991.180176396905, 41146.38280425736, 41785.582144178166, 40289.79855100706, 40768.1846363077, 41360.0, 41833.58166418419, 42042.369364460166, 35963.64036359708, 36451.63548364482, 37326.25347492981, 37373.81313093417, 37443.62556374401, 28247.858760706065, 28306.716932830408, 28382.85808570944, 28520.429591408472, 28645.713542865138], "value": 19608.688777883137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.705524660361, 427.9786010699464, 429.9355096735491, 434.9499807522136, 436.9453818272716, 17697.203625836835, 17981.19084641191, 18543.258269669215, 18616.0, 18821.153048112832, 16919.577010574743, 17153.313867445286, 18591.81408185918, 19859.900700496477, 19911.800881991177, 5613.214150019001, 5637.943620563783, 5801.0428279333855, 5860.472557469827, 5888.793892213774, 5713.8571535711735, 5749.453801888814, 5778.5377169826315, 5797.507211886995, 5803.2165657636315, 5490.752916118764, 5723.942760572382, 5746.310442746855, 5747.137929310595, 5748.827535173951, 5689.687067211302, 5741.540676745851, 5771.336296325892, 5776.364599894008, 5787.594868359217, 5114.33513643224, 5161.458046905096, 5176.55999240065, 5180.222966555009, 5194.948050519484, 13548.525801596898, 14203.502877399242, 22368.88815555928, 22948.196813111626, 23074.53850922989, 2285.6800047993293, 2362.0079566582076, 2382.3906781226456, 2415.3720032791425, 2444.340028192396, 10250.179985601135, 10513.474326283731, 13417.194968301934, 13659.86340136596, 13731.313434328244, 1947.552063025498, 2113.228671534894, 2169.4359466538654, 2238.3620668109675, 2265.694131292271, 74411.25588744097, 78613.0, 82140.17859821445, 85130.57434712848, 85495.0, 10835.0, 11236.325820450798, 11288.492017859217, 11569.38028675986, 11585.478653460614, 16230.594235144215, 16235.350585976665, 16247.268872900748, 16358.672826543403, 16396.344146234256, 8207.7948051298, 8279.296259817984, 8422.494650321001, 8477.915220847835, 8637.179467950535, 7969.6015199240965, 8075.717349892843, 8094.595270236465, 8320.500769953822, 8483.066862645104, 4896.143174944371, 4994.850154495298, 5014.2979982802435, 5031.245313202976, 5092.28707980883, 1881.8306352428347, 1960.696092105726, 1992.3026940570685, 2027.929022484206, 2096.706461095448, 973.1484950668165, 1017.6160421826311, 1018.383877753963, 1028.0798685176874, 1043.0404028293988, 18227.453176404728, 19149.329773457863, 19359.8064019358, 19524.12141453638, 19607.21571137167, 1065.6057258814287, 1085.7394225385851, 1111.7998760223238, 1127.194056249769, 1129.4691494997337, 10649.84025239622, 10773.78452430947, 10800.0, 10955.83566246507, 10967.83548246777, 569063.0, 578403.0, 593839.0, 606381.0, 609852.8029439386, 61955.0, 95116.52441737747, 95396.0, 95985.0, 96947.51526242464, 1068.0974576482859, 1070.710908054821, 1085.8371244313257, 1096.6874440784338, 1101.058594901364, 16759.32962681479, 16951.57621059434, 16989.66020679604, 17198.398056067977, 17198.742018869976, 37292.25415491729, 38253.80873095617, 38913.805430972665, 39221.8038909815, 39733.80133099316, 49922.500774991786, 50852.745736271085, 51456.48543514517, 51821.7408912953, 55074.44925550693, 8241.546714930737, 8563.272121869462, 8798.780030499032, 8970.37207395502, 9135.0, 12932.935335323264, 13332.066755327034, 13345.799813002619, 13370.465181392636, 13602.455901763818, 11617.302961822317, 11769.823452648046, 11875.703107422038, 11913.404329783649, 12036.277823330629, 11640.825387619361, 11755.177137600627, 11872.525098995944, 11892.46483908209, 11914.642560723192, 11931.105167112328, 11941.880581194077, 11952.0, 12011.399430028638, 12161.756764864831, 8789.165029322205, 9033.503157326148, 9078.863817042618, 9302.48836313982, 9315.767105822408, 12006.339651318913, 12282.0, 12290.508379664714, 12362.690932726753, 12640.620781376574], "value": 9385.000995240965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.8351089624696, 1562.3516240760084, 1584.508802271296, 1781.7861856577204, 1904.1336192032618, 8385.245327920486, 8562.91437085629, 8616.439931404462, 8626.35302352323, 8642.308615310776, 8171.550564718938, 8342.582870856464, 8349.248567628912, 8351.248387645112, 8353.707620233294, 2147.03383477435, 2343.2033108743067, 2369.7511761265077, 2375.964360534593, 2421.140495124232, 2461.778439940405, 2477.603583426652, 2493.1897133431617, 2493.264486976337, 2494.077191439161, 2405.518896220754, 2426.235735743235, 2435.5981263091567, 2437.902483900642, 2444.27893771337, 2140.7217061782026, 2372.774586414288, 2413.553492603874, 2414.8671823049726, 2424.9693880100976, 2317.606006978801, 2347.8473899196497, 2356.15178535727, 2358.445765245166, 2368.538135063663, 8443.704470343508, 8466.83066338676, 8491.40560160789, 8497.830043399159, 8498.0, 5414.566834653218, 5495.818399044225, 5543.113101903717, 5546.112621980504, 5552.639078459887, 3617.276544691046, 3621.3481573316794, 3685.6130106338715, 3701.574318953301, 3718.7025037996896, 1209.6612948374382, 1215.2222577550374, 1244.9066320025943, 1347.4004068189658, 2252.767278954705, 12459.875401245961, 12671.17637353569, 12676.302803345812, 12678.049146314062, 12708.173968692097, 4632.837850675211, 4721.3390125382475, 4725.125851717443, 4750.7387093709485, 4766.547178018082, 9942.30403871722, 9943.602255909682, 9947.55236014381, 9963.402195868126, 9980.151687106532, 4911.287863259808, 5429.022775900296, 5466.098093814556, 5467.617266791366, 5469.835904922858, 4845.733484658307, 4895.657303988758, 4945.67853089548, 4952.207646776498, 4973.452920178777, 3943.7633741975574, 3985.701072419522, 4044.6966477513715, 4065.166640838621, 4067.6949228807366, 1245.5080243303844, 1245.6698974771693, 1257.9182353147016, 1275.9808602870964, 1295.1479384480283, 1037.123630532199, 1043.4521876015153, 1044.5717255925035, 1087.49975011494, 1095.1567293184203, 5725.77096916127, 5874.118882167709, 5996.100584912211, 6002.09968504719, 6167.167432396659, 469.72051629280526, 483.64935421819604, 486.1662249242566, 488.58470300244505, 491.3170692737098, 3825.598312177237, 3883.417487376916, 3957.0700885291935, 3985.322495175827, 4026.6979976501293, 10433.426161561187, 10744.516496757664, 10814.35113893169, 10881.401522916158, 10889.891101089046, 10419.322744021614, 10607.0, 10629.043386095134, 10631.202659800545, 10747.623833165802, 8258.256756891788, 8293.460925039853, 8389.664413423518, 8470.534120623424, 8493.660253589787, 5699.487046165865, 5812.709364531841, 5814.215080964185, 5881.529477641864, 5930.34766175729, 9645.469499177612, 9735.123838854537, 9756.365836220906, 9764.02359764018, 9930.900690993287, 9616.230701544, 10008.099271065348, 10009.499525023866, 10011.699649010541, 10113.0, 6437.774677886251, 7204.24355442671, 7315.780526584211, 7357.043584334002, 7389.556626602421, 8328.500289982621, 8392.664293428195, 8409.495430274203, 8435.114312997048, 8443.197896199852, 7455.0681164854395, 7617.619119043915, 7664.770056898079, 7719.768406947801, 7756.0, 7335.706571737284, 7350.117985841734, 7394.741184058532, 7489.13874904393, 7514.9624251878395, 7052.624738176007, 7105.538140020882, 7218.458615603746, 7259.455540834353, 7266.564006159436, 5130.307408499804, 5266.052110620125, 5339.813106541408, 5389.1107967186545, 5406.567474601944, 5144.588432925432, 5147.253648221062, 5174.094533456705, 5209.348831396075, 5237.319148510669], "value": 4612.41818694426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.09551738583997, 356.93396721606507, 357.93199292134494, 370.05451072509726, 372.9984990301042, 5841.474267315941, 6116.755329786809, 6138.048602466619, 6184.938150618504, 6253.906191407121, 6112.724927378267, 6151.0, 6162.907556386658, 6166.475849552782, 6172.981458059426, 4543.750093744843, 4624.699394539361, 4723.0317784854105, 4727.101850648366, 4745.430548334188, 4732.645051621143, 4746.0, 4747.7388743619085, 4759.547842954914, 4760.143174228638, 4689.718616882998, 4697.953020469803, 4698.107359601665, 4705.035467729124, 4710.764461776897, 4510.661700372452, 4602.332661764059, 4696.107739529479, 4736.981548966972, 4751.453582837983, 4127.731697439687, 4130.91738165238, 4138.586141385837, 4141.151064031867, 4146.564610715892, 5858.062709966385, 5871.412858714137, 5883.411658834125, 5929.940700592982, 5950.732217050243, 5462.5083742462975, 5476.069068258405, 5479.835604931818, 5481.068218402881, 5486.972565137189, 6439.581427207217, 6444.967775161141, 6445.065465507522, 6446.903296450557, 6448.322926092739, 4402.911941761146, 4540.296254080623, 4604.986902881361, 4608.400907881954, 4617.953820461819, 6673.132492775908, 6717.865642687118, 6719.7312107515645, 6747.122874026394, 6806.0, 4607.170709272363, 4613.976930115328, 4614.492405835355, 4618.03021365517, 4629.3518907353, 4566.794494247767, 4638.257878739453, 4643.024964757439, 4643.767811609406, 4653.022865198279, 5340.839774806762, 5351.839444816662, 5354.089804733205, 5354.9464505354445, 5355.410904800468, 6431.517636177306, 6477.967610161919, 6488.578242414228, 6495.6752162391695, 6501.187351581052, 1622.756586512009, 1645.9177041147896, 1649.5381293237913, 1653.1238443624898, 1657.9253933573018, 1071.4214324264965, 1097.6784101625005, 1107.2892381270956, 1108.6064447121316, 1115.938623375722, 6150.78472253478, 6192.040233763774, 6273.749050037947, 6287.937120628827, 6367.936320636827, 6731.932680673131, 6735.831604209836, 6747.527673062937, 6749.0551322814845, 6753.729850805913, 6354.173957385603, 6355.142055822497, 6364.968175159187, 6366.172397588377, 6369.617822930639, 3596.892093237207, 3628.854845806138, 3629.6551827576336, 3635.1457407509215, 3635.654612811779, 6861.519693621499, 6942.93057069433, 6991.335823096798, 6998.580085194904, 7004.4396448284015, 6831.863362732717, 6872.450203983769, 6876.140482439695, 6881.346272104142, 6885.518013739091, 6962.477814163958, 6978.337057979383, 6980.581165130007, 6983.476239282074, 6988.79033628992, 6729.798106056826, 6735.595864248161, 6741.865162696817, 6743.696533656095, 6755.4257888080065, 6431.421172094534, 6606.6366349849295, 6616.636085015371, 6620.139381880324, 6653.73385064592, 6960.37356637905, 6978.47661425385, 6983.755568555076, 6990.61551614666, 7001.544899581511, 4623.838165664186, 4626.398568186114, 4627.282771170474, 4628.259478483426, 4638.026014536985, 6706.195256569243, 6706.396424321834, 6709.731610735711, 6720.1599800025, 6727.159105111861, 6379.3301703320485, 6544.345565443417, 6555.770548030796, 6556.508261880283, 6561.835954101186, 6497.577657452251, 6524.575902566318, 6529.967350163219, 6534.673266336569, 6539.11721917535, 6408.58344207625, 6430.131932189094, 6430.421262086435, 6437.710303036468, 6443.355664433707, 6537.182852143482, 6578.243501997332, 6579.868402631825, 6581.473482121323, 6587.4071333580205, 6049.30433000193, 6161.84595385119, 6415.294317624965, 6422.389872962061, 6424.93575064262], "value": 4923.200597840245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.271545878601, 900.3382513852317, 900.6217388696747, 902.3863772634605, 903.6397700365312, 15191.164485953283, 15307.464238751645, 15354.0, 15368.385264589417, 16467.83532164681, 15696.607584810385, 15765.527034188965, 15770.526884193463, 15795.131267780267, 15816.209189540534, 761.231156531904, 852.0499642898186, 864.7838040489878, 865.8701194820765, 885.8759773631697, 885.3890815337396, 891.4339394484516, 892.2326798952895, 892.3575025981283, 892.607252808762, 936.676846487964, 942.5004747483811, 942.5334459442586, 942.8821397325335, 943.1370296178987, 782.5148407987027, 934.7055677461645, 944.0, 944.8582712593097, 952.8332541805225, 695.8573492434039, 696.5507247825125, 696.8118607975819, 696.965151742416, 697.0485287582464, 14979.400823967027, 15007.249637518189, 15056.623584410368, 15087.849121508863, 15108.093514389062, 14501.637459063502, 14914.403423863032, 14930.776038359434, 14937.17845518496, 14983.775243371358, 11939.403029848472, 12146.0, 12169.330686812222, 12215.206011609305, 12352.752944941141, 3923.4899463069905, 3961.425593288986, 3979.0251388410024, 4004.3192657248046, 4010.598940105995, 59419.108713369336, 59443.702781485816, 59578.40421595772, 59580.40419595792, 59925.400745992854, 11266.380349080715, 11628.1860269782, 11698.47356868943, 11712.0, 11889.624108103675, 20755.68866467004, 20781.792182078287, 20800.583988320148, 20818.0, 20895.477613059797, 8349.582520873932, 8552.230299273095, 8640.654373824977, 8654.221120099095, 8969.641214351353, 4802.207635740064, 4946.017721079106, 4992.500749924979, 5011.824586139468, 5011.974940125349, 3382.1713680148523, 3446.8104254266254, 3451.3960056989927, 3456.0, 3458.0317511096932, 578.8032069096528, 653.4054010850103, 656.7373050779631, 657.7073202424875, 660.8347913021745, 656.8620589676221, 718.3283629806148, 725.4595326481805, 733.9119305683246, 737.4284929179928, 9313.20837728787, 9697.660581879742, 9919.65281215154, 9971.501424928725, 10031.0, 726.887332463469, 739.8557281330196, 746.3842330077707, 753.4236309223448, 761.4289283037722, 4109.4181235620235, 4314.80583373749, 4422.690411671152, 4432.312991486325, 4588.0, 67215.0, 67957.3204267951, 67991.32008679949, 68020.3197968014, 68097.31902681009, 58489.0, 59398.70300648469, 59945.0, 61160.0, 61252.69373653103, 55056.724716376164, 55380.72309638426, 55531.72234138884, 56179.0, 56545.43454565484, 8355.248027677539, 8496.575171241537, 8778.956105219433, 8868.600912958804, 8919.73240802777, 39868.60131398649, 40503.18993620052, 41111.58888411077, 41181.176376472904, 41277.174456511304, 48959.510404895496, 51357.22964155615, 53852.46147538631, 54355.45644543504, 54426.727866362, 11544.191906566795, 11633.709157271136, 11680.182387232811, 11733.237339572901, 11806.586769463027, 12815.102942793916, 13252.072354935062, 13288.601341959757, 13306.866931330564, 13696.726065478833, 10415.323004004715, 12580.559680411141, 12997.935010325265, 13032.47870085186, 13419.396127174105, 12933.676658083623, 13031.152975056591, 13106.868931310564, 13128.146670466389, 13295.601131966056, 12981.221126732426, 13169.53906613264, 13228.338583071001, 13326.200427974352, 13406.262655554037, 10742.462876856282, 10976.725581860517, 11110.388928609003, 11163.162762792661, 11206.43967801623, 10906.102117061022, 11083.889161108285, 11109.333439993303, 11135.610253641084, 11276.0], "value": 7154.8977118547555, "unit": "score"}], "name": "dromaeo_css", "value": 7382.130617897135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 111.0, 110.0, 112.0, 105.0, 112.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 173.0, 171.0, 127.0, 169.0, 159.0, 141.0, 184.0, 128.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 177.0, 77.0, 76.0, 76.0, 78.0, 177.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 143.0, 93.0, 91.0, 92.0, 148.0, 92.0, 93.0, 153.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 56.0, 54.0, 54.0, 56.0, 71.0, 53.0, 51.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 74.0, 73.0, 80.0, 73.0, 74.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 115.0, 122.0, 111.0, 112.0, 113.0, 111.0, 120.0, 174.0, 131.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 160.0, 165.0, 166.0, 159.0, 164.0, 157.0, 155.0, 157.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 68.0, 65.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1524.2, "alertThreshold": 2.0}]} 10:32:28 INFO - Return code: 0 10:32:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:32:28 ERROR - # TBPL SUCCESS # 10:32:28 INFO - Running post-action listener: _resource_record_post_action 10:32:28 INFO - Running post-run listener: _resource_record_post_run 10:32:29 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505729024; Read time: 24; Write time: 1007452 10:32:29 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 258441216; Read time: 0; Write time: 544216 10:32:29 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246689792; Read time: 24; Write time: 462352 10:32:29 INFO - Running post-run listener: _upload_blobber_files 10:32:29 INFO - Blob upload gear active. 10:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:29 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 10:32:29 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'] 10:32:29 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 10:32:29 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:30 INFO - (blobuploader) - INFO - Done attempting. 10:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:31 INFO - (blobuploader) - INFO - Done attempting. 10:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:31 INFO - Return code: 0 10:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dac8652bcc8eccdfa7312adf4050cb70e6ab5f9fdf18c393279b43388d073fe6e08285ebe524eefb384ecc89b303d818f33ea4cd52447d75c7226dec0871b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa59637a1a628ccb7a5670f2785cbbc779b3315de638c82f2001d51608cd814fff90ad635e5ec3accbc1a1ab773d7802e3adc375bc3892f8bcb412db5d4a874b"} 10:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:31 INFO - Contents: 10:32:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dac8652bcc8eccdfa7312adf4050cb70e6ab5f9fdf18c393279b43388d073fe6e08285ebe524eefb384ecc89b303d818f33ea4cd52447d75c7226dec0871b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa59637a1a628ccb7a5670f2785cbbc779b3315de638c82f2001d51608cd814fff90ad635e5ec3accbc1a1ab773d7802e3adc375bc3892f8bcb412db5d4a874b"} 10:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:31 INFO - Copying logs to upload dir... 10:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.524472 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-25 10:32:31.609352) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:32:31.612880) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 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/9dac8652bcc8eccdfa7312adf4050cb70e6ab5f9fdf18c393279b43388d073fe6e08285ebe524eefb384ecc89b303d818f33ea4cd52447d75c7226dec0871b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa59637a1a628ccb7a5670f2785cbbc779b3315de638c82f2001d51608cd814fff90ad635e5ec3accbc1a1ab773d7802e3adc375bc3892f8bcb412db5d4a874b"} build_url:https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011658 build_url: 'https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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/9dac8652bcc8eccdfa7312adf4050cb70e6ab5f9fdf18c393279b43388d073fe6e08285ebe524eefb384ecc89b303d818f33ea4cd52447d75c7226dec0871b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa59637a1a628ccb7a5670f2785cbbc779b3315de638c82f2001d51608cd814fff90ad635e5ec3accbc1a1ab773d7802e3adc375bc3892f8bcb412db5d4a874b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:32:31.640919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:32:31.641622) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464196313.378322-1088208135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:32:31.724818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:32:31.725513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:32:31.726168) ========= ========= Total master_lag: 0.19 =========