builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1462885481.27 results: success (0) buildid: 20160510032818 builduid: 9d0f53cdd81b4716a7c35eace595bcd2 revision: 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.268197) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.268617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.268883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.279190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.279485) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 06:04:41-- 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% 17.8M=0.001s 2016-05-10 06:04:41 (17.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.441980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.442245) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.490547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:41.491302) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 --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 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 --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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 06:04:42,038 truncating revision to first 12 chars 2016-05-10 06:04:42,038 Setting DEBUG logging. 2016-05-10 06:04:42,038 attempt 1/10 2016-05-10 06:04:42,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4c5959b81fd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 06:04:42,667 unpacking tar archive at: mozilla-aurora-4c5959b81fd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.887171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:42.395873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:42.396181) ========= script_repo_revision: 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:42.396632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:42.396933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:42.403123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 06:04:42.403475) ========= /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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:43 INFO - MultiFileLogger online at 20160510 06:04:43 in /builds/slave/test 06:04:43 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 06:04:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:43 INFO - {'append_to_log': False, 06:04:43 INFO - 'base_work_dir': '/builds/slave/test', 06:04:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:04:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:43 INFO - 'branch': 'Mozilla-Aurora', 06:04:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:43 INFO - 'config_files': ('talos/linux_config.py',), 06:04:43 INFO - 'default_actions': ('clobber', 06:04:43 INFO - 'read-buildbot-config', 06:04:43 INFO - 'download-and-extract', 06:04:43 INFO - 'populate-webroot', 06:04:43 INFO - 'create-virtualenv', 06:04:43 INFO - 'install', 06:04:43 INFO - 'run-tests'), 06:04:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:43 INFO - 'download_minidump_stackwalk': True, 06:04:43 INFO - 'download_symbols': 'ondemand', 06:04:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:43 INFO - 'installer_path': 'installer.exe', 06:04:43 INFO - 'log_level': 'info', 06:04:43 INFO - 'log_name': 'talos', 06:04:43 INFO - 'log_to_console': True, 06:04:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:43 INFO - 'opt_config_files': (), 06:04:43 INFO - 'pip_index': False, 06:04:43 INFO - 'sps_profile': False, 06:04:43 INFO - 'sps_profile_interval': 0, 06:04:43 INFO - 'suite': 'dromaeojs', 06:04:43 INFO - 'system_bits': '32', 06:04:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:43 INFO - 'title': 'talos-linux64-ix-014', 06:04:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:43 INFO - 'use_talos_json': True, 06:04:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:43 INFO - 'work_dir': 'build'} 06:04:43 INFO - ##### 06:04:43 INFO - ##### Running clobber step. 06:04:43 INFO - ##### 06:04:43 INFO - Running pre-action listener: _resource_record_pre_action 06:04:43 INFO - Running main action method: clobber 06:04:43 INFO - rmtree: /builds/slave/test/build 06:04:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:43 INFO - Running post-action listener: _resource_record_post_action 06:04:43 INFO - ##### 06:04:43 INFO - ##### Running read-buildbot-config step. 06:04:43 INFO - ##### 06:04:43 INFO - Running pre-action listener: _resource_record_pre_action 06:04:43 INFO - Running main action method: read_buildbot_config 06:04:43 INFO - Using buildbot properties: 06:04:43 INFO - { 06:04:43 INFO - "project": "", 06:04:43 INFO - "product": "firefox", 06:04:43 INFO - "script_repo_revision": "production", 06:04:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:04:43 INFO - "repository": "", 06:04:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:04:43 INFO - "buildid": "20160510032818", 06:04:43 INFO - "pgo_build": "True", 06:04:43 INFO - "basedir": "/builds/slave/test", 06:04:43 INFO - "buildnumber": 321, 06:04:43 INFO - "slavename": "talos-linux64-ix-014", 06:04:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:04:43 INFO - "platform": "ubuntu64_hw", 06:04:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:04:43 INFO - "branch": "mozilla-aurora", 06:04:43 INFO - "repo_path": "releases/mozilla-aurora", 06:04:43 INFO - "revision": "4c5959b81fd5b61fe854f2d2e0743afa66f9aa07", 06:04:43 INFO - "stage_platform": "linux64-pgo", 06:04:43 INFO - "builduid": "9d0f53cdd81b4716a7c35eace595bcd2", 06:04:43 INFO - "slavebuilddir": "test" 06:04:43 INFO - } 06:04:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:04:43 INFO - Running post-action listener: _resource_record_post_action 06:04:43 INFO - ##### 06:04:43 INFO - ##### Running download-and-extract step. 06:04:43 INFO - ##### 06:04:43 INFO - Running pre-action listener: _resource_record_pre_action 06:04:43 INFO - Running main action method: download_and_extract 06:04:43 INFO - mkdir: /builds/slave/test/build/tests 06:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:43 INFO - https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:04:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:04:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:04:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:04:51 INFO - Downloaded 1361 bytes. 06:04:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:04:51 INFO - Using the following test package requirements: 06:04:51 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:04:51 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:51 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:04:51 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'jsshell-linux-x86_64.zip'], 06:04:51 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:51 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:04:51 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:04:51 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:04:51 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:51 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:51 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')]} 06:04:51 INFO - https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:04:53 INFO - Downloaded 23798959 bytes. 06:04:53 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'] 06:04:53 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 06:04:54 INFO - Return code: 0 06:04:54 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 06:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:54 INFO - https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:05:01 INFO - Downloaded 23798959 bytes. 06:05:01 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'] 06:05:01 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 06:05:02 INFO - Return code: 0 06:05:02 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')]} 06:05:02 INFO - https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:05:03 INFO - Downloaded 10840145 bytes. 06:05:03 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'] 06:05:03 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 06:05:03 INFO - Return code: 0 06:05: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')]} 06:05:03 INFO - https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:05:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:05:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:05:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:05:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KIJYXZp2SOGqa1BZj3-67A/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 06:05:05 INFO - Downloaded 62723333 bytes. 06:05:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:05:05 INFO - mkdir: /builds/slave/test/properties 06:05:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:05 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:05 INFO - Contents: 06:05:05 INFO - build_url:https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:05:06 INFO - Running post-action listener: _resource_record_post_action 06:05:06 INFO - Running post-action listener: set_extra_try_arguments 06:05:06 INFO - ##### 06:05:06 INFO - ##### Running populate-webroot step. 06:05:06 INFO - ##### 06:05:06 INFO - Running pre-action listener: _resource_record_pre_action 06:05:06 INFO - Running main action method: populate_webroot 06:05:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:06 INFO - '--tppagecycles', 06:05:06 INFO - '7'], 06:05:06 INFO - 'tests': ['tsvgm']}}, 06:05:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['damp', 'tps']}, 06:05:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['damp', 'tps']}, 06:05:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['dromaeo_dom']}, 06:05:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tsvgx', 06:05:06 INFO - 'tsvgr_opacity', 06:05:06 INFO - 'tart', 06:05:06 INFO - 'tscrollx', 06:05:06 INFO - 'cart']}, 06:05:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:06 INFO - 'tsvgr_opacity', 06:05:06 INFO - 'tart', 06:05:06 INFO - 'tscrollx', 06:05:06 INFO - 'cart']}, 06:05:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tp5o']}, 06:05:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['tp5o']}, 06:05:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s', 06:05:06 INFO - '--xperf_path', 06:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:06 INFO - 'tests': ['tp5n']}, 06:05:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--xperf_path', 06:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:06 INFO - 'tests': ['tp5n']}}, 06:05:06 INFO - 'talos.zip': {'path': '', 06:05:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:06 INFO - Running post-action listener: _resource_record_post_action 06:05:06 INFO - ##### 06:05:06 INFO - ##### Running create-virtualenv step. 06:05:06 INFO - ##### 06:05:06 INFO - Running pre-action listener: _resource_record_pre_action 06:05:06 INFO - Running main action method: create_virtualenv 06:05:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:06 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 06:05:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:06 INFO - Using real prefix '/usr' 06:05:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:08 INFO - Installing pip.................done. 06:05:08 INFO - Return code: 0 06:05:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:05:08 INFO - Using env: {'DISPLAY': ':0', 06:05:08 INFO - 'HOME': '/home/cltbld', 06:05:08 INFO - 'LANG': 'en_US.UTF-8', 06:05:08 INFO - 'LANGUAGE': 'en_US:en', 06:05:08 INFO - 'LOGNAME': 'cltbld', 06:05:08 INFO - 'MAIL': '/var/mail/cltbld', 06:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:08 INFO - 'MOZ_NO_REMOTE': '1', 06:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:08 INFO - 'NO_EM_RESTART': '1', 06:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:08 INFO - 'PWD': '/builds/slave/test', 06:05:08 INFO - 'SHELL': '/bin/bash', 06:05:08 INFO - 'SHLVL': '1', 06:05:08 INFO - 'TERM': 'linux', 06:05:08 INFO - 'TMOUT': '86400', 06:05:08 INFO - 'USER': 'cltbld', 06:05:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:08 INFO - '_': '/tools/buildbot/bin/python'} 06:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:09 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 06:05:09 INFO - Cleaning up... 06:05:09 INFO - Return code: 0 06:05:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:09 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 06:05:09 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 06:05:09 INFO - Using env: {'DISPLAY': ':0', 06:05:09 INFO - 'HOME': '/home/cltbld', 06:05:09 INFO - 'LANG': 'en_US.UTF-8', 06:05:09 INFO - 'LANGUAGE': 'en_US:en', 06:05:09 INFO - 'LOGNAME': 'cltbld', 06:05:09 INFO - 'MAIL': '/var/mail/cltbld', 06:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:09 INFO - 'MOZ_NO_REMOTE': '1', 06:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:09 INFO - 'NO_EM_RESTART': '1', 06:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:09 INFO - 'PWD': '/builds/slave/test', 06:05:09 INFO - 'SHELL': '/bin/bash', 06:05:09 INFO - 'SHLVL': '1', 06:05:09 INFO - 'TERM': 'linux', 06:05:09 INFO - 'TMOUT': '86400', 06:05:09 INFO - 'USER': 'cltbld', 06:05:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:09 INFO - '_': '/tools/buildbot/bin/python'} 06:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:09 INFO - Downloading/unpacking psutil>=0.7.1 06:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:11 INFO - Installing collected packages: psutil 06:05:11 INFO - Running setup.py install for psutil 06:05:11 INFO - building 'psutil._psutil_linux' extension 06:05:11 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 06:05:11 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 06:05:11 INFO - building 'psutil._psutil_posix' extension 06:05:11 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 06:05:11 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 06:05:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:11 INFO - Successfully installed psutil 06:05:11 INFO - Cleaning up... 06:05:11 INFO - Return code: 0 06:05:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:11 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 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:11 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 06:05:11 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 06:05:11 INFO - Using env: {'DISPLAY': ':0', 06:05:11 INFO - 'HOME': '/home/cltbld', 06:05:11 INFO - 'LANG': 'en_US.UTF-8', 06:05:11 INFO - 'LANGUAGE': 'en_US:en', 06:05:11 INFO - 'LOGNAME': 'cltbld', 06:05:11 INFO - 'MAIL': '/var/mail/cltbld', 06:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:11 INFO - 'MOZ_NO_REMOTE': '1', 06:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:11 INFO - 'NO_EM_RESTART': '1', 06:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:11 INFO - 'PWD': '/builds/slave/test', 06:05:11 INFO - 'SHELL': '/bin/bash', 06:05:11 INFO - 'SHLVL': '1', 06:05:11 INFO - 'TERM': 'linux', 06:05:11 INFO - 'TMOUT': '86400', 06:05:11 INFO - 'USER': 'cltbld', 06:05:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:11 INFO - '_': '/tools/buildbot/bin/python'} 06:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:05:13 INFO - Installing collected packages: mozsystemmonitor 06:05:13 INFO - Running setup.py install for mozsystemmonitor 06:05:13 INFO - Successfully installed mozsystemmonitor 06:05:13 INFO - Cleaning up... 06:05:13 INFO - Return code: 0 06:05:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:05:13 INFO - Using env: {'DISPLAY': ':0', 06:05:13 INFO - 'HOME': '/home/cltbld', 06:05:13 INFO - 'LANG': 'en_US.UTF-8', 06:05:13 INFO - 'LANGUAGE': 'en_US:en', 06:05:13 INFO - 'LOGNAME': 'cltbld', 06:05:13 INFO - 'MAIL': '/var/mail/cltbld', 06:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:13 INFO - 'MOZ_NO_REMOTE': '1', 06:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:13 INFO - 'NO_EM_RESTART': '1', 06:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:13 INFO - 'PWD': '/builds/slave/test', 06:05:13 INFO - 'SHELL': '/bin/bash', 06:05:13 INFO - 'SHLVL': '1', 06:05:13 INFO - 'TERM': 'linux', 06:05:13 INFO - 'TMOUT': '86400', 06:05:13 INFO - 'USER': 'cltbld', 06:05:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:13 INFO - '_': '/tools/buildbot/bin/python'} 06:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:16 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 06:05:16 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 06:05:16 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 06:05:16 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 06:05:16 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 06:05:16 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 06:05:16 INFO - Downloading docopt-0.6.1.tar.gz 06:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:16 INFO - Running setup.py install for blobuploader 06:05:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:16 INFO - Running setup.py install for requests 06:05:17 INFO - Running setup.py install for docopt 06:05:17 INFO - Successfully installed blobuploader requests docopt 06:05:17 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 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 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:17 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 06:05:17 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 06:05:17 INFO - Using env: {'DISPLAY': ':0', 06:05:17 INFO - 'HOME': '/home/cltbld', 06:05:17 INFO - 'LANG': 'en_US.UTF-8', 06:05:17 INFO - 'LANGUAGE': 'en_US:en', 06:05:17 INFO - 'LOGNAME': 'cltbld', 06:05:17 INFO - 'MAIL': '/var/mail/cltbld', 06:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:17 INFO - 'MOZ_NO_REMOTE': '1', 06:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:17 INFO - 'NO_EM_RESTART': '1', 06:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:17 INFO - 'PWD': '/builds/slave/test', 06:05:17 INFO - 'SHELL': '/bin/bash', 06:05:17 INFO - 'SHLVL': '1', 06:05:17 INFO - 'TERM': 'linux', 06:05:17 INFO - 'TMOUT': '86400', 06:05:17 INFO - 'USER': 'cltbld', 06:05:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:17 INFO - '_': '/tools/buildbot/bin/python'} 06:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:17 INFO - Running setup.py (path:/tmp/pip-du3Wco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:17 INFO - Running setup.py (path:/tmp/pip-PQpZvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:17 INFO - Running setup.py (path:/tmp/pip-sQNcCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:17 INFO - Running setup.py (path:/tmp/pip-IKHz2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:17 INFO - Running setup.py (path:/tmp/pip-Bp1Yn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:17 INFO - Running setup.py (path:/tmp/pip-KZpgjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:17 INFO - Running setup.py (path:/tmp/pip-4i9gQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:17 INFO - Running setup.py (path:/tmp/pip-wmEcDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:17 INFO - Running setup.py (path:/tmp/pip-9WDc_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:17 INFO - Running setup.py (path:/tmp/pip-bCx4tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:17 INFO - Running setup.py (path:/tmp/pip-O3_qfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:18 INFO - Running setup.py (path:/tmp/pip-N7GNlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:18 INFO - Running setup.py (path:/tmp/pip-CXKTVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:18 INFO - Running setup.py (path:/tmp/pip-CtIzvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:18 INFO - Running setup.py (path:/tmp/pip-t0Lbaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:18 INFO - Running setup.py (path:/tmp/pip-nZxOMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:18 INFO - Running setup.py (path:/tmp/pip-Fr393e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:18 INFO - Running setup.py install for manifestparser 06:05:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozcrash 06:05:18 INFO - Running setup.py install for mozdebug 06:05:18 INFO - Running setup.py install for mozdevice 06:05:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozfile 06:05:18 INFO - Running setup.py install for mozhttpd 06:05:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozinfo 06:05:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Running setup.py install for mozInstall 06:05:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozleak 06:05:19 INFO - Running setup.py install for mozlog 06:05:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for moznetwork 06:05:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozprocess 06:05:19 INFO - Running setup.py install for mozprofile 06:05:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozrunner 06:05:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Running setup.py install for mozscreenshot 06:05:19 INFO - Running setup.py install for moztest 06:05:19 INFO - Running setup.py install for mozversion 06:05:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:19 INFO - Cleaning up... 06:05:19 INFO - Return code: 0 06:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05: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')]} 06:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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')]} 06:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:05:19 INFO - Using env: {'DISPLAY': ':0', 06:05:19 INFO - 'HOME': '/home/cltbld', 06:05:19 INFO - 'LANG': 'en_US.UTF-8', 06:05:19 INFO - 'LANGUAGE': 'en_US:en', 06:05:19 INFO - 'LOGNAME': 'cltbld', 06:05:19 INFO - 'MAIL': '/var/mail/cltbld', 06:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:19 INFO - 'MOZ_NO_REMOTE': '1', 06:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:19 INFO - 'NO_EM_RESTART': '1', 06:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:19 INFO - 'PWD': '/builds/slave/test', 06:05:19 INFO - 'SHELL': '/bin/bash', 06:05:19 INFO - 'SHLVL': '1', 06:05:19 INFO - 'TERM': 'linux', 06:05:19 INFO - 'TMOUT': '86400', 06:05:19 INFO - 'USER': 'cltbld', 06:05:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:19 INFO - '_': '/tools/buildbot/bin/python'} 06:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:20 INFO - Running setup.py (path:/tmp/pip-9IqlFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:20 INFO - Running setup.py (path:/tmp/pip-_YctKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:20 INFO - Running setup.py (path:/tmp/pip-ri5lxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:20 INFO - Running setup.py (path:/tmp/pip-Pe3Qb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:20 INFO - Running setup.py (path:/tmp/pip-EAOiZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:20 INFO - Running setup.py (path:/tmp/pip-_CxhJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:20 INFO - Running setup.py (path:/tmp/pip-k3FC5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:20 INFO - Running setup.py (path:/tmp/pip-2m3jPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:20 INFO - Running setup.py (path:/tmp/pip-FbxX2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:20 INFO - Running setup.py (path:/tmp/pip-ACce8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:20 INFO - Running setup.py (path:/tmp/pip-OKmTlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:20 INFO - Running setup.py (path:/tmp/pip-XYalEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:20 INFO - Running setup.py (path:/tmp/pip-z7hCHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:20 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)) 06:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:20 INFO - Running setup.py (path:/tmp/pip-WcqZl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:21 INFO - Running setup.py (path:/tmp/pip-2FfrA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:21 INFO - Running setup.py (path:/tmp/pip-CvANxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:21 INFO - Running setup.py (path:/tmp/pip-5Cjp1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:23 INFO - Downloading blessings-1.6.tar.gz 06:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:23 INFO - Installing collected packages: blessings 06:05:23 INFO - Running setup.py install for blessings 06:05:23 INFO - Successfully installed blessings 06:05:23 INFO - Cleaning up... 06:05:23 INFO - Return code: 0 06:05:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:23 INFO - Reading from file tmpfile_stdout 06:05:23 INFO - Current package versions: 06:05:23 INFO - argparse == 1.2.1 06:05:23 INFO - blessings == 1.6 06:05:23 INFO - blobuploader == 1.2.4 06:05:23 INFO - docopt == 0.6.1 06:05:23 INFO - manifestparser == 1.1 06:05:23 INFO - mozInstall == 1.12 06:05:23 INFO - mozcrash == 0.17 06:05:23 INFO - mozdebug == 0.1 06:05:23 INFO - mozdevice == 0.48 06:05:23 INFO - mozfile == 1.2 06:05:23 INFO - mozhttpd == 0.7 06:05:23 INFO - mozinfo == 0.9 06:05:23 INFO - mozleak == 0.1 06:05:23 INFO - mozlog == 3.1 06:05:23 INFO - moznetwork == 0.27 06:05:23 INFO - mozprocess == 0.22 06:05:23 INFO - mozprofile == 0.28 06:05:23 INFO - mozrunner == 6.11 06:05:23 INFO - mozscreenshot == 0.1 06:05:23 INFO - mozsystemmonitor == 0.0 06:05:23 INFO - moztest == 0.7 06:05:23 INFO - mozversion == 1.4 06:05:23 INFO - psutil == 3.1.1 06:05:23 INFO - requests == 1.2.3 06:05:23 INFO - wsgiref == 0.1.2 06:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:05:23 INFO - Using env: {'DISPLAY': ':0', 06:05:23 INFO - 'HOME': '/home/cltbld', 06:05:23 INFO - 'LANG': 'en_US.UTF-8', 06:05:23 INFO - 'LANGUAGE': 'en_US:en', 06:05:23 INFO - 'LOGNAME': 'cltbld', 06:05:23 INFO - 'MAIL': '/var/mail/cltbld', 06:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:23 INFO - 'MOZ_NO_REMOTE': '1', 06:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:23 INFO - 'NO_EM_RESTART': '1', 06:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:23 INFO - 'PWD': '/builds/slave/test', 06:05:23 INFO - 'SHELL': '/bin/bash', 06:05:23 INFO - 'SHLVL': '1', 06:05:23 INFO - 'TERM': 'linux', 06:05:23 INFO - 'TMOUT': '86400', 06:05:23 INFO - 'USER': 'cltbld', 06:05:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:23 INFO - '_': '/tools/buildbot/bin/python'} 06:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:05:23 INFO - Cleaning up... 06:05:23 INFO - Return code: 0 06:05:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:05:23 INFO - Using env: {'DISPLAY': ':0', 06:05:23 INFO - 'HOME': '/home/cltbld', 06:05:23 INFO - 'LANG': 'en_US.UTF-8', 06:05:23 INFO - 'LANGUAGE': 'en_US:en', 06:05:23 INFO - 'LOGNAME': 'cltbld', 06:05:23 INFO - 'MAIL': '/var/mail/cltbld', 06:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:23 INFO - 'MOZ_NO_REMOTE': '1', 06:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:23 INFO - 'NO_EM_RESTART': '1', 06:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:23 INFO - 'PWD': '/builds/slave/test', 06:05:23 INFO - 'SHELL': '/bin/bash', 06:05:23 INFO - 'SHLVL': '1', 06:05:23 INFO - 'TERM': 'linux', 06:05:23 INFO - 'TMOUT': '86400', 06:05:23 INFO - 'USER': 'cltbld', 06:05:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:23 INFO - '_': '/tools/buildbot/bin/python'} 06:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:23 INFO - Downloading/unpacking jsonschema 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:25 INFO - Downloading/unpacking functools32 (from jsonschema) 06:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:25 INFO - warning: no files found matching '*.txt' 06:05:25 INFO - no previously-included directories found matching 'build' 06:05:25 INFO - no previously-included directories found matching 'dist' 06:05:25 INFO - no previously-included directories found matching '.git*' 06:05:26 INFO - Installing collected packages: jsonschema, functools32 06:05:26 INFO - Running setup.py install for functools32 06:05:26 INFO - warning: no files found matching '*.txt' 06:05:26 INFO - no previously-included directories found matching 'build' 06:05:26 INFO - no previously-included directories found matching 'dist' 06:05:26 INFO - no previously-included directories found matching '.git*' 06:05:26 INFO - Successfully installed jsonschema functools32 06:05:26 INFO - Cleaning up... 06:05:26 INFO - Return code: 0 06:05:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd249e0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', '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 06:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:05:26 INFO - Using env: {'DISPLAY': ':0', 06:05:26 INFO - 'HOME': '/home/cltbld', 06:05:26 INFO - 'LANG': 'en_US.UTF-8', 06:05:26 INFO - 'LANGUAGE': 'en_US:en', 06:05:26 INFO - 'LOGNAME': 'cltbld', 06:05:26 INFO - 'MAIL': '/var/mail/cltbld', 06:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:26 INFO - 'MOZ_NO_REMOTE': '1', 06:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:26 INFO - 'NO_EM_RESTART': '1', 06:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:26 INFO - 'PWD': '/builds/slave/test', 06:05:26 INFO - 'SHELL': '/bin/bash', 06:05:26 INFO - 'SHLVL': '1', 06:05:26 INFO - 'TERM': 'linux', 06:05:26 INFO - 'TMOUT': '86400', 06:05:26 INFO - 'USER': 'cltbld', 06:05:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:26 INFO - '_': '/tools/buildbot/bin/python'} 06:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:26 INFO - Downloading/unpacking flake8 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:28 INFO - no previously-included directories found matching 'docs/_build' 06:05:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:29 INFO - Running setup.py install for pep8 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:29 INFO - no previously-included directories found matching 'docs/_build' 06:05:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:29 INFO - Cleaning up... 06:05:29 INFO - Return code: 0 06:05:29 INFO - Running post-action listener: _resource_record_post_action 06:05:29 INFO - Running post-action listener: _start_resource_monitoring 06:05:29 INFO - Starting resource monitoring. 06:05:29 INFO - ##### 06:05:29 INFO - ##### Running install step. 06:05:29 INFO - ##### 06:05:29 INFO - Running pre-action listener: _resource_record_pre_action 06:05:29 INFO - Running main action method: install 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:29 INFO - Reading from file tmpfile_stdout 06:05:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:29 INFO - Reading from file tmpfile_stdout 06:05:29 INFO - Output received: 06:05:29 INFO - Usage: mozinstall [options] installer 06:05:29 INFO - Options: 06:05:29 INFO - -h, --help show this help message and exit 06:05:29 INFO - -d DEST, --destination=DEST 06:05:29 INFO - Directory to install application into. [default: 06:05:29 INFO - "/builds/slave/test"] 06:05:29 INFO - --app=APP Application being installed. [default: firefox] 06:05:29 INFO - mkdir: /builds/slave/test/build/application 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:05:45 INFO - Reading from file tmpfile_stdout 06:05:45 INFO - Output received: 06:05:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:45 INFO - Running post-action listener: _resource_record_post_action 06:05:45 INFO - ##### 06:05:45 INFO - ##### Running run-tests step. 06:05:45 INFO - ##### 06:05:45 INFO - Running pre-action listener: _resource_record_pre_action 06:05:45 INFO - Running main action method: run_tests 06:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:45 INFO - Python 2.7.3 06:05:45 INFO - Return code: 0 06:05:45 INFO - grabbing minidump binary from tooltool 06:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2410>, '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 0x19a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:05:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:05:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:45 INFO - Return code: 0 06:05:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:46 INFO - Return code: 0 06:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 06:05:46 INFO - Using env: {'DISPLAY': ':0', 06:05:46 INFO - 'HOME': '/home/cltbld', 06:05:46 INFO - 'LANG': 'en_US.UTF-8', 06:05:46 INFO - 'LANGUAGE': 'en_US:en', 06:05:46 INFO - 'LOGNAME': 'cltbld', 06:05:46 INFO - 'MAIL': '/var/mail/cltbld', 06:05:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:46 INFO - 'MOZ_NO_REMOTE': '1', 06:05:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:46 INFO - 'NO_EM_RESTART': '1', 06:05:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:46 INFO - 'PWD': '/builds/slave/test', 06:05:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:46 INFO - 'SHELL': '/bin/bash', 06:05:46 INFO - 'SHLVL': '1', 06:05:46 INFO - 'TERM': 'linux', 06:05:46 INFO - 'TMOUT': '86400', 06:05:46 INFO - 'USER': 'cltbld', 06:05:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337', 06:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:46 INFO - '_': '/tools/buildbot/bin/python'} 06:05:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:05:46 INFO - mozversion application_buildid: 20160510032818 06:05:46 INFO - mozversion application_changeset: 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 06:05:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:05:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:46 INFO - mozversion application_name: Firefox 06:05:46 INFO - mozversion application_remotingname: firefox-dev 06:05:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:05:46 INFO - mozversion application_vendor: Mozilla 06:05:46 INFO - mozversion application_version: 48.0a2 06:05:46 INFO - mozversion platform_buildid: 20160510032818 06:05:46 INFO - mozversion platform_changeset: 4c5959b81fd5b61fe854f2d2e0743afa66f9aa07 06:05:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:05:46 INFO - mozversion platform_version: 48.0a2 06:05:46 INFO - using testdate: 1462885546 06:05:46 INFO - actual date: 1462885546 06:05:46 INFO - starting webserver on 'localhost:60528' 06:05:46 INFO - SUITE-START | Running 2 tests 06:05:46 INFO - TEST-START | dromaeo_css 06:05:46 INFO - operating with platform_type : linux_ 06:05:46 INFO - Initialising browser for dromaeo_css test... 06:05:46 INFO - TEST-INFO | started process 23423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcbncY/profile http://localhost:60528/getInfo.html) 06:05:49 INFO - PROCESS | 23423 | __metrics Screen width/height:1600/1200 06:05:49 INFO - PROCESS | 23423 | colorDepth:24 06:05:49 INFO - PROCESS | 23423 | Browser inner width/height: 1024/697 06:05:49 INFO - PROCESS | 23423 | __metrics 06:05:50 ERROR - PROCESS | 23423 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:05:51 INFO - TEST-INFO | 23423: exit 0 06:05:51 INFO - Browser initialized. 06:05:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:51 INFO - TEST-INFO | started process 23515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcbncY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:02 INFO - PROCESS | 23515 | RSS: Main: 141012992 06:06:02 INFO - PROCESS | 23515 | 06:06:54 INFO - PROCESS | 23515 | 1462885614213 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] 06:09:01 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60528/tests/dromaeo/cssquery-ext.html) 06:09:02 INFO - PROCESS | 23515 | RSS: Main: 271179776 06:09:02 INFO - PROCESS | 23515 | 06:12:04 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-ext.html (next: http://localhost:60528/tests/dromaeo/cssquery-jquery.html) 06:12:05 INFO - PROCESS | 23515 | RSS: Main: 226398208 06:12:05 INFO - PROCESS | 23515 | 06:15:06 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60528/tests/dromaeo/cssquery-mootools.html) 06:15:07 INFO - PROCESS | 23515 | RSS: Main: 224489472 06:15:07 INFO - PROCESS | 23515 | 06:18:09 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60528/tests/dromaeo/cssquery-prototype.html) 06:18:09 INFO - PROCESS | 23515 | RSS: Main: 220372992 06:18:09 INFO - PROCESS | 23515 | 06:21:12 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60528/tests/dromaeo/cssquery-yui.html) 06:21:12 INFO - PROCESS | 23515 | RSS: Main: 209887232 06:21:12 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | Cycle 1(1): loaded http://localhost:60528/tests/dromaeo/cssquery-yui.html (next: http://localhost:60528/tests/dromaeo/cssquery-dojo.html) 06:24:15 INFO - PROCESS | 23515 | RSS: Main: 255905792 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | __start_tp_report 06:24:15 INFO - PROCESS | 23515 | _x_x_mozilla_page_load 06:24:15 INFO - PROCESS | 23515 | _x_x_mozilla_page_load_details 06:24:15 INFO - PROCESS | 23515 | |i|pagename|runs| 06:24:15 INFO - PROCESS | 23515 | |0;dojo.html;3273.8526766295513;3331.4170020246465;3340.549025881506;3348.631650518441;3365.7643964922463;5431.511163995239;5491.313585801775;5497.8075767348155;5503.394626591072;5516.475934786199;5504.614676972614;5509.283793106901;5509.669419834802;5529.695866727328;5550.111982082867;4566.70316429431;5047.419546752125;5059.797608095671;5117.820876269331;5147.047796157704;4721.504242054586;4888.535589119028;4939.481354457784;4950.183219768734;4963.627727920402;4977.178765503688;5047.924281135786;5056.064628043824;5059.3169922060415;5077.238414237875;5056.494350564951;5103.515166059218;5114.974425127869;5119.283300337956;5127.641065125443;4930.926036109461;4930.939847932676;4991.925121123186;5008.899822003539;5032.119379108642;5319.6808191508635;5359.249705041298;5363.570914326883;5374.838754837361;5393.6763794172475;5781.306243250795;5784.987627165229;5785.942140578624;5790.218320526717;5834.737436815353;5925.111233315038;5946.375630558772;5999.340072592011;6014.428629280212;6033.306169790487;5550.611457197998;5579.191017302509;5614.9719251403485;5645.068563686987;5655.943440565583;6026.608270462406;6043.516518678495;6050.30421501533;6103.605404109035;6118.20463339763;5805.564582656233;5824.126381042877;5850.970745146247;5855.063189889597;5876.471117599436;5750.079987202028;5877.9118313225335;5936.436038576328;5960.284765828128;5990.101484777319;5949.940500595025;5992.161097446361;5997.670128142994;6021.006533921854;6040.788572399945;5900.763969441175;5979.1928089707335;6027.819165425044;6028.457438830526;6031.065184896348;4457.955420445819;4532.728036317765;4550.408446901882;4556.498785133633;4561.863144105682;4080.653144482693;4119.155573107566;4120.17596480705;4122.134351786159;4149.564295748964;5766.077427611562;5783.450572195635;5807.419258074159;5812.982728022579;5850.736716847752;5489.917651235235;6014.909776353358;6046.365131661112;6119.4416233545735;6121.239585875146;5746.02317606008;5759.6832174229985;5762.135679648002;5765.164051212634;5780.826575202751;5040.672356296829;5044.54599086084;5150.253213284052;5165.48345165488;5182.352205974254;6067.696615169224;6190.721417536131;6307.4954003679595;6321.525885558602;6357.809265722036;6019.187409699722;6032.155498230339;6032.245969253843;6038.788642397671;6046.062860256668;6121.47967422774;6143.389059649542;6202.875942481215;6206.410391012847;6216.067589861557;5941.494972927349;5946.256717910262;5951.732172052355;5973.313068997121;5983.58114931968;5975.372585878594;5981.970090149522;6007.158997740407;6028.4272994065495;6036.879262414815;5781.392953739797;5799.797007104731;5885.117232415001;5907;5961.850953726018;5891.968905441617;5896.174535564938;5900.5574581907385;5901.704914754331;5918.911216331845;5753.942460575341;5776.306843178845;5805.419458054161;5814.5348372130975;5815.738291776795;5712.80005199816;5830.096335068071;5931;5955;6004.609700369462;5570.972145139248;5618.887622247614;5773.278340207474;5775.653460792366;5785.595008349544 06:24:15 INFO - PROCESS | 23515 | |1;ext.html;593.8248216776051;634.1534052040529;645.819170632223;653.6306986552596;658.6443320606872;33653.66346336536;34273.1431714207;39890.601093989055;40795.59204407955;41045.179096418055;42485;43112.13775724483;43562.56437435625;43597;43637;7890.842183156334;8744.781380465476;8976.820463590724;8990.37067405282;9005.054469280729;10616.681499554987;10932.781344373108;10959.616413425532;10988.560457581687;10988.670339889775;10683.572657093708;10742.73143171423;10742.73143171423;10774.19193560486;10781.46092695366;8087.555184464852;10462.163026957825;10541.841872371882;10734.624288149955;10996.340219586851;10475.79048419035;10507.159427245802;10515.316504427188;10573.418461984587;10600.522976466078;40138.79930600357;40747;40843.59156408457;40874;40887.1822563547;3593.119685677;3648.890533284006;3934.7639141651307;3984.980075099606;4341.848035318781;33207.833960830045;33310.83344583261;33832;34817.129571760655;35118.64881351179;4083.3466645336903;4175.373693945902;4175.645070169039;4195.538490766014;4211.852585159505;344923;345987;346848;346953;348468;39445.21109577792;40210.59789402127;40321.59678403237;40333.39499907504;65015.67492162509;37442;37500;37613.24773504569;37715;37758;17005.06472144019;17022.659546808994;17087.743683844754;17139.485815425556;17172.570685732957;13204.867951320364;13996.16023038621;14215.928920355333;14693.706125877423;14892.329845156994;9147.634094636272;9184.954075229582;9201.953990230006;9219.262459003263;9237.399569027992;3499.807510586942;3596.244788594372;3597.5143355647174;3602.4056030755155;3625.927481450409;1068.2041878800344;1113.2485572238706;1137.4028634966708;1196.9526664168852;1216.2033867816594;33460;33531.4970275446;33907.982760517225;34908.650913491045;34942.65057349394;1203.8796120388067;1218.4273391505978;1261.3377976562194;1282.076904628666;1298.6493646715335;17644.382446614563;17966.371177009005;18039.368622098165;18054;18145.45563633093;473629;481894;482996;484390;485417;64187.679061604395;65079.67460162669;65107.34892651108;65359.67320163369;65631;1483.7180935622414;1517.0215211188722;1532.5095969289944;1549.5738671865327;1646.4895882276533;31053.8447307762;32459;32544.674553254164;32923.835380822944;33247.83376083104;49273.753631231615;50616;50671;50736.23895641642;50908.23637645364;438907.8054609707;446194;446877;447607;448126;40033.399499006955;42478.57521424746;48459;48915;49301.26048109353;48043.39674524494;48915.0216995651;49728.75135624299;49749.502504975935;53194;39749.205015898944;40484.79757601193;41032.58967410407;41416.79291603643;42212;40463.393049103695;40873;40873.795631021654;41051.58948410597;41561.37657935194;41152.58847411607;41212;41903.7904810474;42219.57780422157;42525.36211956885;35059.29881402307;39413;39437.12289615779;39818.80090599528;40034;29800.850995744884;30075.398492030476;30193.849030754707;30566.694333057276;30623.387532248784 06:24:15 INFO - PROCESS | 23515 | |2;jquery.html;441.29172677852046;442.539480488484;442.7033887295512;446.72972851424885;453.48755905826414;18488.537786555342;18528.44414667559;19084.23663053478;20543.794562054376;20584.588308233862;19747.901260493676;19936.401907942785;20045;20096.59806803863;20126.698099528483;5204.947950520494;5727.856803579903;5734.5125664318375;5736.311642602894;5759.769609215627;4198.538160802309;5621.241132447109;5727.198192253067;6027.186329845458;6346.30190679025;6220.595661282025;6283.088952101965;6304.873902521947;6307.936920630781;6316.842078948017;5997.250343707036;6246.718897649594;6253.781117660906;6259.467945224661;6263.342349053375;3932.154586763831;5262.973685131588;5536.640118392292;5600.0759874620635;5650.802221922254;22992.195273165526;23033.309000730005;23210.53578928412;23325.53348933029;23414;2615.8299710518754;2653.204038788375;2756.131818477173;2940.911772646824;3261.59230096238;14229.715405691932;14931.328090235966;15137.772933405897;15392.692146157015;15842.76235856463;2060.526079001823;2107.167668770827;2136.3590922723274;2146.903389347483;2163.286115581854;82151;82716;86444;86718;86776.13223867807;11187.272827266203;11373.374464404536;11587.246828956091;11678.124140689482;11761.294322340687;16249.512514624581;16296.674066518603;16400.507984760476;16532.256048477848;16578;9168.332666933147;9177.724668259963;9267;9315.068493150631;9383.343165978316;9183.173514383738;9184.448933063904;9203.539823008823;9206.677766278148;9313.161815436642;7100.360967512948;7281.271872812782;7284.490085694057;7289.781306560812;7298.160711518137;1820.8972938755985;1930.9324173653854;2029;2096.2453516733963;2116.6613341865227;997.3816233935007;1091.3233795046963;1156.9537218511166;1185.8043422835308;1201.3152503073165;18189.363372281907;18483.260669573065;18889.7166542502;18925.242990280236;19331.613367732567;1042.0985847242082;1063.6649455421518;1066.4134725900724;1095.2990086344746;1146.2205700123995;6348.746050158034;6520.119783829217;6616.933830661632;6620.635865027373;6673;548844;551428;561684;563359.1677035417;565371;93802;94941.52529237448;97874.5106274464;97943;98106.50946745221;491.4962163782152;500.91985282355375;505.87858913860407;506.98225562105887;511.836212412032;9671.17794987434;10196.796064078826;10687.5190616424;11223.88776112261;16031.278592463601;23281.18515851937;39255.41116883192;41726.37410438906;43821.561784381745;43884.78057609691;58156.709216453644;58896;59172.1124183129;60145.69927150336;60630.696846515486;8893.955530222307;8962.551872406224;9125;9162.221211196857;9222.262219022596;9585.712428627152;11747.29516229029;12827;13028.28344441027;13194.670133246746;11902.940485297519;12495.437705303102;12686.965945354785;12713.491460341484;12763.170393924365;8767.912320876709;11683.824742628698;12232.32722200252;12415.565455209024;12454.688632784253;6506.186726659168;9661.985491523288;11378.203525753117;12471.875281247072;12484.063695222712;8548.358873084668;8835.116488351114;8916.821663566821;8922.107789221285;8996.460212387277;10815.24293299493;12199.817002745143;12266.711995240372;12339.814902776645;12408.56570020045 06:24:15 INFO - PROCESS | 23515 | |3;mootools.html;1471.57324375931;1598.5524053265087;1621.5946013496625;1849.9907500462496;1938.7867334593202;8110.4322697411135;8303.792405189874;8357.080721120672;8388.958055209723;8389.874151887727;8190.303824174937;8486.278666313356;8490.53302068386;8493.49039057657;8498.192671696195;2152.8600640958366;2373.169390713254;2382.8212884033724;2413.746556611557;2425.7331693513697;2442.7068751749816;2453.668754718117;2469.4814089041324;2469.925902222936;2473.084958565333;2377.9643305350432;2401.0515846240723;2406.855588664677;2409.795167410772;2413.650020746991;2089.8432617553667;2313.5025969416574;2370.885683728645;2373.9791889487515;2376.346504711192;2297.24191016964;2298.747137814839;2304.5506126305377;2307.619242824932;2334.1480359668767;8050.15473375293;8098.635561399751;8124.1875812418875;8136.34909207262;8140.389470789714;5144.639875208737;5301.60237982149;5324.387695414999;5328.413874473805;5465.535429488498;3359.5296658467832;3363.680450357212;3403.931921361559;3433.484977253432;3485.5643044619424;1157.1148071725138;1164.7667981832828;1171.677788608131;1183.9822402663967;1218.5186851193728;11582.420878956018;11630.592929247436;11651.533938642444;11659.067274618095;11674.708132296675;4546.65900057497;4618.422697162855;4628.4445866496235;4753.215719406328;4755.429348478136;9908.80182396348;9963.252756043326;9969.40183588987;9978.650747223812;9982.151517120981;4915.803367865316;5278.445763194886;5278.841634750964;5290.391604965402;5292.629515933924;4876.658633895664;4885.877853053702;4945.901081978341;4950.133726597831;4997.575206107449;4073.165001174752;4096.672266218696;4122.958770412318;4134.235166494148;4147.3778933159665;1313.6190504753706;1318.6044186743939;1319.9340032998311;1329.6210579984659;1330.9267990260435;966.7534778631403;976.6484065736329;1004.7488127968008;1035.984460233097;1066.0991462214417;5716.57125715573;5775.104858746901;5864.237649105589;5895.705214739246;5921.911171332434;447.17719396310946;449.4965638484918;451.80120746871273;452.76003718029494;453.7776489520177;3975.8807235782974;3986.5415477219913;4008.679305655599;4020.296448121567;4071.75569465833;9346.57940392684;9523.28575356851;9558.330916835755;9676.322657413913;9729.854052189223;9516.095970882756;9525.095115963972;9533.142017218484;9536.904630953602;9609.663661771805;7560.092788865371;7612.657430415645;7643.7324693635455;7677.270659287359;7975.042994840773;5604.635698679573;5630.465105814941;5719.5710321726865;5749.9712501437225;5800.1299805029585;8870.42342247752;8903.109689031045;8992.775180620536;9097.636094556408;9098.59056342453;9144.1770240676;9175.577785443267;9246.907530924605;9512.571934263113;9524.047595240698;6838.179418469616;7130.5365151265005;7344.155422126524;7563.621818909142;7645.88531172044;7914.366850652049;7951.681932722627;7967.725163973968;7972.920270797218;7996.920030799618;6857.245702972569;7247.2390399007345;7252;7264.418846492163;7541.208173141741;7255.238199989136;7353.852922941404;7393;7430.071241094864;7448.6275686214385;6802.115724955922;6839.110915580943;6852.6916288768125;6862.656867156722;6876.553024053421;5262.526372626482;5335.413104558573;5348.224507446476;5467.07059799827;5532.557395408277;5196.68819870809;5290.153575428067;5313.149896016619;5345.1714984177515;5360.2227676987395 06:24:15 INFO - PROCESS | 23515 | |4;prototype.html;354.30025699244;360.38194496438604;362.95644522657284;373.84485438543004;375.7013174526251;6051.304100028498;6238.4697300729495;6253.187085678861;6303.275123360803;6311.810645680625;6015.669138197398;6115.785947491839;6119.9388006119925;6146.078088286759;6161.845953851156;4468.50846406895;4518.525554816746;4627.490975992638;4693.20215563355;4711.670183087185;4640.930386044212;4666.929996050062;4712.481627021025;4738.857834264978;4749.168895443301;4628.814847406116;4638.953610463903;4640.164770341337;4640.3967484227005;4645.62834973203;4476.731396116227;4504.842330518449;4630.652701047435;4654.743219330779;4662.743549104798;4057.2291264659916;4070.409790580349;4076.30702780528;4076.612721791425;4097.836086556535;5810.5932584719085;5821.09772985188;5842.2405087338375;5849.210356601847;5862.941370586324;5378.193271009341;5395.73021348931;5398.865028374283;5406.810761623364;5412.161115027177;6397.648129352884;6410.230772307306;6411.326810684857;6413.134226879405;6420.0690899819265;4252.87241382759;4411.602955733967;4422.005048864012;4513.593776560093;4515.029268707211;6554.541182117254;6669.333066693341;6675.899861502081;6737.898931516032;6745.999999999951;4588.082383523309;4590.472095708969;4601.562851529099;4602.125596136723;4643.582077613031;4650.139724151043;4655.86032419028;4663.673542851968;4674.813007479663;4692.991006933526;5378.1663842104535;5385.246065550826;5403.891922161535;5410.188471729193;5414.106672399089;6202.503799696014;6421.229452465734;6464.903026454513;6474.643894585749;6490.221173459215;1610.8308627593933;1630.5271471273197;1638.475687779899;1639.0903048807788;1651.5540803983097;1023.8259495885717;1056.8995945385177;1084.2572837606108;1103.2883789955433;1111.5109351885144;6134.601250918676;6260.092286618506;6260.718267677966;6269.247690277196;6280.685965701697;6627.536072474977;6637.701303441357;6644.302348253461;6728.562643428161;6731.32686731323;6258.530610204253;6319.925612645861;6337.493000560036;6354.142190804182;6366.745330186834;3553.8223088845452;3598.7660802047785;3606.2426890352795;3607.8015709135725;3610.981945090258;6817.386435220854;6977.092977912839;6988.93011069893;7017.017617533549;7028.086348774729;6789.898151527731;6824.18109826814;6825.965870170717;6834.4874134440115;6847.794566163023;6941.583504989717;6951.200611929592;6964.303569642995;6991.440684745208;7010.509264351548;6648.867022659423;6659.101021362054;6668.633225172662;6674.466042716668;6712.765053223114;6364.236291644847;6562.8359291018105;6596;6602.372774586406;6606.405423511907;6906.723731050903;6910.861782764216;6912.377885990285;6952.096227490394;6963.338482844122;4540.545945405433;4606.262997920317;4607.2398054322;4608.470025946925;4620;6692.263850976486;6700.46396288286;6712.093867327848;6713.865722685421;6727.629980350932;6402.679866006774;6497.415232629086;6500;6514.478841692748;6538.411542961157;6503.967480162569;6512.34876512345;6522.293248301901;6531.954887218022;6541.411272985454;6387.8501869663905;6400.743970241325;6404.391582799627;6408.935910640834;6430.2926678066315;6572.047053177167;6578.177727784027;6585.341465853377;6590.143281373583;6592.17597800275;6054.697265136813;6240.843978900564;6431.228252609717;6447.258565265054;6456.289808121197 06:24:15 INFO - PROCESS | 23515 | |5;yui.html;858.9606576042984;870.6125774030555;894.4990805149117;910.7677542226731;943.1417410156756;14953.700925981473;15049.548513544598;15491.457798977039;15513.534593962198;15529.611759706013;14090.577282681536;14487.130772153678;14713.852861471381;14745.378008419093;14752.778708319356;764.4648745877907;914.0996118822954;920.0339643374464;922.6309476209502;925.5973651461636;901.5537309032038;922.6032805893464;923.2798417234568;923.372106967262;928.8792456980617;957.5643082397527;966.8549717542389;971.6987733802508;975.2198241406882;975.7316737897064;801.0907619851453;954.6992697300328;956.3687965942479;956.9234461243119;958.6644674364021;709.1171491493072;709.5671640299413;710.683745733149;712.5048091576357;712.7256006437507;14746;14782.556523304318;14792.482263120846;14848.10911345312;14884.330205140795;13971.510997115154;14126;14912.403503859832;14948.177850218233;14964.251787410694;11731.7067073323;11950.342731149784;12037.458314375874;12514.249145051326;12527.060470464661;4073.8574149904907;4089.141280331134;4115.0741083256025;4168.958310416918;4187.246295666779;56372.43627563672;56511.71744141294;56600.716996414754;56860.14709779315;57024;11372.14708896836;11717.824232636518;11845.170838041255;11872.821907671392;12039.458224379923;21392.251271205434;21461.67807482889;21473.785262147492;21485.355439336843;21486.892565537386;8649.567521623894;8913.55432228386;9170.991190968987;9296.907030929604;9392.154706076486;5029.1450453423;5049.974750126299;5068.543831055223;5094.6688465249645;5261.947380526222;3642.3261696586214;3723.404255319136;3725.3108174987715;3732.253549290153;3733.906652333659;657.4050484311706;670.7417644206918;671.301846080081;680.1566058088034;688.2223087910629;709.5671640299413;710.8258476673249;726.96728647211;777.9222077792175;809.6437567470294;9495.715128546155;9856.359336643096;9922.80154396908;9923.900760992297;9925.65260215889;701.5264696329957;743.9993209133706;751.504007355143;766.7124828189429;822.2599660305773;4535.206338890681;4538.2738761797955;4548.226801443762;4629.189891768927;4657.504363001764;62982.68508657519;62993.68503157455;63435.68282158559;63447.36552634507;63523.682381587794;50592.24111638328;51035.48964510307;51729.22406163911;51811.22283165756;56339.15491267634;43844.342334865;44748.3287750684;45337.54662453333;45443.772781135885;46010.539894601294;10086.8486972694;10251.794964100825;10397.272190946562;10477.68566942993;10495.79008419812;37846.2430751389;38556.228875422894;38863.41704874373;39472.605273946894;39627.60372396239;50905.236421452966;51690.483095168565;53671.7316413431;56856.43143568677;59036;12890.41993110331;13165.60503184906;13380.866191338351;13999.16005039701;14045.297735113;14194.432222710975;14299.213543254804;14308.284585770878;14407.495737649131;14435.92782036125;13366.465341386236;13432.328383580978;13468.191908485522;13589.86410135886;13829.79255311151;13687.247201404018;13879.444822206999;14083.718325633225;14491.275436227936;14530.346134424188;13344.06591538583;13439.798403023768;13450.798238026633;13466.85531729814;13767.38046787877;11412.600558980395;11559;11768.646940591796;11930.522779088738;12082.697932551757;11293.661190164308;11375.772484550098;11375.829362559734;11383.260088094248;11747.633128742751 06:24:15 INFO - PROCESS | 23515 | __end_tp_report 06:24:15 INFO - PROCESS | 23515 | __start_cc_report 06:24:15 INFO - PROCESS | 23515 | _x_x_mozilla_cycle_collect,1020 06:24:15 INFO - PROCESS | 23515 | __end_cc_report 06:24:15 INFO - PROCESS | 23515 | __startTimestamp1462886655382__endTimestamp 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | ------- Summary: start ------- 06:24:15 INFO - PROCESS | 23515 | Number of tests: 6 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#0] dojo.html Cycles:165 Average:5538.73 Median:5783.45 stddev:635.72 (11.0%) stddev-sans-first:612.34 06:24:15 INFO - PROCESS | 23515 | Values: 3273.9 3331.4 3340.5 3348.6 3365.8 5431.5 5491.3 5497.8 5503.4 5516.5 5504.6 5509.3 5509.7 5529.7 5550.1 4566.7 5047.4 5059.8 5117.8 5147.0 4721.5 4888.5 4939.5 4950.2 4963.6 4977.2 5047.9 5056.1 5059.3 5077.2 5056.5 5103.5 5115.0 5119.3 5127.6 4930.9 4930.9 4991.9 5008.9 5032.1 5319.7 5359.2 5363.6 5374.8 5393.7 5781.3 5785.0 5785.9 5790.2 5834.7 5925.1 5946.4 5999.3 6014.4 6033.3 5550.6 5579.2 5615.0 5645.1 5655.9 6026.6 6043.5 6050.3 6103.6 6118.2 5805.6 5824.1 5851.0 5855.1 5876.5 5750.1 5877.9 5936.4 5960.3 5990.1 5949.9 5992.2 5997.7 6021.0 6040.8 5900.8 5979.2 6027.8 6028.5 6031.1 4458.0 4532.7 4550.4 4556.5 4561.9 4080.7 4119.2 4120.2 4122.1 4149.6 5766.1 5783.5 5807.4 5813.0 5850.7 5489.9 6014.9 6046.4 6119.4 6121.2 5746.0 5759.7 5762.1 5765.2 5780.8 5040.7 5044.5 5150.3 5165.5 5182.4 6067.7 6190.7 6307.5 6321.5 6357.8 6019.2 6032.2 6032.2 6038.8 6046.1 6121.5 6143.4 6202.9 6206.4 6216.1 5941.5 5946.3 5951.7 5973.3 5983.6 5975.4 5982.0 6007.2 6028.4 6036.9 5781.4 5799.8 5885.1 5907.0 5961.9 5892.0 5896.2 5900.6 5901.7 5918.9 5753.9 5776.3 5805.4 5814.5 5815.7 5712.8 5830.1 5931.0 5955.0 6004.6 5571.0 5618.9 5773.3 5775.7 5785.6 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#1] ext.html Cycles:180 Average:58579.37 Median:39425.06 stddev:113287.68 (287.3%) stddev-sans-first:113521.83 06:24:15 INFO - PROCESS | 23515 | Values: 593.8 634.2 645.8 653.6 658.6 33653.7 34273.1 39890.6 40795.6 41045.2 42485.0 43112.1 43562.6 43597.0 43637.0 7890.8 8744.8 8976.8 8990.4 9005.1 10616.7 10932.8 10959.6 10988.6 10988.7 10683.6 10742.7 10742.7 10774.2 10781.5 8087.6 10462.2 10541.8 10734.6 10996.3 10475.8 10507.2 10515.3 10573.4 10600.5 40138.8 40747.0 40843.6 40874.0 40887.2 3593.1 3648.9 3934.8 3985.0 4341.8 33207.8 33310.8 33832.0 34817.1 35118.6 4083.3 4175.4 4175.6 4195.5 4211.9 344923.0 345987.0 346848.0 346953.0 348468.0 39445.2 40210.6 40321.6 40333.4 65015.7 37442.0 37500.0 37613.2 37715.0 37758.0 17005.1 17022.7 17087.7 17139.5 17172.6 13204.9 13996.2 14215.9 14693.7 14892.3 9147.6 9185.0 9202.0 9219.3 9237.4 3499.8 3596.2 3597.5 3602.4 3625.9 1068.2 1113.2 1137.4 1197.0 1216.2 33460.0 33531.5 33908.0 34908.7 34942.7 1203.9 1218.4 1261.3 1282.1 1298.6 17644.4 17966.4 18039.4 18054.0 18145.5 473629.0 481894.0 482996.0 484390.0 485417.0 64187.7 65079.7 65107.3 65359.7 65631.0 1483.7 1517.0 1532.5 1549.6 1646.5 31053.8 32459.0 32544.7 32923.8 33247.8 49273.8 50616.0 50671.0 50736.2 50908.2 438907.8 446194.0 446877.0 447607.0 448126.0 40033.4 42478.6 48459.0 48915.0 49301.3 48043.4 48915.0 49728.8 49749.5 53194.0 39749.2 40484.8 41032.6 41416.8 42212.0 40463.4 40873.0 40873.8 41051.6 41561.4 41152.6 41212.0 41903.8 42219.6 42525.4 35059.3 39413.0 39437.1 39818.8 40034.0 29800.9 30075.4 30193.8 30566.7 30623.4 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#2] jquery.html Cycles:180 Average:31146.08 Median:22163.04 stddev:91846.27 (414.4%) stddev-sans-first:92074.98 06:24:15 INFO - PROCESS | 23515 | Values: 441.3 442.5 442.7 446.7 453.5 18488.5 18528.4 19084.2 20543.8 20584.6 19747.9 19936.4 20045.0 20096.6 20126.7 5204.9 5727.9 5734.5 5736.3 5759.8 4198.5 5621.2 5727.2 6027.2 6346.3 6220.6 6283.1 6304.9 6307.9 6316.8 5997.3 6246.7 6253.8 6259.5 6263.3 3932.2 5263.0 5536.6 5600.1 5650.8 22992.2 23033.3 23210.5 23325.5 23414.0 2615.8 2653.2 2756.1 2940.9 3261.6 14229.7 14931.3 15137.8 15392.7 15842.8 2060.5 2107.2 2136.4 2146.9 2163.3 82151.0 82716.0 86444.0 86718.0 86776.1 11187.3 11373.4 11587.2 11678.1 11761.3 16249.5 16296.7 16400.5 16532.3 16578.0 9168.3 9177.7 9267.0 9315.1 9383.3 9183.2 9184.4 9203.5 9206.7 9313.2 7100.4 7281.3 7284.5 7289.8 7298.2 1820.9 1930.9 2029.0 2096.2 2116.7 997.4 1091.3 1157.0 1185.8 1201.3 18189.4 18483.3 18889.7 18925.2 19331.6 1042.1 1063.7 1066.4 1095.3 1146.2 6348.7 6520.1 6616.9 6620.6 6673.0 548844.0 551428.0 561684.0 563359.2 565371.0 93802.0 94941.5 97874.5 97943.0 98106.5 491.5 500.9 505.9 507.0 511.8 9671.2 10196.8 10687.5 11223.9 16031.3 23281.2 39255.4 41726.4 43821.6 43884.8 58156.7 58896.0 59172.1 60145.7 60630.7 8894.0 8962.6 9125.0 9162.2 9222.3 9585.7 11747.3 12827.0 13028.3 13194.7 11902.9 12495.4 12687.0 12713.5 12763.2 8767.9 11683.8 12232.3 12415.6 12454.7 6506.2 9662.0 11378.2 12471.9 12484.1 8548.4 8835.1 8916.8 8922.1 8996.5 10815.2 12199.8 12266.7 12339.8 12408.6 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#3] mootools.html Cycles:180 Average:5545.95 Median:5331.91 stddev:2983.09 (55.9%) stddev-sans-first:2975.74 06:24:15 INFO - PROCESS | 23515 | Values: 1471.6 1598.6 1621.6 1850.0 1938.8 8110.4 8303.8 8357.1 8389.0 8389.9 8190.3 8486.3 8490.5 8493.5 8498.2 2152.9 2373.2 2382.8 2413.7 2425.7 2442.7 2453.7 2469.5 2469.9 2473.1 2378.0 2401.1 2406.9 2409.8 2413.7 2089.8 2313.5 2370.9 2374.0 2376.3 2297.2 2298.7 2304.6 2307.6 2334.1 8050.2 8098.6 8124.2 8136.3 8140.4 5144.6 5301.6 5324.4 5328.4 5465.5 3359.5 3363.7 3403.9 3433.5 3485.6 1157.1 1164.8 1171.7 1184.0 1218.5 11582.4 11630.6 11651.5 11659.1 11674.7 4546.7 4618.4 4628.4 4753.2 4755.4 9908.8 9963.3 9969.4 9978.7 9982.2 4915.8 5278.4 5278.8 5290.4 5292.6 4876.7 4885.9 4945.9 4950.1 4997.6 4073.2 4096.7 4123.0 4134.2 4147.4 1313.6 1318.6 1319.9 1329.6 1330.9 966.8 976.6 1004.7 1036.0 1066.1 5716.6 5775.1 5864.2 5895.7 5921.9 447.2 449.5 451.8 452.8 453.8 3975.9 3986.5 4008.7 4020.3 4071.8 9346.6 9523.3 9558.3 9676.3 9729.9 9516.1 9525.1 9533.1 9536.9 9609.7 7560.1 7612.7 7643.7 7677.3 7975.0 5604.6 5630.5 5719.6 5750.0 5800.1 8870.4 8903.1 8992.8 9097.6 9098.6 9144.2 9175.6 9246.9 9512.6 9524.0 6838.2 7130.5 7344.2 7563.6 7645.9 7914.4 7951.7 7967.7 7972.9 7996.9 6857.2 7247.2 7252.0 7264.4 7541.2 7255.2 7353.9 7393.0 7430.1 7448.6 6802.1 6839.1 6852.7 6862.7 6876.6 5262.5 5335.4 5348.2 5467.1 5532.6 5196.7 5290.2 5313.1 5345.2 5360.2 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#4] prototype.html Cycles:180 Average:5423.20 Median:6247.02 stddev:1640.68 (26.3%) stddev-sans-first:1600.56 06:24:15 INFO - PROCESS | 23515 | Values: 354.3 360.4 363.0 373.8 375.7 6051.3 6238.5 6253.2 6303.3 6311.8 6015.7 6115.8 6119.9 6146.1 6161.8 4468.5 4518.5 4627.5 4693.2 4711.7 4640.9 4666.9 4712.5 4738.9 4749.2 4628.8 4639.0 4640.2 4640.4 4645.6 4476.7 4504.8 4630.7 4654.7 4662.7 4057.2 4070.4 4076.3 4076.6 4097.8 5810.6 5821.1 5842.2 5849.2 5862.9 5378.2 5395.7 5398.9 5406.8 5412.2 6397.6 6410.2 6411.3 6413.1 6420.1 4252.9 4411.6 4422.0 4513.6 4515.0 6554.5 6669.3 6675.9 6737.9 6746.0 4588.1 4590.5 4601.6 4602.1 4643.6 4650.1 4655.9 4663.7 4674.8 4693.0 5378.2 5385.2 5403.9 5410.2 5414.1 6202.5 6421.2 6464.9 6474.6 6490.2 1610.8 1630.5 1638.5 1639.1 1651.6 1023.8 1056.9 1084.3 1103.3 1111.5 6134.6 6260.1 6260.7 6269.2 6280.7 6627.5 6637.7 6644.3 6728.6 6731.3 6258.5 6319.9 6337.5 6354.1 6366.7 3553.8 3598.8 3606.2 3607.8 3611.0 6817.4 6977.1 6988.9 7017.0 7028.1 6789.9 6824.2 6826.0 6834.5 6847.8 6941.6 6951.2 6964.3 6991.4 7010.5 6648.9 6659.1 6668.6 6674.5 6712.8 6364.2 6562.8 6596.0 6602.4 6606.4 6906.7 6910.9 6912.4 6952.1 6963.3 4540.5 4606.3 4607.2 4608.5 4620.0 6692.3 6700.5 6712.1 6713.9 6727.6 6402.7 6497.4 6500.0 6514.5 6538.4 6504.0 6512.3 6522.3 6532.0 6541.4 6387.9 6400.7 6404.4 6408.9 6430.3 6572.0 6578.2 6585.3 6590.1 6592.2 6054.7 6240.8 6431.2 6447.3 6456.3 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - PROCESS | 23515 | [#5] yui.html Cycles:180 Average:15603.16 Median:44296.34 stddev:17469.26 (39.4%) stddev-sans-first:17483.18 06:24:15 INFO - PROCESS | 23515 | Values: 859.0 870.6 894.5 910.8 943.1 14953.7 15049.5 15491.5 15513.5 15529.6 14090.6 14487.1 14713.9 14745.4 14752.8 764.5 914.1 920.0 922.6 925.6 901.6 922.6 923.3 923.4 928.9 957.6 966.9 971.7 975.2 975.7 801.1 954.7 956.4 956.9 958.7 709.1 709.6 710.7 712.5 712.7 14746.0 14782.6 14792.5 14848.1 14884.3 13971.5 14126.0 14912.4 14948.2 14964.3 11731.7 11950.3 12037.5 12514.2 12527.1 4073.9 4089.1 4115.1 4169.0 4187.2 56372.4 56511.7 56600.7 56860.1 57024.0 11372.1 11717.8 11845.2 11872.8 12039.5 21392.3 21461.7 21473.8 21485.4 21486.9 8649.6 8913.6 9171.0 9296.9 9392.2 5029.1 5050.0 5068.5 5094.7 5261.9 3642.3 3723.4 3725.3 3732.3 3733.9 657.4 670.7 671.3 680.2 688.2 709.6 710.8 727.0 777.9 809.6 9495.7 9856.4 9922.8 9923.9 9925.7 701.5 744.0 751.5 766.7 822.3 4535.2 4538.3 4548.2 4629.2 4657.5 62982.7 62993.7 63435.7 63447.4 63523.7 50592.2 51035.5 51729.2 51811.2 56339.2 43844.3 44748.3 45337.5 45443.8 46010.5 10086.8 10251.8 10397.3 10477.7 10495.8 37846.2 38556.2 38863.4 39472.6 39627.6 50905.2 51690.5 53671.7 56856.4 59036.0 12890.4 13165.6 13380.9 13999.2 14045.3 14194.4 14299.2 14308.3 14407.5 14435.9 13366.5 13432.3 13468.2 13589.9 13829.8 13687.2 13879.4 14083.7 14491.3 14530.3 13344.1 13439.8 13450.8 13466.9 13767.4 11412.6 11559.0 11768.6 11930.5 12082.7 11293.7 11375.8 11375.8 11383.3 11747.6 06:24:15 INFO - PROCESS | 23515 | -------- Summary: end -------- 06:24:15 INFO - PROCESS | 23515 | 06:24:15 INFO - TEST-INFO | 23515: exit 0 06:24:15 INFO - TEST-OK | dromaeo_css | took 1109691ms 06:24:15 INFO - TEST-START | kraken 06:24:15 INFO - operating with platform_type : linux_ 06:24:15 INFO - Initialising browser for kraken test... 06:24:15 INFO - TEST-INFO | started process 23710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBL5KcM/profile http://localhost:60528/getInfo.html) 06:24:19 INFO - PROCESS | 23710 | __metrics Screen width/height:1600/1200 06:24:19 INFO - PROCESS | 23710 | colorDepth:24 06:24:19 INFO - PROCESS | 23710 | Browser inner width/height: 1024/697 06:24:19 INFO - PROCESS | 23710 | __metrics 06:24:20 ERROR - PROCESS | 23710 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:24:20 INFO - TEST-INFO | 23710: exit 0 06:24:20 INFO - Browser initialized. 06:24:20 INFO - Running cycle 1/1 for kraken test... 06:24:20 INFO - TEST-INFO | started process 23799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBL5KcM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:32 INFO - PROCESS | 23799 | RSS: Main: 140800000 06:24:32 INFO - PROCESS | 23799 | 06:24:34 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60528/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:35 INFO - PROCESS | 23799 | RSS: Main: 196370432 06:24:35 INFO - PROCESS | 23799 | 06:24:38 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60528/tests/kraken/driver.html?testName=audio-dft) 06:24:38 INFO - PROCESS | 23799 | RSS: Main: 181252096 06:24:38 INFO - PROCESS | 23799 | 06:24:41 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60528/tests/kraken/driver.html?testName=audio-fft) 06:24:42 INFO - PROCESS | 23799 | RSS: Main: 272617472 06:24:42 INFO - PROCESS | 23799 | 06:24:44 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60528/tests/kraken/driver.html?testName=audio-oscillator) 06:24:44 INFO - PROCESS | 23799 | RSS: Main: 178495488 06:24:44 INFO - PROCESS | 23799 | 06:24:46 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:47 INFO - PROCESS | 23799 | RSS: Main: 176865280 06:24:47 INFO - PROCESS | 23799 | 06:24:50 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60528/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:50 INFO - PROCESS | 23799 | RSS: Main: 211554304 06:24:50 INFO - PROCESS | 23799 | 06:24:54 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60528/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:54 INFO - PROCESS | 23799 | RSS: Main: 210202624 06:24:54 INFO - PROCESS | 23799 | 06:24:57 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60528/tests/kraken/driver.html?testName=json-parse-financial) 06:24:58 INFO - PROCESS | 23799 | RSS: Main: 210665472 06:24:58 INFO - PROCESS | 23799 | 06:24:59 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:25:00 INFO - PROCESS | 23799 | RSS: Main: 191070208 06:25:00 INFO - PROCESS | 23799 | 06:25:02 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:02 INFO - PROCESS | 23799 | RSS: Main: 194990080 06:25:02 INFO - PROCESS | 23799 | 06:25:04 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:05 INFO - PROCESS | 23799 | RSS: Main: 209641472 06:25:05 INFO - PROCESS | 23799 | 06:25:07 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:08 INFO - PROCESS | 23799 | RSS: Main: 214102016 06:25:08 INFO - PROCESS | 23799 | 06:25:10 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:11 INFO - PROCESS | 23799 | RSS: Main: 210767872 06:25:11 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | Cycle 1(1): loaded http://localhost:60528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60528/tests/kraken/driver.html?testName=ai-astar) 06:25:13 INFO - PROCESS | 23799 | RSS: Main: 274898944 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | __start_tp_report 06:25:13 INFO - PROCESS | 23799 | _x_x_mozilla_page_load 06:25:13 INFO - PROCESS | 23799 | _x_x_mozilla_page_load_details 06:25:13 INFO - PROCESS | 23799 | |i|pagename|runs| 06:25:13 INFO - PROCESS | 23799 | |0;ai-astar;111;113;110;112;112;112;107;113;112;110 06:25:13 INFO - PROCESS | 23799 | |1;audio-beat-detection;155;137;160;177;134;162;152;138;182;132 06:25:13 INFO - PROCESS | 23799 | |2;audio-dft;166;164;166;164;164;164;181;164;162;162 06:25:13 INFO - PROCESS | 23799 | |3;audio-fft;77;75;74;175;74;77;77;78;160;76 06:25:13 INFO - PROCESS | 23799 | |4;audio-oscillator;93;93;148;93;92;93;142;93;94;143 06:25:13 INFO - PROCESS | 23799 | |5;imaging-gaussian-blur;118;120;118;119;119;117;119;118;118;119 06:25:13 INFO - PROCESS | 23799 | |6;imaging-darkroom;147;148;150;149;148;149;149;148;147;148 06:25:13 INFO - PROCESS | 23799 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;97;96 06:25:13 INFO - PROCESS | 23799 | |8;json-parse-financial;56;56;56;55;57;55;56;69;54;54 06:25:13 INFO - PROCESS | 23799 | |9;json-stringify-tinderbox;58;59;59;60;59;58;59;59;59;60 06:25:13 INFO - PROCESS | 23799 | |10;stanford-crypto-aes;74;75;73;74;75;76;81;75;75;74 06:25:13 INFO - PROCESS | 23799 | |11;stanford-crypto-ccm;121;123;126;123;130;117;123;119;132;128 06:25:13 INFO - PROCESS | 23799 | |12;stanford-crypto-pbkdf2;163;166;161;159;163;163;160;166;167;166 06:25:13 INFO - PROCESS | 23799 | |13;stanford-crypto-sha256-iterative;66;68;67;67;66;67;68;67;66;66 06:25:13 INFO - PROCESS | 23799 | __end_tp_report 06:25:13 INFO - PROCESS | 23799 | __start_cc_report 06:25:13 INFO - PROCESS | 23799 | _x_x_mozilla_cycle_collect,1487 06:25:13 INFO - PROCESS | 23799 | __end_cc_report 06:25:13 INFO - PROCESS | 23799 | __startTimestamp1462886713377__endTimestamp 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | ------- Summary: start ------- 06:25:13 INFO - PROCESS | 23799 | Number of tests: 14 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.81 (1.6%) stddev-sans-first:1.92 06:25:13 INFO - PROCESS | 23799 | Values: 111.0 113.0 110.0 112.0 112.0 112.0 107.0 113.0 112.0 110.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:157.50 stddev:17.75 (11.3%) stddev-sans-first:18.81 06:25:13 INFO - PROCESS | 23799 | Values: 155.0 137.0 160.0 177.0 134.0 162.0 152.0 138.0 182.0 132.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#2] audio-dft Cycles:10 Average:165.70 Median:164.00 stddev:5.54 (3.4%) stddev-sans-first:5.87 06:25:13 INFO - PROCESS | 23799 | Values: 166.0 164.0 166.0 164.0 164.0 164.0 181.0 164.0 162.0 162.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:38.76 (50.7%) stddev-sans-first:40.61 06:25:13 INFO - PROCESS | 23799 | Values: 77.0 75.0 74.0 175.0 74.0 77.0 77.0 78.0 160.0 76.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.85 (26.7%) stddev-sans-first:25.72 06:25:13 INFO - PROCESS | 23799 | Values: 93.0 93.0 148.0 93.0 92.0 93.0 142.0 93.0 94.0 143.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 06:25:13 INFO - PROCESS | 23799 | Values: 118.0 120.0 118.0 119.0 119.0 117.0 119.0 118.0 118.0 119.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 06:25:13 INFO - PROCESS | 23799 | Values: 147.0 148.0 150.0 149.0 148.0 149.0 149.0 148.0 147.0 148.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:25:13 INFO - PROCESS | 23799 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:4.39 (7.8%) stddev-sans-first:4.65 06:25:13 INFO - PROCESS | 23799 | Values: 56.0 56.0 56.0 55.0 57.0 55.0 56.0 69.0 54.0 54.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 06:25:13 INFO - PROCESS | 23799 | Values: 58.0 59.0 59.0 60.0 59.0 58.0 59.0 59.0 59.0 60.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.20 (2.9%) stddev-sans-first:2.29 06:25:13 INFO - PROCESS | 23799 | Values: 74.0 75.0 73.0 74.0 75.0 76.0 81.0 75.0 75.0 74.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:124.50 stddev:4.78 (3.8%) stddev-sans-first:4.93 06:25:13 INFO - PROCESS | 23799 | Values: 121.0 123.0 126.0 123.0 130.0 117.0 123.0 119.0 132.0 128.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.50 stddev:2.80 (1.7%) stddev-sans-first:2.96 06:25:13 INFO - PROCESS | 23799 | Values: 163.0 166.0 161.0 159.0 163.0 163.0 160.0 166.0 167.0 166.0 06:25:13 INFO - PROCESS | 23799 | 06:25:13 INFO - PROCESS | 23799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 06:25:13 INFO - PROCESS | 23799 | Values: 66.0 68.0 67.0 67.0 66.0 67.0 68.0 67.0 66.0 66.0 06:25:13 INFO - PROCESS | 23799 | -------- Summary: end -------- 06:25:13 INFO - PROCESS | 23799 | 06:25:14 INFO - TEST-INFO | 23799: exit 0 06:25:14 INFO - TEST-OK | kraken | took 58213ms 06:25:14 INFO - SUITE-END | took 1167s 06:25:14 INFO - Completed test suite (00:19:28) 06:25:14 INFO - javascript benchmark 06:25:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.8526766295513, 3331.4170020246465, 3340.549025881506, 3348.631650518441, 3365.7643964922463, 5431.511163995239, 5491.313585801775, 5497.8075767348155, 5503.394626591072, 5516.475934786199, 5504.614676972614, 5509.283793106901, 5509.669419834802, 5529.695866727328, 5550.111982082867, 4566.70316429431, 5047.419546752125, 5059.797608095671, 5117.820876269331, 5147.047796157704, 4721.504242054586, 4888.535589119028, 4939.481354457784, 4950.183219768734, 4963.627727920402, 4977.178765503688, 5047.924281135786, 5056.064628043824, 5059.3169922060415, 5077.238414237875, 5056.494350564951, 5103.515166059218, 5114.974425127869, 5119.283300337956, 5127.641065125443, 4930.926036109461, 4930.939847932676, 4991.925121123186, 5008.899822003539, 5032.119379108642, 5319.6808191508635, 5359.249705041298, 5363.570914326883, 5374.838754837361, 5393.6763794172475, 5781.306243250795, 5784.987627165229, 5785.942140578624, 5790.218320526717, 5834.737436815353, 5925.111233315038, 5946.375630558772, 5999.340072592011, 6014.428629280212, 6033.306169790487, 5550.611457197998, 5579.191017302509, 5614.9719251403485, 5645.068563686987, 5655.943440565583, 6026.608270462406, 6043.516518678495, 6050.30421501533, 6103.605404109035, 6118.20463339763, 5805.564582656233, 5824.126381042877, 5850.970745146247, 5855.063189889597, 5876.471117599436, 5750.079987202028, 5877.9118313225335, 5936.436038576328, 5960.284765828128, 5990.101484777319, 5949.940500595025, 5992.161097446361, 5997.670128142994, 6021.006533921854, 6040.788572399945, 5900.763969441175, 5979.1928089707335, 6027.819165425044, 6028.457438830526, 6031.065184896348, 4457.955420445819, 4532.728036317765, 4550.408446901882, 4556.498785133633, 4561.863144105682, 4080.653144482693, 4119.155573107566, 4120.17596480705, 4122.134351786159, 4149.564295748964, 5766.077427611562, 5783.450572195635, 5807.419258074159, 5812.982728022579, 5850.736716847752, 5489.917651235235, 6014.909776353358, 6046.365131661112, 6119.4416233545735, 6121.239585875146, 5746.02317606008, 5759.6832174229985, 5762.135679648002, 5765.164051212634, 5780.826575202751, 5040.672356296829, 5044.54599086084, 5150.253213284052, 5165.48345165488, 5182.352205974254, 6067.696615169224, 6190.721417536131, 6307.4954003679595, 6321.525885558602, 6357.809265722036, 6019.187409699722, 6032.155498230339, 6032.245969253843, 6038.788642397671, 6046.062860256668, 6121.47967422774, 6143.389059649542, 6202.875942481215, 6206.410391012847, 6216.067589861557, 5941.494972927349, 5946.256717910262, 5951.732172052355, 5973.313068997121, 5983.58114931968, 5975.372585878594, 5981.970090149522, 6007.158997740407, 6028.4272994065495, 6036.879262414815, 5781.392953739797, 5799.797007104731, 5885.117232415001, 5907.0, 5961.850953726018, 5891.968905441617, 5896.174535564938, 5900.5574581907385, 5901.704914754331, 5918.911216331845, 5753.942460575341, 5776.306843178845, 5805.419458054161, 5814.5348372130975, 5815.738291776795, 5712.80005199816, 5830.096335068071, 5931.0, 5955.0, 6004.609700369462, 5570.972145139248, 5618.887622247614, 5773.278340207474, 5775.653460792366, 5785.595008349544], "value": 5496.659095415491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8248216776051, 634.1534052040529, 645.819170632223, 653.6306986552596, 658.6443320606872, 33653.66346336536, 34273.1431714207, 39890.601093989055, 40795.59204407955, 41045.179096418055, 42485.0, 43112.13775724483, 43562.56437435625, 43597.0, 43637.0, 7890.842183156334, 8744.781380465476, 8976.820463590724, 8990.37067405282, 9005.054469280729, 10616.681499554987, 10932.781344373108, 10959.616413425532, 10988.560457581687, 10988.670339889775, 10683.572657093708, 10742.73143171423, 10742.73143171423, 10774.19193560486, 10781.46092695366, 8087.555184464852, 10462.163026957825, 10541.841872371882, 10734.624288149955, 10996.340219586851, 10475.79048419035, 10507.159427245802, 10515.316504427188, 10573.418461984587, 10600.522976466078, 40138.79930600357, 40747.0, 40843.59156408457, 40874.0, 40887.1822563547, 3593.119685677, 3648.890533284006, 3934.7639141651307, 3984.980075099606, 4341.848035318781, 33207.833960830045, 33310.83344583261, 33832.0, 34817.129571760655, 35118.64881351179, 4083.3466645336903, 4175.373693945902, 4175.645070169039, 4195.538490766014, 4211.852585159505, 344923.0, 345987.0, 346848.0, 346953.0, 348468.0, 39445.21109577792, 40210.59789402127, 40321.59678403237, 40333.39499907504, 65015.67492162509, 37442.0, 37500.0, 37613.24773504569, 37715.0, 37758.0, 17005.06472144019, 17022.659546808994, 17087.743683844754, 17139.485815425556, 17172.570685732957, 13204.867951320364, 13996.16023038621, 14215.928920355333, 14693.706125877423, 14892.329845156994, 9147.634094636272, 9184.954075229582, 9201.953990230006, 9219.262459003263, 9237.399569027992, 3499.807510586942, 3596.244788594372, 3597.5143355647174, 3602.4056030755155, 3625.927481450409, 1068.2041878800344, 1113.2485572238706, 1137.4028634966708, 1196.9526664168852, 1216.2033867816594, 33460.0, 33531.4970275446, 33907.982760517225, 34908.650913491045, 34942.65057349394, 1203.8796120388067, 1218.4273391505978, 1261.3377976562194, 1282.076904628666, 1298.6493646715335, 17644.382446614563, 17966.371177009005, 18039.368622098165, 18054.0, 18145.45563633093, 473629.0, 481894.0, 482996.0, 484390.0, 485417.0, 64187.679061604395, 65079.67460162669, 65107.34892651108, 65359.67320163369, 65631.0, 1483.7180935622414, 1517.0215211188722, 1532.5095969289944, 1549.5738671865327, 1646.4895882276533, 31053.8447307762, 32459.0, 32544.674553254164, 32923.835380822944, 33247.83376083104, 49273.753631231615, 50616.0, 50671.0, 50736.23895641642, 50908.23637645364, 438907.8054609707, 446194.0, 446877.0, 447607.0, 448126.0, 40033.399499006955, 42478.57521424746, 48459.0, 48915.0, 49301.26048109353, 48043.39674524494, 48915.0216995651, 49728.75135624299, 49749.502504975935, 53194.0, 39749.205015898944, 40484.79757601193, 41032.58967410407, 41416.79291603643, 42212.0, 40463.393049103695, 40873.0, 40873.795631021654, 41051.58948410597, 41561.37657935194, 41152.58847411607, 41212.0, 41903.7904810474, 42219.57780422157, 42525.36211956885, 35059.29881402307, 39413.0, 39437.12289615779, 39818.80090599528, 40034.0, 29800.850995744884, 30075.398492030476, 30193.849030754707, 30566.694333057276, 30623.387532248784], "value": 20020.59514215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.29172677852046, 442.539480488484, 442.7033887295512, 446.72972851424885, 453.48755905826414, 18488.537786555342, 18528.44414667559, 19084.23663053478, 20543.794562054376, 20584.588308233862, 19747.901260493676, 19936.401907942785, 20045.0, 20096.59806803863, 20126.698099528483, 5204.947950520494, 5727.856803579903, 5734.5125664318375, 5736.311642602894, 5759.769609215627, 4198.538160802309, 5621.241132447109, 5727.198192253067, 6027.186329845458, 6346.30190679025, 6220.595661282025, 6283.088952101965, 6304.873902521947, 6307.936920630781, 6316.842078948017, 5997.250343707036, 6246.718897649594, 6253.781117660906, 6259.467945224661, 6263.342349053375, 3932.154586763831, 5262.973685131588, 5536.640118392292, 5600.0759874620635, 5650.802221922254, 22992.195273165526, 23033.309000730005, 23210.53578928412, 23325.53348933029, 23414.0, 2615.8299710518754, 2653.204038788375, 2756.131818477173, 2940.911772646824, 3261.59230096238, 14229.715405691932, 14931.328090235966, 15137.772933405897, 15392.692146157015, 15842.76235856463, 2060.526079001823, 2107.167668770827, 2136.3590922723274, 2146.903389347483, 2163.286115581854, 82151.0, 82716.0, 86444.0, 86718.0, 86776.13223867807, 11187.272827266203, 11373.374464404536, 11587.246828956091, 11678.124140689482, 11761.294322340687, 16249.512514624581, 16296.674066518603, 16400.507984760476, 16532.256048477848, 16578.0, 9168.332666933147, 9177.724668259963, 9267.0, 9315.068493150631, 9383.343165978316, 9183.173514383738, 9184.448933063904, 9203.539823008823, 9206.677766278148, 9313.161815436642, 7100.360967512948, 7281.271872812782, 7284.490085694057, 7289.781306560812, 7298.160711518137, 1820.8972938755985, 1930.9324173653854, 2029.0, 2096.2453516733963, 2116.6613341865227, 997.3816233935007, 1091.3233795046963, 1156.9537218511166, 1185.8043422835308, 1201.3152503073165, 18189.363372281907, 18483.260669573065, 18889.7166542502, 18925.242990280236, 19331.613367732567, 1042.0985847242082, 1063.6649455421518, 1066.4134725900724, 1095.2990086344746, 1146.2205700123995, 6348.746050158034, 6520.119783829217, 6616.933830661632, 6620.635865027373, 6673.0, 548844.0, 551428.0, 561684.0, 563359.1677035417, 565371.0, 93802.0, 94941.52529237448, 97874.5106274464, 97943.0, 98106.50946745221, 491.4962163782152, 500.91985282355375, 505.87858913860407, 506.98225562105887, 511.836212412032, 9671.17794987434, 10196.796064078826, 10687.5190616424, 11223.88776112261, 16031.278592463601, 23281.18515851937, 39255.41116883192, 41726.37410438906, 43821.561784381745, 43884.78057609691, 58156.709216453644, 58896.0, 59172.1124183129, 60145.69927150336, 60630.696846515486, 8893.955530222307, 8962.551872406224, 9125.0, 9162.221211196857, 9222.262219022596, 9585.712428627152, 11747.29516229029, 12827.0, 13028.28344441027, 13194.670133246746, 11902.940485297519, 12495.437705303102, 12686.965945354785, 12713.491460341484, 12763.170393924365, 8767.912320876709, 11683.824742628698, 12232.32722200252, 12415.565455209024, 12454.688632784253, 6506.186726659168, 9661.985491523288, 11378.203525753117, 12471.875281247072, 12484.063695222712, 8548.358873084668, 8835.116488351114, 8916.821663566821, 8922.107789221285, 8996.460212387277, 10815.24293299493, 12199.817002745143, 12266.711995240372, 12339.814902776645, 12408.56570020045], "value": 9347.740031205485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.57324375931, 1598.5524053265087, 1621.5946013496625, 1849.9907500462496, 1938.7867334593202, 8110.4322697411135, 8303.792405189874, 8357.080721120672, 8388.958055209723, 8389.874151887727, 8190.303824174937, 8486.278666313356, 8490.53302068386, 8493.49039057657, 8498.192671696195, 2152.8600640958366, 2373.169390713254, 2382.8212884033724, 2413.746556611557, 2425.7331693513697, 2442.7068751749816, 2453.668754718117, 2469.4814089041324, 2469.925902222936, 2473.084958565333, 2377.9643305350432, 2401.0515846240723, 2406.855588664677, 2409.795167410772, 2413.650020746991, 2089.8432617553667, 2313.5025969416574, 2370.885683728645, 2373.9791889487515, 2376.346504711192, 2297.24191016964, 2298.747137814839, 2304.5506126305377, 2307.619242824932, 2334.1480359668767, 8050.15473375293, 8098.635561399751, 8124.1875812418875, 8136.34909207262, 8140.389470789714, 5144.639875208737, 5301.60237982149, 5324.387695414999, 5328.413874473805, 5465.535429488498, 3359.5296658467832, 3363.680450357212, 3403.931921361559, 3433.484977253432, 3485.5643044619424, 1157.1148071725138, 1164.7667981832828, 1171.677788608131, 1183.9822402663967, 1218.5186851193728, 11582.420878956018, 11630.592929247436, 11651.533938642444, 11659.067274618095, 11674.708132296675, 4546.65900057497, 4618.422697162855, 4628.4445866496235, 4753.215719406328, 4755.429348478136, 9908.80182396348, 9963.252756043326, 9969.40183588987, 9978.650747223812, 9982.151517120981, 4915.803367865316, 5278.445763194886, 5278.841634750964, 5290.391604965402, 5292.629515933924, 4876.658633895664, 4885.877853053702, 4945.901081978341, 4950.133726597831, 4997.575206107449, 4073.165001174752, 4096.672266218696, 4122.958770412318, 4134.235166494148, 4147.3778933159665, 1313.6190504753706, 1318.6044186743939, 1319.9340032998311, 1329.6210579984659, 1330.9267990260435, 966.7534778631403, 976.6484065736329, 1004.7488127968008, 1035.984460233097, 1066.0991462214417, 5716.57125715573, 5775.104858746901, 5864.237649105589, 5895.705214739246, 5921.911171332434, 447.17719396310946, 449.4965638484918, 451.80120746871273, 452.76003718029494, 453.7776489520177, 3975.8807235782974, 3986.5415477219913, 4008.679305655599, 4020.296448121567, 4071.75569465833, 9346.57940392684, 9523.28575356851, 9558.330916835755, 9676.322657413913, 9729.854052189223, 9516.095970882756, 9525.095115963972, 9533.142017218484, 9536.904630953602, 9609.663661771805, 7560.092788865371, 7612.657430415645, 7643.7324693635455, 7677.270659287359, 7975.042994840773, 5604.635698679573, 5630.465105814941, 5719.5710321726865, 5749.9712501437225, 5800.1299805029585, 8870.42342247752, 8903.109689031045, 8992.775180620536, 9097.636094556408, 9098.59056342453, 9144.1770240676, 9175.577785443267, 9246.907530924605, 9512.571934263113, 9524.047595240698, 6838.179418469616, 7130.5365151265005, 7344.155422126524, 7563.621818909142, 7645.88531172044, 7914.366850652049, 7951.681932722627, 7967.725163973968, 7972.920270797218, 7996.920030799618, 6857.245702972569, 7247.2390399007345, 7252.0, 7264.418846492163, 7541.208173141741, 7255.238199989136, 7353.852922941404, 7393.0, 7430.071241094864, 7448.6275686214385, 6802.115724955922, 6839.110915580943, 6852.6916288768125, 6862.656867156722, 6876.553024053421, 5262.526372626482, 5335.413104558573, 5348.224507446476, 5467.07059799827, 5532.557395408277, 5196.68819870809, 5290.153575428067, 5313.149896016619, 5345.1714984177515, 5360.2227676987395], "value": 4466.580660098488, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.30025699244, 360.38194496438604, 362.95644522657284, 373.84485438543004, 375.7013174526251, 6051.304100028498, 6238.4697300729495, 6253.187085678861, 6303.275123360803, 6311.810645680625, 6015.669138197398, 6115.785947491839, 6119.9388006119925, 6146.078088286759, 6161.845953851156, 4468.50846406895, 4518.525554816746, 4627.490975992638, 4693.20215563355, 4711.670183087185, 4640.930386044212, 4666.929996050062, 4712.481627021025, 4738.857834264978, 4749.168895443301, 4628.814847406116, 4638.953610463903, 4640.164770341337, 4640.3967484227005, 4645.62834973203, 4476.731396116227, 4504.842330518449, 4630.652701047435, 4654.743219330779, 4662.743549104798, 4057.2291264659916, 4070.409790580349, 4076.30702780528, 4076.612721791425, 4097.836086556535, 5810.5932584719085, 5821.09772985188, 5842.2405087338375, 5849.210356601847, 5862.941370586324, 5378.193271009341, 5395.73021348931, 5398.865028374283, 5406.810761623364, 5412.161115027177, 6397.648129352884, 6410.230772307306, 6411.326810684857, 6413.134226879405, 6420.0690899819265, 4252.87241382759, 4411.602955733967, 4422.005048864012, 4513.593776560093, 4515.029268707211, 6554.541182117254, 6669.333066693341, 6675.899861502081, 6737.898931516032, 6745.999999999951, 4588.082383523309, 4590.472095708969, 4601.562851529099, 4602.125596136723, 4643.582077613031, 4650.139724151043, 4655.86032419028, 4663.673542851968, 4674.813007479663, 4692.991006933526, 5378.1663842104535, 5385.246065550826, 5403.891922161535, 5410.188471729193, 5414.106672399089, 6202.503799696014, 6421.229452465734, 6464.903026454513, 6474.643894585749, 6490.221173459215, 1610.8308627593933, 1630.5271471273197, 1638.475687779899, 1639.0903048807788, 1651.5540803983097, 1023.8259495885717, 1056.8995945385177, 1084.2572837606108, 1103.2883789955433, 1111.5109351885144, 6134.601250918676, 6260.092286618506, 6260.718267677966, 6269.247690277196, 6280.685965701697, 6627.536072474977, 6637.701303441357, 6644.302348253461, 6728.562643428161, 6731.32686731323, 6258.530610204253, 6319.925612645861, 6337.493000560036, 6354.142190804182, 6366.745330186834, 3553.8223088845452, 3598.7660802047785, 3606.2426890352795, 3607.8015709135725, 3610.981945090258, 6817.386435220854, 6977.092977912839, 6988.93011069893, 7017.017617533549, 7028.086348774729, 6789.898151527731, 6824.18109826814, 6825.965870170717, 6834.4874134440115, 6847.794566163023, 6941.583504989717, 6951.200611929592, 6964.303569642995, 6991.440684745208, 7010.509264351548, 6648.867022659423, 6659.101021362054, 6668.633225172662, 6674.466042716668, 6712.765053223114, 6364.236291644847, 6562.8359291018105, 6596.0, 6602.372774586406, 6606.405423511907, 6906.723731050903, 6910.861782764216, 6912.377885990285, 6952.096227490394, 6963.338482844122, 4540.545945405433, 4606.262997920317, 4607.2398054322, 4608.470025946925, 4620.0, 6692.263850976486, 6700.46396288286, 6712.093867327848, 6713.865722685421, 6727.629980350932, 6402.679866006774, 6497.415232629086, 6500.0, 6514.478841692748, 6538.411542961157, 6503.967480162569, 6512.34876512345, 6522.293248301901, 6531.954887218022, 6541.411272985454, 6387.8501869663905, 6400.743970241325, 6404.391582799627, 6408.935910640834, 6430.2926678066315, 6572.047053177167, 6578.177727784027, 6585.341465853377, 6590.143281373583, 6592.17597800275, 6054.697265136813, 6240.843978900564, 6431.228252609717, 6447.258565265054, 6456.289808121197], "value": 4894.7817863665905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.9606576042984, 870.6125774030555, 894.4990805149117, 910.7677542226731, 943.1417410156756, 14953.700925981473, 15049.548513544598, 15491.457798977039, 15513.534593962198, 15529.611759706013, 14090.577282681536, 14487.130772153678, 14713.852861471381, 14745.378008419093, 14752.778708319356, 764.4648745877907, 914.0996118822954, 920.0339643374464, 922.6309476209502, 925.5973651461636, 901.5537309032038, 922.6032805893464, 923.2798417234568, 923.372106967262, 928.8792456980617, 957.5643082397527, 966.8549717542389, 971.6987733802508, 975.2198241406882, 975.7316737897064, 801.0907619851453, 954.6992697300328, 956.3687965942479, 956.9234461243119, 958.6644674364021, 709.1171491493072, 709.5671640299413, 710.683745733149, 712.5048091576357, 712.7256006437507, 14746.0, 14782.556523304318, 14792.482263120846, 14848.10911345312, 14884.330205140795, 13971.510997115154, 14126.0, 14912.403503859832, 14948.177850218233, 14964.251787410694, 11731.7067073323, 11950.342731149784, 12037.458314375874, 12514.249145051326, 12527.060470464661, 4073.8574149904907, 4089.141280331134, 4115.0741083256025, 4168.958310416918, 4187.246295666779, 56372.43627563672, 56511.71744141294, 56600.716996414754, 56860.14709779315, 57024.0, 11372.14708896836, 11717.824232636518, 11845.170838041255, 11872.821907671392, 12039.458224379923, 21392.251271205434, 21461.67807482889, 21473.785262147492, 21485.355439336843, 21486.892565537386, 8649.567521623894, 8913.55432228386, 9170.991190968987, 9296.907030929604, 9392.154706076486, 5029.1450453423, 5049.974750126299, 5068.543831055223, 5094.6688465249645, 5261.947380526222, 3642.3261696586214, 3723.404255319136, 3725.3108174987715, 3732.253549290153, 3733.906652333659, 657.4050484311706, 670.7417644206918, 671.301846080081, 680.1566058088034, 688.2223087910629, 709.5671640299413, 710.8258476673249, 726.96728647211, 777.9222077792175, 809.6437567470294, 9495.715128546155, 9856.359336643096, 9922.80154396908, 9923.900760992297, 9925.65260215889, 701.5264696329957, 743.9993209133706, 751.504007355143, 766.7124828189429, 822.2599660305773, 4535.206338890681, 4538.2738761797955, 4548.226801443762, 4629.189891768927, 4657.504363001764, 62982.68508657519, 62993.68503157455, 63435.68282158559, 63447.36552634507, 63523.682381587794, 50592.24111638328, 51035.48964510307, 51729.22406163911, 51811.22283165756, 56339.15491267634, 43844.342334865, 44748.3287750684, 45337.54662453333, 45443.772781135885, 46010.539894601294, 10086.8486972694, 10251.794964100825, 10397.272190946562, 10477.68566942993, 10495.79008419812, 37846.2430751389, 38556.228875422894, 38863.41704874373, 39472.605273946894, 39627.60372396239, 50905.236421452966, 51690.483095168565, 53671.7316413431, 56856.43143568677, 59036.0, 12890.41993110331, 13165.60503184906, 13380.866191338351, 13999.16005039701, 14045.297735113, 14194.432222710975, 14299.213543254804, 14308.284585770878, 14407.495737649131, 14435.92782036125, 13366.465341386236, 13432.328383580978, 13468.191908485522, 13589.86410135886, 13829.79255311151, 13687.247201404018, 13879.444822206999, 14083.718325633225, 14491.275436227936, 14530.346134424188, 13344.06591538583, 13439.798403023768, 13450.798238026633, 13466.85531729814, 13767.38046787877, 11412.600558980395, 11559.0, 11768.646940591796, 11930.522779088738, 12082.697932551757, 11293.661190164308, 11375.772484550098, 11375.829362559734, 11383.260088094248, 11747.633128742751], "value": 7273.188179775763, "unit": "score"}], "name": "dromaeo_css", "value": 7395.360861401621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 110.0, 112.0, 112.0, 112.0, 107.0, 113.0, 112.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 137.0, 160.0, 177.0, 134.0, 162.0, 152.0, 138.0, 182.0, 132.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 164.0, 164.0, 164.0, 181.0, 164.0, 162.0, 162.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 175.0, 74.0, 77.0, 77.0, 78.0, 160.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 93.0, 92.0, 93.0, 142.0, 93.0, 94.0, 143.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 118.0, 119.0, 119.0, 117.0, 119.0, 118.0, 118.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 149.0, 148.0, 149.0, 149.0, 148.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 69.0, 54.0, 54.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 74.0, 75.0, 76.0, 81.0, 75.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 126.0, 123.0, 130.0, 117.0, 123.0, 119.0, 132.0, 128.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 161.0, 159.0, 163.0, 163.0, 160.0, 166.0, 167.0, 166.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1540.6000000000001, "alertThreshold": 2.0}]} 06:25:14 INFO - Return code: 0 06:25:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:14 ERROR - # TBPL SUCCESS # 06:25:14 INFO - Running post-action listener: _resource_record_post_action 06:25:14 INFO - Running post-run listener: _resource_record_post_run 06:25:15 INFO - Total resource usage - Wall time: 1185s; CPU: 25.0%; Read bytes: 262144; Write bytes: 491900928; Read time: 20; Write time: 301448 06:25:15 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 248438784; Read time: 0; Write time: 169512 06:25:15 INFO - run-tests - Wall time: 1170s; CPU: 25.0%; Read bytes: 262144; Write bytes: 243462144; Read time: 20; Write time: 131936 06:25:15 INFO - Running post-run listener: _upload_blobber_files 06:25:15 INFO - Blob upload gear active. 06:25:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:15 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 06:25:15 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'] 06:25:15 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 06:25:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:16 INFO - (blobuploader) - INFO - Done attempting. 06:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:17 INFO - (blobuploader) - INFO - Done attempting. 06:25:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:17 INFO - Return code: 0 06:25:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c336d3b540be12d72a19f9b0bd5b80e08b902c5cc10532bbc4afcf06173963d977cb653a83fe013e2423d424bf487f943ad651f83122dc803e0de840e720da8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c5ad5af1389fca4f310d893532bc3beb1ae3b73330d722232ebfa32388175254b449bb2c61b01c22f2e537f57cf18aa538f57a7f4a25e6e30359c09ba1e90d0"} 06:25:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:17 INFO - Contents: 06:25:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c336d3b540be12d72a19f9b0bd5b80e08b902c5cc10532bbc4afcf06173963d977cb653a83fe013e2423d424bf487f943ad651f83122dc803e0de840e720da8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c5ad5af1389fca4f310d893532bc3beb1ae3b73330d722232ebfa32388175254b449bb2c61b01c22f2e537f57cf18aa538f57a7f4a25e6e30359c09ba1e90d0"} 06:25:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:17 INFO - Copying logs to upload dir... 06:25:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.787828 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 06:25:17.208215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:25:17.211883) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 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/c336d3b540be12d72a19f9b0bd5b80e08b902c5cc10532bbc4afcf06173963d977cb653a83fe013e2423d424bf487f943ad651f83122dc803e0de840e720da8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c5ad5af1389fca4f310d893532bc3beb1ae3b73330d722232ebfa32388175254b449bb2c61b01c22f2e537f57cf18aa538f57a7f4a25e6e30359c09ba1e90d0"} build_url:https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005346 build_url: 'https://queue.taskcluster.net/v1/task/KIJYXZp2SOGqa1BZj3-67A/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/c336d3b540be12d72a19f9b0bd5b80e08b902c5cc10532bbc4afcf06173963d977cb653a83fe013e2423d424bf487f943ad651f83122dc803e0de840e720da8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c5ad5af1389fca4f310d893532bc3beb1ae3b73330d722232ebfa32388175254b449bb2c61b01c22f2e537f57cf18aa538f57a7f4a25e6e30359c09ba1e90d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:25:17.227298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:25:17.227643) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462884781.294070-886331337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002159 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:25:17.313113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:25:17.313855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:25:17.314517) ========= ========= Total master_lag: 0.17 =========