builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1467436020.73 results: success (0) buildid: 20160701192722 builduid: 52584d8b7e0a403084a0345bf9df883d revision: e8999eb7311ec1063176e4a836388b763fb91942 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.732924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.733379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.733711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.778255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.778641) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 22:07:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-07-01 22:07:01 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.879371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.879671) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018552 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.933857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:00.934166) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e8999eb7311ec1063176e4a836388b763fb91942 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e8999eb7311ec1063176e4a836388b763fb91942 --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=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 22:07:01,182 truncating revision to first 12 chars 2016-07-01 22:07:01,182 Setting DEBUG logging. 2016-07-01 22:07:01,182 attempt 1/10 2016-07-01 22:07:01,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e8999eb7311e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 22:07:01,665 unpacking tar archive at: mozilla-beta-e8999eb7311e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:01.773268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:01.773576) ========= script_repo_revision: e8999eb7311ec1063176e4a836388b763fb91942 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:01.773976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:01.774281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 22:07:01.793210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-01 22:07:01.793468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:02 INFO - MultiFileLogger online at 20160701 22:07:02 in /builds/slave/test 22:07:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:07:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:02 INFO - {'append_to_log': False, 22:07:02 INFO - 'base_work_dir': '/builds/slave/test', 22:07:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:07:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:02 INFO - 'branch': 'Mozilla-Beta', 22:07:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:02 INFO - 'config_files': ('talos/linux_config.py',), 22:07:02 INFO - 'default_actions': ('clobber', 22:07:02 INFO - 'read-buildbot-config', 22:07:02 INFO - 'download-and-extract', 22:07:02 INFO - 'populate-webroot', 22:07:02 INFO - 'create-virtualenv', 22:07:02 INFO - 'install', 22:07:02 INFO - 'run-tests'), 22:07:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:02 INFO - 'download_minidump_stackwalk': True, 22:07:02 INFO - 'download_symbols': 'ondemand', 22:07:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:02 INFO - 'installer_path': 'installer.exe', 22:07:02 INFO - 'log_level': 'info', 22:07:02 INFO - 'log_name': 'talos', 22:07:02 INFO - 'log_to_console': True, 22:07:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:02 INFO - 'opt_config_files': (), 22:07:02 INFO - 'pip_index': False, 22:07:02 INFO - 'sps_profile': False, 22:07:02 INFO - 'sps_profile_interval': 0, 22:07:02 INFO - 'suite': 'dromaeojs', 22:07:02 INFO - 'system_bits': '32', 22:07:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:02 INFO - 'title': 'talos-linux64-ix-055', 22:07:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:02 INFO - 'use_talos_json': True, 22:07:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:02 INFO - 'work_dir': 'build'} 22:07:02 INFO - ##### 22:07:02 INFO - ##### Running clobber step. 22:07:02 INFO - ##### 22:07:02 INFO - Running pre-action listener: _resource_record_pre_action 22:07:02 INFO - Running main action method: clobber 22:07:02 INFO - rmtree: /builds/slave/test/build 22:07:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:03 INFO - Running post-action listener: _resource_record_post_action 22:07:03 INFO - ##### 22:07:03 INFO - ##### Running read-buildbot-config step. 22:07:03 INFO - ##### 22:07:03 INFO - Running pre-action listener: _resource_record_pre_action 22:07:03 INFO - Running main action method: read_buildbot_config 22:07:03 INFO - Using buildbot properties: 22:07:03 INFO - { 22:07:03 INFO - "project": "", 22:07:03 INFO - "product": "firefox", 22:07:03 INFO - "script_repo_revision": "production", 22:07:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 22:07:03 INFO - "repository": "", 22:07:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 22:07:03 INFO - "buildid": "20160701192722", 22:07:03 INFO - "pgo_build": "True", 22:07:03 INFO - "basedir": "/builds/slave/test", 22:07:03 INFO - "buildnumber": 79, 22:07:03 INFO - "slavename": "talos-linux64-ix-055", 22:07:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:07:03 INFO - "platform": "ubuntu64_hw", 22:07:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:07:03 INFO - "branch": "mozilla-beta", 22:07:03 INFO - "repo_path": "releases/mozilla-beta", 22:07:03 INFO - "revision": "e8999eb7311ec1063176e4a836388b763fb91942", 22:07:03 INFO - "stage_platform": "linux64-pgo", 22:07:03 INFO - "builduid": "52584d8b7e0a403084a0345bf9df883d", 22:07:03 INFO - "slavebuilddir": "test" 22:07:03 INFO - } 22:07:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 22:07:03 INFO - Running post-action listener: _resource_record_post_action 22:07:03 INFO - ##### 22:07:03 INFO - ##### Running download-and-extract step. 22:07:03 INFO - ##### 22:07:03 INFO - Running pre-action listener: _resource_record_pre_action 22:07:03 INFO - Running main action method: download_and_extract 22:07:03 INFO - mkdir: /builds/slave/test/build/tests 22:07: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')]} 22:07:03 INFO - https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:08 INFO - Downloaded 1327 bytes. 22:07:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:07:08 INFO - Using the following test package requirements: 22:07:08 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:07:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:08 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 22:07:08 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'jsshell-linux-x86_64.zip'], 22:07:08 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:08 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:07:08 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 22:07:08 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 22:07:08 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:08 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07: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')]} 22:07:08 INFO - https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:12 INFO - Downloaded 24236094 bytes. 22:07:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:13 INFO - Return code: 0 22:07:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07: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')]} 22:07:13 INFO - https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:15 INFO - Downloaded 24236094 bytes. 22:07:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:16 INFO - Return code: 0 22:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:16 INFO - https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:17 INFO - Downloaded 10840145 bytes. 22:07:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:07:17 INFO - Return code: 0 22:07: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')]} 22:07:17 INFO - https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:19 INFO - Downloaded 56019413 bytes. 22:07:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:07:19 INFO - mkdir: /builds/slave/test/properties 22:07:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:19 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:19 INFO - Contents: 22:07:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:07:20 INFO - Running post-action listener: _resource_record_post_action 22:07:20 INFO - Running post-action listener: set_extra_try_arguments 22:07:20 INFO - ##### 22:07:20 INFO - ##### Running populate-webroot step. 22:07:20 INFO - ##### 22:07:20 INFO - Running pre-action listener: _resource_record_pre_action 22:07:20 INFO - Running main action method: populate_webroot 22:07:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:20 INFO - '--tppagecycles', 22:07:20 INFO - '7'], 22:07:20 INFO - 'tests': ['tsvgm']}}, 22:07:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:07:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:07:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:07:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['damp', 'tps']}, 22:07:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'tests': ['damp', 'tps']}, 22:07:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['dromaeo_dom']}, 22:07:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'other-e10s': {'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['a11yr', 22:07:20 INFO - 'ts_paint', 22:07:20 INFO - 'tpaint', 22:07:20 INFO - 'sessionrestore', 22:07:20 INFO - 'sessionrestore_no_auto_restore', 22:07:20 INFO - 'tabpaint']}, 22:07:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['tsvgx', 22:07:20 INFO - 'tsvgr_opacity', 22:07:20 INFO - 'tart', 22:07:20 INFO - 'tscrollx', 22:07:20 INFO - 'cart']}, 22:07:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:07:20 INFO - 'tsvgr_opacity', 22:07:20 INFO - 'tart', 22:07:20 INFO - 'tscrollx', 22:07:20 INFO - 'cart']}, 22:07:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'talos_options': ['--disable-e10s'], 22:07:20 INFO - 'tests': ['tp5o']}, 22:07:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'tests': ['tp5o']}, 22:07:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'talos_options': ['--disable-e10s', 22:07:20 INFO - '--xperf_path', 22:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:20 INFO - 'tests': ['tp5n']}, 22:07:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:20 INFO - 'talos_options': ['--xperf_path', 22:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:20 INFO - 'tests': ['tp5n']}}, 22:07:20 INFO - 'talos.zip': {'path': '', 22:07:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:20 INFO - Running post-action listener: _resource_record_post_action 22:07:20 INFO - ##### 22:07:20 INFO - ##### Running create-virtualenv step. 22:07:20 INFO - ##### 22:07:20 INFO - Running pre-action listener: _resource_record_pre_action 22:07:20 INFO - Running main action method: create_virtualenv 22:07:20 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:20 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 22:07:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:20 INFO - Using real prefix '/usr' 22:07:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:20 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:22 INFO - Installing pip.................done. 22:07:22 INFO - Return code: 0 22:07:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:22 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')]} 22:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 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')]} 22:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:22 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 22:07:22 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 22:07:22 INFO - Using env: {'DISPLAY': ':0', 22:07:22 INFO - 'HOME': '/home/cltbld', 22:07:22 INFO - 'LANG': 'en_US.UTF-8', 22:07:22 INFO - 'LANGUAGE': 'en_US:en', 22:07:22 INFO - 'LOGNAME': 'cltbld', 22:07:22 INFO - 'MAIL': '/var/mail/cltbld', 22:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:22 INFO - 'MOZ_NO_REMOTE': '1', 22:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:22 INFO - 'NO_EM_RESTART': '1', 22:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:22 INFO - 'PWD': '/builds/slave/test', 22:07:22 INFO - 'SHELL': '/bin/bash', 22:07:22 INFO - 'SHLVL': '1', 22:07:22 INFO - 'TERM': 'linux', 22:07:22 INFO - 'TMOUT': '86400', 22:07:22 INFO - 'USER': 'cltbld', 22:07:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:22 INFO - '_': '/tools/buildbot/bin/python'} 22:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:23 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 22:07:23 INFO - Cleaning up... 22:07:23 INFO - Return code: 0 22:07:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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', '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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:07: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 psutil>=0.7.1 22:07:23 INFO - Using env: {'DISPLAY': ':0', 22:07:23 INFO - 'HOME': '/home/cltbld', 22:07:23 INFO - 'LANG': 'en_US.UTF-8', 22:07:23 INFO - 'LANGUAGE': 'en_US:en', 22:07:23 INFO - 'LOGNAME': 'cltbld', 22:07:23 INFO - 'MAIL': '/var/mail/cltbld', 22:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:23 INFO - 'MOZ_NO_REMOTE': '1', 22:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:23 INFO - 'NO_EM_RESTART': '1', 22:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:23 INFO - 'PWD': '/builds/slave/test', 22:07:23 INFO - 'SHELL': '/bin/bash', 22:07:23 INFO - 'SHLVL': '1', 22:07:23 INFO - 'TERM': 'linux', 22:07:23 INFO - 'TMOUT': '86400', 22:07:23 INFO - 'USER': 'cltbld', 22:07:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:23 INFO - '_': '/tools/buildbot/bin/python'} 22:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:23 INFO - Downloading/unpacking psutil>=0.7.1 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:25 INFO - Installing collected packages: psutil 22:07:25 INFO - Running setup.py install for psutil 22:07:25 INFO - building 'psutil._psutil_linux' extension 22:07:25 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 22:07:25 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 22:07:25 INFO - building 'psutil._psutil_posix' extension 22:07:25 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 22:07:25 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 22:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:25 INFO - Successfully installed psutil 22:07:25 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07:25 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')]} 22:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 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')]} 22:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:25 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 22:07:25 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 22:07:25 INFO - Using env: {'DISPLAY': ':0', 22:07:25 INFO - 'HOME': '/home/cltbld', 22:07:25 INFO - 'LANG': 'en_US.UTF-8', 22:07:25 INFO - 'LANGUAGE': 'en_US:en', 22:07:25 INFO - 'LOGNAME': 'cltbld', 22:07:25 INFO - 'MAIL': '/var/mail/cltbld', 22:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:25 INFO - 'MOZ_NO_REMOTE': '1', 22:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:25 INFO - 'NO_EM_RESTART': '1', 22:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:25 INFO - 'PWD': '/builds/slave/test', 22:07:25 INFO - 'SHELL': '/bin/bash', 22:07:25 INFO - 'SHLVL': '1', 22:07:25 INFO - 'TERM': 'linux', 22:07:25 INFO - 'TMOUT': '86400', 22:07:25 INFO - 'USER': 'cltbld', 22:07:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:25 INFO - '_': '/tools/buildbot/bin/python'} 22:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:27 INFO - Installing collected packages: mozsystemmonitor 22:07:27 INFO - Running setup.py install for mozsystemmonitor 22:07:28 INFO - Successfully installed mozsystemmonitor 22:07:28 INFO - Cleaning up... 22:07:28 INFO - Return code: 0 22:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:28 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')]} 22:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:28 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')]} 22:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:28 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:28 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 22:07:28 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 22:07:28 INFO - Using env: {'DISPLAY': ':0', 22:07:28 INFO - 'HOME': '/home/cltbld', 22:07:28 INFO - 'LANG': 'en_US.UTF-8', 22:07:28 INFO - 'LANGUAGE': 'en_US:en', 22:07:28 INFO - 'LOGNAME': 'cltbld', 22:07:28 INFO - 'MAIL': '/var/mail/cltbld', 22:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:28 INFO - 'MOZ_NO_REMOTE': '1', 22:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:28 INFO - 'NO_EM_RESTART': '1', 22:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:28 INFO - 'PWD': '/builds/slave/test', 22:07:28 INFO - 'SHELL': '/bin/bash', 22:07:28 INFO - 'SHLVL': '1', 22:07:28 INFO - 'TERM': 'linux', 22:07:28 INFO - 'TMOUT': '86400', 22:07:28 INFO - 'USER': 'cltbld', 22:07:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:28 INFO - '_': '/tools/buildbot/bin/python'} 22:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:28 INFO - Downloading/unpacking blobuploader==1.2.4 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 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 22:07:30 INFO - Downloading docopt-0.6.1.tar.gz 22:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:30 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:30 INFO - Running setup.py install for blobuploader 22:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:31 INFO - Running setup.py install for requests 22:07:31 INFO - Running setup.py install for docopt 22:07:31 INFO - Successfully installed blobuploader requests docopt 22:07:31 INFO - Cleaning up... 22:07:31 INFO - Return code: 0 22:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:31 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:31 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 22:07:31 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 22:07:31 INFO - Using env: {'DISPLAY': ':0', 22:07:31 INFO - 'HOME': '/home/cltbld', 22:07:31 INFO - 'LANG': 'en_US.UTF-8', 22:07:31 INFO - 'LANGUAGE': 'en_US:en', 22:07:31 INFO - 'LOGNAME': 'cltbld', 22:07:31 INFO - 'MAIL': '/var/mail/cltbld', 22:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:31 INFO - 'MOZ_NO_REMOTE': '1', 22:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:31 INFO - 'NO_EM_RESTART': '1', 22:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:31 INFO - 'PWD': '/builds/slave/test', 22:07:31 INFO - 'SHELL': '/bin/bash', 22:07:31 INFO - 'SHLVL': '1', 22:07:31 INFO - 'TERM': 'linux', 22:07:31 INFO - 'TMOUT': '86400', 22:07:31 INFO - 'USER': 'cltbld', 22:07:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:31 INFO - '_': '/tools/buildbot/bin/python'} 22:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:31 INFO - Running setup.py (path:/tmp/pip-zy24K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:31 INFO - Running setup.py (path:/tmp/pip-IM0G2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:31 INFO - Running setup.py (path:/tmp/pip-FZubcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:31 INFO - Running setup.py (path:/tmp/pip-M9pfj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:32 INFO - Running setup.py (path:/tmp/pip-BIvmUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:32 INFO - Running setup.py (path:/tmp/pip-YBDCZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:32 INFO - Running setup.py (path:/tmp/pip-nNLr7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:32 INFO - Running setup.py (path:/tmp/pip-vehT5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:32 INFO - Running setup.py (path:/tmp/pip-dJW8pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:32 INFO - Running setup.py (path:/tmp/pip-2885cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:32 INFO - Running setup.py (path:/tmp/pip-b7T8Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:32 INFO - Running setup.py (path:/tmp/pip-Il3PnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:32 INFO - Running setup.py (path:/tmp/pip-JHwHt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:32 INFO - Running setup.py (path:/tmp/pip-flLCiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:32 INFO - Running setup.py (path:/tmp/pip-tFEBUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:32 INFO - Running setup.py (path:/tmp/pip-1eiEdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:32 INFO - Running setup.py (path:/tmp/pip-_Czu85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:32 INFO - Running setup.py install for manifestparser 22:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozcrash 22:07:33 INFO - Running setup.py install for mozdebug 22:07:33 INFO - Running setup.py install for mozdevice 22:07:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozfile 22:07:33 INFO - Running setup.py install for mozhttpd 22:07:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozinfo 22:07:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozInstall 22:07:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozleak 22:07:33 INFO - Running setup.py install for mozlog 22:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for moznetwork 22:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozprocess 22:07:34 INFO - Running setup.py install for mozprofile 22:07:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozrunner 22:07:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozscreenshot 22:07:34 INFO - Running setup.py install for moztest 22:07:34 INFO - Running setup.py install for mozversion 22:07:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:34 INFO - Cleaning up... 22:07:34 INFO - Return code: 0 22:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:34 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')]} 22:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:34 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')]} 22:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:34 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:34 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 22:07:34 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 22:07:34 INFO - Using env: {'DISPLAY': ':0', 22:07:34 INFO - 'HOME': '/home/cltbld', 22:07:34 INFO - 'LANG': 'en_US.UTF-8', 22:07:34 INFO - 'LANGUAGE': 'en_US:en', 22:07:34 INFO - 'LOGNAME': 'cltbld', 22:07:34 INFO - 'MAIL': '/var/mail/cltbld', 22:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:34 INFO - 'MOZ_NO_REMOTE': '1', 22:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:34 INFO - 'NO_EM_RESTART': '1', 22:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:34 INFO - 'PWD': '/builds/slave/test', 22:07:34 INFO - 'SHELL': '/bin/bash', 22:07:34 INFO - 'SHLVL': '1', 22:07:34 INFO - 'TERM': 'linux', 22:07:34 INFO - 'TMOUT': '86400', 22:07:34 INFO - 'USER': 'cltbld', 22:07:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:34 INFO - '_': '/tools/buildbot/bin/python'} 22:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:35 INFO - Running setup.py (path:/tmp/pip-B9D8nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:35 INFO - Running setup.py (path:/tmp/pip-pM6IYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:35 INFO - Running setup.py (path:/tmp/pip-ULik5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:35 INFO - Running setup.py (path:/tmp/pip-bRKXTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:35 INFO - Running setup.py (path:/tmp/pip-ybxTY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:35 INFO - Running setup.py (path:/tmp/pip-S9sGyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:35 INFO - Running setup.py (path:/tmp/pip-6Dry6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:35 INFO - Running setup.py (path:/tmp/pip-rGcn5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:35 INFO - Running setup.py (path:/tmp/pip-JkDRD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:35 INFO - Running setup.py (path:/tmp/pip-X83bWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:35 INFO - Running setup.py (path:/tmp/pip-8SmuIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:35 INFO - Running setup.py (path:/tmp/pip-jDiSC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:35 INFO - Running setup.py (path:/tmp/pip-XK1gnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:35 INFO - Running setup.py (path:/tmp/pip-jcZzfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:36 INFO - Running setup.py (path:/tmp/pip-vvNa8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:36 INFO - Running setup.py (path:/tmp/pip-8S50hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:36 INFO - Running setup.py (path:/tmp/pip-9d9T0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:36 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)) 22:07:36 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)) 22:07:36 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)) 22:07:36 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)) 22:07:36 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)) 22:07:36 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)) 22:07:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:38 INFO - Downloading blessings-1.6.tar.gz 22:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:38 INFO - Installing collected packages: blessings 22:07:38 INFO - Running setup.py install for blessings 22:07:38 INFO - Successfully installed blessings 22:07:38 INFO - Cleaning up... 22:07:38 INFO - Return code: 0 22:07:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:38 INFO - Reading from file tmpfile_stdout 22:07:38 INFO - Current package versions: 22:07:38 INFO - argparse == 1.2.1 22:07:38 INFO - blessings == 1.6 22:07:38 INFO - blobuploader == 1.2.4 22:07:38 INFO - docopt == 0.6.1 22:07:38 INFO - manifestparser == 1.1 22:07:38 INFO - mozInstall == 1.12 22:07:38 INFO - mozcrash == 0.17 22:07:38 INFO - mozdebug == 0.1 22:07:38 INFO - mozdevice == 0.48 22:07:38 INFO - mozfile == 1.2 22:07:38 INFO - mozhttpd == 0.7 22:07:38 INFO - mozinfo == 0.9 22:07:38 INFO - mozleak == 0.1 22:07:38 INFO - mozlog == 3.1 22:07:38 INFO - moznetwork == 0.27 22:07:38 INFO - mozprocess == 0.22 22:07:38 INFO - mozprofile == 0.28 22:07:38 INFO - mozrunner == 6.11 22:07:38 INFO - mozscreenshot == 0.1 22:07:38 INFO - mozsystemmonitor == 0.0 22:07:38 INFO - moztest == 0.7 22:07:38 INFO - mozversion == 1.4 22:07:38 INFO - psutil == 3.1.1 22:07:38 INFO - requests == 1.2.3 22:07:38 INFO - wsgiref == 0.1.2 22:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:38 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')]} 22:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:38 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')]} 22:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:38 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:38 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 22:07:38 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 22:07:38 INFO - Using env: {'DISPLAY': ':0', 22:07:38 INFO - 'HOME': '/home/cltbld', 22:07:38 INFO - 'LANG': 'en_US.UTF-8', 22:07:38 INFO - 'LANGUAGE': 'en_US:en', 22:07:38 INFO - 'LOGNAME': 'cltbld', 22:07:38 INFO - 'MAIL': '/var/mail/cltbld', 22:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:38 INFO - 'MOZ_NO_REMOTE': '1', 22:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:38 INFO - 'NO_EM_RESTART': '1', 22:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:38 INFO - 'PWD': '/builds/slave/test', 22:07:38 INFO - 'SHELL': '/bin/bash', 22:07:38 INFO - 'SHLVL': '1', 22:07:38 INFO - 'TERM': 'linux', 22:07:38 INFO - 'TMOUT': '86400', 22:07:38 INFO - 'USER': 'cltbld', 22:07:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:38 INFO - '_': '/tools/buildbot/bin/python'} 22:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 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)) 22:07:38 INFO - Cleaning up... 22:07:38 INFO - Return code: 0 22:07:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:38 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')]} 22:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:38 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')]} 22:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:38 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 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:38 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 22:07:38 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 22:07:38 INFO - Using env: {'DISPLAY': ':0', 22:07:38 INFO - 'HOME': '/home/cltbld', 22:07:38 INFO - 'LANG': 'en_US.UTF-8', 22:07:38 INFO - 'LANGUAGE': 'en_US:en', 22:07:38 INFO - 'LOGNAME': 'cltbld', 22:07:38 INFO - 'MAIL': '/var/mail/cltbld', 22:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:38 INFO - 'MOZ_NO_REMOTE': '1', 22:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:38 INFO - 'NO_EM_RESTART': '1', 22:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:38 INFO - 'PWD': '/builds/slave/test', 22:07:38 INFO - 'SHELL': '/bin/bash', 22:07:38 INFO - 'SHLVL': '1', 22:07:38 INFO - 'TERM': 'linux', 22:07:38 INFO - 'TMOUT': '86400', 22:07:38 INFO - 'USER': 'cltbld', 22:07:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:38 INFO - '_': '/tools/buildbot/bin/python'} 22:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:39 INFO - Downloading/unpacking jsonschema 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:40 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:40 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 22:07:40 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 22:07:40 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 22:07:40 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 22:07:40 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 22:07:40 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 22:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:41 INFO - warning: no files found matching '*.txt' 22:07:41 INFO - no previously-included directories found matching 'build' 22:07:41 INFO - no previously-included directories found matching 'dist' 22:07:41 INFO - no previously-included directories found matching '.git*' 22:07:41 INFO - Installing collected packages: jsonschema, functools32 22:07:41 INFO - Running setup.py install for functools32 22:07:41 INFO - warning: no files found matching '*.txt' 22:07:41 INFO - no previously-included directories found matching 'build' 22:07:41 INFO - no previously-included directories found matching 'dist' 22:07:41 INFO - no previously-included directories found matching '.git*' 22:07:41 INFO - Successfully installed jsonschema functools32 22:07:41 INFO - Cleaning up... 22:07:41 INFO - Return code: 0 22:07:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f3bb72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', '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 22:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:07:41 INFO - Using env: {'DISPLAY': ':0', 22:07:41 INFO - 'HOME': '/home/cltbld', 22:07:41 INFO - 'LANG': 'en_US.UTF-8', 22:07:41 INFO - 'LANGUAGE': 'en_US:en', 22:07:41 INFO - 'LOGNAME': 'cltbld', 22:07:41 INFO - 'MAIL': '/var/mail/cltbld', 22:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:41 INFO - 'MOZ_NO_REMOTE': '1', 22:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:41 INFO - 'NO_EM_RESTART': '1', 22:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:41 INFO - 'PWD': '/builds/slave/test', 22:07:41 INFO - 'SHELL': '/bin/bash', 22:07:41 INFO - 'SHLVL': '1', 22:07:41 INFO - 'TERM': 'linux', 22:07:41 INFO - 'TMOUT': '86400', 22:07:41 INFO - 'USER': 'cltbld', 22:07:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:41 INFO - '_': '/tools/buildbot/bin/python'} 22:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:41 INFO - Downloading/unpacking flake8 22:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:44 INFO - no previously-included directories found matching 'docs/_build' 22:07:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:44 INFO - Running setup.py install for pep8 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:44 INFO - no previously-included directories found matching 'docs/_build' 22:07:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:07:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:44 INFO - Cleaning up... 22:07:44 INFO - Return code: 0 22:07:44 INFO - Running post-action listener: _resource_record_post_action 22:07:44 INFO - Running post-action listener: _start_resource_monitoring 22:07:44 INFO - Starting resource monitoring. 22:07:44 INFO - ##### 22:07:44 INFO - ##### Running install step. 22:07:44 INFO - ##### 22:07:44 INFO - Running pre-action listener: _resource_record_pre_action 22:07:44 INFO - Running main action method: install 22:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:44 INFO - Reading from file tmpfile_stdout 22:07:44 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:44 INFO - Reading from file tmpfile_stdout 22:07:44 INFO - Output received: 22:07:44 INFO - Usage: mozinstall [options] installer 22:07:44 INFO - Options: 22:07:44 INFO - -h, --help show this help message and exit 22:07:44 INFO - -d DEST, --destination=DEST 22:07:44 INFO - Directory to install application into. [default: 22:07:44 INFO - "/builds/slave/test"] 22:07:44 INFO - --app=APP Application being installed. [default: firefox] 22:07:44 INFO - mkdir: /builds/slave/test/build/application 22:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:07:58 INFO - Reading from file tmpfile_stdout 22:07:58 INFO - Output received: 22:07:58 INFO - /builds/slave/test/build/application/firefox/firefox 22:07:58 INFO - Running post-action listener: _resource_record_post_action 22:07:58 INFO - ##### 22:07:58 INFO - ##### Running run-tests step. 22:07:58 INFO - ##### 22:07:58 INFO - Running pre-action listener: _resource_record_pre_action 22:07:58 INFO - Running main action method: run_tests 22:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:07:58 INFO - Python 2.7.3 22:07:58 INFO - Return code: 0 22:07:58 INFO - grabbing minidump binary from tooltool 22:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:58 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 0x27ac410>, '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 0x27ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ad7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:07:58 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 22:07:58 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 22:07:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:58 INFO - Return code: 0 22:07:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:07:59 INFO - Return code: 0 22:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 22:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 22:07:59 INFO - Using env: {'DISPLAY': ':0', 22:07:59 INFO - 'HOME': '/home/cltbld', 22:07:59 INFO - 'LANG': 'en_US.UTF-8', 22:07:59 INFO - 'LANGUAGE': 'en_US:en', 22:07:59 INFO - 'LOGNAME': 'cltbld', 22:07:59 INFO - 'MAIL': '/var/mail/cltbld', 22:07:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:07:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:59 INFO - 'MOZ_NO_REMOTE': '1', 22:07:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:59 INFO - 'NO_EM_RESTART': '1', 22:07:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:59 INFO - 'PWD': '/builds/slave/test', 22:07:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:07:59 INFO - 'SHELL': '/bin/bash', 22:07:59 INFO - 'SHLVL': '1', 22:07:59 INFO - 'TERM': 'linux', 22:07:59 INFO - 'TMOUT': '86400', 22:07:59 INFO - 'USER': 'cltbld', 22:07:59 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418', 22:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:59 INFO - '_': '/tools/buildbot/bin/python'} 22:07:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 22:07:59 INFO - mozversion application_buildid: 20160701192722 22:07:59 INFO - mozversion application_changeset: e8999eb7311ec1063176e4a836388b763fb91942 22:07:59 INFO - mozversion application_display_name: Firefox 22:07:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:59 INFO - mozversion application_name: Firefox 22:07:59 INFO - mozversion application_remotingname: firefox 22:07:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:07:59 INFO - mozversion application_vendor: Mozilla 22:07:59 INFO - mozversion application_version: 48.0 22:07:59 INFO - mozversion platform_buildid: 20160701192722 22:07:59 INFO - mozversion platform_changeset: e8999eb7311ec1063176e4a836388b763fb91942 22:07:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:07:59 INFO - mozversion platform_version: 48.0 22:07:59 INFO - using testdate: 1467436079 22:07:59 INFO - actual date: 1467436079 22:07:59 INFO - starting webserver on 'localhost:47592' 22:07:59 INFO - SUITE-START | Running 2 tests 22:07:59 INFO - TEST-START | dromaeo_css 22:07:59 INFO - operating with platform_type : linux_ 22:07:59 INFO - Initialising browser for dromaeo_css test... 22:07:59 INFO - TEST-INFO | started process 11869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf4G7S/profile http://localhost:47592/getInfo.html) 22:08:03 INFO - PROCESS | 11869 | __metrics Screen width/height:1600/1200 22:08:03 INFO - PROCESS | 11869 | colorDepth:24 22:08:03 INFO - PROCESS | 11869 | Browser inner width/height: 1024/697 22:08:03 INFO - PROCESS | 11869 | __metrics 22:08:04 ERROR - PROCESS | 11869 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:08:04 INFO - TEST-INFO | 11869: exit 0 22:08:04 INFO - Browser initialized. 22:08:04 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:04 INFO - TEST-INFO | started process 11963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf4G7S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:16 INFO - PROCESS | 11963 | RSS: Main: 139227136 22:08:16 INFO - PROCESS | 11963 | 22:09:08 INFO - PROCESS | 11963 | 1467436148109 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:11:14 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47592/tests/dromaeo/cssquery-ext.html) 22:11:15 INFO - PROCESS | 11963 | RSS: Main: 249364480 22:11:15 INFO - PROCESS | 11963 | 22:14:18 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-ext.html (next: http://localhost:47592/tests/dromaeo/cssquery-jquery.html) 22:14:18 INFO - PROCESS | 11963 | RSS: Main: 224026624 22:14:18 INFO - PROCESS | 11963 | 22:17:20 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47592/tests/dromaeo/cssquery-mootools.html) 22:17:21 INFO - PROCESS | 11963 | RSS: Main: 220729344 22:17:21 INFO - PROCESS | 11963 | 22:20:22 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47592/tests/dromaeo/cssquery-prototype.html) 22:20:23 INFO - PROCESS | 11963 | RSS: Main: 217800704 22:20:23 INFO - PROCESS | 11963 | 22:23:25 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47592/tests/dromaeo/cssquery-yui.html) 22:23:26 INFO - PROCESS | 11963 | RSS: Main: 195850240 22:23:26 INFO - PROCESS | 11963 | 22:26:28 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:47592/tests/dromaeo/cssquery-yui.html (next: http://localhost:47592/tests/dromaeo/cssquery-dojo.html) 22:26:29 INFO - PROCESS | 11963 | RSS: Main: 257024000 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | __start_tp_report 22:26:29 INFO - PROCESS | 11963 | _x_x_mozilla_page_load 22:26:29 INFO - PROCESS | 11963 | _x_x_mozilla_page_load_details 22:26:29 INFO - PROCESS | 11963 | |i|pagename|runs| 22:26:29 INFO - PROCESS | 11963 | |0;dojo.html;3274.050525347649;3353.3796247694163;3370.865165393381;3372.6458721834206;3412.829358532073;5553.08374118271;5557.499825015748;5578.274824272844;5585.441455854412;5619.438056194378;5552.7223638817995;5583.3300003999475;5586.35756887958;5593.916091258634;5632.324121105463;4992.126377883874;5036.7481625918745;5117.411497677759;5149.794008239666;5185.792568297283;4963.280324352967;5083.923741143886;5122.334096567441;5174.818881339153;5217.947820521803;5110.233464980264;5146;5155.613329000321;5155.896882062357;5166.509181627739;5102.948970510284;5144.43411224765;5165.63840531163;5171.482851714836;5190.896182076337;4913.410390753133;4966.776495057731;5028.823991160292;5059.16523773577;5074.543291103819;5351.170568561879;5353.116735738598;5353.598480113968;5363.839084827461;5369.865753356158;5840.591158618899;5841.0362290222065;5841.56188285876;5848.210491583624;5862.618929769594;5761.654300741969;5962.880742385171;6063.878722425571;6082.635041897501;6084.30030546484;5640.802571910004;5641.576881733887;5646.632968857052;5648.4633959773755;5662.235598194232;5977.342492325841;6111.052786818051;6114.052321890114;6132.08018797184;6133.539984501181;5849.181114643953;5915.822525324247;5928.970355148283;5966.045432730829;5968.104784282305;5960.135780311831;5965.28416590012;5965.79119730816;5968.970155149196;5969.343372229051;5691.800786972436;5786.074228123564;5925;5933.199018132583;5936;5946.167536544887;5954.19618351517;5963.254593175853;5964.970175149097;5997.910031349533;4545.613622842029;4564.497905230422;4571.794269257892;4575.931361029588;4599.264117741212;4025.335819589735;4050.311447054008;4102.097538541516;4114;4147.81334839933;5638.830835074954;5641.464060914206;5651.745671444794;5677.1768093627015;5711.029125048752;5865.325487568899;5876.794312199053;5904.793332233351;5928.021876390348;5933.317668468095;5595.524380427628;5604.159376093618;5681.204631351614;5720.799772007959;5759.251297331404;4951.059298733229;4953.083679519301;4953.8018479261145;4956.479569645136;4976.278439626234;6068.939310606926;6077.4226448487325;6137.631742095488;6138.7237574309265;6151.784687535915;5810.5061069809535;5907.675077870758;5982.7008649568215;6009.429104235091;6022.548308876764;6130.693465326626;6133.080037994337;6134.38656134383;6137.938620613915;6146.200993870768;5750.5112065474905;5765.91351129725;5766.250387449605;5778.624389414675;5779.624324418899;5969.015112506388;6030.7889223876955;6041.758329666764;6051.697415129314;6082.178905847654;5814.127880817911;5828.067509198508;5849.034909239927;5856.765729370777;5861.827634473208;5638.407967163389;5762.827115186551;5841.18223448709;5850.005499065254;5853.1220316952795;5715.8571035724435;5724.4275572444085;5756.934967031113;5765.135229715576;5801.883962320814;5852.5317974561085;5861.120831875252;5864.266966629171;5868.2664666916635;5868.295804503487;5591.217229587943;5687.118496633028;5689.914651280317;5735.340435849764;5784.537237020944 22:26:29 INFO - PROCESS | 11963 | |1;ext.html;665.4443539644396;668.8461653819625;675.5203805298238;675.975896516777;747.8691229034918;33197.834010829945;39173.60826391739;39754.99999999996;39867.60132398675;39915.20169596606;42902.57097429033;43424;43630.7818460908;43632.56367436325;43779.562204378024;8797.824043519126;8967.686130985418;8971.641134354652;8986.23616992553;8986.820263594724;8748.47509149453;8864;8872.556372181398;8874.023857375683;9036.412633178856;9049;9131.13254240846;9131.31515136364;9135.26917846574;9139.497327646977;9011.594478248495;9058.818823623491;9060.048694887073;9064.410813297114;9067.274618030542;9017.684381046698;9053.09469053096;9125.954370228174;9138.862917056249;9139.177474027369;44634.66096017125;45014.77492612516;45148;45169.77415112904;45242.32136517955;3854.2869569129803;3940.7241493095494;4063.573324800883;4162.979185104085;4281.636060934824;33657.49513757296;33944.49083263753;33995.830020849986;34088;35416.82291588551;4552.567506086916;4587.747673877935;4649.116667833135;4656.487786343533;4690.50749671283;231202;231223;232001;232301;232418;39700;40356.77145828327;60552.69723651354;61395;61429.38570614326;40298.59701402948;40534.59465405308;40623;40724.79637601852;40726.1854762909;16377.508674739776;16380.344786208418;16414.917925410537;16501.752473712902;16617.91691041537;14966.251687415586;15037.172955487335;15040.247987600576;15049.849501505063;15053.623659408602;9535.046495350549;9584.28117891161;9593.376430531993;9629.181519570915;9644.324897257125;3611.963880361215;3658.378075727133;3668.761530500509;3689.3543629864666;3707.0547010512146;1082.6210826210763;1130.8013505683837;1141.4578075414113;1142.3260276436777;1208.7219939413808;32543.349133017207;32903.1774205642;33587.160320992174;33973.490397644055;34160;1198.568515334479;1208.6615747590688;1210.5883999440232;1326.5091915991145;1380.6962468256968;17544.122793860257;17597.824021759618;17630.82369176292;17835.554111147067;17840.286388544573;478396;483222;484013;485522.289554214;486183;61641.691791540754;63070.36929630737;63182.36817631765;63252.36747632557;63299.6835015822;1430.9212993285262;1502.8046353973914;1514.5304955463841;1530.1125347298319;1538.907665540071;32825.50761738623;34804.303913922085;35086.64913350936;35281.294374112884;35292.294154117284;52399;53206.73396632992;53233;53378.73310633422;53395.73302133464;413989;417959;423548;423606;424983;41203.58796411997;47534.762326188145;47535.762321189555;48618.75690621524;48823.267650984555;50642.24036639527;52621;53487.46512534825;53762.731186343815;54274;43817.56182438135;44025.779871100436;44181.77909110434;44220;44265.77867110644;43745.78127109344;44052.55947440613;44315.77842110769;44853;45101;44487.77756111199;44854.55145448504;44909.775451122536;45659.54340456553;46288.30567541557;38124.2375152501;38952.41571376488;38988.61011389963;39189.41215881821;39388.65196458333;29474.750182430525;29512.852435738543;29907.850460747555;30170.84914575413;30182 22:26:29 INFO - PROCESS | 11963 | |2;jquery.html;436.4152036271396;439.8394585976119;444.44444444444446;447.5323287164913;453.22046080741114;18950.336738214166;18982.050897455123;19612.019399030043;20059.09734061967;20098.59802803943;20448.182072717074;20548.486287842774;20880.89559552204;20883.79116208841;20918.16327346908;5512.503874651271;6016.0975853622085;6022.608530445507;6024.48791852693;6025.945459544584;4436.844710435135;5837.941620583803;5979.1031345298115;6291.276503202122;6616.933830661704;6586.440152587036;6604.603723776589;6612.206535215781;6616.27221005689;6623.635700036496;6384.648844313561;6418.684169745215;6450.903236451457;6468.8706225875685;6481.48148148147;4061.6344528992236;5648.971755141198;5742.483176514133;5777.88444231113;5934.554908381845;22186.556268874694;22607.660885086738;22634.20780272699;22693.659595106088;22702.432439189153;2657.9601305980427;2705.242532090998;2844.687084420712;3001.1446737679876;3005.6985733641445;14113.364898579588;14522.927385363111;14710.779338309934;15246.542603721906;15562.37750489979;2030.2691031228746;2061.8247448966854;2095.6437405641077;2102.7792081831494;2162.8702277863376;79409;80257;80341.59829200876;81404.9999999994;81633.59183204106;10921.563137474572;10945.124390048777;11205.887941120647;11435.14236432271;11461.54153833854;15721.528354149394;15831.287592058385;15911.840881591035;15956.601084972737;15972.920135399248;9013.098690130935;9087.36388452802;9092.318076144316;9150.679726209552;9209.125133112344;8953.59708813105;8967.282617390723;9023.593938272794;9116.316276279305;9179.17387435134;6834.58992460444;6984.301569843076;7078.221395646475;7107.147142342952;7153.570785752871;1824.6350729854082;1886.2926402599026;1955.7946415626154;2019.768156187421;2076.4705000224844;1015.735908663738;1113.7605414835687;1134.489479734123;1146.39241202163;1167.737259116692;19488;19619.901900490408;19854;20182.19271229164;20555.691664624745;1056.3609016545033;1082.4479515447179;1097.3306283167421;1126.1047467263545;1141.8001849676273;10405.42770147634;11629.941850290863;11631.302121872715;11639.59261425846;11721.120915931338;527759;535851;537541;543779;545099;86120;87343;87452.5627371859;87746;87893;1132.1056365471186;1165.4405885175163;1165.452237448398;1167.9299242045504;1169.7655981211956;17072.74390884113;17786.5553361167;17886.195121219836;18012.189451474453;18184.181711823265;35237.295254094264;36014;36141.27717445584;37865.62134378621;37928.431073533364;46520;48368.27447588219;48734.512654873;48807.26789098237;49095.754521227165;9169.679061232824;9275.21160701348;9421.952890235505;9478.289128315266;9643.08390702882;12756.872431275568;13494.190348579117;13747.518836841062;13817.516386926409;13964.162150271017;11770.82343764827;12263;12358.320292383645;12416.627501174979;12777.16948398351;12146.635600931986;12478.87521124777;12727.681807954876;12815.935920320711;12835.743285134058;12603.87396126027;12739.872601273868;12751.744965100832;12792.6801829955;12959.805602916153;9118.22495087925;9191.402558833654;9202.953985230031;9408.506745712255;9442.575084121094;9374.96875343698;11510.769784604428;12118.818217726564;12184.695382615506;12186.57346992851 22:26:29 INFO - PROCESS | 11963 | |3;mootools.html;1423.629856237378;1514.1672080355804;1523.0404844947684;1705.1729910993174;1852.4164888060252;7959.2040795920375;8195.508269503827;8225.218604232603;8226.01287845458;8233.588320583962;8269.131741167166;8435.451695639795;8445.746627601182;8450.366222533305;8455.746327610166;2411.951760964784;2438.5366780311774;2438.8658623775773;2447.21689059501;2448;2389.6893403857475;2439.109724950389;2443.035001174535;2448.179859746978;2459.754024597544;2414.28778510339;2424.030387844867;2464.827462077655;2507.674002379688;2510.585753350695;2293.2546922250167;2338.5089131282452;2416.7583241675866;2422.9394265143424;2432.9878350608133;2427.2718184544565;2464.741202173782;2480.2435257246534;2480.3179125740385;2480.6651102101346;7335.559866408033;8008.159143289987;8591.5704214789;8649.65401383944;8676.479411235347;5315.123004704219;5406.107992181285;5407.918881216785;5452.536534394581;5452.863678408032;3506.877259295938;3579.8568057277676;3645.7265705072227;3758.68051215647;3773.2642134783728;1215.878412158786;1230.1143176912608;1250.2248605864331;1283.8587755346905;1301.9804702929464;12028.458719357563;12031.939840300742;12069.215500992408;12096.092793040469;12107.818382724266;4681.95318046822;4744.098621261949;4793.376861008047;4835;4855.450888283679;10201.38791672502;10208.183345332356;10213.948930255301;10220.131288840383;10222.64220752285;5307.310049693592;5312.5218730314455;5316.574674026068;5319.441458646864;5329.680219186861;4842.5157484251295;4906.852794416173;4918.877028074256;4927.728974906415;4930.038642464757;3727.6086010969;3737.7383583148917;3746.4942232798767;3762.097096696828;3772.3775577030033;1235.1600911380347;1251.393074358935;1264.7217612125319;1268.5686866465446;1273.891719203878;1018.383877753963;1069.0485467933545;1086.1690806533009;1086.5327908999047;1110.7389763405592;6058.27300723916;6195.473384762256;6236.282827474898;6357.837498692846;6366.108744775735;1064.643344479608;1078.757279612081;1082.0532034469838;1082.226208261097;1088.6733979806027;3876.282887665791;4227.133437645337;4297.720648157922;4327.805248763751;4365.257906155961;10179.18566514677;10200.846987295048;10338.638147664946;10444.21668374875;10510.316829406063;10263;10286.794264114676;10294.227932904912;10389.480525973822;10403.94798026005;7704.614769261514;7784.649690763929;7889.2110788920645;7940.285374316224;7975.162607926084;6009.248843894513;6034.366391528826;6131.908021379772;6162.907556386747;6185.783497577743;9284.907150928404;9384.249260059316;9549.47477888695;9556.187724043533;9570;9275.443473391619;9458.716238512581;9471.242300616072;9672.56473458682;9695.806083878142;7107.147142342952;7119.893201601876;7136.750213742494;7138.321859423347;7176.892346614701;8113.107558168715;8184.754457366289;8185.754427367188;8186;8193;7470.775876723707;7484.288992545699;7661.118971318369;7667.424943129176;7760.534367937942;7335.303146201102;7412.851742965218;7485.0643669541305;7577.355924746458;7625.50434221796;6483.384078512534;6567.868642627216;6613.966930165318;6623.536352455282;6625.768098116543;4674.62602991753;4911.263310503453;4999.425066117297;5027.723475208899;5200.843974680765;5168.612354073384;5268.604854635994;5278.89442211146;5335.093034184276;5340.439253878442 22:26:29 INFO - PROCESS | 11963 | |4;prototype.html;364.47371679005647;364.74832365667686;370.52202658570445;372.1533511261879;374.09282489961834;5930.733117009734;6004.339522652515;6095.481884039857;6132.386761323865;6178.567500274977;5869.8239052828485;5962.403759624035;5962.6124301920345;5977.043673012308;6091.055886337614;4512.5261847506035;4707.176244157267;4731.455882573497;4737.810487580493;4751.738654374008;4595.241785105453;4613.1696294666945;4669.789859456333;4710.128626204146;4760.166970780117;4684.625229981611;4693.108309421216;4696.365990591277;4698.060387922412;4720.811167553294;4690.742009189493;4699.506551812045;4708.693934894221;4708.764561771898;4708.811647534111;4172.395002724618;4191.203671302474;4200.936985945214;4207.284761590537;4207.97896010518;5836.182934389189;5843.970780146072;5845.444682755132;5852.268466441695;5862.296524417055;5278.419373868871;5413.83758487246;5414.810481633163;5504.91742623861;5507.697076660782;6380.808575742689;6393.680315984228;6398.424141827211;6417.518686098561;6420.6147631142285;4531.207038768202;4631.560001799824;4667.6265898728025;4671.532846715335;4672.696274742165;6593.80218593443;6677.666116694194;6683.2314283857495;6696.63168525726;6701.530892837503;4793.1372352976105;4797.736124513115;4801.207800712913;4804.039192161582;4804.73573953429;4846.491118432585;4851.369321988119;4852.902941941142;4870.95129048705;4873.707577545359;5493.478119578714;5494.835154945358;5498.670079795225;5503.229547863302;5510.256115424447;6239.344868788802;6459.063435801782;6467.997460393646;6474.320196379406;6483.546151769331;1684.4609724887919;1695.6184858407007;1707.3682737386998;1707.5474999125242;1710.9914450427668;1148.5979907032638;1168.1414160591958;1185.5376403202758;1185.8636256830403;1191.5293459083614;6280.497560195174;6296;6306;6307.92765229912;6308.148399966038;6592.571482853599;6615.206175259;6623.536352455379;6625.337466253336;6637.668116594151;6290.182276304143;6295.874082518416;6300.30696623371;6307.053941908659;6317.5893566918;3521.2781379817075;3554;3559.3771090059654;3560.608333083359;3560.608333083359;6875.621840798804;7017.578945263301;7082.327178917994;7085.972533982544;7095.219525852152;6789.626570538668;6793.218779840382;6799.048133261347;6801.081853949653;6816.147981502312;7053.259407762213;7060.505764596532;7069.222385537587;7071.398931090915;7075.433965282765;6600.141981542369;6626.271110177973;6649.401553860176;6656.866862662817;6660.367265109807;6443.259025212161;6565.343465653396;6570.441512471302;6588.308227636221;6591.373819487141;7004.194517630538;7028.191757947901;7033.788986330418;7037.049998250375;7043.260457652078;4388.2759344707765;4487.5288094749585;4530.592246697813;4658.04510075427;4671.76641167947;6590.80227593173;6599.208095028627;6603.306652801579;6605.867882642417;6608.074869518176;6367.172267605181;6409.455196308366;6416.133821934166;6422.614643121427;6430.839229019312;6402.135711678864;6406.423421892052;6408.967955160194;6416.165898433173;6416.807495774948;6188.628682279078;6275.403836635513;6313.210848643919;6321.620702757849;6324.083007963727;6398.872022559616;6427.389398007182;6430.64631445275;6438;6442.8389290268115;6268.592541484789;6278.937210628018;6288.654124023223;6288.6855657217875;6293.276273228455 22:26:29 INFO - PROCESS | 11963 | |5;yui.html;910.9453432794032;914.5975770660908;930.3348106104137;936.2369668719997;938.8779458670376;15310.46413375532;15633.218339083058;15707.84292157078;15736.134512601817;15743.370265189393;14549.92725036376;14552.708945821078;14656.633584160401;14657;14664.633384165401;773.4663082473089;911.3347256502757;926.4533924984258;928.4290161550631;930.9255259579252;913.0367462327242;916.9358144929857;920.8250432417852;922.2852289475643;922.4880191493718;994.3089552760835;994.9850752238686;996.3922007575374;996.6163027234494;997.1125698128672;815.4088285992638;969.1277849935079;984.4191926763244;986.4525188520369;987.328616540752;726.8909663550456;727.1928159742735;727.2436665867491;727.3998950865557;727.7889412070493;15135.924320378437;15192.772108418272;15193.620159495991;15254.771178432333;15264.771028434583;14983.250837458192;15264.618384540365;15345.232738363036;15452.5364239073;15455.536333909888;12067.456964436622;12112.81830772539;12113.939430302793;12369.010479161645;12407.813882791765;4003.259397011533;4051.4125451809323;4065.6340929316207;4073.633372996415;4200.70595058346;54713.452865471234;54996.725016374665;55048.17427738587;55143.72428137834;55291.170632440546;11686;11842.171048026556;12077.879221207675;12242.510299588095;12245.755084898252;21932.45168870791;21934;21968.780312196992;21970.780292196872;21971.121155153614;8642.913570864337;8883.511406872554;9117.407368521024;9139.588718507683;9171.678991235409;4949.950500495021;5046.016026874798;5063.924041139386;5070.949290507121;5146.279520867081;3628.6552777486095;3704.7036237100965;3768.660820526111;3902.2585708715255;3904.394818803033;650.187265917603;720.200577359131;731.119001603067;751.7782254235013;753.5252790741797;716.3373879161754;770.3875419041763;828.7430896422128;838.4466252273592;855.7561095087871;9732.270079743907;10132.138768204637;10175.185985121172;10176.643817466502;10216.233782466345;795.1055063054064;816.1348970091722;817.284875733733;820.4912953968578;822.6380392627225;5056.671306422733;5127.07712611726;5163.741812909339;5197;5323.680579165262;63664.68167659132;63716;64488;64654;64850.351496485375;56875.43124568701;56915;56937.145942810894;56946.145807812085;57929.4207057924;49739;49892;50255;51218;51264.74367628212;10125.67109564819;10309.948450258;10343.431111288952;10360.740981475523;10465.633702820365;37549;38009.619903801715;38265.617343826205;38619.613803862725;38993.220135597694;45895;46107;48666.75666621786;48861;49355;13017.934910325388;13086.214827110403;13323.13399629021;13482.325883705971;13499.86500134986;14220.786688199893;14647.853521464649;14717.33771980242;15198.848011520186;15532.378704851679;13906.304684765519;14102.153870767377;14108.153510789385;14184.219867907364;14379.928100359431;13920.860791392362;14081.647958801112;14169.929150354596;14175.503857364944;14332.713345733235;13125.34373281313;13366.93316533411;13483.460661573426;13801.51694690681;13811.51659691906;10665.360078395011;10684.946575267073;10988.230823842254;10997.56496746628;11241.437928103398;10952.890471095507;11038.227324087236;11051.944740276247;11116.49975751077;11220.66338009861 22:26:29 INFO - PROCESS | 11963 | __end_tp_report 22:26:29 INFO - PROCESS | 11963 | __start_cc_report 22:26:29 INFO - PROCESS | 11963 | _x_x_mozilla_cycle_collect,868 22:26:29 INFO - PROCESS | 11963 | __end_cc_report 22:26:29 INFO - PROCESS | 11963 | __startTimestamp1467437189152__endTimestamp 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | ------- Summary: start ------- 22:26:29 INFO - PROCESS | 11963 | Number of tests: 6 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#0] dojo.html Cycles:165 Average:5530.14 Median:5750.51 stddev:607.29 (10.6%) stddev-sans-first:582.80 22:26:29 INFO - PROCESS | 11963 | Values: 3274.1 3353.4 3370.9 3372.6 3412.8 5553.1 5557.5 5578.3 5585.4 5619.4 5552.7 5583.3 5586.4 5593.9 5632.3 4992.1 5036.7 5117.4 5149.8 5185.8 4963.3 5083.9 5122.3 5174.8 5217.9 5110.2 5146.0 5155.6 5155.9 5166.5 5102.9 5144.4 5165.6 5171.5 5190.9 4913.4 4966.8 5028.8 5059.2 5074.5 5351.2 5353.1 5353.6 5363.8 5369.9 5840.6 5841.0 5841.6 5848.2 5862.6 5761.7 5962.9 6063.9 6082.6 6084.3 5640.8 5641.6 5646.6 5648.5 5662.2 5977.3 6111.1 6114.1 6132.1 6133.5 5849.2 5915.8 5929.0 5966.0 5968.1 5960.1 5965.3 5965.8 5969.0 5969.3 5691.8 5786.1 5925.0 5933.2 5936.0 5946.2 5954.2 5963.3 5965.0 5997.9 4545.6 4564.5 4571.8 4575.9 4599.3 4025.3 4050.3 4102.1 4114.0 4147.8 5638.8 5641.5 5651.7 5677.2 5711.0 5865.3 5876.8 5904.8 5928.0 5933.3 5595.5 5604.2 5681.2 5720.8 5759.3 4951.1 4953.1 4953.8 4956.5 4976.3 6068.9 6077.4 6137.6 6138.7 6151.8 5810.5 5907.7 5982.7 6009.4 6022.5 6130.7 6133.1 6134.4 6137.9 6146.2 5750.5 5765.9 5766.3 5778.6 5779.6 5969.0 6030.8 6041.8 6051.7 6082.2 5814.1 5828.1 5849.0 5856.8 5861.8 5638.4 5762.8 5841.2 5850.0 5853.1 5715.9 5724.4 5756.9 5765.1 5801.9 5852.5 5861.1 5864.3 5868.3 5868.3 5591.2 5687.1 5689.9 5735.3 5784.5 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#1] ext.html Cycles:180 Average:55490.28 Median:43631.67 stddev:104197.03 (238.8%) stddev-sans-first:104408.02 22:26:29 INFO - PROCESS | 11963 | Values: 665.4 668.8 675.5 676.0 747.9 33197.8 39173.6 39755.0 39867.6 39915.2 42902.6 43424.0 43630.8 43632.6 43779.6 8797.8 8967.7 8971.6 8986.2 8986.8 8748.5 8864.0 8872.6 8874.0 9036.4 9049.0 9131.1 9131.3 9135.3 9139.5 9011.6 9058.8 9060.0 9064.4 9067.3 9017.7 9053.1 9126.0 9138.9 9139.2 44634.7 45014.8 45148.0 45169.8 45242.3 3854.3 3940.7 4063.6 4163.0 4281.6 33657.5 33944.5 33995.8 34088.0 35416.8 4552.6 4587.7 4649.1 4656.5 4690.5 231202.0 231223.0 232001.0 232301.0 232418.0 39700.0 40356.8 60552.7 61395.0 61429.4 40298.6 40534.6 40623.0 40724.8 40726.2 16377.5 16380.3 16414.9 16501.8 16617.9 14966.3 15037.2 15040.2 15049.8 15053.6 9535.0 9584.3 9593.4 9629.2 9644.3 3612.0 3658.4 3668.8 3689.4 3707.1 1082.6 1130.8 1141.5 1142.3 1208.7 32543.3 32903.2 33587.2 33973.5 34160.0 1198.6 1208.7 1210.6 1326.5 1380.7 17544.1 17597.8 17630.8 17835.6 17840.3 478396.0 483222.0 484013.0 485522.3 486183.0 61641.7 63070.4 63182.4 63252.4 63299.7 1430.9 1502.8 1514.5 1530.1 1538.9 32825.5 34804.3 35086.6 35281.3 35292.3 52399.0 53206.7 53233.0 53378.7 53395.7 413989.0 417959.0 423548.0 423606.0 424983.0 41203.6 47534.8 47535.8 48618.8 48823.3 50642.2 52621.0 53487.5 53762.7 54274.0 43817.6 44025.8 44181.8 44220.0 44265.8 43745.8 44052.6 44315.8 44853.0 45101.0 44487.8 44854.6 44909.8 45659.5 46288.3 38124.2 38952.4 38988.6 39189.4 39388.7 29474.8 29512.9 29907.9 30170.8 30182.0 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#2] jquery.html Cycles:180 Average:30340.81 Median:22620.93 stddev:88168.27 (389.8%) stddev-sans-first:88387.01 22:26:29 INFO - PROCESS | 11963 | Values: 436.4 439.8 444.4 447.5 453.2 18950.3 18982.1 19612.0 20059.1 20098.6 20448.2 20548.5 20880.9 20883.8 20918.2 5512.5 6016.1 6022.6 6024.5 6025.9 4436.8 5837.9 5979.1 6291.3 6616.9 6586.4 6604.6 6612.2 6616.3 6623.6 6384.6 6418.7 6450.9 6468.9 6481.5 4061.6 5649.0 5742.5 5777.9 5934.6 22186.6 22607.7 22634.2 22693.7 22702.4 2658.0 2705.2 2844.7 3001.1 3005.7 14113.4 14522.9 14710.8 15246.5 15562.4 2030.3 2061.8 2095.6 2102.8 2162.9 79409.0 80257.0 80341.6 81405.0 81633.6 10921.6 10945.1 11205.9 11435.1 11461.5 15721.5 15831.3 15911.8 15956.6 15972.9 9013.1 9087.4 9092.3 9150.7 9209.1 8953.6 8967.3 9023.6 9116.3 9179.2 6834.6 6984.3 7078.2 7107.1 7153.6 1824.6 1886.3 1955.8 2019.8 2076.5 1015.7 1113.8 1134.5 1146.4 1167.7 19488.0 19619.9 19854.0 20182.2 20555.7 1056.4 1082.4 1097.3 1126.1 1141.8 10405.4 11629.9 11631.3 11639.6 11721.1 527759.0 535851.0 537541.0 543779.0 545099.0 86120.0 87343.0 87452.6 87746.0 87893.0 1132.1 1165.4 1165.5 1167.9 1169.8 17072.7 17786.6 17886.2 18012.2 18184.2 35237.3 36014.0 36141.3 37865.6 37928.4 46520.0 48368.3 48734.5 48807.3 49095.8 9169.7 9275.2 9422.0 9478.3 9643.1 12756.9 13494.2 13747.5 13817.5 13964.2 11770.8 12263.0 12358.3 12416.6 12777.2 12146.6 12478.9 12727.7 12815.9 12835.7 12603.9 12739.9 12751.7 12792.7 12959.8 9118.2 9191.4 9203.0 9408.5 9442.6 9375.0 11510.8 12118.8 12184.7 12186.6 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#3] mootools.html Cycles:180 Average:5685.59 Median:4848.98 stddev:3076.27 (63.4%) stddev-sans-first:3068.22 22:26:29 INFO - PROCESS | 11963 | Values: 1423.6 1514.2 1523.0 1705.2 1852.4 7959.2 8195.5 8225.2 8226.0 8233.6 8269.1 8435.5 8445.7 8450.4 8455.7 2412.0 2438.5 2438.9 2447.2 2448.0 2389.7 2439.1 2443.0 2448.2 2459.8 2414.3 2424.0 2464.8 2507.7 2510.6 2293.3 2338.5 2416.8 2422.9 2433.0 2427.3 2464.7 2480.2 2480.3 2480.7 7335.6 8008.2 8591.6 8649.7 8676.5 5315.1 5406.1 5407.9 5452.5 5452.9 3506.9 3579.9 3645.7 3758.7 3773.3 1215.9 1230.1 1250.2 1283.9 1302.0 12028.5 12031.9 12069.2 12096.1 12107.8 4682.0 4744.1 4793.4 4835.0 4855.5 10201.4 10208.2 10213.9 10220.1 10222.6 5307.3 5312.5 5316.6 5319.4 5329.7 4842.5 4906.9 4918.9 4927.7 4930.0 3727.6 3737.7 3746.5 3762.1 3772.4 1235.2 1251.4 1264.7 1268.6 1273.9 1018.4 1069.0 1086.2 1086.5 1110.7 6058.3 6195.5 6236.3 6357.8 6366.1 1064.6 1078.8 1082.1 1082.2 1088.7 3876.3 4227.1 4297.7 4327.8 4365.3 10179.2 10200.8 10338.6 10444.2 10510.3 10263.0 10286.8 10294.2 10389.5 10403.9 7704.6 7784.6 7889.2 7940.3 7975.2 6009.2 6034.4 6131.9 6162.9 6185.8 9284.9 9384.2 9549.5 9556.2 9570.0 9275.4 9458.7 9471.2 9672.6 9695.8 7107.1 7119.9 7136.8 7138.3 7176.9 8113.1 8184.8 8185.8 8186.0 8193.0 7470.8 7484.3 7661.1 7667.4 7760.5 7335.3 7412.9 7485.1 7577.4 7625.5 6483.4 6567.9 6614.0 6623.5 6625.8 4674.6 4911.3 4999.4 5027.7 5200.8 5168.6 5268.6 5278.9 5335.1 5340.4 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#4] prototype.html Cycles:180 Average:5434.98 Median:6213.99 stddev:1607.32 (25.9%) stddev-sans-first:1566.12 22:26:29 INFO - PROCESS | 11963 | Values: 364.5 364.7 370.5 372.2 374.1 5930.7 6004.3 6095.5 6132.4 6178.6 5869.8 5962.4 5962.6 5977.0 6091.1 4512.5 4707.2 4731.5 4737.8 4751.7 4595.2 4613.2 4669.8 4710.1 4760.2 4684.6 4693.1 4696.4 4698.1 4720.8 4690.7 4699.5 4708.7 4708.8 4708.8 4172.4 4191.2 4200.9 4207.3 4208.0 5836.2 5844.0 5845.4 5852.3 5862.3 5278.4 5413.8 5414.8 5504.9 5507.7 6380.8 6393.7 6398.4 6417.5 6420.6 4531.2 4631.6 4667.6 4671.5 4672.7 6593.8 6677.7 6683.2 6696.6 6701.5 4793.1 4797.7 4801.2 4804.0 4804.7 4846.5 4851.4 4852.9 4871.0 4873.7 5493.5 5494.8 5498.7 5503.2 5510.3 6239.3 6459.1 6468.0 6474.3 6483.5 1684.5 1695.6 1707.4 1707.5 1711.0 1148.6 1168.1 1185.5 1185.9 1191.5 6280.5 6296.0 6306.0 6307.9 6308.1 6592.6 6615.2 6623.5 6625.3 6637.7 6290.2 6295.9 6300.3 6307.1 6317.6 3521.3 3554.0 3559.4 3560.6 3560.6 6875.6 7017.6 7082.3 7086.0 7095.2 6789.6 6793.2 6799.0 6801.1 6816.1 7053.3 7060.5 7069.2 7071.4 7075.4 6600.1 6626.3 6649.4 6656.9 6660.4 6443.3 6565.3 6570.4 6588.3 6591.4 7004.2 7028.2 7033.8 7037.0 7043.3 4388.3 4487.5 4530.6 4658.0 4671.8 6590.8 6599.2 6603.3 6605.9 6608.1 6367.2 6409.5 6416.1 6422.6 6430.8 6402.1 6406.4 6409.0 6416.2 6416.8 6188.6 6275.4 6313.2 6321.6 6324.1 6398.9 6427.4 6430.6 6438.0 6442.8 6268.6 6278.9 6288.7 6288.7 6293.3 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - PROCESS | 11963 | [#5] yui.html Cycles:180 Average:15752.10 Median:4058.52 stddev:17600.68 (433.7%) stddev-sans-first:17614.76 22:26:29 INFO - PROCESS | 11963 | Values: 910.9 914.6 930.3 936.2 938.9 15310.5 15633.2 15707.8 15736.1 15743.4 14549.9 14552.7 14656.6 14657.0 14664.6 773.5 911.3 926.5 928.4 930.9 913.0 916.9 920.8 922.3 922.5 994.3 995.0 996.4 996.6 997.1 815.4 969.1 984.4 986.5 987.3 726.9 727.2 727.2 727.4 727.8 15135.9 15192.8 15193.6 15254.8 15264.8 14983.3 15264.6 15345.2 15452.5 15455.5 12067.5 12112.8 12113.9 12369.0 12407.8 4003.3 4051.4 4065.6 4073.6 4200.7 54713.5 54996.7 55048.2 55143.7 55291.2 11686.0 11842.2 12077.9 12242.5 12245.8 21932.5 21934.0 21968.8 21970.8 21971.1 8642.9 8883.5 9117.4 9139.6 9171.7 4950.0 5046.0 5063.9 5070.9 5146.3 3628.7 3704.7 3768.7 3902.3 3904.4 650.2 720.2 731.1 751.8 753.5 716.3 770.4 828.7 838.4 855.8 9732.3 10132.1 10175.2 10176.6 10216.2 795.1 816.1 817.3 820.5 822.6 5056.7 5127.1 5163.7 5197.0 5323.7 63664.7 63716.0 64488.0 64654.0 64850.4 56875.4 56915.0 56937.1 56946.1 57929.4 49739.0 49892.0 50255.0 51218.0 51264.7 10125.7 10309.9 10343.4 10360.7 10465.6 37549.0 38009.6 38265.6 38619.6 38993.2 45895.0 46107.0 48666.8 48861.0 49355.0 13017.9 13086.2 13323.1 13482.3 13499.9 14220.8 14647.9 14717.3 15198.8 15532.4 13906.3 14102.2 14108.2 14184.2 14379.9 13920.9 14081.6 14169.9 14175.5 14332.7 13125.3 13366.9 13483.5 13801.5 13811.5 10665.4 10684.9 10988.2 10997.6 11241.4 10952.9 11038.2 11051.9 11116.5 11220.7 22:26:29 INFO - PROCESS | 11963 | -------- Summary: end -------- 22:26:29 INFO - PROCESS | 11963 | 22:26:29 INFO - TEST-INFO | 11963: exit 0 22:26:29 INFO - TEST-OK | dromaeo_css | took 1110604ms 22:26:29 INFO - TEST-START | kraken 22:26:29 INFO - operating with platform_type : linux_ 22:26:29 INFO - Initialising browser for kraken test... 22:26:29 INFO - TEST-INFO | started process 12157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyII9pG/profile http://localhost:47592/getInfo.html) 22:26:33 INFO - PROCESS | 12157 | __metrics Screen width/height:1600/1200 22:26:33 INFO - PROCESS | 12157 | colorDepth:24 22:26:33 INFO - PROCESS | 12157 | Browser inner width/height: 1024/697 22:26:33 INFO - PROCESS | 12157 | __metrics 22:26:34 ERROR - PROCESS | 12157 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:26:35 INFO - TEST-INFO | 12157: exit 0 22:26:35 INFO - Browser initialized. 22:26:35 INFO - Running cycle 1/1 for kraken test... 22:26:35 INFO - TEST-INFO | started process 12246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyII9pG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:47 INFO - PROCESS | 12246 | RSS: Main: 139145216 22:26:47 INFO - PROCESS | 12246 | 22:26:49 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47592/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:50 INFO - PROCESS | 12246 | RSS: Main: 197738496 22:26:50 INFO - PROCESS | 12246 | 22:26:53 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47592/tests/kraken/driver.html?testName=audio-dft) 22:26:53 INFO - PROCESS | 12246 | RSS: Main: 184750080 22:26:53 INFO - PROCESS | 12246 | 22:26:56 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47592/tests/kraken/driver.html?testName=audio-fft) 22:26:57 INFO - PROCESS | 12246 | RSS: Main: 273977344 22:26:57 INFO - PROCESS | 12246 | 22:26:59 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47592/tests/kraken/driver.html?testName=audio-oscillator) 22:26:59 INFO - PROCESS | 12246 | RSS: Main: 181194752 22:26:59 INFO - PROCESS | 12246 | 22:27:01 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47592/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:02 INFO - PROCESS | 12246 | RSS: Main: 178962432 22:27:02 INFO - PROCESS | 12246 | 22:27:05 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47592/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:06 INFO - PROCESS | 12246 | RSS: Main: 213557248 22:27:06 INFO - PROCESS | 12246 | 22:27:09 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47592/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:10 INFO - PROCESS | 12246 | RSS: Main: 212840448 22:27:10 INFO - PROCESS | 12246 | 22:27:12 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47592/tests/kraken/driver.html?testName=json-parse-financial) 22:27:13 INFO - PROCESS | 12246 | RSS: Main: 212824064 22:27:13 INFO - PROCESS | 12246 | 22:27:14 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47592/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:15 INFO - PROCESS | 12246 | RSS: Main: 192868352 22:27:15 INFO - PROCESS | 12246 | 22:27:17 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:17 INFO - PROCESS | 12246 | RSS: Main: 197222400 22:27:17 INFO - PROCESS | 12246 | 22:27:19 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:20 INFO - PROCESS | 12246 | RSS: Main: 209104896 22:27:20 INFO - PROCESS | 12246 | 22:27:22 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:23 INFO - PROCESS | 12246 | RSS: Main: 217726976 22:27:23 INFO - PROCESS | 12246 | 22:27:26 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:26 INFO - PROCESS | 12246 | RSS: Main: 212742144 22:27:26 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:47592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47592/tests/kraken/driver.html?testName=ai-astar) 22:27:28 INFO - PROCESS | 12246 | RSS: Main: 273768448 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | __start_tp_report 22:27:28 INFO - PROCESS | 12246 | _x_x_mozilla_page_load 22:27:28 INFO - PROCESS | 12246 | _x_x_mozilla_page_load_details 22:27:28 INFO - PROCESS | 12246 | |i|pagename|runs| 22:27:28 INFO - PROCESS | 12246 | |0;ai-astar;112;111;112;111;111;111;108;112;110;109 22:27:28 INFO - PROCESS | 12246 | |1;audio-beat-detection;153;126;157;172;125;156;156;133;182;135 22:27:28 INFO - PROCESS | 12246 | |2;audio-dft;160;159;160;160;160;160;161;167;162;160 22:27:28 INFO - PROCESS | 12246 | |3;audio-fft;76;74;72;181;76;75;75;75;168;76 22:27:28 INFO - PROCESS | 12246 | |4;audio-oscillator;100;92;152;92;92;92;141;91;91;155 22:27:28 INFO - PROCESS | 12246 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;117;117 22:27:28 INFO - PROCESS | 12246 | |6;imaging-darkroom;145;145;145;145;145;145;145;146;146;145 22:27:28 INFO - PROCESS | 12246 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;95 22:27:28 INFO - PROCESS | 12246 | |8;json-parse-financial;54;55;56;53;57;55;57;77;54;53 22:27:28 INFO - PROCESS | 12246 | |9;json-stringify-tinderbox;57;59;57;58;58;57;58;58;58;59 22:27:28 INFO - PROCESS | 12246 | |10;stanford-crypto-aes;72;72;71;71;75;73;73;72;82;72 22:27:28 INFO - PROCESS | 12246 | |11;stanford-crypto-ccm;114;121;125;113;118;110;120;122;134;123 22:27:28 INFO - PROCESS | 12246 | |12;stanford-crypto-pbkdf2;161;159;163;160;156;160;161;158;161;160 22:27:28 INFO - PROCESS | 12246 | |13;stanford-crypto-sha256-iterative;66;66;67;65;68;66;67;66;67;64 22:27:28 INFO - PROCESS | 12246 | __end_tp_report 22:27:28 INFO - PROCESS | 12246 | __start_cc_report 22:27:28 INFO - PROCESS | 12246 | _x_x_mozilla_cycle_collect,1565 22:27:28 INFO - PROCESS | 12246 | __end_cc_report 22:27:28 INFO - PROCESS | 12246 | __startTimestamp1467437248583__endTimestamp 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | ------- Summary: start ------- 22:27:28 INFO - PROCESS | 12246 | Number of tests: 14 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.33 22:27:28 INFO - PROCESS | 12246 | Values: 112.0 111.0 112.0 111.0 111.0 111.0 108.0 112.0 110.0 109.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.00 stddev:19.29 (12.4%) stddev-sans-first:20.42 22:27:28 INFO - PROCESS | 12246 | Values: 153.0 126.0 157.0 172.0 125.0 156.0 156.0 133.0 182.0 135.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#2] audio-dft Cycles:10 Average:160.90 Median:160.00 stddev:2.28 (1.4%) stddev-sans-first:2.40 22:27:28 INFO - PROCESS | 12246 | Values: 160.0 159.0 160.0 160.0 160.0 160.0 161.0 167.0 162.0 160.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:42.13 (56.2%) stddev-sans-first:44.14 22:27:28 INFO - PROCESS | 12246 | Values: 76.0 74.0 72.0 181.0 76.0 75.0 75.0 75.0 168.0 76.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:91.50 stddev:27.62 (30.2%) stddev-sans-first:29.07 22:27:28 INFO - PROCESS | 12246 | Values: 100.0 92.0 152.0 92.0 92.0 92.0 141.0 91.0 91.0 155.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:27:28 INFO - PROCESS | 12246 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 22:27:28 INFO - PROCESS | 12246 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:27:28 INFO - PROCESS | 12246 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:55.50 stddev:7.14 (12.9%) stddev-sans-first:7.49 22:27:28 INFO - PROCESS | 12246 | Values: 54.0 55.0 56.0 53.0 57.0 55.0 57.0 77.0 54.0 53.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 22:27:28 INFO - PROCESS | 12246 | Values: 57.0 59.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 59.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:72.50 stddev:3.27 (4.5%) stddev-sans-first:3.43 22:27:28 INFO - PROCESS | 12246 | Values: 72.0 72.0 71.0 71.0 75.0 73.0 73.0 72.0 82.0 72.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:121.50 stddev:6.86 (5.6%) stddev-sans-first:6.93 22:27:28 INFO - PROCESS | 12246 | Values: 114.0 121.0 125.0 113.0 118.0 110.0 120.0 122.0 134.0 123.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:1.91 (1.2%) stddev-sans-first:1.99 22:27:28 INFO - PROCESS | 12246 | Values: 161.0 159.0 163.0 160.0 156.0 160.0 161.0 158.0 161.0 160.0 22:27:28 INFO - PROCESS | 12246 | 22:27:28 INFO - PROCESS | 12246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.20 22:27:28 INFO - PROCESS | 12246 | Values: 66.0 66.0 67.0 65.0 68.0 66.0 67.0 66.0 67.0 64.0 22:27:28 INFO - PROCESS | 12246 | -------- Summary: end -------- 22:27:28 INFO - PROCESS | 12246 | 22:27:29 INFO - TEST-INFO | 12246: exit 0 22:27:29 INFO - TEST-OK | kraken | took 59747ms 22:27:29 INFO - SUITE-END | took 1170s 22:27:29 INFO - Completed test suite (00:19:30) 22:27:29 INFO - javascript benchmark 22:27:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.050525347649, 3353.3796247694163, 3370.865165393381, 3372.6458721834206, 3412.829358532073, 5553.08374118271, 5557.499825015748, 5578.274824272844, 5585.441455854412, 5619.438056194378, 5552.7223638817995, 5583.3300003999475, 5586.35756887958, 5593.916091258634, 5632.324121105463, 4992.126377883874, 5036.7481625918745, 5117.411497677759, 5149.794008239666, 5185.792568297283, 4963.280324352967, 5083.923741143886, 5122.334096567441, 5174.818881339153, 5217.947820521803, 5110.233464980264, 5146.0, 5155.613329000321, 5155.896882062357, 5166.509181627739, 5102.948970510284, 5144.43411224765, 5165.63840531163, 5171.482851714836, 5190.896182076337, 4913.410390753133, 4966.776495057731, 5028.823991160292, 5059.16523773577, 5074.543291103819, 5351.170568561879, 5353.116735738598, 5353.598480113968, 5363.839084827461, 5369.865753356158, 5840.591158618899, 5841.0362290222065, 5841.56188285876, 5848.210491583624, 5862.618929769594, 5761.654300741969, 5962.880742385171, 6063.878722425571, 6082.635041897501, 6084.30030546484, 5640.802571910004, 5641.576881733887, 5646.632968857052, 5648.4633959773755, 5662.235598194232, 5977.342492325841, 6111.052786818051, 6114.052321890114, 6132.08018797184, 6133.539984501181, 5849.181114643953, 5915.822525324247, 5928.970355148283, 5966.045432730829, 5968.104784282305, 5960.135780311831, 5965.28416590012, 5965.79119730816, 5968.970155149196, 5969.343372229051, 5691.800786972436, 5786.074228123564, 5925.0, 5933.199018132583, 5936.0, 5946.167536544887, 5954.19618351517, 5963.254593175853, 5964.970175149097, 5997.910031349533, 4545.613622842029, 4564.497905230422, 4571.794269257892, 4575.931361029588, 4599.264117741212, 4025.335819589735, 4050.311447054008, 4102.097538541516, 4114.0, 4147.81334839933, 5638.830835074954, 5641.464060914206, 5651.745671444794, 5677.1768093627015, 5711.029125048752, 5865.325487568899, 5876.794312199053, 5904.793332233351, 5928.021876390348, 5933.317668468095, 5595.524380427628, 5604.159376093618, 5681.204631351614, 5720.799772007959, 5759.251297331404, 4951.059298733229, 4953.083679519301, 4953.8018479261145, 4956.479569645136, 4976.278439626234, 6068.939310606926, 6077.4226448487325, 6137.631742095488, 6138.7237574309265, 6151.784687535915, 5810.5061069809535, 5907.675077870758, 5982.7008649568215, 6009.429104235091, 6022.548308876764, 6130.693465326626, 6133.080037994337, 6134.38656134383, 6137.938620613915, 6146.200993870768, 5750.5112065474905, 5765.91351129725, 5766.250387449605, 5778.624389414675, 5779.624324418899, 5969.015112506388, 6030.7889223876955, 6041.758329666764, 6051.697415129314, 6082.178905847654, 5814.127880817911, 5828.067509198508, 5849.034909239927, 5856.765729370777, 5861.827634473208, 5638.407967163389, 5762.827115186551, 5841.18223448709, 5850.005499065254, 5853.1220316952795, 5715.8571035724435, 5724.4275572444085, 5756.934967031113, 5765.135229715576, 5801.883962320814, 5852.5317974561085, 5861.120831875252, 5864.266966629171, 5868.2664666916635, 5868.295804503487, 5591.217229587943, 5687.118496633028, 5689.914651280317, 5735.340435849764, 5784.537237020944], "value": 5491.143067365215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.4443539644396, 668.8461653819625, 675.5203805298238, 675.975896516777, 747.8691229034918, 33197.834010829945, 39173.60826391739, 39754.99999999996, 39867.60132398675, 39915.20169596606, 42902.57097429033, 43424.0, 43630.7818460908, 43632.56367436325, 43779.562204378024, 8797.824043519126, 8967.686130985418, 8971.641134354652, 8986.23616992553, 8986.820263594724, 8748.47509149453, 8864.0, 8872.556372181398, 8874.023857375683, 9036.412633178856, 9049.0, 9131.13254240846, 9131.31515136364, 9135.26917846574, 9139.497327646977, 9011.594478248495, 9058.818823623491, 9060.048694887073, 9064.410813297114, 9067.274618030542, 9017.684381046698, 9053.09469053096, 9125.954370228174, 9138.862917056249, 9139.177474027369, 44634.66096017125, 45014.77492612516, 45148.0, 45169.77415112904, 45242.32136517955, 3854.2869569129803, 3940.7241493095494, 4063.573324800883, 4162.979185104085, 4281.636060934824, 33657.49513757296, 33944.49083263753, 33995.830020849986, 34088.0, 35416.82291588551, 4552.567506086916, 4587.747673877935, 4649.116667833135, 4656.487786343533, 4690.50749671283, 231202.0, 231223.0, 232001.0, 232301.0, 232418.0, 39700.0, 40356.77145828327, 60552.69723651354, 61395.0, 61429.38570614326, 40298.59701402948, 40534.59465405308, 40623.0, 40724.79637601852, 40726.1854762909, 16377.508674739776, 16380.344786208418, 16414.917925410537, 16501.752473712902, 16617.91691041537, 14966.251687415586, 15037.172955487335, 15040.247987600576, 15049.849501505063, 15053.623659408602, 9535.046495350549, 9584.28117891161, 9593.376430531993, 9629.181519570915, 9644.324897257125, 3611.963880361215, 3658.378075727133, 3668.761530500509, 3689.3543629864666, 3707.0547010512146, 1082.6210826210763, 1130.8013505683837, 1141.4578075414113, 1142.3260276436777, 1208.7219939413808, 32543.349133017207, 32903.1774205642, 33587.160320992174, 33973.490397644055, 34160.0, 1198.568515334479, 1208.6615747590688, 1210.5883999440232, 1326.5091915991145, 1380.6962468256968, 17544.122793860257, 17597.824021759618, 17630.82369176292, 17835.554111147067, 17840.286388544573, 478396.0, 483222.0, 484013.0, 485522.289554214, 486183.0, 61641.691791540754, 63070.36929630737, 63182.36817631765, 63252.36747632557, 63299.6835015822, 1430.9212993285262, 1502.8046353973914, 1514.5304955463841, 1530.1125347298319, 1538.907665540071, 32825.50761738623, 34804.303913922085, 35086.64913350936, 35281.294374112884, 35292.294154117284, 52399.0, 53206.73396632992, 53233.0, 53378.73310633422, 53395.73302133464, 413989.0, 417959.0, 423548.0, 423606.0, 424983.0, 41203.58796411997, 47534.762326188145, 47535.762321189555, 48618.75690621524, 48823.267650984555, 50642.24036639527, 52621.0, 53487.46512534825, 53762.731186343815, 54274.0, 43817.56182438135, 44025.779871100436, 44181.77909110434, 44220.0, 44265.77867110644, 43745.78127109344, 44052.55947440613, 44315.77842110769, 44853.0, 45101.0, 44487.77756111199, 44854.55145448504, 44909.775451122536, 45659.54340456553, 46288.30567541557, 38124.2375152501, 38952.41571376488, 38988.61011389963, 39189.41215881821, 39388.65196458333, 29474.750182430525, 29512.852435738543, 29907.850460747555, 30170.84914575413, 30182.0], "value": 19977.95871762773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.4152036271396, 439.8394585976119, 444.44444444444446, 447.5323287164913, 453.22046080741114, 18950.336738214166, 18982.050897455123, 19612.019399030043, 20059.09734061967, 20098.59802803943, 20448.182072717074, 20548.486287842774, 20880.89559552204, 20883.79116208841, 20918.16327346908, 5512.503874651271, 6016.0975853622085, 6022.608530445507, 6024.48791852693, 6025.945459544584, 4436.844710435135, 5837.941620583803, 5979.1031345298115, 6291.276503202122, 6616.933830661704, 6586.440152587036, 6604.603723776589, 6612.206535215781, 6616.27221005689, 6623.635700036496, 6384.648844313561, 6418.684169745215, 6450.903236451457, 6468.8706225875685, 6481.48148148147, 4061.6344528992236, 5648.971755141198, 5742.483176514133, 5777.88444231113, 5934.554908381845, 22186.556268874694, 22607.660885086738, 22634.20780272699, 22693.659595106088, 22702.432439189153, 2657.9601305980427, 2705.242532090998, 2844.687084420712, 3001.1446737679876, 3005.6985733641445, 14113.364898579588, 14522.927385363111, 14710.779338309934, 15246.542603721906, 15562.37750489979, 2030.2691031228746, 2061.8247448966854, 2095.6437405641077, 2102.7792081831494, 2162.8702277863376, 79409.0, 80257.0, 80341.59829200876, 81404.9999999994, 81633.59183204106, 10921.563137474572, 10945.124390048777, 11205.887941120647, 11435.14236432271, 11461.54153833854, 15721.528354149394, 15831.287592058385, 15911.840881591035, 15956.601084972737, 15972.920135399248, 9013.098690130935, 9087.36388452802, 9092.318076144316, 9150.679726209552, 9209.125133112344, 8953.59708813105, 8967.282617390723, 9023.593938272794, 9116.316276279305, 9179.17387435134, 6834.58992460444, 6984.301569843076, 7078.221395646475, 7107.147142342952, 7153.570785752871, 1824.6350729854082, 1886.2926402599026, 1955.7946415626154, 2019.768156187421, 2076.4705000224844, 1015.735908663738, 1113.7605414835687, 1134.489479734123, 1146.39241202163, 1167.737259116692, 19488.0, 19619.901900490408, 19854.0, 20182.19271229164, 20555.691664624745, 1056.3609016545033, 1082.4479515447179, 1097.3306283167421, 1126.1047467263545, 1141.8001849676273, 10405.42770147634, 11629.941850290863, 11631.302121872715, 11639.59261425846, 11721.120915931338, 527759.0, 535851.0, 537541.0, 543779.0, 545099.0, 86120.0, 87343.0, 87452.5627371859, 87746.0, 87893.0, 1132.1056365471186, 1165.4405885175163, 1165.452237448398, 1167.9299242045504, 1169.7655981211956, 17072.74390884113, 17786.5553361167, 17886.195121219836, 18012.189451474453, 18184.181711823265, 35237.295254094264, 36014.0, 36141.27717445584, 37865.62134378621, 37928.431073533364, 46520.0, 48368.27447588219, 48734.512654873, 48807.26789098237, 49095.754521227165, 9169.679061232824, 9275.21160701348, 9421.952890235505, 9478.289128315266, 9643.08390702882, 12756.872431275568, 13494.190348579117, 13747.518836841062, 13817.516386926409, 13964.162150271017, 11770.82343764827, 12263.0, 12358.320292383645, 12416.627501174979, 12777.16948398351, 12146.635600931986, 12478.87521124777, 12727.681807954876, 12815.935920320711, 12835.743285134058, 12603.87396126027, 12739.872601273868, 12751.744965100832, 12792.6801829955, 12959.805602916153, 9118.22495087925, 9191.402558833654, 9202.953985230031, 9408.506745712255, 9442.575084121094, 9374.96875343698, 11510.769784604428, 12118.818217726564, 12184.695382615506, 12186.57346992851], "value": 9859.086990036156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.629856237378, 1514.1672080355804, 1523.0404844947684, 1705.1729910993174, 1852.4164888060252, 7959.2040795920375, 8195.508269503827, 8225.218604232603, 8226.01287845458, 8233.588320583962, 8269.131741167166, 8435.451695639795, 8445.746627601182, 8450.366222533305, 8455.746327610166, 2411.951760964784, 2438.5366780311774, 2438.8658623775773, 2447.21689059501, 2448.0, 2389.6893403857475, 2439.109724950389, 2443.035001174535, 2448.179859746978, 2459.754024597544, 2414.28778510339, 2424.030387844867, 2464.827462077655, 2507.674002379688, 2510.585753350695, 2293.2546922250167, 2338.5089131282452, 2416.7583241675866, 2422.9394265143424, 2432.9878350608133, 2427.2718184544565, 2464.741202173782, 2480.2435257246534, 2480.3179125740385, 2480.6651102101346, 7335.559866408033, 8008.159143289987, 8591.5704214789, 8649.65401383944, 8676.479411235347, 5315.123004704219, 5406.107992181285, 5407.918881216785, 5452.536534394581, 5452.863678408032, 3506.877259295938, 3579.8568057277676, 3645.7265705072227, 3758.68051215647, 3773.2642134783728, 1215.878412158786, 1230.1143176912608, 1250.2248605864331, 1283.8587755346905, 1301.9804702929464, 12028.458719357563, 12031.939840300742, 12069.215500992408, 12096.092793040469, 12107.818382724266, 4681.95318046822, 4744.098621261949, 4793.376861008047, 4835.0, 4855.450888283679, 10201.38791672502, 10208.183345332356, 10213.948930255301, 10220.131288840383, 10222.64220752285, 5307.310049693592, 5312.5218730314455, 5316.574674026068, 5319.441458646864, 5329.680219186861, 4842.5157484251295, 4906.852794416173, 4918.877028074256, 4927.728974906415, 4930.038642464757, 3727.6086010969, 3737.7383583148917, 3746.4942232798767, 3762.097096696828, 3772.3775577030033, 1235.1600911380347, 1251.393074358935, 1264.7217612125319, 1268.5686866465446, 1273.891719203878, 1018.383877753963, 1069.0485467933545, 1086.1690806533009, 1086.5327908999047, 1110.7389763405592, 6058.27300723916, 6195.473384762256, 6236.282827474898, 6357.837498692846, 6366.108744775735, 1064.643344479608, 1078.757279612081, 1082.0532034469838, 1082.226208261097, 1088.6733979806027, 3876.282887665791, 4227.133437645337, 4297.720648157922, 4327.805248763751, 4365.257906155961, 10179.18566514677, 10200.846987295048, 10338.638147664946, 10444.21668374875, 10510.316829406063, 10263.0, 10286.794264114676, 10294.227932904912, 10389.480525973822, 10403.94798026005, 7704.614769261514, 7784.649690763929, 7889.2110788920645, 7940.285374316224, 7975.162607926084, 6009.248843894513, 6034.366391528826, 6131.908021379772, 6162.907556386747, 6185.783497577743, 9284.907150928404, 9384.249260059316, 9549.47477888695, 9556.187724043533, 9570.0, 9275.443473391619, 9458.716238512581, 9471.242300616072, 9672.56473458682, 9695.806083878142, 7107.147142342952, 7119.893201601876, 7136.750213742494, 7138.321859423347, 7176.892346614701, 8113.107558168715, 8184.754457366289, 8185.754427367188, 8186.0, 8193.0, 7470.775876723707, 7484.288992545699, 7661.118971318369, 7667.424943129176, 7760.534367937942, 7335.303146201102, 7412.851742965218, 7485.0643669541305, 7577.355924746458, 7625.50434221796, 6483.384078512534, 6567.868642627216, 6613.966930165318, 6623.536352455282, 6625.768098116543, 4674.62602991753, 4911.263310503453, 4999.425066117297, 5027.723475208899, 5200.843974680765, 5168.612354073384, 5268.604854635994, 5278.89442211146, 5335.093034184276, 5340.439253878442], "value": 4658.223988435306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.47371679005647, 364.74832365667686, 370.52202658570445, 372.1533511261879, 374.09282489961834, 5930.733117009734, 6004.339522652515, 6095.481884039857, 6132.386761323865, 6178.567500274977, 5869.8239052828485, 5962.403759624035, 5962.6124301920345, 5977.043673012308, 6091.055886337614, 4512.5261847506035, 4707.176244157267, 4731.455882573497, 4737.810487580493, 4751.738654374008, 4595.241785105453, 4613.1696294666945, 4669.789859456333, 4710.128626204146, 4760.166970780117, 4684.625229981611, 4693.108309421216, 4696.365990591277, 4698.060387922412, 4720.811167553294, 4690.742009189493, 4699.506551812045, 4708.693934894221, 4708.764561771898, 4708.811647534111, 4172.395002724618, 4191.203671302474, 4200.936985945214, 4207.284761590537, 4207.97896010518, 5836.182934389189, 5843.970780146072, 5845.444682755132, 5852.268466441695, 5862.296524417055, 5278.419373868871, 5413.83758487246, 5414.810481633163, 5504.91742623861, 5507.697076660782, 6380.808575742689, 6393.680315984228, 6398.424141827211, 6417.518686098561, 6420.6147631142285, 4531.207038768202, 4631.560001799824, 4667.6265898728025, 4671.532846715335, 4672.696274742165, 6593.80218593443, 6677.666116694194, 6683.2314283857495, 6696.63168525726, 6701.530892837503, 4793.1372352976105, 4797.736124513115, 4801.207800712913, 4804.039192161582, 4804.73573953429, 4846.491118432585, 4851.369321988119, 4852.902941941142, 4870.95129048705, 4873.707577545359, 5493.478119578714, 5494.835154945358, 5498.670079795225, 5503.229547863302, 5510.256115424447, 6239.344868788802, 6459.063435801782, 6467.997460393646, 6474.320196379406, 6483.546151769331, 1684.4609724887919, 1695.6184858407007, 1707.3682737386998, 1707.5474999125242, 1710.9914450427668, 1148.5979907032638, 1168.1414160591958, 1185.5376403202758, 1185.8636256830403, 1191.5293459083614, 6280.497560195174, 6296.0, 6306.0, 6307.92765229912, 6308.148399966038, 6592.571482853599, 6615.206175259, 6623.536352455379, 6625.337466253336, 6637.668116594151, 6290.182276304143, 6295.874082518416, 6300.30696623371, 6307.053941908659, 6317.5893566918, 3521.2781379817075, 3554.0, 3559.3771090059654, 3560.608333083359, 3560.608333083359, 6875.621840798804, 7017.578945263301, 7082.327178917994, 7085.972533982544, 7095.219525852152, 6789.626570538668, 6793.218779840382, 6799.048133261347, 6801.081853949653, 6816.147981502312, 7053.259407762213, 7060.505764596532, 7069.222385537587, 7071.398931090915, 7075.433965282765, 6600.141981542369, 6626.271110177973, 6649.401553860176, 6656.866862662817, 6660.367265109807, 6443.259025212161, 6565.343465653396, 6570.441512471302, 6588.308227636221, 6591.373819487141, 7004.194517630538, 7028.191757947901, 7033.788986330418, 7037.049998250375, 7043.260457652078, 4388.2759344707765, 4487.5288094749585, 4530.592246697813, 4658.04510075427, 4671.76641167947, 6590.80227593173, 6599.208095028627, 6603.306652801579, 6605.867882642417, 6608.074869518176, 6367.172267605181, 6409.455196308366, 6416.133821934166, 6422.614643121427, 6430.839229019312, 6402.135711678864, 6406.423421892052, 6408.967955160194, 6416.165898433173, 6416.807495774948, 6188.628682279078, 6275.403836635513, 6313.210848643919, 6321.620702757849, 6324.083007963727, 6398.872022559616, 6427.389398007182, 6430.64631445275, 6438.0, 6442.8389290268115, 6268.592541484789, 6278.937210628018, 6288.654124023223, 6288.6855657217875, 6293.276273228455], "value": 4925.999523207794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.9453432794032, 914.5975770660908, 930.3348106104137, 936.2369668719997, 938.8779458670376, 15310.46413375532, 15633.218339083058, 15707.84292157078, 15736.134512601817, 15743.370265189393, 14549.92725036376, 14552.708945821078, 14656.633584160401, 14657.0, 14664.633384165401, 773.4663082473089, 911.3347256502757, 926.4533924984258, 928.4290161550631, 930.9255259579252, 913.0367462327242, 916.9358144929857, 920.8250432417852, 922.2852289475643, 922.4880191493718, 994.3089552760835, 994.9850752238686, 996.3922007575374, 996.6163027234494, 997.1125698128672, 815.4088285992638, 969.1277849935079, 984.4191926763244, 986.4525188520369, 987.328616540752, 726.8909663550456, 727.1928159742735, 727.2436665867491, 727.3998950865557, 727.7889412070493, 15135.924320378437, 15192.772108418272, 15193.620159495991, 15254.771178432333, 15264.771028434583, 14983.250837458192, 15264.618384540365, 15345.232738363036, 15452.5364239073, 15455.536333909888, 12067.456964436622, 12112.81830772539, 12113.939430302793, 12369.010479161645, 12407.813882791765, 4003.259397011533, 4051.4125451809323, 4065.6340929316207, 4073.633372996415, 4200.70595058346, 54713.452865471234, 54996.725016374665, 55048.17427738587, 55143.72428137834, 55291.170632440546, 11686.0, 11842.171048026556, 12077.879221207675, 12242.510299588095, 12245.755084898252, 21932.45168870791, 21934.0, 21968.780312196992, 21970.780292196872, 21971.121155153614, 8642.913570864337, 8883.511406872554, 9117.407368521024, 9139.588718507683, 9171.678991235409, 4949.950500495021, 5046.016026874798, 5063.924041139386, 5070.949290507121, 5146.279520867081, 3628.6552777486095, 3704.7036237100965, 3768.660820526111, 3902.2585708715255, 3904.394818803033, 650.187265917603, 720.200577359131, 731.119001603067, 751.7782254235013, 753.5252790741797, 716.3373879161754, 770.3875419041763, 828.7430896422128, 838.4466252273592, 855.7561095087871, 9732.270079743907, 10132.138768204637, 10175.185985121172, 10176.643817466502, 10216.233782466345, 795.1055063054064, 816.1348970091722, 817.284875733733, 820.4912953968578, 822.6380392627225, 5056.671306422733, 5127.07712611726, 5163.741812909339, 5197.0, 5323.680579165262, 63664.68167659132, 63716.0, 64488.0, 64654.0, 64850.351496485375, 56875.43124568701, 56915.0, 56937.145942810894, 56946.145807812085, 57929.4207057924, 49739.0, 49892.0, 50255.0, 51218.0, 51264.74367628212, 10125.67109564819, 10309.948450258, 10343.431111288952, 10360.740981475523, 10465.633702820365, 37549.0, 38009.619903801715, 38265.617343826205, 38619.613803862725, 38993.220135597694, 45895.0, 46107.0, 48666.75666621786, 48861.0, 49355.0, 13017.934910325388, 13086.214827110403, 13323.13399629021, 13482.325883705971, 13499.86500134986, 14220.786688199893, 14647.853521464649, 14717.33771980242, 15198.848011520186, 15532.378704851679, 13906.304684765519, 14102.153870767377, 14108.153510789385, 14184.219867907364, 14379.928100359431, 13920.860791392362, 14081.647958801112, 14169.929150354596, 14175.503857364944, 14332.713345733235, 13125.34373281313, 13366.93316533411, 13483.460661573426, 13801.51694690681, 13811.51659691906, 10665.360078395011, 10684.946575267073, 10988.230823842254, 10997.56496746628, 11241.437928103398, 10952.890471095507, 11038.227324087236, 11051.944740276247, 11116.49975751077, 11220.66338009861], "value": 7397.027171041888, "unit": "score"}], "name": "dromaeo_css", "value": 7538.940375727014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 108.0, 112.0, 110.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 157.0, 172.0, 125.0, 156.0, 156.0, 133.0, 182.0, 135.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 160.0, 160.0, 160.0, 161.0, 167.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 72.0, 181.0, 76.0, 75.0, 75.0, 75.0, 168.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 92.0, 152.0, 92.0, 92.0, 92.0, 141.0, 91.0, 91.0, 155.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 53.0, 57.0, 55.0, 57.0, 77.0, 54.0, 53.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 71.0, 75.0, 73.0, 73.0, 72.0, 82.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 125.0, 113.0, 118.0, 110.0, 120.0, 122.0, 134.0, 123.0], "value": 120.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 160.0, 156.0, 160.0, 161.0, 158.0, 161.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 68.0, 66.0, 67.0, 66.0, 67.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1516.7, "alertThreshold": 2.0}]} 22:27:29 INFO - Return code: 0 22:27:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:29 ERROR - # TBPL SUCCESS # 22:27:29 INFO - Running post-action listener: _resource_record_post_action 22:27:29 INFO - Running post-run listener: _resource_record_post_run 22:27:30 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 464158720; Read time: 16; Write time: 331076 22:27:30 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242593792; Read time: 0; Write time: 224532 22:27:30 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 221564928; Read time: 0; Write time: 106544 22:27:30 INFO - Running post-run listener: _upload_blobber_files 22:27:30 INFO - Blob upload gear active. 22:27:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:27:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:27:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:32 INFO - (blobuploader) - INFO - Done attempting. 22:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:33 INFO - (blobuploader) - INFO - Done attempting. 22:27:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:33 INFO - Return code: 0 22:27:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:27:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a1c919ca246c20fc5acc03b43ea00ac3cdb2fd6c1e6d84839cc3cf0a0560a127e74828a1585670f3c467aaeae768eb62010cd72a8179a72a4e90da2ef10b398", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c183f9df82eb7a616654357f7216cfdad0a857c296e587e096cbf6142a087cce8865524fcd489cbfd20db61b44d8dfdd2b5de46de8fb87a5b11397810060aeb6"} 22:27:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:27:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:27:33 INFO - Contents: 22:27:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a1c919ca246c20fc5acc03b43ea00ac3cdb2fd6c1e6d84839cc3cf0a0560a127e74828a1585670f3c467aaeae768eb62010cd72a8179a72a4e90da2ef10b398", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c183f9df82eb7a616654357f7216cfdad0a857c296e587e096cbf6142a087cce8865524fcd489cbfd20db61b44d8dfdd2b5de46de8fb87a5b11397810060aeb6"} 22:27:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:33 INFO - Copying logs to upload dir... 22:27:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:27:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.121828 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-01 22:27:32.928976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 22:27:32.933009) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a1c919ca246c20fc5acc03b43ea00ac3cdb2fd6c1e6d84839cc3cf0a0560a127e74828a1585670f3c467aaeae768eb62010cd72a8179a72a4e90da2ef10b398", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c183f9df82eb7a616654357f7216cfdad0a857c296e587e096cbf6142a087cce8865524fcd489cbfd20db61b44d8dfdd2b5de46de8fb87a5b11397810060aeb6"} build_url:https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/OyUqXYfPS-aLgBf5K7JodQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a1c919ca246c20fc5acc03b43ea00ac3cdb2fd6c1e6d84839cc3cf0a0560a127e74828a1585670f3c467aaeae768eb62010cd72a8179a72a4e90da2ef10b398", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c183f9df82eb7a616654357f7216cfdad0a857c296e587e096cbf6142a087cce8865524fcd489cbfd20db61b44d8dfdd2b5de46de8fb87a5b11397810060aeb6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 22:27:32.958379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:27:32.958713) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467434190.476857-1871548418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 22:27:33.045495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 22:27:33.045966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 22:27:33.046379) ========= ========= Total master_lag: 0.18 =========