builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1462836572.76 results: success (0) buildid: 20160509134609 builduid: 09aef832063f45eb8080f23855736164 revision: 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.757332) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.757781) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.758182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.774418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.774736) ========= 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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:29:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-05-09 16:29:32 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.879980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.880249) ========= 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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017805 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:32.938056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:29:32.938392) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 --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 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 --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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:29:32,964 truncating revision to first 12 chars 2016-05-09 16:29:32,964 Setting DEBUG logging. 2016-05-09 16:29:32,964 attempt 1/10 2016-05-09 16:29:32,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2b710898eaf6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:29:33,928 unpacking tar archive at: mozilla-beta-2b710898eaf6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:29:34.199801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:34.200064) ========= script_repo_revision: 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:34.200408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:34.200678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:29:34.243804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 16:29:34.244082) ========= /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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:29:34 INFO - MultiFileLogger online at 20160509 16:29:34 in /builds/slave/test 16:29:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:29:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:34 INFO - {'append_to_log': False, 16:29:34 INFO - 'base_work_dir': '/builds/slave/test', 16:29:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:29:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:34 INFO - 'branch': 'Mozilla-Beta', 16:29:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:34 INFO - 'config_files': ('talos/linux_config.py',), 16:29:34 INFO - 'default_actions': ('clobber', 16:29:34 INFO - 'read-buildbot-config', 16:29:34 INFO - 'download-and-extract', 16:29:34 INFO - 'populate-webroot', 16:29:34 INFO - 'create-virtualenv', 16:29:34 INFO - 'install', 16:29:34 INFO - 'run-tests'), 16:29:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:34 INFO - 'download_minidump_stackwalk': True, 16:29:34 INFO - 'download_symbols': 'ondemand', 16:29:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:29:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:29:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:29:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:29:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:34 INFO - 'installer_path': 'installer.exe', 16:29:34 INFO - 'log_level': 'info', 16:29:34 INFO - 'log_name': 'talos', 16:29:34 INFO - 'log_to_console': True, 16:29:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:29:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:29:34 INFO - 'opt_config_files': (), 16:29:34 INFO - 'pip_index': False, 16:29:34 INFO - 'sps_profile': False, 16:29:34 INFO - 'sps_profile_interval': 0, 16:29:34 INFO - 'suite': 'dromaeojs', 16:29:34 INFO - 'system_bits': '32', 16:29:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:34 INFO - 'title': 'talos-linux64-ix-018', 16:29:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:34 INFO - 'use_talos_json': True, 16:29:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:34 INFO - 'work_dir': 'build'} 16:29:34 INFO - ##### 16:29:34 INFO - ##### Running clobber step. 16:29:34 INFO - ##### 16:29:34 INFO - Running pre-action listener: _resource_record_pre_action 16:29:34 INFO - Running main action method: clobber 16:29:34 INFO - rmtree: /builds/slave/test/build 16:29:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:35 INFO - Running post-action listener: _resource_record_post_action 16:29:35 INFO - ##### 16:29:35 INFO - ##### Running read-buildbot-config step. 16:29:35 INFO - ##### 16:29:35 INFO - Running pre-action listener: _resource_record_pre_action 16:29:35 INFO - Running main action method: read_buildbot_config 16:29:35 INFO - Using buildbot properties: 16:29:35 INFO - { 16:29:35 INFO - "project": "", 16:29:35 INFO - "product": "firefox", 16:29:35 INFO - "script_repo_revision": "production", 16:29:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:29:35 INFO - "repository": "", 16:29:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:29:35 INFO - "buildid": "20160509134609", 16:29:35 INFO - "pgo_build": "True", 16:29:35 INFO - "basedir": "/builds/slave/test", 16:29:35 INFO - "buildnumber": 81, 16:29:35 INFO - "slavename": "talos-linux64-ix-018", 16:29:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:29:35 INFO - "platform": "ubuntu64_hw", 16:29:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:29:35 INFO - "branch": "mozilla-beta", 16:29:35 INFO - "repo_path": "releases/mozilla-beta", 16:29:35 INFO - "revision": "2b710898eaf609aa9dc45fd75e03bc134d20f6b8", 16:29:35 INFO - "stage_platform": "linux64-pgo", 16:29:35 INFO - "builduid": "09aef832063f45eb8080f23855736164", 16:29:35 INFO - "slavebuilddir": "test" 16:29:35 INFO - } 16:29:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:29:35 INFO - Running post-action listener: _resource_record_post_action 16:29:35 INFO - ##### 16:29:35 INFO - ##### Running download-and-extract step. 16:29:35 INFO - ##### 16:29:35 INFO - Running pre-action listener: _resource_record_pre_action 16:29:35 INFO - Running main action method: download_and_extract 16:29:35 INFO - mkdir: /builds/slave/test/build/tests 16:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:35 INFO - https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:29:38 INFO - Downloaded 1412 bytes. 16:29:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:29:38 INFO - Using the following test package requirements: 16:29:38 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:29:38 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:29:38 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'jsshell-linux-x86_64.zip'], 16:29:38 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:29:38 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:29:38 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:29:38 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:29:38 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:29:38 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:29:38 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:29:38 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:29: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')]} 16:29:38 INFO - https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:29:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:29:39 INFO - Downloaded 23364534 bytes. 16:29:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:29:40 INFO - Return code: 0 16:29:40 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:40 INFO - https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:29:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:29:42 INFO - Downloaded 23364534 bytes. 16:29:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:29:43 INFO - Return code: 0 16:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:43 INFO - https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:29:44 INFO - Downloaded 10845194 bytes. 16:29:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:29:45 INFO - Return code: 0 16:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:45 INFO - https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:29:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:29:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:29:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:29:46 INFO - Downloaded 53797967 bytes. 16:29:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:29:46 INFO - mkdir: /builds/slave/test/properties 16:29:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:46 INFO - Contents: 16:29:46 INFO - build_url:https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - Running post-action listener: set_extra_try_arguments 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running populate-webroot step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: populate_webroot 16:29:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:29:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:29:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:29:47 INFO - '--tppagecycles', 16:29:47 INFO - '7'], 16:29:47 INFO - 'tests': ['tsvgm']}}, 16:29:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:29:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:29:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:29:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['damp', 'tps']}, 16:29:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['damp', 'tps']}, 16:29:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:29:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:47 INFO - 'other': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'other_l64': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'other_nol64': {'tests': ['a11yr', 16:29:47 INFO - 'ts_paint', 16:29:47 INFO - 'tpaint', 16:29:47 INFO - 'sessionrestore', 16:29:47 INFO - 'sessionrestore_no_auto_restore', 16:29:47 INFO - 'tabpaint']}, 16:29:47 INFO - 'svgr': {'tests': ['tsvgx', 16:29:47 INFO - 'tsvgr_opacity', 16:29:47 INFO - 'tart', 16:29:47 INFO - 'tscrollx', 16:29:47 INFO - 'cart']}, 16:29:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tsvgx', 16:29:47 INFO - 'tsvgr_opacity', 16:29:47 INFO - 'tart', 16:29:47 INFO - 'tscrollx', 16:29:47 INFO - 'cart']}, 16:29:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'tests': ['tp5o']}, 16:29:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s'], 16:29:47 INFO - 'tests': ['tp5o']}, 16:29:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--xperf_path', 16:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:47 INFO - 'tests': ['tp5n']}, 16:29:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:47 INFO - 'talos_options': ['--e10s', 16:29:47 INFO - '--xperf_path', 16:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:47 INFO - 'tests': ['tp5n']}}, 16:29:47 INFO - 'talos.zip': {'path': '', 16:29:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running create-virtualenv step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: create_virtualenv 16:29:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:29:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:29:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:47 INFO - Using real prefix '/usr' 16:29:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:49 INFO - Installing pip.................done. 16:29:49 INFO - Return code: 0 16:29:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:49 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:29:49 INFO - Using env: {'DISPLAY': ':0', 16:29:49 INFO - 'HOME': '/home/cltbld', 16:29:49 INFO - 'LANG': 'en_US.UTF-8', 16:29:49 INFO - 'LANGUAGE': 'en_US:en', 16:29:49 INFO - 'LOGNAME': 'cltbld', 16:29:49 INFO - 'MAIL': '/var/mail/cltbld', 16:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:49 INFO - 'MOZ_NO_REMOTE': '1', 16:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:49 INFO - 'NO_EM_RESTART': '1', 16:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:49 INFO - 'PWD': '/builds/slave/test', 16:29:49 INFO - 'SHELL': '/bin/bash', 16:29:49 INFO - 'SHLVL': '1', 16:29:49 INFO - 'TERM': 'linux', 16:29:49 INFO - 'TMOUT': '86400', 16:29:49 INFO - 'USER': 'cltbld', 16:29:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:49 INFO - '_': '/tools/buildbot/bin/python'} 16:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:29:49 INFO - Cleaning up... 16:29:49 INFO - Return code: 0 16:29:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:49 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:29:49 INFO - Using env: {'DISPLAY': ':0', 16:29:49 INFO - 'HOME': '/home/cltbld', 16:29:49 INFO - 'LANG': 'en_US.UTF-8', 16:29:49 INFO - 'LANGUAGE': 'en_US:en', 16:29:49 INFO - 'LOGNAME': 'cltbld', 16:29:49 INFO - 'MAIL': '/var/mail/cltbld', 16:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:49 INFO - 'MOZ_NO_REMOTE': '1', 16:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:49 INFO - 'NO_EM_RESTART': '1', 16:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:49 INFO - 'PWD': '/builds/slave/test', 16:29:49 INFO - 'SHELL': '/bin/bash', 16:29:49 INFO - 'SHLVL': '1', 16:29:49 INFO - 'TERM': 'linux', 16:29:49 INFO - 'TMOUT': '86400', 16:29:49 INFO - 'USER': 'cltbld', 16:29:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:49 INFO - '_': '/tools/buildbot/bin/python'} 16:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:50 INFO - Downloading/unpacking psutil>=0.7.1 16:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:52 INFO - Installing collected packages: psutil 16:29:52 INFO - Running setup.py install for psutil 16:29:52 INFO - building 'psutil._psutil_linux' extension 16:29:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:29:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:29:52 INFO - building 'psutil._psutil_posix' extension 16:29:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:29:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:52 INFO - Successfully installed psutil 16:29:52 INFO - Cleaning up... 16:29:52 INFO - Return code: 0 16:29:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:29:52 INFO - Using env: {'DISPLAY': ':0', 16:29:52 INFO - 'HOME': '/home/cltbld', 16:29:52 INFO - 'LANG': 'en_US.UTF-8', 16:29:52 INFO - 'LANGUAGE': 'en_US:en', 16:29:52 INFO - 'LOGNAME': 'cltbld', 16:29:52 INFO - 'MAIL': '/var/mail/cltbld', 16:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:52 INFO - 'MOZ_NO_REMOTE': '1', 16:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:52 INFO - 'NO_EM_RESTART': '1', 16:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:52 INFO - 'PWD': '/builds/slave/test', 16:29:52 INFO - 'SHELL': '/bin/bash', 16:29:52 INFO - 'SHLVL': '1', 16:29:52 INFO - 'TERM': 'linux', 16:29:52 INFO - 'TMOUT': '86400', 16:29:52 INFO - 'USER': 'cltbld', 16:29:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:52 INFO - '_': '/tools/buildbot/bin/python'} 16:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:29:54 INFO - Installing collected packages: mozsystemmonitor 16:29:54 INFO - Running setup.py install for mozsystemmonitor 16:29:54 INFO - Successfully installed mozsystemmonitor 16:29:54 INFO - Cleaning up... 16:29:54 INFO - Return code: 0 16:29:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:54 INFO - Using env: {'DISPLAY': ':0', 16:29:54 INFO - 'HOME': '/home/cltbld', 16:29:54 INFO - 'LANG': 'en_US.UTF-8', 16:29:54 INFO - 'LANGUAGE': 'en_US:en', 16:29:54 INFO - 'LOGNAME': 'cltbld', 16:29:54 INFO - 'MAIL': '/var/mail/cltbld', 16:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:54 INFO - 'MOZ_NO_REMOTE': '1', 16:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:54 INFO - 'NO_EM_RESTART': '1', 16:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:54 INFO - 'PWD': '/builds/slave/test', 16:29:54 INFO - 'SHELL': '/bin/bash', 16:29:54 INFO - 'SHLVL': '1', 16:29:54 INFO - 'TERM': 'linux', 16:29:54 INFO - 'TMOUT': '86400', 16:29:54 INFO - 'USER': 'cltbld', 16:29:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:54 INFO - '_': '/tools/buildbot/bin/python'} 16:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:57 INFO - Downloading docopt-0.6.1.tar.gz 16:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:57 INFO - Running setup.py install for blobuploader 16:29:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:57 INFO - Running setup.py install for requests 16:29:58 INFO - Running setup.py install for docopt 16:29:58 INFO - Successfully installed blobuploader requests docopt 16:29:58 INFO - Cleaning up... 16:29:58 INFO - Return code: 0 16:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:58 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:58 INFO - Using env: {'DISPLAY': ':0', 16:29:58 INFO - 'HOME': '/home/cltbld', 16:29:58 INFO - 'LANG': 'en_US.UTF-8', 16:29:58 INFO - 'LANGUAGE': 'en_US:en', 16:29:58 INFO - 'LOGNAME': 'cltbld', 16:29:58 INFO - 'MAIL': '/var/mail/cltbld', 16:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:58 INFO - 'MOZ_NO_REMOTE': '1', 16:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:58 INFO - 'NO_EM_RESTART': '1', 16:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:58 INFO - 'PWD': '/builds/slave/test', 16:29:58 INFO - 'SHELL': '/bin/bash', 16:29:58 INFO - 'SHLVL': '1', 16:29:58 INFO - 'TERM': 'linux', 16:29:58 INFO - 'TMOUT': '86400', 16:29:58 INFO - 'USER': 'cltbld', 16:29:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:58 INFO - '_': '/tools/buildbot/bin/python'} 16:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:58 INFO - Running setup.py (path:/tmp/pip-57cKWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:58 INFO - Running setup.py (path:/tmp/pip-QTeYjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:58 INFO - Running setup.py (path:/tmp/pip-AwAp8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:58 INFO - Running setup.py (path:/tmp/pip-p1yhzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:58 INFO - Running setup.py (path:/tmp/pip-nwiwcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:58 INFO - Running setup.py (path:/tmp/pip-9b1XL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:58 INFO - Running setup.py (path:/tmp/pip-4D7h7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:58 INFO - Running setup.py (path:/tmp/pip-T38Am2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:59 INFO - Running setup.py (path:/tmp/pip-1CcLmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:59 INFO - Running setup.py (path:/tmp/pip-hJuSs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:59 INFO - Running setup.py (path:/tmp/pip-KZxuag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:59 INFO - Running setup.py (path:/tmp/pip-NmTYoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:59 INFO - Running setup.py (path:/tmp/pip-3NZCc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:59 INFO - Running setup.py (path:/tmp/pip-VBNiII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:59 INFO - Running setup.py (path:/tmp/pip-sEFwRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:59 INFO - Running setup.py (path:/tmp/pip-q1tU4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:59 INFO - Running setup.py (path:/tmp/pip-rHasK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:59 INFO - Running setup.py install for manifestparser 16:29:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:59 INFO - Running setup.py install for mozcrash 16:29:59 INFO - Running setup.py install for mozdebug 16:29:59 INFO - Running setup.py install for mozdevice 16:30:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozfile 16:30:00 INFO - Running setup.py install for mozhttpd 16:30:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozinfo 16:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozInstall 16:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozleak 16:30:00 INFO - Running setup.py install for mozlog 16:30:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for moznetwork 16:30:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:00 INFO - Running setup.py install for mozprocess 16:30:00 INFO - Running setup.py install for mozprofile 16:30:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Running setup.py install for mozrunner 16:30:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Running setup.py install for mozscreenshot 16:30:01 INFO - Running setup.py install for moztest 16:30:01 INFO - Running setup.py install for mozversion 16:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:01 INFO - Cleaning up... 16:30:01 INFO - Return code: 0 16:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:01 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:01 INFO - Using env: {'DISPLAY': ':0', 16:30:01 INFO - 'HOME': '/home/cltbld', 16:30:01 INFO - 'LANG': 'en_US.UTF-8', 16:30:01 INFO - 'LANGUAGE': 'en_US:en', 16:30:01 INFO - 'LOGNAME': 'cltbld', 16:30:01 INFO - 'MAIL': '/var/mail/cltbld', 16:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:01 INFO - 'MOZ_NO_REMOTE': '1', 16:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:01 INFO - 'NO_EM_RESTART': '1', 16:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:01 INFO - 'PWD': '/builds/slave/test', 16:30:01 INFO - 'SHELL': '/bin/bash', 16:30:01 INFO - 'SHLVL': '1', 16:30:01 INFO - 'TERM': 'linux', 16:30:01 INFO - 'TMOUT': '86400', 16:30:01 INFO - 'USER': 'cltbld', 16:30:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:01 INFO - '_': '/tools/buildbot/bin/python'} 16:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:01 INFO - Running setup.py (path:/tmp/pip-T7039a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:01 INFO - Running setup.py (path:/tmp/pip-dvqr6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:01 INFO - Running setup.py (path:/tmp/pip-oc0RYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:01 INFO - Running setup.py (path:/tmp/pip-ALaqBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:01 INFO - Running setup.py (path:/tmp/pip-0oEo8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:02 INFO - Running setup.py (path:/tmp/pip-7PjYzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:02 INFO - Running setup.py (path:/tmp/pip-A2Aeo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:02 INFO - Running setup.py (path:/tmp/pip-sPd7Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:02 INFO - Running setup.py (path:/tmp/pip-Ml9AmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:02 INFO - Running setup.py (path:/tmp/pip-uSzOZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:02 INFO - Running setup.py (path:/tmp/pip-I2Q3wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:02 INFO - Running setup.py (path:/tmp/pip-V5JZCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:02 INFO - Running setup.py (path:/tmp/pip-0Px4vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:02 INFO - Running setup.py (path:/tmp/pip-6AjeZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:02 INFO - Running setup.py (path:/tmp/pip-wh0SdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:02 INFO - Running setup.py (path:/tmp/pip-VsnhoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:02 INFO - Running setup.py (path:/tmp/pip-xKAcl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:04 INFO - Downloading blessings-1.6.tar.gz 16:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:04 INFO - Installing collected packages: blessings 16:30:04 INFO - Running setup.py install for blessings 16:30:04 INFO - Successfully installed blessings 16:30:04 INFO - Cleaning up... 16:30:05 INFO - Return code: 0 16:30:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:05 INFO - Reading from file tmpfile_stdout 16:30:05 INFO - Current package versions: 16:30:05 INFO - argparse == 1.2.1 16:30:05 INFO - blessings == 1.6 16:30:05 INFO - blobuploader == 1.2.4 16:30:05 INFO - docopt == 0.6.1 16:30:05 INFO - manifestparser == 1.1 16:30:05 INFO - mozInstall == 1.12 16:30:05 INFO - mozcrash == 0.17 16:30:05 INFO - mozdebug == 0.1 16:30:05 INFO - mozdevice == 0.48 16:30:05 INFO - mozfile == 1.2 16:30:05 INFO - mozhttpd == 0.7 16:30:05 INFO - mozinfo == 0.9 16:30:05 INFO - mozleak == 0.1 16:30:05 INFO - mozlog == 3.1 16:30:05 INFO - moznetwork == 0.27 16:30:05 INFO - mozprocess == 0.22 16:30:05 INFO - mozprofile == 0.28 16:30:05 INFO - mozrunner == 6.11 16:30:05 INFO - mozscreenshot == 0.1 16:30:05 INFO - mozsystemmonitor == 0.0 16:30:05 INFO - moztest == 0.7 16:30:05 INFO - mozversion == 1.4 16:30:05 INFO - psutil == 3.1.1 16:30:05 INFO - requests == 1.2.3 16:30:05 INFO - wsgiref == 0.1.2 16:30:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:05 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:05 INFO - Using env: {'DISPLAY': ':0', 16:30:05 INFO - 'HOME': '/home/cltbld', 16:30:05 INFO - 'LANG': 'en_US.UTF-8', 16:30:05 INFO - 'LANGUAGE': 'en_US:en', 16:30:05 INFO - 'LOGNAME': 'cltbld', 16:30:05 INFO - 'MAIL': '/var/mail/cltbld', 16:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:05 INFO - 'MOZ_NO_REMOTE': '1', 16:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:05 INFO - 'NO_EM_RESTART': '1', 16:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:05 INFO - 'PWD': '/builds/slave/test', 16:30:05 INFO - 'SHELL': '/bin/bash', 16:30:05 INFO - 'SHLVL': '1', 16:30:05 INFO - 'TERM': 'linux', 16:30:05 INFO - 'TMOUT': '86400', 16:30:05 INFO - 'USER': 'cltbld', 16:30:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:05 INFO - '_': '/tools/buildbot/bin/python'} 16:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:05 INFO - Cleaning up... 16:30:05 INFO - Return code: 0 16:30:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:05 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 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:30:05 INFO - Using env: {'DISPLAY': ':0', 16:30:05 INFO - 'HOME': '/home/cltbld', 16:30:05 INFO - 'LANG': 'en_US.UTF-8', 16:30:05 INFO - 'LANGUAGE': 'en_US:en', 16:30:05 INFO - 'LOGNAME': 'cltbld', 16:30:05 INFO - 'MAIL': '/var/mail/cltbld', 16:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:05 INFO - 'MOZ_NO_REMOTE': '1', 16:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:05 INFO - 'NO_EM_RESTART': '1', 16:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:05 INFO - 'PWD': '/builds/slave/test', 16:30:05 INFO - 'SHELL': '/bin/bash', 16:30:05 INFO - 'SHLVL': '1', 16:30:05 INFO - 'TERM': 'linux', 16:30:05 INFO - 'TMOUT': '86400', 16:30:05 INFO - 'USER': 'cltbld', 16:30:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:05 INFO - '_': '/tools/buildbot/bin/python'} 16:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:05 INFO - Downloading/unpacking jsonschema 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:30:07 INFO - Downloading/unpacking functools32 (from jsonschema) 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:30:07 INFO - warning: no files found matching '*.txt' 16:30:07 INFO - no previously-included directories found matching 'build' 16:30:07 INFO - no previously-included directories found matching 'dist' 16:30:07 INFO - no previously-included directories found matching '.git*' 16:30:07 INFO - Installing collected packages: jsonschema, functools32 16:30:07 INFO - Running setup.py install for functools32 16:30:07 INFO - warning: no files found matching '*.txt' 16:30:07 INFO - no previously-included directories found matching 'build' 16:30:07 INFO - no previously-included directories found matching 'dist' 16:30:07 INFO - no previously-included directories found matching '.git*' 16:30:07 INFO - Successfully installed jsonschema functools32 16:30:07 INFO - Cleaning up... 16:30:08 INFO - Return code: 0 16:30:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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')]} 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e94cedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, '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': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:30:08 INFO - Using env: {'DISPLAY': ':0', 16:30:08 INFO - 'HOME': '/home/cltbld', 16:30:08 INFO - 'LANG': 'en_US.UTF-8', 16:30:08 INFO - 'LANGUAGE': 'en_US:en', 16:30:08 INFO - 'LOGNAME': 'cltbld', 16:30:08 INFO - 'MAIL': '/var/mail/cltbld', 16:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:08 INFO - 'MOZ_NO_REMOTE': '1', 16:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:08 INFO - 'NO_EM_RESTART': '1', 16:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:08 INFO - 'PWD': '/builds/slave/test', 16:30:08 INFO - 'SHELL': '/bin/bash', 16:30:08 INFO - 'SHLVL': '1', 16:30:08 INFO - 'TERM': 'linux', 16:30:08 INFO - 'TMOUT': '86400', 16:30:08 INFO - 'USER': 'cltbld', 16:30:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:08 INFO - '_': '/tools/buildbot/bin/python'} 16:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:08 INFO - Downloading/unpacking flake8 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:30:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:30:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:30:10 INFO - no previously-included directories found matching 'docs/_build' 16:30:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:30:10 INFO - Running setup.py install for pep8 16:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:30:10 INFO - no previously-included directories found matching 'docs/_build' 16:30:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:30:11 INFO - Cleaning up... 16:30:11 INFO - Return code: 0 16:30:11 INFO - Running post-action listener: _resource_record_post_action 16:30:11 INFO - Running post-action listener: _start_resource_monitoring 16:30:11 INFO - Starting resource monitoring. 16:30:11 INFO - ##### 16:30:11 INFO - ##### Running install step. 16:30:11 INFO - ##### 16:30:11 INFO - Running pre-action listener: _resource_record_pre_action 16:30:11 INFO - Running main action method: install 16:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:11 INFO - Reading from file tmpfile_stdout 16:30:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:11 INFO - Reading from file tmpfile_stdout 16:30:11 INFO - Output received: 16:30:11 INFO - Usage: mozinstall [options] installer 16:30:11 INFO - Options: 16:30:11 INFO - -h, --help show this help message and exit 16:30:11 INFO - -d DEST, --destination=DEST 16:30:11 INFO - Directory to install application into. [default: 16:30:11 INFO - "/builds/slave/test"] 16:30:11 INFO - --app=APP Application being installed. [default: firefox] 16:30:11 INFO - mkdir: /builds/slave/test/build/application 16:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:30:24 INFO - Reading from file tmpfile_stdout 16:30:24 INFO - Output received: 16:30:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:24 INFO - Running post-action listener: _resource_record_post_action 16:30:24 INFO - ##### 16:30:24 INFO - ##### Running run-tests step. 16:30:24 INFO - ##### 16:30:24 INFO - Running pre-action listener: _resource_record_pre_action 16:30:24 INFO - Running main action method: run_tests 16:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:24 INFO - Python 2.7.3 16:30:24 INFO - Return code: 0 16:30:24 INFO - grabbing minidump binary from tooltool 16:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:24 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 0x1482160>, '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 0x1483060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14834f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:30:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:30:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:24 INFO - Return code: 0 16:30:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:30:25 INFO - Return code: 0 16:30:25 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/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:30:25 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/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:30:25 INFO - Using env: {'DISPLAY': ':0', 16:30:25 INFO - 'HOME': '/home/cltbld', 16:30:25 INFO - 'LANG': 'en_US.UTF-8', 16:30:25 INFO - 'LANGUAGE': 'en_US:en', 16:30:25 INFO - 'LOGNAME': 'cltbld', 16:30:25 INFO - 'MAIL': '/var/mail/cltbld', 16:30:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:25 INFO - 'MOZ_NO_REMOTE': '1', 16:30:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:25 INFO - 'NO_EM_RESTART': '1', 16:30:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:25 INFO - 'PWD': '/builds/slave/test', 16:30:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:25 INFO - 'SHELL': '/bin/bash', 16:30:25 INFO - 'SHLVL': '1', 16:30:25 INFO - 'TERM': 'linux', 16:30:25 INFO - 'TMOUT': '86400', 16:30:25 INFO - 'USER': 'cltbld', 16:30:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751', 16:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:25 INFO - '_': '/tools/buildbot/bin/python'} 16:30:25 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/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:30:25 INFO - mozversion application_buildid: 20160509134609 16:30:25 INFO - mozversion application_changeset: 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 16:30:25 INFO - mozversion application_display_name: Firefox 16:30:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:25 INFO - mozversion application_name: Firefox 16:30:25 INFO - mozversion application_remotingname: firefox 16:30:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:30:25 INFO - mozversion application_vendor: Mozilla 16:30:25 INFO - mozversion application_version: 47.0 16:30:25 INFO - mozversion platform_buildid: 20160509134609 16:30:25 INFO - mozversion platform_changeset: 2b710898eaf609aa9dc45fd75e03bc134d20f6b8 16:30:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:30:25 INFO - mozversion platform_version: 47.0 16:30:25 INFO - using testdate: 1462836625 16:30:25 INFO - actual date: 1462836625 16:30:25 INFO - starting webserver on 'localhost:32822' 16:30:25 INFO - SUITE-START | Running 2 tests 16:30:25 INFO - TEST-START | dromaeo_css 16:30:25 INFO - operating with platform_type : linux_ 16:30:25 INFO - Initialising browser for dromaeo_css test... 16:30:25 INFO - TEST-INFO | started process 23271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDi8pls/profile http://localhost:32822/getInfo.html) 16:30:29 INFO - PROCESS | 23271 | __metrics Screen width/height:1600/1200 16:30:29 INFO - PROCESS | 23271 | colorDepth:24 16:30:29 INFO - PROCESS | 23271 | Browser inner width/height: 1024/697 16:30:29 INFO - PROCESS | 23271 | __metrics 16:30:30 INFO - PROCESS | 23271 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:31 INFO - TEST-INFO | 23271: exit 0 16:30:31 INFO - Browser initialized. 16:30:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:30:31 INFO - TEST-INFO | started process 23363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDi8pls/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:43 INFO - PROCESS | 23363 | RSS: Main: 139354112 16:30:43 INFO - PROCESS | 23363 | 16:31:34 INFO - PROCESS | 23363 | 1462836694580 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:33:41 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32822/tests/dromaeo/cssquery-ext.html) 16:33:42 INFO - PROCESS | 23363 | RSS: Main: 286425088 16:33:42 INFO - PROCESS | 23363 | 16:36:45 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-ext.html (next: http://localhost:32822/tests/dromaeo/cssquery-jquery.html) 16:36:45 INFO - PROCESS | 23363 | RSS: Main: 225378304 16:36:45 INFO - PROCESS | 23363 | 16:39:47 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32822/tests/dromaeo/cssquery-mootools.html) 16:39:48 INFO - PROCESS | 23363 | RSS: Main: 219844608 16:39:48 INFO - PROCESS | 23363 | 16:42:49 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32822/tests/dromaeo/cssquery-prototype.html) 16:42:50 INFO - PROCESS | 23363 | RSS: Main: 205365248 16:42:50 INFO - PROCESS | 23363 | 16:45:52 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32822/tests/dromaeo/cssquery-yui.html) 16:45:53 INFO - PROCESS | 23363 | RSS: Main: 206045184 16:45:53 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | Cycle 1(1): loaded http://localhost:32822/tests/dromaeo/cssquery-yui.html (next: http://localhost:32822/tests/dromaeo/cssquery-dojo.html) 16:48:55 INFO - PROCESS | 23363 | RSS: Main: 248123392 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | __start_tp_report 16:48:55 INFO - PROCESS | 23363 | _x_x_mozilla_page_load 16:48:55 INFO - PROCESS | 23363 | _x_x_mozilla_page_load_details 16:48:55 INFO - PROCESS | 23363 | |i|pagename|runs| 16:48:55 INFO - PROCESS | 23363 | |0;dojo.html;3295.6704329567037;3345.7657963942534;3382.8477718502663;3387.4749413840864;3403.421418358879;5424.810131645393;5426.972865135679;5433.049216387127;5441.863953401162;5485.780568777254;5407.405185429599;5434.076207044802;5448.972755136228;5449.972750136254;5455.754491047903;4796.088743138793;4933.654644174918;4946.3817022872145;5008.173651347542;5031.698098114125;4903.754812259391;4984.426790919037;4987.900241995158;4990.3762029746285;4990.925136122961;4978.925316120261;5034.446210916796;5034.697918124906;5040.243963405482;5059.797608095671;4897.4123105227245;5000.499950005007;5050.166722490803;5056.873578160538;5059.595232381401;4862.6353023523025;4958.454569997298;4980.953999660076;5009.173486374744;5020.171671674169;5151.66514176581;5208.088584497697;5221.791128354861;5225.555827754645;5240.947590524084;5857.121431785266;5860.619059761102;5872.295324561037;5872.7357268923;5880;5782.653040817564;5833.504152147073;5858.707064646793;5884.205632239636;5923.022701254288;5454.181872719045;5464.426235245322;5465.644733092376;5490.972545137289;5540.584456165804;5932.139839723216;5935.169076329231;5935.2877654681715;5936.1689363488285;5967.6121052131475;5650.3219613646625;5733.569982251348;5735.569832262597;5766.826995190151;5846.123081537803;5949.1076338549565;5951.642901425928;5959.344472108065;5961.493273071837;5971.880562388728;5842.503387212049;5873.119032145127;5873.913326034697;5874;5882.735276912549;5656.943430565724;5720.427957204246;5782.103773914966;5786.189933409326;5881.7647294107755;4455.420795296591;4475.552444755564;4481.775911204427;4486.035502367007;4503.279475284005;4023.7786921719003;4043.8180281887385;4058.837646494107;4078.2659121358442;4079.6124368184974;5384.111621582395;5543.861403464865;5602.1036634139155;5632.577556683265;5635.830925072254;5880.117982302603;5899.321578018497;5917.970410147922;5922.141289512996;5928.288605367297;5355.919661205007;5556;5571.749271282802;5575.498205161555;5577.74900129487;5070.949290507121;5120.948790512047;5126.92309615356;5130.79476820923;5160.0969830279555;6064.545159113084;6072;6095.05526643371;6098.0243161094895;6104.847378815565;5727.599068065196;5744.224529688606;5901.940980590139;5911.172435859069;5921;5955.791547295824;5998.850028749316;6013.548983826318;6030.065339872327;6052.273727152769;5724.227229323988;5760.049591817303;5764.07774756037;5765.56758243125;5772.480476757112;5685.147227915681;5788.565857560784;5828.708564571839;5846.298444186725;5865.384134665798;5741.167530708108;5755;5756.2229099072765;5756.856078597901;5762.769489220552;5686.43135686428;5732.226149469935;5733.082706766897;5753;5755.194272801895;5447.428020057995;5577.832665020056;5595.328560572757;5637.915431268616;5683.7442315095095;5630.60585758993;5689.203511508475;5713.200151978644;5713.542916566582;5725.6850873202375;5462.590305727166;5478.534324582296;5482.698451585201;5592.748326325243;5641.492265696107 16:48:55 INFO - PROCESS | 23363 | |1;ext.html;538.3432212700504;551.0549407765681;562.2606272751332;570.5806232419174;576.1300436341123;32096.518552221707;32773.18067048325;32776.836115819446;32777.50833737496;32778.508322375186;40346.7982660087;40501.79749101258;40549.79725101378;40560.79719601405;40601.59398406015;8821.426607270507;9033.367664263504;9042.954785226064;9045.276377889786;9053.04942980984;8740.825183496327;8841.292696584258;8879.28965682744;8881.999999999967;8886.644534218623;8848.911510884906;8929.973053098913;8931.598078086501;9213.262938964866;9254.67608633698;9167.862482062774;9267.582958766805;9274.30442716799;9275.48984805832;9276.07239276067;8958.820823583492;9082.636694532212;9092.863607045834;9095.317851161124;9101.180893719531;42490.57509424897;43189.35215971732;43194.784026079666;43230.13539729219;43297.783511082554;3380.5943286805496;3513.9106876868254;3681.668649821529;3704.018435114697;3852.499175107246;31023.37953240945;31332.06003819889;31359.37281254385;31758.364832703446;31942.20144496383;3665.798381089039;3691.778493290411;3846.0961674006585;3871.3805791073573;3881.573026967031;223533;226691.8665406679;227087;227112;227749;46290.30564541535;46944;47034.05931881343;70536.294637054;72865.27134728584;47488.28767568489;47592;47802;47867.28199077016;47965;17254.827451725574;17542.21060052301;17591.73612395815;17637.82362176362;17640.294388224327;13870.445182192801;13982.930085349712;13997.580072597839;14006.439742410394;14009.579712608638;15397.23013849303;15465.536033919001;15877.2855221513;15958.9202053989;15968.600784980468;6206.937930620727;6253.906191407133;6282.120503129566;6333.904991425133;6385.936140638627;994.2394068537575;1005.2360206243162;1025.2566889005411;1039.3504059962524;1102.2639343034753;26652.334766523192;26848.731512685015;26997.325066873484;27297.454050919267;28580.71419285822;1012;1096.3421946831836;1129.3449799116493;1139.2879450343535;1207.3600991474532;16003;16171.919140404223;16217.51347459578;16287.267072981744;16698.6660266794;403325;407996;408096;408435;408727;60493.69753151294;61070;61331.08003379953;61412.69293653503;61424.07863882045;1348.3123606960326;1463.5536161470854;1482.6219314074842;1498.5579254120062;1521.6880539489157;28207.858960705064;28389.290267743472;28906.566401503573;29103.272418189714;29224.123276300896;48545;48903;49195.508044919094;49209.507904920494;49215;257517;258233;258898;259324;259589;34717.65282347144;35436.11409714675;35488.64511354853;35781;35815.10462238361;47732.76133619449;48629.27056094232;49361.259581105594;49423.75288123536;49687.25469118039;39102.45225359;40041.799791000856;40341.79829100836;40393.39409908795;41053.79473102615;38570.071496425626;38604.42093368658;39295.41056884092;39364.803175983936;40299.79850100731;39598.60401396064;41561.58438415577;42470.36294455647;42599.7870010648;42901.141977159656;32935.50596741099;34383.828080859435;34589.48115778215;35038;35123.473147903314;26992.73007269902;27369.17892463229;27529.459670170618;27593;27618.585721213796 16:48:55 INFO - PROCESS | 23363 | |2;jquery.html;352.16185478561005;355.15650330465144;357.61556326948534;358.3728475168455;361.5119588555449;17392;17712.380066697668;18290.725639115422;18444.262229510805;18686.906565467187;18040;18060.729089063643;18483.722744158815;18530.629387412242;18533.721994170064;5368.973155134219;5377.650452720571;5472.616916815805;5509.035918714209;5586.469285417878;4176.206520761061;5440.156775699773;5774.682392468412;6005.519558435315;6044.365341639131;5972.850678733023;5985.610935289193;6004.879902401949;6008.068749343859;6015.578909476339;5762.222100016486;5997.520198384119;6026.276846778393;6040.637561746309;6051.092336149591;3802.8478860845535;5218.6868787872845;5378.085725426687;5388.703621300827;5401.459854014606;20323.491912702153;20418.081186346502;20576.279830205873;21798.782012179832;21828.45428864275;2242.3048854855047;2294.5066810635794;2465.6917885264343;2808.747212750862;3052.4047810676925;12691.936540317332;12881.935590322082;12963.935180324039;13138.934305328508;13215.074944753871;1861.9813801861944;1880.6144740328336;1939.4957311099074;1946.6593346164364;1957.7063440483898;64582.67708661427;65038.3496165037;65592.34407655911;66733.3326666732;67607;10108.140808031252;10228.795424091477;10327.225458090523;10514.369137851754;10525.526351314209;14988.47540336083;15022.549323520312;15082.24588770557;15132.092074475566;15139.71312438433;7917.129115797257;8224.766285057289;8447.113053129333;8486.448380855225;8486.74539763808;8142;8333.2916702081;8413.495190288602;8481.321494280442;8486.74539763808;4634.629229661687;4701.318308845198;4705.764711764398;4713.858584242478;4790.449098353664;1831.569581148429;1844.6810530470777;1856.433787694739;1936.9225230990885;1945.4260993007097;963.5904740485265;967.7967626798311;1036.7926414716935;1060.39557452253;1095.7972775036644;16155.273012714457;16525.58686032835;16640.334386624643;17041.91479042597;17222.311107555557;980.5930538826307;991.945443000642;995.5967833027636;1030.7783826477194;1071.314358810362;9537.380070295547;10116.848247276297;10148.492575371201;10153.64462243818;10325.122364598943;421663;428591;435004;436246;436465;77293.61353193199;78574.21425785669;79480.20519794844;80074;80727.59636201899;1047.2930771729052;1065.8561094252332;1068.150820098024;1083.6369816111533;1086.4187659602076;15540.611484712972;15611.063336199864;15835.208239587744;15846.12846293465;15955.282012309706;35529.467057993636;35683.643163568035;35698.10754731153;36991.44512832256;37080;50517.74741126271;50575;50786.746066269436;50810.49189508206;51399.743001284754;7961.960190199012;8119.512829230265;8198;8205.671773129008;8281.047679516932;11763.353015584225;11788.469518871843;12347.38263086824;12730.554430594884;13387.531436399679;10504.632337868137;11420.371879546372;11503.942480287546;11511.654650360502;11877.168598198043;10659.573617055232;11544.653660390202;11646.534138634699;11683.824742628698;11761.294322340687;11408.372539510407;11409.714757131138;11477.942610286895;11889.048876089719;11911.642650720492;7725.304722574995;7742.264484873928;7803.687852486064;7942.166072562529;8212.096669366245;9588.37675551087;11367.943160284145;11398.08815294758;11470.82793758111;11572.59495917639 16:48:55 INFO - PROCESS | 23363 | |3;mootools.html;1352.6338398217797;1548.8615867337505;1584.690985257875;1783.3045112406164;1864.2449807827834;7414.406847452205;7942.483738556997;8105.716299929503;8110.837783244331;8117.228863257996;7902.841943161147;8072.394570407214;8085.393595480333;8112.91887081129;8116.472429292106;2354.7998420134268;2381.57131716291;2385.0340612052146;2386.0336563691644;2386.1052105460453;2338.5206032763326;2372.762723727622;2374.02664907388;2389.64155376694;2390.22317746733;2374.5963186258377;2388.988055059731;2390.3546042568496;2433.8052955763496;2437.402836305108;2416.66166736657;2437.146998550511;2446.2416650838295;2446.865422401776;2448.2777580613674;2335.7664233576675;2390.5696974544576;2390.581648211556;2395.964060539093;2397.436602398435;8330.208630180123;8368.246857782768;8373.581320933929;8380.832383352299;8405.033421156584;5050.974745126287;5207.140821764404;5214.374275087014;5215.817446389358;5216.9739151304;3103.332783451569;3114.299282661406;3162.7469802415753;3196.9200769980703;3226.3386005868974;973.459729849933;978.5205249427801;984.0553069053717;996.9700908972742;1002.6340385759146;11616.419179041015;11624.593139240085;11636.650900473;11654.88345116555;11658.125640576991;4359.324304732771;4386.912261754747;4439.622632076245;4460.264056430653;4460.509343972225;9873.851892221479;9882.950585247028;9906.306558540833;9913.959034301295;9932.553035113437;5061.873453163626;5091.694498330112;5094.312267843868;5102.668326558762;5104.9489505104475;4125.195586860594;4203.936940945889;4444.533324000933;4537.863864084083;4615.607673347736;3730.7761534307488;3810.828512716879;3815.503984482055;3825.2349530094093;3884;1195.1574140231116;1223.577865636354;1226.9877301226873;1232.642533665245;1237.641084085623;1422.537675255546;1422.615893708693;1425.0309789343346;1441.1641248076091;1450.4125829039256;7760.767176984699;7762.883556746653;7771.911932329365;7801.531908085533;7808.414368922354;522.5349438999293;529.888723368097;529.9920501192486;530.8168681804772;535.2265975665126;5836;5842.474177324061;5847.94152058474;5881.911771323434;5897.764089436375;9589.328746987783;9661.227101831837;9705.078017588317;9719.028097190367;9865.210783137476;9536.809263814685;9700.951495242478;9705.6117755289;9731.172850307661;9735.367201131903;7281.745138920112;7389.261073892568;7395.038644976119;7398.11222653285;7405.370543503863;7568.962155189189;7592.696292148473;7700.19147989453;7720.150783413707;7818.17909119557;8669.263112635497;8976.596053177493;9033.322500812334;9060.139286767746;9062.04848490899;9125.634974601207;9144.679936202201;9242.768930776785;9354.25165986733;9378.437293762396;6357.904631430625;6512.023196520559;7031.507794454339;7352.080989876265;7472.327490525879;7802.726904558313;7838.686452541834;7902.68389264446;7908.683652653829;7910.841783164419;6956.304369563003;6996.230414654486;7110.146782386147;7142.500024998408;7268.527545709512;6583.242927063449;6602.537822352581;6605.768798092044;6746.0555522227905;6902.06822079033;7124.786256412316;7170.784876453715;7253.165885923187;7373.3732632726815;7414.184439711736;6784.660766961731;6796.93203067963;6829.760958366433;6843.931560684329;6844.623545705034;6560.803175904731;6567.408933196035;6607.405333520006;6609.735610575523;6617.205935287796 16:48:55 INFO - PROCESS | 23363 | |4;prototype.html;344.5658470327387;345.2938740276135;347.6019957149063;352.99647003529964;354.5390991710775;5983.790567330145;5991.131285963533;5994.790182343619;6005.159277701126;6010.218671572689;5890.440408161228;5908;5917.5561832862495;5931.6441013539215;5971.581989260753;4479.888002799931;4562.634989200873;4657.091867085919;4682.6956247843955;4687.8359257426;4617.261238201889;4650.790714417859;4673.3223682566;4680.25115981443;4680.461746899116;4482.148391805563;4637.582617564419;4639.211334073216;4644.326572646964;4647.7676116194225;4561.703489273186;4587.174308624446;4589.334546490757;4681.836135735267;4698.154332220199;4127.566605506408;4181.498220213563;4188.350805625133;4189.114898295748;4192.790360481964;5714.942850571524;5718.456746609066;5725.169850371714;5726.055200891848;5734;5466;5474.972625136849;5476.58925580583;5480.698561579112;5481.890362192774;6342;6349.8412539686415;6355.205599300088;6355.332690067568;6359.936400635981;4488.775561221926;4616.330632058366;4617.72293662378;4618.307253911907;4620.075984803053;6527.249366322886;6638.535302528825;6642.136522252076;6643.7674681385915;6646;4562.61217796491;4679.836205732783;4680.765961701902;4682.391289132459;4708.835190768306;4764.976175119103;4766.928496072562;4767.022760334124;4769.070031343924;4775.5224477551965;5414.40441551429;5415.404305526389;5418.539424148991;5418.566514678816;5422.43064478232;6367.172267605181;6407.199100112486;6411.455026322815;6411.903821442682;6416.390442907917;1697.499237724874;1722.2680360846591;1723.1814887928133;1724.430937790526;1729.161356741979;1105.0551778229499;1141.3608379307614;1143.874173840877;1193.2065176657425;1208.10600155884;6145.907811382833;6217.347178546278;6226.626402415779;6237;6252.406021427957;6606.306337834554;6614.305497922745;6615.875301198807;6623.741489117052;6626.86746265072;6207.472364849038;6216.844578885473;6218.968905155445;6224.595401298901;6234.096056071935;3518.40187168182;3552.87564935226;3553.466979953028;3553.680168784822;3558.430651095812;6694.665266736643;6826.624535650587;6842.623655698984;6846.691898864563;6860.3139686032;6730.293319201512;6761.594304341756;6766.391024807791;6769.05233267343;6772.864542709118;6794.966025169842;6816.227780777033;6817.625030623264;6818.147731533559;6835.906254999276;6547.607143571401;6570.113034740249;6582.901256481061;6585.440237579859;6597.5381723280825;6327.778527751507;6352.174217351715;6459.386358295955;6498.317676643885;6514;6807.3873351398615;6820.727170913108;6821.761238356634;6822.727090916308;6826.522143449911;4797.328374027569;4799.1601469743355;4804.06320767447;4806.543378379049;4806.591439727662;6574.737010519526;6588.8352791180605;6593.637349945799;6594.901076483952;6597.670116494252;6258.123862659322;6399.55203135776;6400.167978162809;6406.839829004312;6410.61536307823;6404;6407.423331900151;6408;6421.775237866652;6448.2262128543;6196.690165491617;6206.472449841814;6220.440160385587;6225.657588832658;6230.626162430269;6420.2616699078335;6431.099646049463;6433.420992110732;6438.935610643834;6441.710123044568;6031.366706495754;6184.752609895554;6293.213348331458;6295.055741638791;6298.401651843067 16:48:55 INFO - PROCESS | 23363 | |5;yui.html;750.7222327738738;798.4889670610809;803.2289002557541;869.5043825019741;930.7254359963812;13732.24472654005;13757.380917858696;13799.2410417427;13808.378622961965;13959.092658977172;13248.337583120829;13405.731885362287;13419.396127174276;13421.194728316308;13498.73002539951;787.4291138924291;923.556692787464;928.642472648032;949.9857502137473;954.3605784124653;942.354487176283;945.8392073347513;948.1987720376271;949.278548303291;950.857371394293;1002.0880998291556;1004.8593196952396;1005.1104772276551;1005.5324274212489;1005.6781829814462;808.2281421242699;979.3340528440657;985.261054209343;987.2842189412654;987.4717026390847;716.992830071703;722.3751454991448;725.2095216214352;728.3881539506787;729.1286912139994;14331.71336573273;14341.713165736732;14396.136231826124;14424.134551926918;14478.493252736209;13548.86451135486;13900.582982510541;13943.511977080854;14201.076929999517;14243.216623085726;10965.451727413598;11093.223474356799;11124.49939752713;11303.095752339794;11443.713907152305;3776.9055773605605;3801.353769859131;3805.4101614249835;3847.3267178243977;3917.2361389529055;51512.742436287575;51778.741106294605;54506;54892.45107548913;55060.971646559425;10199.592016319264;10440.530176142092;10576.576936922436;11372;11532.827007594893;20065.197392104445;20313.695294570593;20348.796512034987;20383.08276127578;20388.49028774263;8116.147804480563;8200.958995204986;8276.544790036485;8429.114942931026;8461.2807911327;4725.645576581702;4743.881402964885;4768.499307572655;4784.497627749106;4857.101436234308;3519.472079188091;3601.585817631006;3605.603383627799;3605.7836529808296;3608.8376023079027;580.3123298890828;594.6075590110593;599.3766482857866;622.0575827621067;623.3548277532823;630.8864404407251;657.135866335767;669.7923643670478;673.7810211681223;676.5027704637088;8831;8930.374873758905;8938.37431379797;9007.324450666227;9060.54697265134;650.6876699184418;665.8846432226002;673.572281601177;678.1590827374021;704.2464562917731;3978.1645854370327;3991.1419044905483;4045.0898547826505;4103.97948010264;4118.979405102956;58498.7075064622;59147;59398;59692.70153649291;59698.70150649306;51321.743391282806;52571.73714131405;53115.20327195095;53362;53611;46866.5313346869;48398;48673.26990095151;49194;49244.75377623089;7726;7927.84144317122;7985.920140798517;8024.799380015313;8242.052164001216;36654.26691466209;36695.449568255965;36913.630863692095;38806;38883.80558097304;42539.361909572;42708;46428.767856160506;46518.767406162755;47451.28823067588;10009.049140331657;10314.690559283234;10451.268411211142;10797.892021080002;10859.51132199037;11734.94132529332;11768.35274059935;11792.23350482216;12171.087168462223;12510.687232819253;10246.487675616041;10496.79006419852;10890.29213101146;11210.831837522606;11655.18413711066;10685.465726713788;10970.945145274223;13004.479820807062;13208.459572284613;13378.13042152257;11265.605703800327;11318.037966772587;12105;12146.574869879512;12666.746665066832;10447.216458765472;10489.265751397328;10577.682669519927;10735.516901739284;10749.408782516724;9238.907610923805;9254.12085851843;9254.35219534626;9282.860757088783;9376.671816486663 16:48:55 INFO - PROCESS | 23363 | __end_tp_report 16:48:55 INFO - PROCESS | 23363 | __start_cc_report 16:48:55 INFO - PROCESS | 23363 | _x_x_mozilla_cycle_collect,1149 16:48:55 INFO - PROCESS | 23363 | __end_cc_report 16:48:55 INFO - PROCESS | 23363 | __startTimestamp1462837735838__endTimestamp 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | ------- Summary: start ------- 16:48:55 INFO - PROCESS | 23363 | Number of tests: 6 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#0] dojo.html Cycles:165 Average:5434.01 Median:5635.83 stddev:588.01 (10.4%) stddev-sans-first:565.38 16:48:55 INFO - PROCESS | 23363 | Values: 3295.7 3345.8 3382.8 3387.5 3403.4 5424.8 5427.0 5433.0 5441.9 5485.8 5407.4 5434.1 5449.0 5450.0 5455.8 4796.1 4933.7 4946.4 5008.2 5031.7 4903.8 4984.4 4987.9 4990.4 4990.9 4978.9 5034.4 5034.7 5040.2 5059.8 4897.4 5000.5 5050.2 5056.9 5059.6 4862.6 4958.5 4981.0 5009.2 5020.2 5151.7 5208.1 5221.8 5225.6 5240.9 5857.1 5860.6 5872.3 5872.7 5880.0 5782.7 5833.5 5858.7 5884.2 5923.0 5454.2 5464.4 5465.6 5491.0 5540.6 5932.1 5935.2 5935.3 5936.2 5967.6 5650.3 5733.6 5735.6 5766.8 5846.1 5949.1 5951.6 5959.3 5961.5 5971.9 5842.5 5873.1 5873.9 5874.0 5882.7 5656.9 5720.4 5782.1 5786.2 5881.8 4455.4 4475.6 4481.8 4486.0 4503.3 4023.8 4043.8 4058.8 4078.3 4079.6 5384.1 5543.9 5602.1 5632.6 5635.8 5880.1 5899.3 5918.0 5922.1 5928.3 5355.9 5556.0 5571.7 5575.5 5577.7 5070.9 5120.9 5126.9 5130.8 5160.1 6064.5 6072.0 6095.1 6098.0 6104.8 5727.6 5744.2 5901.9 5911.2 5921.0 5955.8 5998.9 6013.5 6030.1 6052.3 5724.2 5760.0 5764.1 5765.6 5772.5 5685.1 5788.6 5828.7 5846.3 5865.4 5741.2 5755.0 5756.2 5756.9 5762.8 5686.4 5732.2 5733.1 5753.0 5755.2 5447.4 5577.8 5595.3 5637.9 5683.7 5630.6 5689.2 5713.2 5713.5 5725.7 5462.6 5478.5 5482.7 5592.7 5641.5 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#1] ext.html Cycles:180 Average:47359.58 Median:21492.01 stddev:80895.98 (376.4%) stddev-sans-first:81046.53 16:48:55 INFO - PROCESS | 23363 | Values: 538.3 551.1 562.3 570.6 576.1 32096.5 32773.2 32776.8 32777.5 32778.5 40346.8 40501.8 40549.8 40560.8 40601.6 8821.4 9033.4 9043.0 9045.3 9053.0 8740.8 8841.3 8879.3 8882.0 8886.6 8848.9 8930.0 8931.6 9213.3 9254.7 9167.9 9267.6 9274.3 9275.5 9276.1 8958.8 9082.6 9092.9 9095.3 9101.2 42490.6 43189.4 43194.8 43230.1 43297.8 3380.6 3513.9 3681.7 3704.0 3852.5 31023.4 31332.1 31359.4 31758.4 31942.2 3665.8 3691.8 3846.1 3871.4 3881.6 223533.0 226691.9 227087.0 227112.0 227749.0 46290.3 46944.0 47034.1 70536.3 72865.3 47488.3 47592.0 47802.0 47867.3 47965.0 17254.8 17542.2 17591.7 17637.8 17640.3 13870.4 13982.9 13997.6 14006.4 14009.6 15397.2 15465.5 15877.3 15958.9 15968.6 6206.9 6253.9 6282.1 6333.9 6385.9 994.2 1005.2 1025.3 1039.4 1102.3 26652.3 26848.7 26997.3 27297.5 28580.7 1012.0 1096.3 1129.3 1139.3 1207.4 16003.0 16171.9 16217.5 16287.3 16698.7 403325.0 407996.0 408096.0 408435.0 408727.0 60493.7 61070.0 61331.1 61412.7 61424.1 1348.3 1463.6 1482.6 1498.6 1521.7 28207.9 28389.3 28906.6 29103.3 29224.1 48545.0 48903.0 49195.5 49209.5 49215.0 257517.0 258233.0 258898.0 259324.0 259589.0 34717.7 35436.1 35488.6 35781.0 35815.1 47732.8 48629.3 49361.3 49423.8 49687.3 39102.5 40041.8 40341.8 40393.4 41053.8 38570.1 38604.4 39295.4 39364.8 40299.8 39598.6 41561.6 42470.4 42599.8 42901.1 32935.5 34383.8 34589.5 35038.0 35123.5 26992.7 27369.2 27529.5 27593.0 27618.6 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#2] jquery.html Cycles:180 Average:25979.27 Median:2637.22 stddev:70888.61 (2688.0%) stddev-sans-first:71061.36 16:48:55 INFO - PROCESS | 23363 | Values: 352.2 355.2 357.6 358.4 361.5 17392.0 17712.4 18290.7 18444.3 18686.9 18040.0 18060.7 18483.7 18530.6 18533.7 5369.0 5377.7 5472.6 5509.0 5586.5 4176.2 5440.2 5774.7 6005.5 6044.4 5972.9 5985.6 6004.9 6008.1 6015.6 5762.2 5997.5 6026.3 6040.6 6051.1 3802.8 5218.7 5378.1 5388.7 5401.5 20323.5 20418.1 20576.3 21798.8 21828.5 2242.3 2294.5 2465.7 2808.7 3052.4 12691.9 12881.9 12963.9 13138.9 13215.1 1862.0 1880.6 1939.5 1946.7 1957.7 64582.7 65038.3 65592.3 66733.3 67607.0 10108.1 10228.8 10327.2 10514.4 10525.5 14988.5 15022.5 15082.2 15132.1 15139.7 7917.1 8224.8 8447.1 8486.4 8486.7 8142.0 8333.3 8413.5 8481.3 8486.7 4634.6 4701.3 4705.8 4713.9 4790.4 1831.6 1844.7 1856.4 1936.9 1945.4 963.6 967.8 1036.8 1060.4 1095.8 16155.3 16525.6 16640.3 17041.9 17222.3 980.6 991.9 995.6 1030.8 1071.3 9537.4 10116.8 10148.5 10153.6 10325.1 421663.0 428591.0 435004.0 436246.0 436465.0 77293.6 78574.2 79480.2 80074.0 80727.6 1047.3 1065.9 1068.2 1083.6 1086.4 15540.6 15611.1 15835.2 15846.1 15955.3 35529.5 35683.6 35698.1 36991.4 37080.0 50517.7 50575.0 50786.7 50810.5 51399.7 7962.0 8119.5 8198.0 8205.7 8281.0 11763.4 11788.5 12347.4 12730.6 13387.5 10504.6 11420.4 11503.9 11511.7 11877.2 10659.6 11544.7 11646.5 11683.8 11761.3 11408.4 11409.7 11477.9 11889.0 11911.6 7725.3 7742.3 7803.7 7942.2 8212.1 9588.4 11367.9 11398.1 11470.8 11572.6 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#3] mootools.html Cycles:180 Average:5703.16 Median:6592.89 stddev:3005.62 (45.6%) stddev-sans-first:2996.26 16:48:55 INFO - PROCESS | 23363 | Values: 1352.6 1548.9 1584.7 1783.3 1864.2 7414.4 7942.5 8105.7 8110.8 8117.2 7902.8 8072.4 8085.4 8112.9 8116.5 2354.8 2381.6 2385.0 2386.0 2386.1 2338.5 2372.8 2374.0 2389.6 2390.2 2374.6 2389.0 2390.4 2433.8 2437.4 2416.7 2437.1 2446.2 2446.9 2448.3 2335.8 2390.6 2390.6 2396.0 2397.4 8330.2 8368.2 8373.6 8380.8 8405.0 5051.0 5207.1 5214.4 5215.8 5217.0 3103.3 3114.3 3162.7 3196.9 3226.3 973.5 978.5 984.1 997.0 1002.6 11616.4 11624.6 11636.7 11654.9 11658.1 4359.3 4386.9 4439.6 4460.3 4460.5 9873.9 9883.0 9906.3 9914.0 9932.6 5061.9 5091.7 5094.3 5102.7 5104.9 4125.2 4203.9 4444.5 4537.9 4615.6 3730.8 3810.8 3815.5 3825.2 3884.0 1195.2 1223.6 1227.0 1232.6 1237.6 1422.5 1422.6 1425.0 1441.2 1450.4 7760.8 7762.9 7771.9 7801.5 7808.4 522.5 529.9 530.0 530.8 535.2 5836.0 5842.5 5847.9 5881.9 5897.8 9589.3 9661.2 9705.1 9719.0 9865.2 9536.8 9701.0 9705.6 9731.2 9735.4 7281.7 7389.3 7395.0 7398.1 7405.4 7569.0 7592.7 7700.2 7720.2 7818.2 8669.3 8976.6 9033.3 9060.1 9062.0 9125.6 9144.7 9242.8 9354.3 9378.4 6357.9 6512.0 7031.5 7352.1 7472.3 7802.7 7838.7 7902.7 7908.7 7910.8 6956.3 6996.2 7110.1 7142.5 7268.5 6583.2 6602.5 6605.8 6746.1 6902.1 7124.8 7170.8 7253.2 7373.4 7414.2 6784.7 6796.9 6829.8 6843.9 6844.6 6560.8 6567.4 6607.4 6609.7 6617.2 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#4] prototype.html Cycles:180 Average:5381.16 Median:6088.64 stddev:1580.74 (26.0%) stddev-sans-first:1539.30 16:48:55 INFO - PROCESS | 23363 | Values: 344.6 345.3 347.6 353.0 354.5 5983.8 5991.1 5994.8 6005.2 6010.2 5890.4 5908.0 5917.6 5931.6 5971.6 4479.9 4562.6 4657.1 4682.7 4687.8 4617.3 4650.8 4673.3 4680.3 4680.5 4482.1 4637.6 4639.2 4644.3 4647.8 4561.7 4587.2 4589.3 4681.8 4698.2 4127.6 4181.5 4188.4 4189.1 4192.8 5714.9 5718.5 5725.2 5726.1 5734.0 5466.0 5475.0 5476.6 5480.7 5481.9 6342.0 6349.8 6355.2 6355.3 6359.9 4488.8 4616.3 4617.7 4618.3 4620.1 6527.2 6638.5 6642.1 6643.8 6646.0 4562.6 4679.8 4680.8 4682.4 4708.8 4765.0 4766.9 4767.0 4769.1 4775.5 5414.4 5415.4 5418.5 5418.6 5422.4 6367.2 6407.2 6411.5 6411.9 6416.4 1697.5 1722.3 1723.2 1724.4 1729.2 1105.1 1141.4 1143.9 1193.2 1208.1 6145.9 6217.3 6226.6 6237.0 6252.4 6606.3 6614.3 6615.9 6623.7 6626.9 6207.5 6216.8 6219.0 6224.6 6234.1 3518.4 3552.9 3553.5 3553.7 3558.4 6694.7 6826.6 6842.6 6846.7 6860.3 6730.3 6761.6 6766.4 6769.1 6772.9 6795.0 6816.2 6817.6 6818.1 6835.9 6547.6 6570.1 6582.9 6585.4 6597.5 6327.8 6352.2 6459.4 6498.3 6514.0 6807.4 6820.7 6821.8 6822.7 6826.5 4797.3 4799.2 4804.1 4806.5 4806.6 6574.7 6588.8 6593.6 6594.9 6597.7 6258.1 6399.6 6400.2 6406.8 6410.6 6404.0 6407.4 6408.0 6421.8 6448.2 6196.7 6206.5 6220.4 6225.7 6230.6 6420.3 6431.1 6433.4 6438.9 6441.7 6031.4 6184.8 6293.2 6295.1 6298.4 16:48:55 INFO - PROCESS | 23363 | 16:48:55 INFO - PROCESS | 23363 | [#5] yui.html Cycles:180 Average:14469.50 Median:42623.68 stddev:16729.65 (39.2%) stddev-sans-first:16744.86 16:48:55 INFO - PROCESS | 23363 | Values: 750.7 798.5 803.2 869.5 930.7 13732.2 13757.4 13799.2 13808.4 13959.1 13248.3 13405.7 13419.4 13421.2 13498.7 787.4 923.6 928.6 950.0 954.4 942.4 945.8 948.2 949.3 950.9 1002.1 1004.9 1005.1 1005.5 1005.7 808.2 979.3 985.3 987.3 987.5 717.0 722.4 725.2 728.4 729.1 14331.7 14341.7 14396.1 14424.1 14478.5 13548.9 13900.6 13943.5 14201.1 14243.2 10965.5 11093.2 11124.5 11303.1 11443.7 3776.9 3801.4 3805.4 3847.3 3917.2 51512.7 51778.7 54506.0 54892.5 55061.0 10199.6 10440.5 10576.6 11372.0 11532.8 20065.2 20313.7 20348.8 20383.1 20388.5 8116.1 8201.0 8276.5 8429.1 8461.3 4725.6 4743.9 4768.5 4784.5 4857.1 3519.5 3601.6 3605.6 3605.8 3608.8 580.3 594.6 599.4 622.1 623.4 630.9 657.1 669.8 673.8 676.5 8831.0 8930.4 8938.4 9007.3 9060.5 650.7 665.9 673.6 678.2 704.2 3978.2 3991.1 4045.1 4104.0 4119.0 58498.7 59147.0 59398.0 59692.7 59698.7 51321.7 52571.7 53115.2 53362.0 53611.0 46866.5 48398.0 48673.3 49194.0 49244.8 7726.0 7927.8 7985.9 8024.8 8242.1 36654.3 36695.4 36913.6 38806.0 38883.8 42539.4 42708.0 46428.8 46518.8 47451.3 10009.0 10314.7 10451.3 10797.9 10859.5 11734.9 11768.4 11792.2 12171.1 12510.7 10246.5 10496.8 10890.3 11210.8 11655.2 10685.5 10970.9 13004.5 13208.5 13378.1 11265.6 11318.0 12105.0 12146.6 12666.7 10447.2 10489.3 10577.7 10735.5 10749.4 9238.9 9254.1 9254.4 9282.9 9376.7 16:48:55 INFO - PROCESS | 23363 | -------- Summary: end -------- 16:48:55 INFO - PROCESS | 23363 | 16:48:56 INFO - TEST-INFO | 23363: exit 0 16:48:56 INFO - TEST-OK | dromaeo_css | took 1111191ms 16:48:56 INFO - TEST-START | kraken 16:48:56 INFO - operating with platform_type : linux_ 16:48:56 INFO - Initialising browser for kraken test... 16:48:56 INFO - TEST-INFO | started process 23557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5EQPG/profile http://localhost:32822/getInfo.html) 16:49:00 INFO - PROCESS | 23557 | __metrics Screen width/height:1600/1200 16:49:00 INFO - PROCESS | 23557 | colorDepth:24 16:49:00 INFO - PROCESS | 23557 | Browser inner width/height: 1024/697 16:49:00 INFO - PROCESS | 23557 | __metrics 16:49:01 INFO - PROCESS | 23557 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:02 INFO - TEST-INFO | 23557: exit 0 16:49:02 INFO - Browser initialized. 16:49:02 INFO - Running cycle 1/1 for kraken test... 16:49:02 INFO - TEST-INFO | started process 23646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5EQPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:13 INFO - PROCESS | 23646 | RSS: Main: 139612160 16:49:13 INFO - PROCESS | 23646 | 16:49:16 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32822/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:16 INFO - PROCESS | 23646 | RSS: Main: 173686784 16:49:16 INFO - PROCESS | 23646 | 16:49:19 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32822/tests/kraken/driver.html?testName=audio-dft) 16:49:20 INFO - PROCESS | 23646 | RSS: Main: 171163648 16:49:20 INFO - PROCESS | 23646 | 16:49:22 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32822/tests/kraken/driver.html?testName=audio-fft) 16:49:23 INFO - PROCESS | 23646 | RSS: Main: 168542208 16:49:23 INFO - PROCESS | 23646 | 16:49:25 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32822/tests/kraken/driver.html?testName=audio-oscillator) 16:49:26 INFO - PROCESS | 23646 | RSS: Main: 169836544 16:49:26 INFO - PROCESS | 23646 | 16:49:28 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:28 INFO - PROCESS | 23646 | RSS: Main: 167137280 16:49:28 INFO - PROCESS | 23646 | 16:49:31 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32822/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:32 INFO - PROCESS | 23646 | RSS: Main: 167219200 16:49:32 INFO - PROCESS | 23646 | 16:49:35 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32822/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:36 INFO - PROCESS | 23646 | RSS: Main: 167407616 16:49:36 INFO - PROCESS | 23646 | 16:49:39 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32822/tests/kraken/driver.html?testName=json-parse-financial) 16:49:39 INFO - PROCESS | 23646 | RSS: Main: 167981056 16:49:39 INFO - PROCESS | 23646 | 16:49:41 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:41 INFO - PROCESS | 23646 | RSS: Main: 174354432 16:49:41 INFO - PROCESS | 23646 | 16:49:43 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:44 INFO - PROCESS | 23646 | RSS: Main: 171728896 16:49:44 INFO - PROCESS | 23646 | 16:49:46 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:46 INFO - PROCESS | 23646 | RSS: Main: 177631232 16:49:46 INFO - PROCESS | 23646 | 16:49:49 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:49 INFO - PROCESS | 23646 | RSS: Main: 181997568 16:49:49 INFO - PROCESS | 23646 | 16:49:52 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:52 INFO - PROCESS | 23646 | RSS: Main: 181125120 16:49:52 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | Cycle 1(1): loaded http://localhost:32822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32822/tests/kraken/driver.html?testName=ai-astar) 16:49:54 INFO - PROCESS | 23646 | RSS: Main: 243716096 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | __start_tp_report 16:49:54 INFO - PROCESS | 23646 | _x_x_mozilla_page_load 16:49:54 INFO - PROCESS | 23646 | _x_x_mozilla_page_load_details 16:49:54 INFO - PROCESS | 23646 | |i|pagename|runs| 16:49:54 INFO - PROCESS | 23646 | |0;ai-astar;109;111;103;109;110;110;100;110;108;110 16:49:54 INFO - PROCESS | 23646 | |1;audio-beat-detection;170;129;151;161;128;154;155;135;169;128 16:49:54 INFO - PROCESS | 23646 | |2;audio-dft;160;160;160;160;160;162;160;163;159;160 16:49:54 INFO - PROCESS | 23646 | |3;audio-fft;75;76;73;162;77;76;74;76;157;76 16:49:54 INFO - PROCESS | 23646 | |4;audio-oscillator;93;94;138;94;93;93;139;93;94;135 16:49:54 INFO - PROCESS | 23646 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;117 16:49:54 INFO - PROCESS | 23646 | |6;imaging-darkroom;146;146;145;146;145;145;145;145;145;145 16:49:54 INFO - PROCESS | 23646 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;96;95 16:49:54 INFO - PROCESS | 23646 | |8;json-parse-financial;58;56;55;56;56;57;54;55;54;53 16:49:54 INFO - PROCESS | 23646 | |9;json-stringify-tinderbox;77;77;76;77;76;76;77;77;76;76 16:49:54 INFO - PROCESS | 23646 | |10;stanford-crypto-aes;77;78;78;79;77;79;78;76;78;77 16:49:54 INFO - PROCESS | 23646 | |11;stanford-crypto-ccm;115;109;111;111;113;114;119;113;119;111 16:49:54 INFO - PROCESS | 23646 | |12;stanford-crypto-pbkdf2;136;136;146;135;135;124;138;134;136;137 16:49:54 INFO - PROCESS | 23646 | |13;stanford-crypto-sha256-iterative;65;65;67;65;63;64;66;66;67;63 16:49:54 INFO - PROCESS | 23646 | __end_tp_report 16:49:54 INFO - PROCESS | 23646 | __start_cc_report 16:49:54 INFO - PROCESS | 23646 | _x_x_mozilla_cycle_collect,1037 16:49:54 INFO - PROCESS | 23646 | __end_cc_report 16:49:54 INFO - PROCESS | 23646 | __startTimestamp1462837794685__endTimestamp 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | ------- Summary: start ------- 16:49:54 INFO - PROCESS | 23646 | Number of tests: 14 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.59 (3.3%) stddev-sans-first:3.79 16:49:54 INFO - PROCESS | 23646 | Values: 109.0 111.0 103.0 109.0 110.0 110.0 100.0 110.0 108.0 110.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.50 stddev:16.73 (10.8%) stddev-sans-first:15.73 16:49:54 INFO - PROCESS | 23646 | Values: 170.0 129.0 151.0 161.0 128.0 154.0 155.0 135.0 169.0 128.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 16:49:54 INFO - PROCESS | 23646 | Values: 160.0 160.0 160.0 160.0 160.0 162.0 160.0 163.0 159.0 160.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:35.51 (46.7%) stddev-sans-first:37.11 16:49:54 INFO - PROCESS | 23646 | Values: 75.0 76.0 73.0 162.0 77.0 76.0 74.0 76.0 157.0 76.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:21.24 (22.8%) stddev-sans-first:21.95 16:49:54 INFO - PROCESS | 23646 | Values: 93.0 94.0 138.0 94.0 93.0 93.0 139.0 93.0 94.0 135.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:49:54 INFO - PROCESS | 23646 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:49:54 INFO - PROCESS | 23646 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:49:54 INFO - PROCESS | 23646 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.27 16:49:54 INFO - PROCESS | 23646 | Values: 58.0 56.0 55.0 56.0 56.0 57.0 54.0 55.0 54.0 53.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:77.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 16:49:54 INFO - PROCESS | 23646 | Values: 77.0 77.0 76.0 77.0 76.0 76.0 77.0 77.0 76.0 76.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:0.97 16:49:54 INFO - PROCESS | 23646 | Values: 77.0 78.0 78.0 79.0 77.0 79.0 78.0 76.0 78.0 77.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#11] stanford-crypto-ccm Cycles:10 Average:113.50 Median:113.50 stddev:3.37 (3.0%) stddev-sans-first:3.54 16:49:54 INFO - PROCESS | 23646 | Values: 115.0 109.0 111.0 111.0 113.0 114.0 119.0 113.0 119.0 111.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:136.00 stddev:5.31 (3.9%) stddev-sans-first:5.63 16:49:54 INFO - PROCESS | 23646 | Values: 136.0 136.0 146.0 135.0 135.0 124.0 138.0 134.0 136.0 137.0 16:49:54 INFO - PROCESS | 23646 | 16:49:54 INFO - PROCESS | 23646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.45 (2.2%) stddev-sans-first:1.54 16:49:54 INFO - PROCESS | 23646 | Values: 65.0 65.0 67.0 65.0 63.0 64.0 66.0 66.0 67.0 63.0 16:49:54 INFO - PROCESS | 23646 | -------- Summary: end -------- 16:49:54 INFO - PROCESS | 23646 | 16:49:55 INFO - TEST-INFO | 23646: exit 0 16:49:55 INFO - TEST-OK | kraken | took 59050ms 16:49:55 INFO - SUITE-END | took 1170s 16:49:55 INFO - Completed test suite (00:19:30) 16:49:55 INFO - javascript benchmark 16:49:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3295.6704329567037, 3345.7657963942534, 3382.8477718502663, 3387.4749413840864, 3403.421418358879, 5424.810131645393, 5426.972865135679, 5433.049216387127, 5441.863953401162, 5485.780568777254, 5407.405185429599, 5434.076207044802, 5448.972755136228, 5449.972750136254, 5455.754491047903, 4796.088743138793, 4933.654644174918, 4946.3817022872145, 5008.173651347542, 5031.698098114125, 4903.754812259391, 4984.426790919037, 4987.900241995158, 4990.3762029746285, 4990.925136122961, 4978.925316120261, 5034.446210916796, 5034.697918124906, 5040.243963405482, 5059.797608095671, 4897.4123105227245, 5000.499950005007, 5050.166722490803, 5056.873578160538, 5059.595232381401, 4862.6353023523025, 4958.454569997298, 4980.953999660076, 5009.173486374744, 5020.171671674169, 5151.66514176581, 5208.088584497697, 5221.791128354861, 5225.555827754645, 5240.947590524084, 5857.121431785266, 5860.619059761102, 5872.295324561037, 5872.7357268923, 5880.0, 5782.653040817564, 5833.504152147073, 5858.707064646793, 5884.205632239636, 5923.022701254288, 5454.181872719045, 5464.426235245322, 5465.644733092376, 5490.972545137289, 5540.584456165804, 5932.139839723216, 5935.169076329231, 5935.2877654681715, 5936.1689363488285, 5967.6121052131475, 5650.3219613646625, 5733.569982251348, 5735.569832262597, 5766.826995190151, 5846.123081537803, 5949.1076338549565, 5951.642901425928, 5959.344472108065, 5961.493273071837, 5971.880562388728, 5842.503387212049, 5873.119032145127, 5873.913326034697, 5874.0, 5882.735276912549, 5656.943430565724, 5720.427957204246, 5782.103773914966, 5786.189933409326, 5881.7647294107755, 4455.420795296591, 4475.552444755564, 4481.775911204427, 4486.035502367007, 4503.279475284005, 4023.7786921719003, 4043.8180281887385, 4058.837646494107, 4078.2659121358442, 4079.6124368184974, 5384.111621582395, 5543.861403464865, 5602.1036634139155, 5632.577556683265, 5635.830925072254, 5880.117982302603, 5899.321578018497, 5917.970410147922, 5922.141289512996, 5928.288605367297, 5355.919661205007, 5556.0, 5571.749271282802, 5575.498205161555, 5577.74900129487, 5070.949290507121, 5120.948790512047, 5126.92309615356, 5130.79476820923, 5160.0969830279555, 6064.545159113084, 6072.0, 6095.05526643371, 6098.0243161094895, 6104.847378815565, 5727.599068065196, 5744.224529688606, 5901.940980590139, 5911.172435859069, 5921.0, 5955.791547295824, 5998.850028749316, 6013.548983826318, 6030.065339872327, 6052.273727152769, 5724.227229323988, 5760.049591817303, 5764.07774756037, 5765.56758243125, 5772.480476757112, 5685.147227915681, 5788.565857560784, 5828.708564571839, 5846.298444186725, 5865.384134665798, 5741.167530708108, 5755.0, 5756.2229099072765, 5756.856078597901, 5762.769489220552, 5686.43135686428, 5732.226149469935, 5733.082706766897, 5753.0, 5755.194272801895, 5447.428020057995, 5577.832665020056, 5595.328560572757, 5637.915431268616, 5683.7442315095095, 5630.60585758993, 5689.203511508475, 5713.200151978644, 5713.542916566582, 5725.6850873202375, 5462.590305727166, 5478.534324582296, 5482.698451585201, 5592.748326325243, 5641.492265696107], "unit": "score", "name": "dojo.html", "value": 5397.250609689872}, {"lowerIsBetter": false, "replicates": [538.3432212700504, 551.0549407765681, 562.2606272751332, 570.5806232419174, 576.1300436341123, 32096.518552221707, 32773.18067048325, 32776.836115819446, 32777.50833737496, 32778.508322375186, 40346.7982660087, 40501.79749101258, 40549.79725101378, 40560.79719601405, 40601.59398406015, 8821.426607270507, 9033.367664263504, 9042.954785226064, 9045.276377889786, 9053.04942980984, 8740.825183496327, 8841.292696584258, 8879.28965682744, 8881.999999999967, 8886.644534218623, 8848.911510884906, 8929.973053098913, 8931.598078086501, 9213.262938964866, 9254.67608633698, 9167.862482062774, 9267.582958766805, 9274.30442716799, 9275.48984805832, 9276.07239276067, 8958.820823583492, 9082.636694532212, 9092.863607045834, 9095.317851161124, 9101.180893719531, 42490.57509424897, 43189.35215971732, 43194.784026079666, 43230.13539729219, 43297.783511082554, 3380.5943286805496, 3513.9106876868254, 3681.668649821529, 3704.018435114697, 3852.499175107246, 31023.37953240945, 31332.06003819889, 31359.37281254385, 31758.364832703446, 31942.20144496383, 3665.798381089039, 3691.778493290411, 3846.0961674006585, 3871.3805791073573, 3881.573026967031, 223533.0, 226691.8665406679, 227087.0, 227112.0, 227749.0, 46290.30564541535, 46944.0, 47034.05931881343, 70536.294637054, 72865.27134728584, 47488.28767568489, 47592.0, 47802.0, 47867.28199077016, 47965.0, 17254.827451725574, 17542.21060052301, 17591.73612395815, 17637.82362176362, 17640.294388224327, 13870.445182192801, 13982.930085349712, 13997.580072597839, 14006.439742410394, 14009.579712608638, 15397.23013849303, 15465.536033919001, 15877.2855221513, 15958.9202053989, 15968.600784980468, 6206.937930620727, 6253.906191407133, 6282.120503129566, 6333.904991425133, 6385.936140638627, 994.2394068537575, 1005.2360206243162, 1025.2566889005411, 1039.3504059962524, 1102.2639343034753, 26652.334766523192, 26848.731512685015, 26997.325066873484, 27297.454050919267, 28580.71419285822, 1012.0, 1096.3421946831836, 1129.3449799116493, 1139.2879450343535, 1207.3600991474532, 16003.0, 16171.919140404223, 16217.51347459578, 16287.267072981744, 16698.6660266794, 403325.0, 407996.0, 408096.0, 408435.0, 408727.0, 60493.69753151294, 61070.0, 61331.08003379953, 61412.69293653503, 61424.07863882045, 1348.3123606960326, 1463.5536161470854, 1482.6219314074842, 1498.5579254120062, 1521.6880539489157, 28207.858960705064, 28389.290267743472, 28906.566401503573, 29103.272418189714, 29224.123276300896, 48545.0, 48903.0, 49195.508044919094, 49209.507904920494, 49215.0, 257517.0, 258233.0, 258898.0, 259324.0, 259589.0, 34717.65282347144, 35436.11409714675, 35488.64511354853, 35781.0, 35815.10462238361, 47732.76133619449, 48629.27056094232, 49361.259581105594, 49423.75288123536, 49687.25469118039, 39102.45225359, 40041.799791000856, 40341.79829100836, 40393.39409908795, 41053.79473102615, 38570.071496425626, 38604.42093368658, 39295.41056884092, 39364.803175983936, 40299.79850100731, 39598.60401396064, 41561.58438415577, 42470.36294455647, 42599.7870010648, 42901.141977159656, 32935.50596741099, 34383.828080859435, 34589.48115778215, 35038.0, 35123.473147903314, 26992.73007269902, 27369.17892463229, 27529.459670170618, 27593.0, 27618.585721213796], "unit": "score", "name": "ext.html", "value": 18910.62692245151}, {"lowerIsBetter": false, "replicates": [352.16185478561005, 355.15650330465144, 357.61556326948534, 358.3728475168455, 361.5119588555449, 17392.0, 17712.380066697668, 18290.725639115422, 18444.262229510805, 18686.906565467187, 18040.0, 18060.729089063643, 18483.722744158815, 18530.629387412242, 18533.721994170064, 5368.973155134219, 5377.650452720571, 5472.616916815805, 5509.035918714209, 5586.469285417878, 4176.206520761061, 5440.156775699773, 5774.682392468412, 6005.519558435315, 6044.365341639131, 5972.850678733023, 5985.610935289193, 6004.879902401949, 6008.068749343859, 6015.578909476339, 5762.222100016486, 5997.520198384119, 6026.276846778393, 6040.637561746309, 6051.092336149591, 3802.8478860845535, 5218.6868787872845, 5378.085725426687, 5388.703621300827, 5401.459854014606, 20323.491912702153, 20418.081186346502, 20576.279830205873, 21798.782012179832, 21828.45428864275, 2242.3048854855047, 2294.5066810635794, 2465.6917885264343, 2808.747212750862, 3052.4047810676925, 12691.936540317332, 12881.935590322082, 12963.935180324039, 13138.934305328508, 13215.074944753871, 1861.9813801861944, 1880.6144740328336, 1939.4957311099074, 1946.6593346164364, 1957.7063440483898, 64582.67708661427, 65038.3496165037, 65592.34407655911, 66733.3326666732, 67607.0, 10108.140808031252, 10228.795424091477, 10327.225458090523, 10514.369137851754, 10525.526351314209, 14988.47540336083, 15022.549323520312, 15082.24588770557, 15132.092074475566, 15139.71312438433, 7917.129115797257, 8224.766285057289, 8447.113053129333, 8486.448380855225, 8486.74539763808, 8142.0, 8333.2916702081, 8413.495190288602, 8481.321494280442, 8486.74539763808, 4634.629229661687, 4701.318308845198, 4705.764711764398, 4713.858584242478, 4790.449098353664, 1831.569581148429, 1844.6810530470777, 1856.433787694739, 1936.9225230990885, 1945.4260993007097, 963.5904740485265, 967.7967626798311, 1036.7926414716935, 1060.39557452253, 1095.7972775036644, 16155.273012714457, 16525.58686032835, 16640.334386624643, 17041.91479042597, 17222.311107555557, 980.5930538826307, 991.945443000642, 995.5967833027636, 1030.7783826477194, 1071.314358810362, 9537.380070295547, 10116.848247276297, 10148.492575371201, 10153.64462243818, 10325.122364598943, 421663.0, 428591.0, 435004.0, 436246.0, 436465.0, 77293.61353193199, 78574.21425785669, 79480.20519794844, 80074.0, 80727.59636201899, 1047.2930771729052, 1065.8561094252332, 1068.150820098024, 1083.6369816111533, 1086.4187659602076, 15540.611484712972, 15611.063336199864, 15835.208239587744, 15846.12846293465, 15955.282012309706, 35529.467057993636, 35683.643163568035, 35698.10754731153, 36991.44512832256, 37080.0, 50517.74741126271, 50575.0, 50786.746066269436, 50810.49189508206, 51399.743001284754, 7961.960190199012, 8119.512829230265, 8198.0, 8205.671773129008, 8281.047679516932, 11763.353015584225, 11788.469518871843, 12347.38263086824, 12730.554430594884, 13387.531436399679, 10504.632337868137, 11420.371879546372, 11503.942480287546, 11511.654650360502, 11877.168598198043, 10659.573617055232, 11544.653660390202, 11646.534138634699, 11683.824742628698, 11761.294322340687, 11408.372539510407, 11409.714757131138, 11477.942610286895, 11889.048876089719, 11911.642650720492, 7725.304722574995, 7742.264484873928, 7803.687852486064, 7942.166072562529, 8212.096669366245, 9588.37675551087, 11367.943160284145, 11398.08815294758, 11470.82793758111, 11572.59495917639], "unit": "score", "name": "jquery.html", "value": 8874.909442502487}, {"lowerIsBetter": false, "replicates": [1352.6338398217797, 1548.8615867337505, 1584.690985257875, 1783.3045112406164, 1864.2449807827834, 7414.406847452205, 7942.483738556997, 8105.716299929503, 8110.837783244331, 8117.228863257996, 7902.841943161147, 8072.394570407214, 8085.393595480333, 8112.91887081129, 8116.472429292106, 2354.7998420134268, 2381.57131716291, 2385.0340612052146, 2386.0336563691644, 2386.1052105460453, 2338.5206032763326, 2372.762723727622, 2374.02664907388, 2389.64155376694, 2390.22317746733, 2374.5963186258377, 2388.988055059731, 2390.3546042568496, 2433.8052955763496, 2437.402836305108, 2416.66166736657, 2437.146998550511, 2446.2416650838295, 2446.865422401776, 2448.2777580613674, 2335.7664233576675, 2390.5696974544576, 2390.581648211556, 2395.964060539093, 2397.436602398435, 8330.208630180123, 8368.246857782768, 8373.581320933929, 8380.832383352299, 8405.033421156584, 5050.974745126287, 5207.140821764404, 5214.374275087014, 5215.817446389358, 5216.9739151304, 3103.332783451569, 3114.299282661406, 3162.7469802415753, 3196.9200769980703, 3226.3386005868974, 973.459729849933, 978.5205249427801, 984.0553069053717, 996.9700908972742, 1002.6340385759146, 11616.419179041015, 11624.593139240085, 11636.650900473, 11654.88345116555, 11658.125640576991, 4359.324304732771, 4386.912261754747, 4439.622632076245, 4460.264056430653, 4460.509343972225, 9873.851892221479, 9882.950585247028, 9906.306558540833, 9913.959034301295, 9932.553035113437, 5061.873453163626, 5091.694498330112, 5094.312267843868, 5102.668326558762, 5104.9489505104475, 4125.195586860594, 4203.936940945889, 4444.533324000933, 4537.863864084083, 4615.607673347736, 3730.7761534307488, 3810.828512716879, 3815.503984482055, 3825.2349530094093, 3884.0, 1195.1574140231116, 1223.577865636354, 1226.9877301226873, 1232.642533665245, 1237.641084085623, 1422.537675255546, 1422.615893708693, 1425.0309789343346, 1441.1641248076091, 1450.4125829039256, 7760.767176984699, 7762.883556746653, 7771.911932329365, 7801.531908085533, 7808.414368922354, 522.5349438999293, 529.888723368097, 529.9920501192486, 530.8168681804772, 535.2265975665126, 5836.0, 5842.474177324061, 5847.94152058474, 5881.911771323434, 5897.764089436375, 9589.328746987783, 9661.227101831837, 9705.078017588317, 9719.028097190367, 9865.210783137476, 9536.809263814685, 9700.951495242478, 9705.6117755289, 9731.172850307661, 9735.367201131903, 7281.745138920112, 7389.261073892568, 7395.038644976119, 7398.11222653285, 7405.370543503863, 7568.962155189189, 7592.696292148473, 7700.19147989453, 7720.150783413707, 7818.17909119557, 8669.263112635497, 8976.596053177493, 9033.322500812334, 9060.139286767746, 9062.04848490899, 9125.634974601207, 9144.679936202201, 9242.768930776785, 9354.25165986733, 9378.437293762396, 6357.904631430625, 6512.023196520559, 7031.507794454339, 7352.080989876265, 7472.327490525879, 7802.726904558313, 7838.686452541834, 7902.68389264446, 7908.683652653829, 7910.841783164419, 6956.304369563003, 6996.230414654486, 7110.146782386147, 7142.500024998408, 7268.527545709512, 6583.242927063449, 6602.537822352581, 6605.768798092044, 6746.0555522227905, 6902.06822079033, 7124.786256412316, 7170.784876453715, 7253.165885923187, 7373.3732632726815, 7414.184439711736, 6784.660766961731, 6796.93203067963, 6829.760958366433, 6843.931560684329, 6844.623545705034, 6560.803175904731, 6567.408933196035, 6607.405333520006, 6609.735610575523, 6617.205935287796], "unit": "score", "name": "mootools.html", "value": 4607.191258249974}, {"lowerIsBetter": false, "replicates": [344.5658470327387, 345.2938740276135, 347.6019957149063, 352.99647003529964, 354.5390991710775, 5983.790567330145, 5991.131285963533, 5994.790182343619, 6005.159277701126, 6010.218671572689, 5890.440408161228, 5908.0, 5917.5561832862495, 5931.6441013539215, 5971.581989260753, 4479.888002799931, 4562.634989200873, 4657.091867085919, 4682.6956247843955, 4687.8359257426, 4617.261238201889, 4650.790714417859, 4673.3223682566, 4680.25115981443, 4680.461746899116, 4482.148391805563, 4637.582617564419, 4639.211334073216, 4644.326572646964, 4647.7676116194225, 4561.703489273186, 4587.174308624446, 4589.334546490757, 4681.836135735267, 4698.154332220199, 4127.566605506408, 4181.498220213563, 4188.350805625133, 4189.114898295748, 4192.790360481964, 5714.942850571524, 5718.456746609066, 5725.169850371714, 5726.055200891848, 5734.0, 5466.0, 5474.972625136849, 5476.58925580583, 5480.698561579112, 5481.890362192774, 6342.0, 6349.8412539686415, 6355.205599300088, 6355.332690067568, 6359.936400635981, 4488.775561221926, 4616.330632058366, 4617.72293662378, 4618.307253911907, 4620.075984803053, 6527.249366322886, 6638.535302528825, 6642.136522252076, 6643.7674681385915, 6646.0, 4562.61217796491, 4679.836205732783, 4680.765961701902, 4682.391289132459, 4708.835190768306, 4764.976175119103, 4766.928496072562, 4767.022760334124, 4769.070031343924, 4775.5224477551965, 5414.40441551429, 5415.404305526389, 5418.539424148991, 5418.566514678816, 5422.43064478232, 6367.172267605181, 6407.199100112486, 6411.455026322815, 6411.903821442682, 6416.390442907917, 1697.499237724874, 1722.2680360846591, 1723.1814887928133, 1724.430937790526, 1729.161356741979, 1105.0551778229499, 1141.3608379307614, 1143.874173840877, 1193.2065176657425, 1208.10600155884, 6145.907811382833, 6217.347178546278, 6226.626402415779, 6237.0, 6252.406021427957, 6606.306337834554, 6614.305497922745, 6615.875301198807, 6623.741489117052, 6626.86746265072, 6207.472364849038, 6216.844578885473, 6218.968905155445, 6224.595401298901, 6234.096056071935, 3518.40187168182, 3552.87564935226, 3553.466979953028, 3553.680168784822, 3558.430651095812, 6694.665266736643, 6826.624535650587, 6842.623655698984, 6846.691898864563, 6860.3139686032, 6730.293319201512, 6761.594304341756, 6766.391024807791, 6769.05233267343, 6772.864542709118, 6794.966025169842, 6816.227780777033, 6817.625030623264, 6818.147731533559, 6835.906254999276, 6547.607143571401, 6570.113034740249, 6582.901256481061, 6585.440237579859, 6597.5381723280825, 6327.778527751507, 6352.174217351715, 6459.386358295955, 6498.317676643885, 6514.0, 6807.3873351398615, 6820.727170913108, 6821.761238356634, 6822.727090916308, 6826.522143449911, 4797.328374027569, 4799.1601469743355, 4804.06320767447, 4806.543378379049, 4806.591439727662, 6574.737010519526, 6588.8352791180605, 6593.637349945799, 6594.901076483952, 6597.670116494252, 6258.123862659322, 6399.55203135776, 6400.167978162809, 6406.839829004312, 6410.61536307823, 6404.0, 6407.423331900151, 6408.0, 6421.775237866652, 6448.2262128543, 6196.690165491617, 6206.472449841814, 6220.440160385587, 6225.657588832658, 6230.626162430269, 6420.2616699078335, 6431.099646049463, 6433.420992110732, 6438.935610643834, 6441.710123044568, 6031.366706495754, 6184.752609895554, 6293.213348331458, 6295.055741638791, 6298.401651843067], "unit": "score", "name": "prototype.html", "value": 4875.217004341897}, {"lowerIsBetter": false, "replicates": [750.7222327738738, 798.4889670610809, 803.2289002557541, 869.5043825019741, 930.7254359963812, 13732.24472654005, 13757.380917858696, 13799.2410417427, 13808.378622961965, 13959.092658977172, 13248.337583120829, 13405.731885362287, 13419.396127174276, 13421.194728316308, 13498.73002539951, 787.4291138924291, 923.556692787464, 928.642472648032, 949.9857502137473, 954.3605784124653, 942.354487176283, 945.8392073347513, 948.1987720376271, 949.278548303291, 950.857371394293, 1002.0880998291556, 1004.8593196952396, 1005.1104772276551, 1005.5324274212489, 1005.6781829814462, 808.2281421242699, 979.3340528440657, 985.261054209343, 987.2842189412654, 987.4717026390847, 716.992830071703, 722.3751454991448, 725.2095216214352, 728.3881539506787, 729.1286912139994, 14331.71336573273, 14341.713165736732, 14396.136231826124, 14424.134551926918, 14478.493252736209, 13548.86451135486, 13900.582982510541, 13943.511977080854, 14201.076929999517, 14243.216623085726, 10965.451727413598, 11093.223474356799, 11124.49939752713, 11303.095752339794, 11443.713907152305, 3776.9055773605605, 3801.353769859131, 3805.4101614249835, 3847.3267178243977, 3917.2361389529055, 51512.742436287575, 51778.741106294605, 54506.0, 54892.45107548913, 55060.971646559425, 10199.592016319264, 10440.530176142092, 10576.576936922436, 11372.0, 11532.827007594893, 20065.197392104445, 20313.695294570593, 20348.796512034987, 20383.08276127578, 20388.49028774263, 8116.147804480563, 8200.958995204986, 8276.544790036485, 8429.114942931026, 8461.2807911327, 4725.645576581702, 4743.881402964885, 4768.499307572655, 4784.497627749106, 4857.101436234308, 3519.472079188091, 3601.585817631006, 3605.603383627799, 3605.7836529808296, 3608.8376023079027, 580.3123298890828, 594.6075590110593, 599.3766482857866, 622.0575827621067, 623.3548277532823, 630.8864404407251, 657.135866335767, 669.7923643670478, 673.7810211681223, 676.5027704637088, 8831.0, 8930.374873758905, 8938.37431379797, 9007.324450666227, 9060.54697265134, 650.6876699184418, 665.8846432226002, 673.572281601177, 678.1590827374021, 704.2464562917731, 3978.1645854370327, 3991.1419044905483, 4045.0898547826505, 4103.97948010264, 4118.979405102956, 58498.7075064622, 59147.0, 59398.0, 59692.70153649291, 59698.70150649306, 51321.743391282806, 52571.73714131405, 53115.20327195095, 53362.0, 53611.0, 46866.5313346869, 48398.0, 48673.26990095151, 49194.0, 49244.75377623089, 7726.0, 7927.84144317122, 7985.920140798517, 8024.799380015313, 8242.052164001216, 36654.26691466209, 36695.449568255965, 36913.630863692095, 38806.0, 38883.80558097304, 42539.361909572, 42708.0, 46428.767856160506, 46518.767406162755, 47451.28823067588, 10009.049140331657, 10314.690559283234, 10451.268411211142, 10797.892021080002, 10859.51132199037, 11734.94132529332, 11768.35274059935, 11792.23350482216, 12171.087168462223, 12510.687232819253, 10246.487675616041, 10496.79006419852, 10890.29213101146, 11210.831837522606, 11655.18413711066, 10685.465726713788, 10970.945145274223, 13004.479820807062, 13208.459572284613, 13378.13042152257, 11265.605703800327, 11318.037966772587, 12105.0, 12146.574869879512, 12666.746665066832, 10447.216458765472, 10489.265751397328, 10577.682669519927, 10735.516901739284, 10749.408782516724, 9238.907610923805, 9254.12085851843, 9254.35219534626, 9282.860757088783, 9376.671816486663], "unit": "score", "name": "yui.html", "value": 6691.852031691353}], "name": "dromaeo_css", "value": 7172.590640708231}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 109.0, 110.0, 110.0, 100.0, 110.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [170.0, 129.0, 151.0, 161.0, 128.0, 154.0, 155.0, 135.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 163.0, 159.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 73.0, 162.0, 77.0, 76.0, 74.0, 76.0, 157.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.2}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 138.0, 94.0, 93.0, 93.0, 139.0, 93.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 55.0, 56.0, 56.0, 57.0, 54.0, 55.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 76.0, 77.0, 76.0, 76.0, 77.0, 77.0, 76.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 79.0, 77.0, 79.0, 78.0, 76.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [115.0, 109.0, 111.0, 111.0, 113.0, 114.0, 119.0, 113.0, 119.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.5}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 146.0, 135.0, 135.0, 124.0, 138.0, 134.0, 136.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 65.0, 63.0, 64.0, 66.0, 66.0, 67.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1496.5}]} 16:49:55 INFO - Return code: 0 16:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:49:56 INFO - # TBPL SUCCESS # 16:49:56 INFO - Running post-action listener: _resource_record_post_action 16:49:56 INFO - Running post-run listener: _resource_record_post_run 16:49:57 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 466579456; Read time: 28; Write time: 437172 16:49:57 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 254783488; Read time: 0; Write time: 316188 16:49:57 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 211795968; Read time: 28; Write time: 120984 16:49:57 INFO - Running post-run listener: _upload_blobber_files 16:49:57 INFO - Blob upload gear active. 16:49:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:49:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:58 INFO - (blobuploader) - INFO - Done attempting. 16:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:59 INFO - (blobuploader) - INFO - Done attempting. 16:49:59 INFO - (blobuploader) - INFO - Iteration through files over. 16:49:59 INFO - Return code: 0 16:49:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:49:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:49:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2850f8bab348f9ad2eef974b5c0181d2783b6b8759ab2d60de2e5e3bd4f36c22a27ef6b66863b1ecd3cab6b1b54c77a38240f748e5e6c70e67819db0ebf4f9f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/062c89055e917f8a5ca8f65ee3aa7c4393849cdeaafa3c62ce11a80c6b1f128821662e9690c367c11cc4e43140e1bf2ed8ceab4909d88ba749cbedc8bac6e30e"} 16:49:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:49:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:49:59 INFO - Contents: 16:49:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2850f8bab348f9ad2eef974b5c0181d2783b6b8759ab2d60de2e5e3bd4f36c22a27ef6b66863b1ecd3cab6b1b54c77a38240f748e5e6c70e67819db0ebf4f9f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/062c89055e917f8a5ca8f65ee3aa7c4393849cdeaafa3c62ce11a80c6b1f128821662e9690c367c11cc4e43140e1bf2ed8ceab4909d88ba749cbedc8bac6e30e"} 16:49:59 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:59 INFO - Copying logs to upload dir... 16:49:59 INFO - mkdir: /builds/slave/test/build/upload/logs 16:49:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.113062 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 16:49:59.375411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:49:59.378892) ========= 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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 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/2850f8bab348f9ad2eef974b5c0181d2783b6b8759ab2d60de2e5e3bd4f36c22a27ef6b66863b1ecd3cab6b1b54c77a38240f748e5e6c70e67819db0ebf4f9f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/062c89055e917f8a5ca8f65ee3aa7c4393849cdeaafa3c62ce11a80c6b1f128821662e9690c367c11cc4e43140e1bf2ed8ceab4909d88ba749cbedc8bac6e30e"} build_url:https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/SPtkHs5LRE-doce0dmS8qg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2850f8bab348f9ad2eef974b5c0181d2783b6b8759ab2d60de2e5e3bd4f36c22a27ef6b66863b1ecd3cab6b1b54c77a38240f748e5e6c70e67819db0ebf4f9f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/062c89055e917f8a5ca8f65ee3aa7c4393849cdeaafa3c62ce11a80c6b1f128821662e9690c367c11cc4e43140e1bf2ed8ceab4909d88ba749cbedc8bac6e30e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:49:59.403554) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:49:59.403910) ========= 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=62c568580acbfdaac3eec7be000001dc-1462836123.550097-94807751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:49:59.490091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:49:59.490405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:49:59.490749) ========= ========= Total master_lag: 0.18 =========