builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1464652359.43 results: success (0) buildid: 20160526112438 builduid: 7b7803f5dee74ad79ba6e8f098a8fa00 revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.434254) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.434738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.435031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.450375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.450795) ========= 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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:52:39-- 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% 229M=0s 2016-05-30 16:52:39 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.548981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.549327) ========= 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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013984 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.598623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:39.598990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 417e1ec42d8f68c55e52c336cdf81e83323db88c --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 417e1ec42d8f68c55e52c336cdf81e83323db88c --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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:52:39,739 truncating revision to first 12 chars 2016-05-30 16:52:39,739 Setting DEBUG logging. 2016-05-30 16:52:39,739 attempt 1/10 2016-05-30 16:52:39,739 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/417e1ec42d8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:52:40,265 unpacking tar archive at: mozilla-beta-417e1ec42d8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:40.477475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:40.477961) ========= script_repo_revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:40.478562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:40.478894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:40.489156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-30 16:52:40.489578) ========= /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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:40 INFO - MultiFileLogger online at 20160530 16:52:40 in /builds/slave/test 16:52:40 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:52:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:40 INFO - {'append_to_log': False, 16:52:40 INFO - 'base_work_dir': '/builds/slave/test', 16:52:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:40 INFO - 'branch': 'Mozilla-Beta', 16:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:40 INFO - 'config_files': ('talos/linux_config.py',), 16:52:40 INFO - 'default_actions': ('clobber', 16:52:40 INFO - 'read-buildbot-config', 16:52:40 INFO - 'download-and-extract', 16:52:40 INFO - 'populate-webroot', 16:52:40 INFO - 'create-virtualenv', 16:52:40 INFO - 'install', 16:52:40 INFO - 'run-tests'), 16:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:40 INFO - 'download_minidump_stackwalk': True, 16:52:40 INFO - 'download_symbols': 'ondemand', 16:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:40 INFO - 'installer_path': 'installer.exe', 16:52:40 INFO - 'log_level': 'info', 16:52:40 INFO - 'log_name': 'talos', 16:52:40 INFO - 'log_to_console': True, 16:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:40 INFO - 'opt_config_files': (), 16:52:40 INFO - 'pip_index': False, 16:52:40 INFO - 'sps_profile': False, 16:52:40 INFO - 'sps_profile_interval': 0, 16:52:40 INFO - 'suite': 'dromaeojs', 16:52:40 INFO - 'system_bits': '32', 16:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:40 INFO - 'title': 'talos-linux64-ix-003', 16:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:40 INFO - 'use_talos_json': True, 16:52:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:40 INFO - 'work_dir': 'build'} 16:52:40 INFO - ##### 16:52:40 INFO - ##### Running clobber step. 16:52:40 INFO - ##### 16:52:40 INFO - Running pre-action listener: _resource_record_pre_action 16:52:40 INFO - Running main action method: clobber 16:52:40 INFO - rmtree: /builds/slave/test/build 16:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:41 INFO - Running post-action listener: _resource_record_post_action 16:52:41 INFO - ##### 16:52:41 INFO - ##### Running read-buildbot-config step. 16:52:41 INFO - ##### 16:52:41 INFO - Running pre-action listener: _resource_record_pre_action 16:52:41 INFO - Running main action method: read_buildbot_config 16:52:41 INFO - Using buildbot properties: 16:52:41 INFO - { 16:52:41 INFO - "project": "", 16:52:41 INFO - "product": "firefox", 16:52:41 INFO - "script_repo_revision": "production", 16:52:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:52:41 INFO - "repository": "", 16:52:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:52:41 INFO - "buildid": "20160526112438", 16:52:41 INFO - "pgo_build": "True", 16:52:41 INFO - "basedir": "/builds/slave/test", 16:52:41 INFO - "buildnumber": 25, 16:52:41 INFO - "slavename": "talos-linux64-ix-003", 16:52:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:52:41 INFO - "platform": "ubuntu64_hw", 16:52:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:52:41 INFO - "branch": "mozilla-beta", 16:52:41 INFO - "repo_path": "releases/mozilla-beta", 16:52:41 INFO - "revision": "417e1ec42d8f68c55e52c336cdf81e83323db88c", 16:52:41 INFO - "stage_platform": "linux64-pgo", 16:52:41 INFO - "builduid": "7b7803f5dee74ad79ba6e8f098a8fa00", 16:52:41 INFO - "slavebuilddir": "test" 16:52:41 INFO - } 16:52:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:52:41 INFO - Running post-action listener: _resource_record_post_action 16:52:41 INFO - ##### 16:52:41 INFO - ##### Running download-and-extract step. 16:52:41 INFO - ##### 16:52:41 INFO - Running pre-action listener: _resource_record_pre_action 16:52:41 INFO - Running main action method: download_and_extract 16:52:41 INFO - mkdir: /builds/slave/test/build/tests 16:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:41 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:42 INFO - Downloaded 1412 bytes. 16:52:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:42 INFO - Using the following test package requirements: 16:52:42 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:42 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:42 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:52:42 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'jsshell-linux-x86_64.zip'], 16:52:42 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:42 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:42 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:52:42 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:52:42 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:42 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:42 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:42 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:42 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:42 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:52:42 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:43 INFO - Downloaded 23434090 bytes. 16:52:43 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:52:43 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:52:44 INFO - Return code: 0 16:52:44 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:52:44 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:52:44 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:46 INFO - Downloaded 23434090 bytes. 16:52:46 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:52:46 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:52:47 INFO - Return code: 0 16:52:47 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:52:47 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:48 INFO - Downloaded 10845194 bytes. 16:52:48 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:52:48 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:52:48 INFO - Return code: 0 16:52:48 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:52:48 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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:52:51 INFO - Downloaded 53852157 bytes. 16:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:51 INFO - mkdir: /builds/slave/test/properties 16:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:51 INFO - Contents: 16:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:52 INFO - Running post-action listener: _resource_record_post_action 16:52:52 INFO - Running post-action listener: set_extra_try_arguments 16:52:52 INFO - ##### 16:52:52 INFO - ##### Running populate-webroot step. 16:52:52 INFO - ##### 16:52:52 INFO - Running pre-action listener: _resource_record_pre_action 16:52:52 INFO - Running main action method: populate_webroot 16:52:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:52 INFO - '--tppagecycles', 16:52:52 INFO - '7'], 16:52:52 INFO - 'tests': ['tsvgm']}}, 16:52:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:52:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:52:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'tests': ['damp', 'tps']}, 16:52:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['damp', 'tps']}, 16:52:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:52:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:52 INFO - 'other': {'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'other_l64': {'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'other_nol64': {'tests': ['a11yr', 16:52:52 INFO - 'ts_paint', 16:52:52 INFO - 'tpaint', 16:52:52 INFO - 'sessionrestore', 16:52:52 INFO - 'sessionrestore_no_auto_restore', 16:52:52 INFO - 'tabpaint']}, 16:52:52 INFO - 'svgr': {'tests': ['tsvgx', 16:52:52 INFO - 'tsvgr_opacity', 16:52:52 INFO - 'tart', 16:52:52 INFO - 'tscrollx', 16:52:52 INFO - 'cart']}, 16:52:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['tsvgx', 16:52:52 INFO - 'tsvgr_opacity', 16:52:52 INFO - 'tart', 16:52:52 INFO - 'tscrollx', 16:52:52 INFO - 'cart']}, 16:52:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'tests': ['tp5o']}, 16:52:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'talos_options': ['--e10s'], 16:52:52 INFO - 'tests': ['tp5o']}, 16:52:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'talos_options': ['--xperf_path', 16:52:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:52 INFO - 'tests': ['tp5n']}, 16:52:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:52 INFO - 'talos_options': ['--e10s', 16:52:52 INFO - '--xperf_path', 16:52:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:52 INFO - 'tests': ['tp5n']}}, 16:52:52 INFO - 'talos.zip': {'path': '', 16:52:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:52 INFO - Running post-action listener: _resource_record_post_action 16:52:52 INFO - ##### 16:52:52 INFO - ##### Running create-virtualenv step. 16:52:52 INFO - ##### 16:52:52 INFO - Running pre-action listener: _resource_record_pre_action 16:52:52 INFO - Running main action method: create_virtualenv 16:52:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:52 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:52:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:52 INFO - Using real prefix '/usr' 16:52:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:54 INFO - Installing pip.................done. 16:52:55 INFO - Return code: 0 16:52:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52:55 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:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 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:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:52:55 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:52:55 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:52:55 INFO - Using env: {'DISPLAY': ':0', 16:52:55 INFO - 'HOME': '/home/cltbld', 16:52:55 INFO - 'LANG': 'en_US.UTF-8', 16:52:55 INFO - 'LANGUAGE': 'en_US:en', 16:52:55 INFO - 'LOGNAME': 'cltbld', 16:52:55 INFO - 'MAIL': '/var/mail/cltbld', 16:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:55 INFO - 'MOZ_NO_REMOTE': '1', 16:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:55 INFO - 'NO_EM_RESTART': '1', 16:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:55 INFO - 'PWD': '/builds/slave/test', 16:52:55 INFO - 'SHELL': '/bin/bash', 16:52:55 INFO - 'SHLVL': '1', 16:52:55 INFO - 'TERM': 'linux', 16:52:55 INFO - 'TMOUT': '86400', 16:52:55 INFO - 'USER': 'cltbld', 16:52:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:55 INFO - '_': '/tools/buildbot/bin/python'} 16:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:55 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:52:55 INFO - Cleaning up... 16:52:55 INFO - Return code: 0 16:52:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:52:55 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:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 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:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:52:55 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:52:55 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:52:55 INFO - Using env: {'DISPLAY': ':0', 16:52:55 INFO - 'HOME': '/home/cltbld', 16:52:55 INFO - 'LANG': 'en_US.UTF-8', 16:52:55 INFO - 'LANGUAGE': 'en_US:en', 16:52:55 INFO - 'LOGNAME': 'cltbld', 16:52:55 INFO - 'MAIL': '/var/mail/cltbld', 16:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:55 INFO - 'MOZ_NO_REMOTE': '1', 16:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:55 INFO - 'NO_EM_RESTART': '1', 16:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:55 INFO - 'PWD': '/builds/slave/test', 16:52:55 INFO - 'SHELL': '/bin/bash', 16:52:55 INFO - 'SHLVL': '1', 16:52:55 INFO - 'TERM': 'linux', 16:52:55 INFO - 'TMOUT': '86400', 16:52:55 INFO - 'USER': 'cltbld', 16:52:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:55 INFO - '_': '/tools/buildbot/bin/python'} 16:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:55 INFO - Downloading/unpacking psutil>=0.7.1 16:52: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:52: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:52: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:52: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:52: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:52: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:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:57 INFO - Installing collected packages: psutil 16:52:57 INFO - Running setup.py install for psutil 16:52:57 INFO - building 'psutil._psutil_linux' extension 16:52:57 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:52:57 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:52:57 INFO - building 'psutil._psutil_posix' extension 16:52:57 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:52:57 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:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:57 INFO - Successfully installed psutil 16:52:57 INFO - Cleaning up... 16:52:57 INFO - Return code: 0 16:52:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:52:57 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:52:57 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:52:57 INFO - Using env: {'DISPLAY': ':0', 16:52:57 INFO - 'HOME': '/home/cltbld', 16:52:57 INFO - 'LANG': 'en_US.UTF-8', 16:52:57 INFO - 'LANGUAGE': 'en_US:en', 16:52:57 INFO - 'LOGNAME': 'cltbld', 16:52:57 INFO - 'MAIL': '/var/mail/cltbld', 16:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:57 INFO - 'MOZ_NO_REMOTE': '1', 16:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:57 INFO - 'NO_EM_RESTART': '1', 16:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:57 INFO - 'PWD': '/builds/slave/test', 16:52:57 INFO - 'SHELL': '/bin/bash', 16:52:57 INFO - 'SHLVL': '1', 16:52:57 INFO - 'TERM': 'linux', 16:52:57 INFO - 'TMOUT': '86400', 16:52:57 INFO - 'USER': 'cltbld', 16:52:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:57 INFO - '_': '/tools/buildbot/bin/python'} 16:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:53:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:00 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:53:00 INFO - Installing collected packages: mozsystemmonitor 16:53:00 INFO - Running setup.py install for mozsystemmonitor 16:53:00 INFO - Successfully installed mozsystemmonitor 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:00 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:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 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:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:00 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:53:00 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:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:03 INFO - Downloading docopt-0.6.1.tar.gz 16:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:03 INFO - Running setup.py install for blobuploader 16:53:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:03 INFO - Running setup.py install for requests 16:53:03 INFO - Running setup.py install for docopt 16:53:03 INFO - Successfully installed blobuploader requests docopt 16:53:03 INFO - Cleaning up... 16:53:03 INFO - Return code: 0 16:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:03 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:53:03 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:53:03 INFO - Using env: {'DISPLAY': ':0', 16:53:03 INFO - 'HOME': '/home/cltbld', 16:53:03 INFO - 'LANG': 'en_US.UTF-8', 16:53:03 INFO - 'LANGUAGE': 'en_US:en', 16:53:03 INFO - 'LOGNAME': 'cltbld', 16:53:03 INFO - 'MAIL': '/var/mail/cltbld', 16:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:03 INFO - 'MOZ_NO_REMOTE': '1', 16:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:03 INFO - 'NO_EM_RESTART': '1', 16:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:03 INFO - 'PWD': '/builds/slave/test', 16:53:03 INFO - 'SHELL': '/bin/bash', 16:53:03 INFO - 'SHLVL': '1', 16:53:03 INFO - 'TERM': 'linux', 16:53:03 INFO - 'TMOUT': '86400', 16:53:03 INFO - 'USER': 'cltbld', 16:53:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:03 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Running setup.py (path:/tmp/pip-MRUcLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:04 INFO - Running setup.py (path:/tmp/pip-xO8F51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:04 INFO - Running setup.py (path:/tmp/pip-_iaseB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:04 INFO - Running setup.py (path:/tmp/pip-CuprKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:04 INFO - Running setup.py (path:/tmp/pip-NHcyZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:04 INFO - Running setup.py (path:/tmp/pip-k1OMkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:04 INFO - Running setup.py (path:/tmp/pip-cbsGzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:04 INFO - Running setup.py (path:/tmp/pip-q9HutF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:04 INFO - Running setup.py (path:/tmp/pip-5kQc7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:04 INFO - Running setup.py (path:/tmp/pip-tElgW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:04 INFO - Running setup.py (path:/tmp/pip-iz2IY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:04 INFO - Running setup.py (path:/tmp/pip-7F2PNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:04 INFO - Running setup.py (path:/tmp/pip-FqFcge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Running setup.py (path:/tmp/pip-QGvbv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Running setup.py (path:/tmp/pip-bDb9Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:05 INFO - Running setup.py (path:/tmp/pip-dwBuqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:05 INFO - Running setup.py (path:/tmp/pip-exhdlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:05 INFO - Running setup.py install for manifestparser 16:53:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozcrash 16:53:05 INFO - Running setup.py install for mozdebug 16:53:05 INFO - Running setup.py install for mozdevice 16:53:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozfile 16:53:05 INFO - Running setup.py install for mozhttpd 16:53:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozinfo 16:53:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozInstall 16:53:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozleak 16:53:06 INFO - Running setup.py install for mozlog 16:53:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for moznetwork 16:53:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozprocess 16:53:06 INFO - Running setup.py install for mozprofile 16:53:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozrunner 16:53:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozscreenshot 16:53:06 INFO - Running setup.py install for moztest 16:53:06 INFO - Running setup.py install for mozversion 16:53:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:06 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:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:06 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:53:06 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:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:07 INFO - Running setup.py (path:/tmp/pip-z0D4sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:07 INFO - Running setup.py (path:/tmp/pip-KCsP3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:07 INFO - Running setup.py (path:/tmp/pip-A0YQlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:07 INFO - Running setup.py (path:/tmp/pip-XptxXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:07 INFO - Running setup.py (path:/tmp/pip-02KRdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:07 INFO - Running setup.py (path:/tmp/pip-quany0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:07 INFO - Running setup.py (path:/tmp/pip-dIz_bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:07 INFO - Running setup.py (path:/tmp/pip-iRHNSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:07 INFO - Running setup.py (path:/tmp/pip-WJ_md2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:07 INFO - Running setup.py (path:/tmp/pip-2BsLzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:07 INFO - Running setup.py (path:/tmp/pip-SmZmvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:07 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:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:07 INFO - Running setup.py (path:/tmp/pip-k_LpJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:08 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:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:08 INFO - Running setup.py (path:/tmp/pip-gsAI1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:08 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:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:08 INFO - Running setup.py (path:/tmp/pip-mc0HPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:08 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:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:08 INFO - Running setup.py (path:/tmp/pip-mASL2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:08 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:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:08 INFO - Running setup.py (path:/tmp/pip-FNdK9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:08 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:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:08 INFO - Running setup.py (path:/tmp/pip-yE3AEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:10 INFO - Downloading blessings-1.6.tar.gz 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:10 INFO - Installing collected packages: blessings 16:53:10 INFO - Running setup.py install for blessings 16:53:10 INFO - Successfully installed blessings 16:53:10 INFO - Cleaning up... 16:53:10 INFO - Return code: 0 16:53:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:10 INFO - Reading from file tmpfile_stdout 16:53:10 INFO - Current package versions: 16:53:10 INFO - argparse == 1.2.1 16:53:10 INFO - blessings == 1.6 16:53:10 INFO - blobuploader == 1.2.4 16:53:10 INFO - docopt == 0.6.1 16:53:10 INFO - manifestparser == 1.1 16:53:10 INFO - mozInstall == 1.12 16:53:10 INFO - mozcrash == 0.17 16:53:10 INFO - mozdebug == 0.1 16:53:10 INFO - mozdevice == 0.48 16:53:10 INFO - mozfile == 1.2 16:53:10 INFO - mozhttpd == 0.7 16:53:10 INFO - mozinfo == 0.9 16:53:10 INFO - mozleak == 0.1 16:53:10 INFO - mozlog == 3.1 16:53:10 INFO - moznetwork == 0.27 16:53:10 INFO - mozprocess == 0.22 16:53:10 INFO - mozprofile == 0.28 16:53:10 INFO - mozrunner == 6.11 16:53:10 INFO - mozscreenshot == 0.1 16:53:10 INFO - mozsystemmonitor == 0.0 16:53:10 INFO - moztest == 0.7 16:53:10 INFO - mozversion == 1.4 16:53:10 INFO - psutil == 3.1.1 16:53:10 INFO - requests == 1.2.3 16:53:10 INFO - wsgiref == 0.1.2 16:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 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 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:10 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:53:10 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:53:10 INFO - Using env: {'DISPLAY': ':0', 16:53:10 INFO - 'HOME': '/home/cltbld', 16:53:10 INFO - 'LANG': 'en_US.UTF-8', 16:53:10 INFO - 'LANGUAGE': 'en_US:en', 16:53:10 INFO - 'LOGNAME': 'cltbld', 16:53:10 INFO - 'MAIL': '/var/mail/cltbld', 16:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:10 INFO - 'MOZ_NO_REMOTE': '1', 16:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:10 INFO - 'NO_EM_RESTART': '1', 16:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:10 INFO - 'PWD': '/builds/slave/test', 16:53:10 INFO - 'SHELL': '/bin/bash', 16:53:10 INFO - 'SHLVL': '1', 16:53:10 INFO - 'TERM': 'linux', 16:53:10 INFO - 'TMOUT': '86400', 16:53:10 INFO - 'USER': 'cltbld', 16:53:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:10 INFO - '_': '/tools/buildbot/bin/python'} 16:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 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:53:10 INFO - Cleaning up... 16:53:10 INFO - Return code: 0 16:53:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:53:10 INFO - Using env: {'DISPLAY': ':0', 16:53:10 INFO - 'HOME': '/home/cltbld', 16:53:10 INFO - 'LANG': 'en_US.UTF-8', 16:53:10 INFO - 'LANGUAGE': 'en_US:en', 16:53:10 INFO - 'LOGNAME': 'cltbld', 16:53:10 INFO - 'MAIL': '/var/mail/cltbld', 16:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:10 INFO - 'MOZ_NO_REMOTE': '1', 16:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:10 INFO - 'NO_EM_RESTART': '1', 16:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:10 INFO - 'PWD': '/builds/slave/test', 16:53:10 INFO - 'SHELL': '/bin/bash', 16:53:10 INFO - 'SHLVL': '1', 16:53:10 INFO - 'TERM': 'linux', 16:53:10 INFO - 'TMOUT': '86400', 16:53:10 INFO - 'USER': 'cltbld', 16:53:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:10 INFO - '_': '/tools/buildbot/bin/python'} 16:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:11 INFO - Downloading/unpacking jsonschema 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:13 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:13 INFO - warning: no files found matching '*.txt' 16:53:13 INFO - no previously-included directories found matching 'build' 16:53:13 INFO - no previously-included directories found matching 'dist' 16:53:13 INFO - no previously-included directories found matching '.git*' 16:53:13 INFO - Installing collected packages: jsonschema, functools32 16:53:13 INFO - Running setup.py install for functools32 16:53:13 INFO - warning: no files found matching '*.txt' 16:53:13 INFO - no previously-included directories found matching 'build' 16:53:13 INFO - no previously-included directories found matching 'dist' 16:53:13 INFO - no previously-included directories found matching '.git*' 16:53:13 INFO - Successfully installed jsonschema functools32 16:53:13 INFO - Cleaning up... 16:53:13 INFO - Return code: 0 16:53:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f096983cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, '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': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', '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:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:53:13 INFO - Using env: {'DISPLAY': ':0', 16:53:13 INFO - 'HOME': '/home/cltbld', 16:53:13 INFO - 'LANG': 'en_US.UTF-8', 16:53:13 INFO - 'LANGUAGE': 'en_US:en', 16:53:13 INFO - 'LOGNAME': 'cltbld', 16:53:13 INFO - 'MAIL': '/var/mail/cltbld', 16:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:13 INFO - 'MOZ_NO_REMOTE': '1', 16:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:13 INFO - 'NO_EM_RESTART': '1', 16:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:13 INFO - 'PWD': '/builds/slave/test', 16:53:13 INFO - 'SHELL': '/bin/bash', 16:53:13 INFO - 'SHLVL': '1', 16:53:13 INFO - 'TERM': 'linux', 16:53:13 INFO - 'TMOUT': '86400', 16:53:13 INFO - 'USER': 'cltbld', 16:53:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:13 INFO - '_': '/tools/buildbot/bin/python'} 16:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:13 INFO - Downloading/unpacking flake8 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:16 INFO - no previously-included directories found matching 'docs/_build' 16:53:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:16 INFO - Running setup.py install for pep8 16:53:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:16 INFO - no previously-included directories found matching 'docs/_build' 16:53:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:16 INFO - Cleaning up... 16:53:16 INFO - Return code: 0 16:53:16 INFO - Running post-action listener: _resource_record_post_action 16:53:16 INFO - Running post-action listener: _start_resource_monitoring 16:53:16 INFO - Starting resource monitoring. 16:53:16 INFO - ##### 16:53:16 INFO - ##### Running install step. 16:53:16 INFO - ##### 16:53:16 INFO - Running pre-action listener: _resource_record_pre_action 16:53:16 INFO - Running main action method: install 16:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:16 INFO - Reading from file tmpfile_stdout 16:53:16 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:16 INFO - Reading from file tmpfile_stdout 16:53:16 INFO - Output received: 16:53:16 INFO - Usage: mozinstall [options] installer 16:53:16 INFO - Options: 16:53:16 INFO - -h, --help show this help message and exit 16:53:16 INFO - -d DEST, --destination=DEST 16:53:16 INFO - Directory to install application into. [default: 16:53:16 INFO - "/builds/slave/test"] 16:53:16 INFO - --app=APP Application being installed. [default: firefox] 16:53:16 INFO - mkdir: /builds/slave/test/build/application 16:53:16 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:53:16 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:53:29 INFO - Reading from file tmpfile_stdout 16:53:29 INFO - Output received: 16:53:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:29 INFO - Running post-action listener: _resource_record_post_action 16:53:29 INFO - ##### 16:53:29 INFO - ##### Running run-tests step. 16:53:29 INFO - ##### 16:53:29 INFO - Running pre-action listener: _resource_record_pre_action 16:53:29 INFO - Running main action method: run_tests 16:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:29 INFO - Python 2.7.3 16:53:29 INFO - Return code: 0 16:53:29 INFO - grabbing minidump binary from tooltool 16:53:29 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:53:29 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 0x1c55160>, '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 0x1c56060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c564f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:29 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:53:29 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:53:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:29 INFO - Return code: 0 16:53:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:30 INFO - Return code: 0 16:53:30 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/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:53:30 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/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:53:30 INFO - Using env: {'DISPLAY': ':0', 16:53:30 INFO - 'HOME': '/home/cltbld', 16:53:30 INFO - 'LANG': 'en_US.UTF-8', 16:53:30 INFO - 'LANGUAGE': 'en_US:en', 16:53:30 INFO - 'LOGNAME': 'cltbld', 16:53:30 INFO - 'MAIL': '/var/mail/cltbld', 16:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:30 INFO - 'MOZ_NO_REMOTE': '1', 16:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:30 INFO - 'NO_EM_RESTART': '1', 16:53:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:30 INFO - 'PWD': '/builds/slave/test', 16:53:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:30 INFO - 'SHELL': '/bin/bash', 16:53:30 INFO - 'SHLVL': '1', 16:53:30 INFO - 'TERM': 'linux', 16:53:30 INFO - 'TMOUT': '86400', 16:53:30 INFO - 'USER': 'cltbld', 16:53:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464652348.893992-1683953030', 16:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:30 INFO - '_': '/tools/buildbot/bin/python'} 16:53:30 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/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:53:30 INFO - mozversion application_buildid: 20160526112438 16:53:30 INFO - mozversion application_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:53:30 INFO - mozversion application_display_name: Firefox 16:53:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:30 INFO - mozversion application_name: Firefox 16:53:30 INFO - mozversion application_remotingname: firefox 16:53:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:53:30 INFO - mozversion application_vendor: Mozilla 16:53:30 INFO - mozversion application_version: 47.0 16:53:30 INFO - mozversion platform_buildid: 20160526112438 16:53:30 INFO - mozversion platform_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:53:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:53:30 INFO - mozversion platform_version: 47.0 16:53:30 INFO - using testdate: 1464652410 16:53:30 INFO - actual date: 1464652410 16:53:30 INFO - starting webserver on 'localhost:52991' 16:53:30 INFO - SUITE-START | Running 2 tests 16:53:30 INFO - TEST-START | dromaeo_css 16:53:30 INFO - operating with platform_type : linux_ 16:53:30 INFO - Initialising browser for dromaeo_css test... 16:53:30 INFO - TEST-INFO | started process 13982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYVosC/profile http://localhost:52991/getInfo.html) 16:53:35 INFO - PROCESS | 13982 | __metrics Screen width/height:1600/1200 16:53:35 INFO - PROCESS | 13982 | colorDepth:24 16:53:35 INFO - PROCESS | 13982 | Browser inner width/height: 1024/697 16:53:35 INFO - PROCESS | 13982 | __metrics 16:53:36 INFO - PROCESS | 13982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:53:37 INFO - TEST-INFO | 13982: exit 0 16:53:37 INFO - Browser initialized. 16:53:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:37 INFO - TEST-INFO | started process 14075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYVosC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:48 INFO - PROCESS | 14075 | RSS: Main: 138821632 16:53:48 INFO - PROCESS | 14075 | 16:54:39 INFO - PROCESS | 14075 | 1464652479915 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:56:47 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52991/tests/dromaeo/cssquery-ext.html) 16:56:48 INFO - PROCESS | 14075 | RSS: Main: 272007168 16:56:48 INFO - PROCESS | 14075 | 16:59:50 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-ext.html (next: http://localhost:52991/tests/dromaeo/cssquery-jquery.html) 16:59:51 INFO - PROCESS | 14075 | RSS: Main: 224288768 16:59:51 INFO - PROCESS | 14075 | 17:02:53 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52991/tests/dromaeo/cssquery-mootools.html) 17:02:53 INFO - PROCESS | 14075 | RSS: Main: 222187520 17:02:53 INFO - PROCESS | 14075 | 17:05:55 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52991/tests/dromaeo/cssquery-prototype.html) 17:05:56 INFO - PROCESS | 14075 | RSS: Main: 207126528 17:05:56 INFO - PROCESS | 14075 | 17:08:58 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52991/tests/dromaeo/cssquery-yui.html) 17:08:59 INFO - PROCESS | 14075 | RSS: Main: 210726912 17:08:59 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:52991/tests/dromaeo/cssquery-yui.html (next: http://localhost:52991/tests/dromaeo/cssquery-dojo.html) 17:12:01 INFO - PROCESS | 14075 | RSS: Main: 245485568 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | __start_tp_report 17:12:01 INFO - PROCESS | 14075 | _x_x_mozilla_page_load 17:12:01 INFO - PROCESS | 14075 | _x_x_mozilla_page_load_details 17:12:01 INFO - PROCESS | 14075 | |i|pagename|runs| 17:12:01 INFO - PROCESS | 14075 | |0;dojo.html;3238.1904523869034;3295.209149804047;3301.6863397977186;3328.5839270091237;3332.2002719347365;5320.521153096221;5325.440828712987;5343.412224655285;5343.438938911417;5352.330958630167;5347.946520534793;5351.946480535204;5363.8122665706705;5366.677999320043;5371.140617501201;4745.477997420281;4892.975535122328;4908.361912951312;4976.2286845539;4976.925346119811;4823;4904.215325547913;4907.411110666725;4908.092002979442;4908.263760435945;4903.31353610493;4957.925631115536;5005.1491246488185;5011.799528018893;5018.372703412074;4941.579965702902;4949.455559888409;4969.304297398367;4975.850724478271;5004.924926126093;4496.589094779634;4804.303376010494;4857.781399837016;4863.19757240055;4906.386701662293;5162.3030890830005;5170.482951704837;5177.767000484987;5185.0148471790235;5210.478952104797;5498.037843377433;5648.181013753024;5708.571857110692;5709.77160913563;5711.914321285184;5587.916181257285;5603.047481928082;5612.242347283105;5613.410591887834;5628.352739434936;5275.525202731734;5278.577713782926;5417.187421886709;5484.862878427992;5490.835274941798;5879.941200588025;5885.117232415087;5901.291844978544;5917.31950825652;5922.289325280994;5636.520895723827;5671.517920976763;5687.260656114761;5692.772289108472;5696.202531645573;5551.417101204315;5641.858953526113;5703.54371650267;5716.028275193227;5764.337101233328;5663.773449062074;5683.943160568424;5702.800401985911;5705.800296989585;5712.942870571241;5648;5699.772009119672;5708.57185711065;5712.771489140471;5721.4278572143285;4281.293586558183;4353.412289340962;4406.184855801623;4411.691181617256;4420.84527041552;3970.305196590643;3987.840486380512;3993.0217096811466;4024.879253622396;4028.576999415019;5332.040232758063;5418.620696551282;5429.267048948421;5435.320584926884;5436.972815135978;5777.711114444345;5797.826065217966;5801.7099145042575;5811.854703632358;5837.036888913367;5380.78476860929;5442;5442.428545002717;5447.836564903059;5451.454854514517;4807.567318941312;4909.165441874889;4974.676646017997;5003.7998480061115;5044.621653376012;5970.492508136857;5974.2233509643465;5975.701214939236;5979.970100149471;5991.700414979234;5768.567357448208;5773.451522105393;5805.79679711225;5819.854503637443;5823;5664.178694089416;5836.678982655994;5859.824205273849;5877.794277200277;5972.343042265435;5665.065264231355;5675.716214189357;5675.829725108253;5677.659340439587;5712.285964254468;5780.971095144498;5788.623739456922;5794.913076303775;5801.042827933344;5801.9709901451915;5439.3200849893765;5534.584906131976;5580.609357344947;5595.972020140036;5618.101103823368;5616.494515493625;5627.803026894039;5643.830685079454;5662.178984047207;5666.2350582670815;5335.786568537215;5505.064139096443;5553.72231388437;5556.611037227355;5564.38791732901;5436.592255580927;5468.945310546844;5614.522765564972;5660.773569057192;5666.121751128581;5360.946390536044;5394.163904594794;5400.216968539461;5403.8108666196495;5498 17:12:01 INFO - PROCESS | 14075 | |1;ext.html;539.5521716974911;561.2591379379219;568.9957225496997;580.3268208877703;581.0644861772546;32306.515402268957;40736.79631601845;40753.7962310188;40814.59185408145;40827.57103501378;43373.13253734924;43630.12739745203;43720.78139609298;43897.12205755883;44015;9284.675036373728;9551.522423878778;9565.043495650414;9565.234781217487;9576.47329396883;9285.025072367405;9414.905850941472;9430.717078487656;9434.339596228267;9445.622175113022;9436.669716559922;9530;9533.952330238339;9537.904620953772;9560.760980975461;9341;9406.341556091076;9421.670241541582;9422.90577094234;9427.15155635996;9337.859932101024;9459.952700236523;9460.43237405751;9465.337426380156;9467;42800.57199428028;43269.56730432718;43282.78358608187;43325.350119748226;43370.56629433697;1804.9729254061199;3872.283627528888;3967.8809635710977;4290.613844753956;4452.0873220989615;33456.33087338264;33552.496712549335;33764.49353259703;33849.830750846086;33869.49195762065;4319.892002699926;4377.34339849022;4411.161879242965;4472.44094488189;4495.977520112411;276021;276755.99999999796;277909;278514;278690;47144.764276179085;65332;66209.33790662128;66217;66302;45223.773881130386;45395.31907021398;45481.31778023332;45495;45524.317135243;17103.74344384835;17550;17572.91213543924;17590.384336548414;17601;13314.334283285796;13501.459941602227;13507;13507.864921350661;13515.729685406433;15308.311125999357;15341.923290383476;15902.681946361008;15908.363665453484;15942.920285398499;5859.53123750099;5898.94101058984;5918.408159184133;5992.370801065826;6197.816473880113;1093.4696672114019;1135.8069128248217;1171.1567671276666;1182.9822552661717;1204.5422739358987;30603.387932241232;30833.691663083082;30880;31267.374652506824;31338.843305783783;1075.080805910935;1148.3798748675788;1164.4934453512749;1235.7528494301175;1241.5902752091788;14577.41690332396;14629.634259143393;14643.414263429344;14854.480093196686;15005.549833505012;317551;321120;322227;322740;322750;59393;60568.39431605716;60594.394056059755;60644.69677651583;60852.391476085555;1371.2732251906505;1475.1486883960774;1483.8887083468783;1489.664825414273;1507.4422463688506;28585.42829143447;28672.85663571669;28736.856315718287;29466.85266573739;29924.251893702833;48192.5180748188;48659.270110947655;49108.50891491182;49187.262191066446;49210.26184607162;215829;216280;216603;217197.484075478;217286;30795.538066928566;35162;35182;35202.29595408026;35222.8238858804;53252.201216982554;53395;53410.1988470181;53786.731066344415;54456;37019;37716.43425348677;37791;38186.42720359141;38706.22587548177;36374.636253638186;42902.35646465243;43007.78496107625;43559.78220108879;44574.10851783011;37117;37169.81415092907;37376.252474950896;37537;43220.35169472398;32767.836160819043;34046.82976585101;36834.26331473409;37161.256774864894;37415.6258437423;27760;28002.439951201268;28133.296667582654;28714.712852871206;29583.260418488848 17:12:01 INFO - PROCESS | 14075 | |2;jquery.html;377.29257641921396;381.33457117330244;381.7327870490656;382.2507884546289;385.29491031412516;17436.302547898067;18305.633887322263;19200.51998700033;19665.60668786627;19692.803071969276;18047.4585762427;18067.728984065216;19080.141393637285;19082.90458547709;19085.809141908576;5680.31836179658;5846.50304724099;5849.122631605251;5893.55798315126;5902.055671092626;4354.869353919387;6108.205933228674;6427.967860160693;6446.387593178664;6462.192225971754;5543.362513310981;6369.07648390983;6386.329435409285;6392.264889537693;6408.3591640835775;5675.177099320596;5682.488576028136;5694.658320500763;5697.31632204134;5729.140628905656;3967.504061992251;5450.482204190595;5644.6330988486025;5651.095824668033;5653.519450846683;13638.181709097486;13995.440182392693;14056.718865622732;14070.43718251279;14193.78709319361;2316.5598536278053;2366.467544802406;2656.7608915197725;2770.34896799252;3103.239706271955;10058.245631577662;10159.59361625534;10628.468576571218;10650.094741946943;12695.49218031287;1898.5823118913818;1955.5502234486148;1974.6149500847198;2015.8811859418017;2070.3995841206033;62104.37895621076;67146.3285367145;67881;68193.31806681919;68824.6558767203;10502.73743156412;10742.24804263694;10968.945155274172;10976.341419514854;11019.338839669645;15432.15123168214;15480.458183963507;15509.302081406364;15537.145456999973;15547.30037148331;8387.077421483631;8424.410291279552;8559.572021398904;8639.308855291687;8651;8466.576671166416;8492.915070849336;8505.61724722389;8533.957330213309;8582.957085214533;4856.223004319292;4856.8300109495995;4861.6353773467135;4878.170710979142;4917.532834380728;1815.1650240889076;1845.9293609706338;1950.3758797185048;1952.8340091092132;2013.2349707111496;1018.6485662446444;1029.2897900448665;1074.7742973975396;1098.873629532598;1168.4391492083678;16344.346226150821;16818.747718784227;17184.484465466056;17361.30554777795;18001.36995205188;884.8893888263967;1038.2161468091695;1063.2025980514613;1087.9347239165518;1090.7436752363187;9418.576164072632;9429.245660347156;9543.570539325747;9588.37675551087;9699.854502182472;466080;483475;485467;488884;506129;78660;81381.59309203416;81566.18433815586;81732;82752;1119.7704470583674;1127.4531852051748;1136.78969390663;1148.6324376199536;1151.8329842172839;14882.553523394316;14882.627934301729;15021.924890375916;15280.847191528386;15323.77014344808;33536.16159596029;33706.325873482885;33850.153746156546;34153.65846341505;34267.82866085654;50673.493265068355;51018.74490627672;51083.74458127686;51230.23154652608;52636;8278.71024514139;8397.076321604742;8430.283425908867;8558.743237702629;8584.313254939714;9583;10321.896781032394;12979.480820767063;13211.801822972855;13767.242801645605;11274.605388811353;11484.82772758426;11704.297742135499;11764.235324703866;11830.408479575815;11047.337159770439;11176.16178786578;11401.714957126138;11433.371164585695;12037.699057523632;11373.20387572862;11445.771084578428;11710.473028713557;11747.765044698886;11922.940385298018;8349.457285276438;8450.535220562928;8534.445261058012;8588.969323681198;8775.210231078978;8999.685011024583;10816.4050977197;11248.381339026431;11303.547858085913;11335.603253886075 17:12:01 INFO - PROCESS | 14075 | |3;mootools.html;1216.8296438498605;1577.9132147731873;1590.3082159260723;1822.4897028831924;1933.2750218668;7230.493865429416;7309.89035164473;7352.742654007111;7364.447666425012;7364.77905662831;7620.618969051539;7729.729459468906;7750.14748377678;7753.612319384037;7753.767386978386;2326.941826454335;2347.0025239273327;2348.3307257431634;2348.6711860339565;2349.9177528786495;2350.8824558771994;2377.5720370333333;2392.7487613800563;2398.796102331295;2399.9760002399926;2318.5015221727326;2336.8013718833918;2343.16817529777;2354.81161507079;2354.858708477488;2291.702078729771;2315.548468048731;2325.3024092772184;2326.7556906524824;2338.8947497362487;2344.5779759643256;2364.7517010713973;2365.4441206316674;2365.5978483657645;2368.39605900496;7855.253750893713;7860.6069696515515;7897.8025549361155;7898.881516777195;7901.723439679641;4710.74090924999;4877.829275975359;4914.090893184736;4916.06594746997;4924.335214745999;3117.0804612639326;3156.7474602031784;3213.983930080358;3219.2273854274804;3223.06531105979;1025.2003437318904;1026.9589216431334;1032.091759251861;1046.6493724602267;1070.882202957674;10702.197335199813;10707.411092389915;10709.892901070967;10713.839292410543;10721.410322432263;4224.598663126998;4339.7613131278085;4364.738115713068;4390.736555806662;4394.626456751148;9212.078792120734;9260.675876344296;9266.21237194846;9283.11810378013;9285.535723213812;4974.427940786856;4981.651284410056;5021.6735912165595;5023.171176755867;5024.648274620741;3936.2521120987494;4379.715318504351;4431.889202769957;4434.689571729948;4577.679562430664;3653.9634603654154;3717;3717.4423836424753;3752.137008488063;3777.0934975606206;1160.3212120909363;1163.4124766992616;1166.854143232096;1167.7781221568046;1168.7428765671539;1462.4588902106077;1476.8892333074848;1486.2642991719167;1493.4548889655198;1499.1230130373635;7561.243875612395;7587.355074818592;7620.733274335372;7623.580703061385;7639.732609358646;544.5453046705966;556.0408295689983;562.0809975689776;574.8160588611688;582.251806428737;5884.558658100659;5917.408259174048;5952;5957.702114894325;6013.128096425994;9373.343865929319;9641.42151470914;9654.372465789702;9664.516774161264;9673;9283.814323713488;9335.346525743133;9380.5309734513;9446.716598502057;9530.761730956781;7255.709771609182;7360.889586656204;7371.520851144658;7371.889421658572;7390.113186417664;7088.610126442889;7171.8565628688175;7254.347108760237;7309.195988441374;7320.26797320285;8395.874061888955;8626.223639872442;8669.913300867163;8754.387192896436;8767.473951562926;8716;8731.91268087311;8869.423487473294;8902.065283145177;8911.465312081036;6109.419605137505;6666.766663166766;6826.931730682828;7063.71745130189;7126.180489243596;7202.171750248788;7211.062561866924;7220.530665506725;7263.6005019724425;7283.708651653875;6491.221053473613;6658.600483970978;6691.59850408977;6738.932610673831;6766.93233067663;6465.353464653497;6701.698423570853;6747.628880411428;6823.829404264933;6832.829179270558;7148.213696493278;7161.39128174111;7172.175199852084;7186.353228209487;7197.856042879218;6499.902501462577;6547;6560.376764207393;6581.506387020897;6598.670066496752;6602.240742314503;6675.899861501985;6679.9332006679315;6680.298568650222;6686 17:12:01 INFO - PROCESS | 14075 | |4;prototype.html;336.2585498974761;338.7747148146483;348.2894894415393;350.9227969846633;351.96304388039255;5944.732487038083;5987.640741555504;6001.4298641628975;6019.819405417834;6064.605800622968;5937.050071988483;5939.732712027958;5940.524758019359;5951.077582974646;5959.225300710912;4416.24923762961;4530.524294949032;4624.283236098393;4624.537546245382;4666.929996050062;4619.74591397473;4645.070985802836;4656.185167595674;4659;4659.394278743758;4609.262517997121;4616.746078965655;4617.607503362218;4624.768761561909;4630.606398456119;4397.978010109945;4482.417285752864;4568.360429539867;4612.5156858530045;4621.792019359137;4100.0569868930315;4100.2414553307435;4103.097318589906;4106.568810274908;4110.219058378899;5667.234923285386;5669.574781891375;5673.120666296731;5676.914846277268;5678.205051292823;5387.218853266294;5395.946040539584;5397.487238712316;5402.756875940592;5403.2705584745945;6282.654454005028;6286.371362863677;6289.811305660837;6295.118683384329;6296.622202667809;4286.699931004831;4435.0908063847155;4458.398116254297;4467.910641787179;4557.79489922951;6528.445082168021;6584.308647591982;6588.8023359299295;6593.80218593443;6594.769183078617;4543.977280113579;4552.11233809404;4553.066621342617;4560.771961401917;4564.338170965191;4608.493065762764;4613.792379342937;4615.630749540029;4617.676762626651;4621.653375996813;5308.761105750174;5313.070212712837;5318.547923426475;5319.547838433777;5324.627276090637;6261.8454975975055;6299.055141728686;6368.713407896656;6379.840503987344;6407.551471397051;1598.8720902327786;1611.9838801611834;1616.4827255278199;1622.3105180298562;1628.5114465660492;1012.6405126180247;1050.8108540462638;1060.984085238722;1083.712816103733;1086.7120213143523;6000.969995150083;6085.695715214221;6088.269407671108;6089.391060893964;6092.51259899207;6503.219613646298;6503.479721622259;6514.413702766774;6521.706523206467;6527.314631963671;6063.605865618721;6072.817815465543;6076.8784624308155;6082.513398928075;6088.330283668793;3459.100633835171;3502.842372093262;3503.5270238517473;3507.3511400391008;3513.0163554204864;6612;6754.932450675528;6846.281140480278;6861.897071543931;6866.588004719633;6769.086173366631;6771.187457505131;6775.864482710318;6789.524733268722;6798.354156355138;6801.319868013159;6807.829804254933;6816.352446517573;6823.863522729517;6848.7260509579055;6623;6626.337366263335;6630.9668451657435;6632.038354438676;6633.270340262471;6277.843053923689;6520.087187793808;6521.119648847345;6531.183602049744;6532.967335163294;6770.763023294161;6801.421879140328;6813.761518346834;6829.52193346461;6837.1111755471475;4541.09178164375;4571.748553829571;4580.633549316113;4600.723956562483;4620.792064357045;6565.080888675685;6568.1789776277965;6581.506387021088;6587.0448784926875;6605.2734199239;6203.31763506023;6408.359164083555;6412.839679008062;6418.29398766126;6426.196725409324;6241.063840423973;6298.716557755004;6302.527310451826;6311.116443697978;6326.398992095744;6226.470749986302;6229.688515574294;6230.626162430269;6233.2208473940755;6236.781712640036;6341.0805433212845;6349.904751428639;6350.174477317919;6476.676166191766;6478.1578394808375;5991.580589358878;6147.661878596541;6181.629102253699;6314.336994615499;6314.463270622048 17:12:01 INFO - PROCESS | 14075 | |5;yui.html;733.7101844771317;773.2653978720216;810.4893916832394;819.9631016604252;923.09536654079;14922.477713280037;15118.395264189447;15167.469138580153;15226;15234.314455849486;14310.785338219936;14368.640783980405;14380;14403.063800852937;14407.711845763079;779.4349096904756;932.0632764072099;950.5437390052779;953.904609539044;955.106974978394;938.8122375524888;941.6845356805444;945.2910317262053;946.0870260198907;946.9147776700096;835.064727505192;990.4997976022099;994.2791476179784;999.1507218863944;1000.1148983149928;829.8879651247095;832.0223737108903;965.9227261819037;981.0238812381726;981.7692842182081;729.8905164225356;731.5171986488945;732.6886073418829;733.08730630365;733.3912852332551;14448.49430269946;14682.926585367004;14739.336729847182;14810.259487025713;14857.628559285997;14206.147631142165;14660.926695366456;14748.262586870613;14797.630059248497;14884.255787210705;11963;12010.579629713005;12035.217710848854;12116.757664846653;12284.692882677915;3948.9802550987347;3950.1309711863346;3962.5244970603712;3992.7205095643317;3998.640122388999;50559.74720126376;50697.74651126758;50870;51584.74207628938;53211;10925.344479331106;10930.508127134299;11155.498002589902;11242.100631949424;11316.547338106548;18241;18345.54136146607;18413.171407286703;18456.446306610822;18469.353572624892;8217.178282171855;8272.875906861402;8280.544570048705;8286.41995060352;8724.43291186071;4465.218586747306;4641.303804429363;4710.8351207707565;4776.116418462596;4860.781264843091;3298.241404476984;3329.8668053277597;3338.6494418086236;3346.7657263991287;3347.8326083696206;573.5652156595197;597.0328068529011;598.6707310978944;599.4694695194784;600.1447936690199;739.5303981971487;756.9129550101809;759.8572026884134;794.9721759738497;805.1787177079347;8933.821323573493;9272.907270927204;9409.247260219166;9455.243580513543;9571.61713531465;747.1407880936966;748.3360673205117;762.1273641680245;769.5882702754112;776.3472860192779;4336.609705126491;4385.254506733863;4436.378906953029;4442.666799990014;4531.501534831166;60024.69987650034;60730;60845.69577152174;60860.69569652212;60922;54450.455495445334;54660.18009729857;54993.72503137459;55911;55931.720341398846;48491.51508484941;48577;49052.50947490479;49190.75404622954;49548;8670.13298670128;8702.869456958024;8769.517676527852;8841.60212790413;8913.955430222808;38276;38913.2217355657;39037.02407439837;39386.21227575375;40352;44113.338299924886;44314;44670.553294467936;45928.77035614801;46010.76994615005;12369.162741133752;12475.563355282522;12623.548291946543;12715.10994230395;12716.427760750603;12884.742305153657;13562.660933476742;13827.654308642364;14289.35697893618;14300.785488217476;10838.891611083789;11890.28658280506;12615.621531354074;12733.108682392143;13517;12279.324637144686;12282.508699652271;12305.876941230474;12315;12318.322492263012;10786.244962852525;11172.441377931233;11384.203105782515;11536.192466527598;11666.824997624874;10287.125594324567;10733.785324293314;10879.891201087888;10970.177236707439;11139.610113645984;10258.230632702727;10571.629992950517;10820.458977051274;10822.945885270523;10854.67435976922 17:12:01 INFO - PROCESS | 14075 | __end_tp_report 17:12:01 INFO - PROCESS | 14075 | __start_cc_report 17:12:01 INFO - PROCESS | 14075 | _x_x_mozilla_cycle_collect,1068 17:12:01 INFO - PROCESS | 14075 | __end_cc_report 17:12:01 INFO - PROCESS | 14075 | __startTimestamp1464653521667__endTimestamp 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | ------- Summary: start ------- 17:12:01 INFO - PROCESS | 14075 | Number of tests: 6 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#0] dojo.html Cycles:165 Average:5325.66 Median:5490.84 stddev:572.51 (10.4%) stddev-sans-first:550.35 17:12:01 INFO - PROCESS | 14075 | Values: 3238.2 3295.2 3301.7 3328.6 3332.2 5320.5 5325.4 5343.4 5343.4 5352.3 5347.9 5351.9 5363.8 5366.7 5371.1 4745.5 4893.0 4908.4 4976.2 4976.9 4823.0 4904.2 4907.4 4908.1 4908.3 4903.3 4957.9 5005.1 5011.8 5018.4 4941.6 4949.5 4969.3 4975.9 5004.9 4496.6 4804.3 4857.8 4863.2 4906.4 5162.3 5170.5 5177.8 5185.0 5210.5 5498.0 5648.2 5708.6 5709.8 5711.9 5587.9 5603.0 5612.2 5613.4 5628.4 5275.5 5278.6 5417.2 5484.9 5490.8 5879.9 5885.1 5901.3 5917.3 5922.3 5636.5 5671.5 5687.3 5692.8 5696.2 5551.4 5641.9 5703.5 5716.0 5764.3 5663.8 5683.9 5702.8 5705.8 5712.9 5648.0 5699.8 5708.6 5712.8 5721.4 4281.3 4353.4 4406.2 4411.7 4420.8 3970.3 3987.8 3993.0 4024.9 4028.6 5332.0 5418.6 5429.3 5435.3 5437.0 5777.7 5797.8 5801.7 5811.9 5837.0 5380.8 5442.0 5442.4 5447.8 5451.5 4807.6 4909.2 4974.7 5003.8 5044.6 5970.5 5974.2 5975.7 5980.0 5991.7 5768.6 5773.5 5805.8 5819.9 5823.0 5664.2 5836.7 5859.8 5877.8 5972.3 5665.1 5675.7 5675.8 5677.7 5712.3 5781.0 5788.6 5794.9 5801.0 5802.0 5439.3 5534.6 5580.6 5596.0 5618.1 5616.5 5627.8 5643.8 5662.2 5666.2 5335.8 5505.1 5553.7 5556.6 5564.4 5436.6 5468.9 5614.5 5660.8 5666.1 5360.9 5394.2 5400.2 5403.8 5498.0 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#1] ext.html Cycles:180 Average:45828.13 Median:38446.33 stddev:71732.13 (186.6%) stddev-sans-first:71852.75 17:12:01 INFO - PROCESS | 14075 | Values: 539.6 561.3 569.0 580.3 581.1 32306.5 40736.8 40753.8 40814.6 40827.6 43373.1 43630.1 43720.8 43897.1 44015.0 9284.7 9551.5 9565.0 9565.2 9576.5 9285.0 9414.9 9430.7 9434.3 9445.6 9436.7 9530.0 9534.0 9537.9 9560.8 9341.0 9406.3 9421.7 9422.9 9427.2 9337.9 9460.0 9460.4 9465.3 9467.0 42800.6 43269.6 43282.8 43325.4 43370.6 1805.0 3872.3 3967.9 4290.6 4452.1 33456.3 33552.5 33764.5 33849.8 33869.5 4319.9 4377.3 4411.2 4472.4 4496.0 276021.0 276756.0 277909.0 278514.0 278690.0 47144.8 65332.0 66209.3 66217.0 66302.0 45223.8 45395.3 45481.3 45495.0 45524.3 17103.7 17550.0 17572.9 17590.4 17601.0 13314.3 13501.5 13507.0 13507.9 13515.7 15308.3 15341.9 15902.7 15908.4 15942.9 5859.5 5898.9 5918.4 5992.4 6197.8 1093.5 1135.8 1171.2 1183.0 1204.5 30603.4 30833.7 30880.0 31267.4 31338.8 1075.1 1148.4 1164.5 1235.8 1241.6 14577.4 14629.6 14643.4 14854.5 15005.5 317551.0 321120.0 322227.0 322740.0 322750.0 59393.0 60568.4 60594.4 60644.7 60852.4 1371.3 1475.1 1483.9 1489.7 1507.4 28585.4 28672.9 28736.9 29466.9 29924.3 48192.5 48659.3 49108.5 49187.3 49210.3 215829.0 216280.0 216603.0 217197.5 217286.0 30795.5 35162.0 35182.0 35202.3 35222.8 53252.2 53395.0 53410.2 53786.7 54456.0 37019.0 37716.4 37791.0 38186.4 38706.2 36374.6 42902.4 43007.8 43559.8 44574.1 37117.0 37169.8 37376.3 37537.0 43220.4 32767.8 34046.8 36834.3 37161.3 37415.6 27760.0 28002.4 28133.3 28714.7 29583.3 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#2] jquery.html Cycles:180 Average:27366.64 Median:2936.79 stddev:79701.66 (2713.9%) stddev-sans-first:79899.48 17:12:01 INFO - PROCESS | 14075 | Values: 377.3 381.3 381.7 382.3 385.3 17436.3 18305.6 19200.5 19665.6 19692.8 18047.5 18067.7 19080.1 19082.9 19085.8 5680.3 5846.5 5849.1 5893.6 5902.1 4354.9 6108.2 6428.0 6446.4 6462.2 5543.4 6369.1 6386.3 6392.3 6408.4 5675.2 5682.5 5694.7 5697.3 5729.1 3967.5 5450.5 5644.6 5651.1 5653.5 13638.2 13995.4 14056.7 14070.4 14193.8 2316.6 2366.5 2656.8 2770.3 3103.2 10058.2 10159.6 10628.5 10650.1 12695.5 1898.6 1955.6 1974.6 2015.9 2070.4 62104.4 67146.3 67881.0 68193.3 68824.7 10502.7 10742.2 10968.9 10976.3 11019.3 15432.2 15480.5 15509.3 15537.1 15547.3 8387.1 8424.4 8559.6 8639.3 8651.0 8466.6 8492.9 8505.6 8534.0 8583.0 4856.2 4856.8 4861.6 4878.2 4917.5 1815.2 1845.9 1950.4 1952.8 2013.2 1018.6 1029.3 1074.8 1098.9 1168.4 16344.3 16818.7 17184.5 17361.3 18001.4 884.9 1038.2 1063.2 1087.9 1090.7 9418.6 9429.2 9543.6 9588.4 9699.9 466080.0 483475.0 485467.0 488884.0 506129.0 78660.0 81381.6 81566.2 81732.0 82752.0 1119.8 1127.5 1136.8 1148.6 1151.8 14882.6 14882.6 15021.9 15280.8 15323.8 33536.2 33706.3 33850.2 34153.7 34267.8 50673.5 51018.7 51083.7 51230.2 52636.0 8278.7 8397.1 8430.3 8558.7 8584.3 9583.0 10321.9 12979.5 13211.8 13767.2 11274.6 11484.8 11704.3 11764.2 11830.4 11047.3 11176.2 11401.7 11433.4 12037.7 11373.2 11445.8 11710.5 11747.8 11922.9 8349.5 8450.5 8534.4 8589.0 8775.2 8999.7 10816.4 11248.4 11303.5 11335.6 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#3] mootools.html Cycles:180 Average:5510.62 Median:6287.39 stddev:2835.69 (45.1%) stddev-sans-first:2825.27 17:12:01 INFO - PROCESS | 14075 | Values: 1216.8 1577.9 1590.3 1822.5 1933.3 7230.5 7309.9 7352.7 7364.4 7364.8 7620.6 7729.7 7750.1 7753.6 7753.8 2326.9 2347.0 2348.3 2348.7 2349.9 2350.9 2377.6 2392.7 2398.8 2400.0 2318.5 2336.8 2343.2 2354.8 2354.9 2291.7 2315.5 2325.3 2326.8 2338.9 2344.6 2364.8 2365.4 2365.6 2368.4 7855.3 7860.6 7897.8 7898.9 7901.7 4710.7 4877.8 4914.1 4916.1 4924.3 3117.1 3156.7 3214.0 3219.2 3223.1 1025.2 1027.0 1032.1 1046.6 1070.9 10702.2 10707.4 10709.9 10713.8 10721.4 4224.6 4339.8 4364.7 4390.7 4394.6 9212.1 9260.7 9266.2 9283.1 9285.5 4974.4 4981.7 5021.7 5023.2 5024.6 3936.3 4379.7 4431.9 4434.7 4577.7 3654.0 3717.0 3717.4 3752.1 3777.1 1160.3 1163.4 1166.9 1167.8 1168.7 1462.5 1476.9 1486.3 1493.5 1499.1 7561.2 7587.4 7620.7 7623.6 7639.7 544.5 556.0 562.1 574.8 582.3 5884.6 5917.4 5952.0 5957.7 6013.1 9373.3 9641.4 9654.4 9664.5 9673.0 9283.8 9335.3 9380.5 9446.7 9530.8 7255.7 7360.9 7371.5 7371.9 7390.1 7088.6 7171.9 7254.3 7309.2 7320.3 8395.9 8626.2 8669.9 8754.4 8767.5 8716.0 8731.9 8869.4 8902.1 8911.5 6109.4 6666.8 6826.9 7063.7 7126.2 7202.2 7211.1 7220.5 7263.6 7283.7 6491.2 6658.6 6691.6 6738.9 6766.9 6465.4 6701.7 6747.6 6823.8 6832.8 7148.2 7161.4 7172.2 7186.4 7197.9 6499.9 6547.0 6560.4 6581.5 6598.7 6602.2 6675.9 6679.9 6680.3 6686.0 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#4] prototype.html Cycles:180 Average:5327.20 Median:6041.71 stddev:1597.48 (26.4%) stddev-sans-first:1557.42 17:12:01 INFO - PROCESS | 14075 | Values: 336.3 338.8 348.3 350.9 352.0 5944.7 5987.6 6001.4 6019.8 6064.6 5937.1 5939.7 5940.5 5951.1 5959.2 4416.2 4530.5 4624.3 4624.5 4666.9 4619.7 4645.1 4656.2 4659.0 4659.4 4609.3 4616.7 4617.6 4624.8 4630.6 4398.0 4482.4 4568.4 4612.5 4621.8 4100.1 4100.2 4103.1 4106.6 4110.2 5667.2 5669.6 5673.1 5676.9 5678.2 5387.2 5395.9 5397.5 5402.8 5403.3 6282.7 6286.4 6289.8 6295.1 6296.6 4286.7 4435.1 4458.4 4467.9 4557.8 6528.4 6584.3 6588.8 6593.8 6594.8 4544.0 4552.1 4553.1 4560.8 4564.3 4608.5 4613.8 4615.6 4617.7 4621.7 5308.8 5313.1 5318.5 5319.5 5324.6 6261.8 6299.1 6368.7 6379.8 6407.6 1598.9 1612.0 1616.5 1622.3 1628.5 1012.6 1050.8 1061.0 1083.7 1086.7 6001.0 6085.7 6088.3 6089.4 6092.5 6503.2 6503.5 6514.4 6521.7 6527.3 6063.6 6072.8 6076.9 6082.5 6088.3 3459.1 3502.8 3503.5 3507.4 3513.0 6612.0 6754.9 6846.3 6861.9 6866.6 6769.1 6771.2 6775.9 6789.5 6798.4 6801.3 6807.8 6816.4 6823.9 6848.7 6623.0 6626.3 6631.0 6632.0 6633.3 6277.8 6520.1 6521.1 6531.2 6533.0 6770.8 6801.4 6813.8 6829.5 6837.1 4541.1 4571.7 4580.6 4600.7 4620.8 6565.1 6568.2 6581.5 6587.0 6605.3 6203.3 6408.4 6412.8 6418.3 6426.2 6241.1 6298.7 6302.5 6311.1 6326.4 6226.5 6229.7 6230.6 6233.2 6236.8 6341.1 6349.9 6350.2 6476.7 6478.2 5991.6 6147.7 6181.6 6314.3 6314.5 17:12:01 INFO - PROCESS | 14075 | 17:12:01 INFO - PROCESS | 14075 | [#5] yui.html Cycles:180 Average:14858.97 Median:4439.52 stddev:16859.74 (379.8%) stddev-sans-first:16873.66 17:12:01 INFO - PROCESS | 14075 | Values: 733.7 773.3 810.5 820.0 923.1 14922.5 15118.4 15167.5 15226.0 15234.3 14310.8 14368.6 14380.0 14403.1 14407.7 779.4 932.1 950.5 953.9 955.1 938.8 941.7 945.3 946.1 946.9 835.1 990.5 994.3 999.2 1000.1 829.9 832.0 965.9 981.0 981.8 729.9 731.5 732.7 733.1 733.4 14448.5 14682.9 14739.3 14810.3 14857.6 14206.1 14660.9 14748.3 14797.6 14884.3 11963.0 12010.6 12035.2 12116.8 12284.7 3949.0 3950.1 3962.5 3992.7 3998.6 50559.7 50697.7 50870.0 51584.7 53211.0 10925.3 10930.5 11155.5 11242.1 11316.5 18241.0 18345.5 18413.2 18456.4 18469.4 8217.2 8272.9 8280.5 8286.4 8724.4 4465.2 4641.3 4710.8 4776.1 4860.8 3298.2 3329.9 3338.6 3346.8 3347.8 573.6 597.0 598.7 599.5 600.1 739.5 756.9 759.9 795.0 805.2 8933.8 9272.9 9409.2 9455.2 9571.6 747.1 748.3 762.1 769.6 776.3 4336.6 4385.3 4436.4 4442.7 4531.5 60024.7 60730.0 60845.7 60860.7 60922.0 54450.5 54660.2 54993.7 55911.0 55931.7 48491.5 48577.0 49052.5 49190.8 49548.0 8670.1 8702.9 8769.5 8841.6 8914.0 38276.0 38913.2 39037.0 39386.2 40352.0 44113.3 44314.0 44670.6 45928.8 46010.8 12369.2 12475.6 12623.5 12715.1 12716.4 12884.7 13562.7 13827.7 14289.4 14300.8 10838.9 11890.3 12615.6 12733.1 13517.0 12279.3 12282.5 12305.9 12315.0 12318.3 10786.2 11172.4 11384.2 11536.2 11666.8 10287.1 10733.8 10879.9 10970.2 11139.6 10258.2 10571.6 10820.5 10822.9 10854.7 17:12:01 INFO - PROCESS | 14075 | -------- Summary: end -------- 17:12:01 INFO - PROCESS | 14075 | 17:12:02 INFO - TEST-INFO | 14075: exit 0 17:12:02 INFO - TEST-OK | dromaeo_css | took 1111444ms 17:12:02 INFO - TEST-START | kraken 17:12:02 INFO - operating with platform_type : linux_ 17:12:02 INFO - Initialising browser for kraken test... 17:12:02 INFO - TEST-INFO | started process 14266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg26FwR/profile http://localhost:52991/getInfo.html) 17:12:06 INFO - PROCESS | 14266 | __metrics Screen width/height:1600/1200 17:12:06 INFO - PROCESS | 14266 | colorDepth:24 17:12:06 INFO - PROCESS | 14266 | Browser inner width/height: 1024/697 17:12:06 INFO - PROCESS | 14266 | __metrics 17:12:07 INFO - PROCESS | 14266 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:08 INFO - TEST-INFO | 14266: exit 0 17:12:08 INFO - Browser initialized. 17:12:08 INFO - Running cycle 1/1 for kraken test... 17:12:08 INFO - TEST-INFO | started process 14357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg26FwR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:20 INFO - PROCESS | 14357 | RSS: Main: 138813440 17:12:20 INFO - PROCESS | 14357 | 17:12:22 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52991/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:23 INFO - PROCESS | 14357 | RSS: Main: 182136832 17:12:23 INFO - PROCESS | 14357 | 17:12:25 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52991/tests/kraken/driver.html?testName=audio-dft) 17:12:26 INFO - PROCESS | 14357 | RSS: Main: 174366720 17:12:26 INFO - PROCESS | 14357 | 17:12:29 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52991/tests/kraken/driver.html?testName=audio-fft) 17:12:29 INFO - PROCESS | 14357 | RSS: Main: 174661632 17:12:29 INFO - PROCESS | 14357 | 17:12:31 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52991/tests/kraken/driver.html?testName=audio-oscillator) 17:12:32 INFO - PROCESS | 14357 | RSS: Main: 176566272 17:12:32 INFO - PROCESS | 14357 | 17:12:34 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:35 INFO - PROCESS | 14357 | RSS: Main: 174407680 17:12:35 INFO - PROCESS | 14357 | 17:12:38 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52991/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:38 INFO - PROCESS | 14357 | RSS: Main: 173891584 17:12:38 INFO - PROCESS | 14357 | 17:12:42 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52991/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:42 INFO - PROCESS | 14357 | RSS: Main: 174632960 17:12:42 INFO - PROCESS | 14357 | 17:12:45 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52991/tests/kraken/driver.html?testName=json-parse-financial) 17:12:45 INFO - PROCESS | 14357 | RSS: Main: 175431680 17:12:45 INFO - PROCESS | 14357 | 17:12:47 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:48 INFO - PROCESS | 14357 | RSS: Main: 184418304 17:12:48 INFO - PROCESS | 14357 | 17:12:49 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:50 INFO - PROCESS | 14357 | RSS: Main: 183123968 17:12:50 INFO - PROCESS | 14357 | 17:12:52 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:52 INFO - PROCESS | 14357 | RSS: Main: 185335808 17:12:52 INFO - PROCESS | 14357 | 17:12:55 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:55 INFO - PROCESS | 14357 | RSS: Main: 187457536 17:12:55 INFO - PROCESS | 14357 | 17:12:58 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:58 INFO - PROCESS | 14357 | RSS: Main: 184172544 17:12:58 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | Cycle 1(1): loaded http://localhost:52991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52991/tests/kraken/driver.html?testName=ai-astar) 17:13:00 INFO - PROCESS | 14357 | RSS: Main: 247279616 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | __start_tp_report 17:13:00 INFO - PROCESS | 14357 | _x_x_mozilla_page_load 17:13:00 INFO - PROCESS | 14357 | _x_x_mozilla_page_load_details 17:13:00 INFO - PROCESS | 14357 | |i|pagename|runs| 17:13:00 INFO - PROCESS | 14357 | |0;ai-astar;112;110;112;112;111;111;111;110;112;124 17:13:00 INFO - PROCESS | 14357 | |1;audio-beat-detection;148;128;150;169;125;157;150;127;169;131 17:13:00 INFO - PROCESS | 14357 | |2;audio-dft;161;162;160;160;160;161;160;160;159;160 17:13:00 INFO - PROCESS | 14357 | |3;audio-fft;77;76;75;170;76;75;75;78;164;74 17:13:00 INFO - PROCESS | 14357 | |4;audio-oscillator;93;94;148;94;93;93;134;92;92;136 17:13:00 INFO - PROCESS | 14357 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;116;116;117 17:13:00 INFO - PROCESS | 14357 | |6;imaging-darkroom;146;145;145;146;146;145;145;146;145;145 17:13:00 INFO - PROCESS | 14357 | |7;imaging-desaturate;96;95;96;96;95;95;96;96;96;96 17:13:00 INFO - PROCESS | 14357 | |8;json-parse-financial;56;60;59;55;56;56;55;56;70;53 17:13:00 INFO - PROCESS | 14357 | |9;json-stringify-tinderbox;64;64;63;64;64;64;63;65;67;63 17:13:00 INFO - PROCESS | 14357 | |10;stanford-crypto-aes;78;85;78;79;77;79;84;78;77;79 17:13:00 INFO - PROCESS | 14357 | |11;stanford-crypto-ccm;113;113;112;111;110;112;121;112;111;111 17:13:00 INFO - PROCESS | 14357 | |12;stanford-crypto-pbkdf2;155;136;145;136;149;134;159;148;144;145 17:13:00 INFO - PROCESS | 14357 | |13;stanford-crypto-sha256-iterative;69;66;68;67;66;67;67;67;66;68 17:13:00 INFO - PROCESS | 14357 | __end_tp_report 17:13:00 INFO - PROCESS | 14357 | __start_cc_report 17:13:00 INFO - PROCESS | 14357 | _x_x_mozilla_cycle_collect,1025 17:13:00 INFO - PROCESS | 14357 | __end_cc_report 17:13:00 INFO - PROCESS | 14357 | __startTimestamp1464653580900__endTimestamp 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | ------- Summary: start ------- 17:13:00 INFO - PROCESS | 14357 | Number of tests: 14 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 17:13:00 INFO - PROCESS | 14357 | Values: 112.0 110.0 112.0 112.0 111.0 111.0 111.0 110.0 112.0 124.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:150.00 stddev:16.87 (11.2%) stddev-sans-first:17.87 17:13:00 INFO - PROCESS | 14357 | Values: 148.0 128.0 150.0 169.0 125.0 157.0 150.0 127.0 169.0 131.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 17:13:00 INFO - PROCESS | 14357 | Values: 161.0 162.0 160.0 160.0 160.0 161.0 160.0 160.0 159.0 160.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.52 (51.0%) stddev-sans-first:40.36 17:13:00 INFO - PROCESS | 14357 | Values: 77.0 76.0 75.0 170.0 76.0 75.0 75.0 78.0 164.0 74.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:22.67 (24.4%) stddev-sans-first:23.48 17:13:00 INFO - PROCESS | 14357 | Values: 93.0 94.0 148.0 94.0 93.0 93.0 134.0 92.0 92.0 136.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:13:00 INFO - PROCESS | 14357 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:13:00 INFO - PROCESS | 14357 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:13:00 INFO - PROCESS | 14357 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:4.79 (8.6%) stddev-sans-first:5.04 17:13:00 INFO - PROCESS | 14357 | Values: 56.0 60.0 59.0 55.0 56.0 56.0 55.0 56.0 70.0 53.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 17:13:00 INFO - PROCESS | 14357 | Values: 64.0 64.0 63.0 64.0 64.0 64.0 63.0 65.0 67.0 63.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.80 (3.5%) stddev-sans-first:2.92 17:13:00 INFO - PROCESS | 14357 | Values: 78.0 85.0 78.0 79.0 77.0 79.0 84.0 78.0 77.0 79.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#11] stanford-crypto-ccm Cycles:10 Average:112.60 Median:112.00 stddev:3.10 (2.8%) stddev-sans-first:3.28 17:13:00 INFO - PROCESS | 14357 | Values: 113.0 113.0 112.0 111.0 110.0 112.0 121.0 112.0 111.0 111.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:146.50 stddev:8.20 (5.6%) stddev-sans-first:7.87 17:13:00 INFO - PROCESS | 14357 | Values: 155.0 136.0 145.0 136.0 149.0 134.0 159.0 148.0 144.0 145.0 17:13:00 INFO - PROCESS | 14357 | 17:13:00 INFO - PROCESS | 14357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 17:13:00 INFO - PROCESS | 14357 | Values: 69.0 66.0 68.0 67.0 66.0 67.0 67.0 67.0 66.0 68.0 17:13:00 INFO - PROCESS | 14357 | -------- Summary: end -------- 17:13:00 INFO - PROCESS | 14357 | 17:13:01 INFO - TEST-INFO | 14357: exit 0 17:13:01 INFO - TEST-OK | kraken | took 59421ms 17:13:01 INFO - SUITE-END | took 1170s 17:13:02 INFO - Completed test suite (00:19:31) 17:13:02 INFO - javascript benchmark 17:13:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3238.1904523869034, 3295.209149804047, 3301.6863397977186, 3328.5839270091237, 3332.2002719347365, 5320.521153096221, 5325.440828712987, 5343.412224655285, 5343.438938911417, 5352.330958630167, 5347.946520534793, 5351.946480535204, 5363.8122665706705, 5366.677999320043, 5371.140617501201, 4745.477997420281, 4892.975535122328, 4908.361912951312, 4976.2286845539, 4976.925346119811, 4823.0, 4904.215325547913, 4907.411110666725, 4908.092002979442, 4908.263760435945, 4903.31353610493, 4957.925631115536, 5005.1491246488185, 5011.799528018893, 5018.372703412074, 4941.579965702902, 4949.455559888409, 4969.304297398367, 4975.850724478271, 5004.924926126093, 4496.589094779634, 4804.303376010494, 4857.781399837016, 4863.19757240055, 4906.386701662293, 5162.3030890830005, 5170.482951704837, 5177.767000484987, 5185.0148471790235, 5210.478952104797, 5498.037843377433, 5648.181013753024, 5708.571857110692, 5709.77160913563, 5711.914321285184, 5587.916181257285, 5603.047481928082, 5612.242347283105, 5613.410591887834, 5628.352739434936, 5275.525202731734, 5278.577713782926, 5417.187421886709, 5484.862878427992, 5490.835274941798, 5879.941200588025, 5885.117232415087, 5901.291844978544, 5917.31950825652, 5922.289325280994, 5636.520895723827, 5671.517920976763, 5687.260656114761, 5692.772289108472, 5696.202531645573, 5551.417101204315, 5641.858953526113, 5703.54371650267, 5716.028275193227, 5764.337101233328, 5663.773449062074, 5683.943160568424, 5702.800401985911, 5705.800296989585, 5712.942870571241, 5648.0, 5699.772009119672, 5708.57185711065, 5712.771489140471, 5721.4278572143285, 4281.293586558183, 4353.412289340962, 4406.184855801623, 4411.691181617256, 4420.84527041552, 3970.305196590643, 3987.840486380512, 3993.0217096811466, 4024.879253622396, 4028.576999415019, 5332.040232758063, 5418.620696551282, 5429.267048948421, 5435.320584926884, 5436.972815135978, 5777.711114444345, 5797.826065217966, 5801.7099145042575, 5811.854703632358, 5837.036888913367, 5380.78476860929, 5442.0, 5442.428545002717, 5447.836564903059, 5451.454854514517, 4807.567318941312, 4909.165441874889, 4974.676646017997, 5003.7998480061115, 5044.621653376012, 5970.492508136857, 5974.2233509643465, 5975.701214939236, 5979.970100149471, 5991.700414979234, 5768.567357448208, 5773.451522105393, 5805.79679711225, 5819.854503637443, 5823.0, 5664.178694089416, 5836.678982655994, 5859.824205273849, 5877.794277200277, 5972.343042265435, 5665.065264231355, 5675.716214189357, 5675.829725108253, 5677.659340439587, 5712.285964254468, 5780.971095144498, 5788.623739456922, 5794.913076303775, 5801.042827933344, 5801.9709901451915, 5439.3200849893765, 5534.584906131976, 5580.609357344947, 5595.972020140036, 5618.101103823368, 5616.494515493625, 5627.803026894039, 5643.830685079454, 5662.178984047207, 5666.2350582670815, 5335.786568537215, 5505.064139096443, 5553.72231388437, 5556.611037227355, 5564.38791732901, 5436.592255580927, 5468.945310546844, 5614.522765564972, 5660.773569057192, 5666.121751128581, 5360.946390536044, 5394.163904594794, 5400.216968539461, 5403.8108666196495, 5498.0], "unit": "score", "name": "dojo.html", "value": 5290.187967728138}, {"lowerIsBetter": false, "replicates": [539.5521716974911, 561.2591379379219, 568.9957225496997, 580.3268208877703, 581.0644861772546, 32306.515402268957, 40736.79631601845, 40753.7962310188, 40814.59185408145, 40827.57103501378, 43373.13253734924, 43630.12739745203, 43720.78139609298, 43897.12205755883, 44015.0, 9284.675036373728, 9551.522423878778, 9565.043495650414, 9565.234781217487, 9576.47329396883, 9285.025072367405, 9414.905850941472, 9430.717078487656, 9434.339596228267, 9445.622175113022, 9436.669716559922, 9530.0, 9533.952330238339, 9537.904620953772, 9560.760980975461, 9341.0, 9406.341556091076, 9421.670241541582, 9422.90577094234, 9427.15155635996, 9337.859932101024, 9459.952700236523, 9460.43237405751, 9465.337426380156, 9467.0, 42800.57199428028, 43269.56730432718, 43282.78358608187, 43325.350119748226, 43370.56629433697, 1804.9729254061199, 3872.283627528888, 3967.8809635710977, 4290.613844753956, 4452.0873220989615, 33456.33087338264, 33552.496712549335, 33764.49353259703, 33849.830750846086, 33869.49195762065, 4319.892002699926, 4377.34339849022, 4411.161879242965, 4472.44094488189, 4495.977520112411, 276021.0, 276755.99999999796, 277909.0, 278514.0, 278690.0, 47144.764276179085, 65332.0, 66209.33790662128, 66217.0, 66302.0, 45223.773881130386, 45395.31907021398, 45481.31778023332, 45495.0, 45524.317135243, 17103.74344384835, 17550.0, 17572.91213543924, 17590.384336548414, 17601.0, 13314.334283285796, 13501.459941602227, 13507.0, 13507.864921350661, 13515.729685406433, 15308.311125999357, 15341.923290383476, 15902.681946361008, 15908.363665453484, 15942.920285398499, 5859.53123750099, 5898.94101058984, 5918.408159184133, 5992.370801065826, 6197.816473880113, 1093.4696672114019, 1135.8069128248217, 1171.1567671276666, 1182.9822552661717, 1204.5422739358987, 30603.387932241232, 30833.691663083082, 30880.0, 31267.374652506824, 31338.843305783783, 1075.080805910935, 1148.3798748675788, 1164.4934453512749, 1235.7528494301175, 1241.5902752091788, 14577.41690332396, 14629.634259143393, 14643.414263429344, 14854.480093196686, 15005.549833505012, 317551.0, 321120.0, 322227.0, 322740.0, 322750.0, 59393.0, 60568.39431605716, 60594.394056059755, 60644.69677651583, 60852.391476085555, 1371.2732251906505, 1475.1486883960774, 1483.8887083468783, 1489.664825414273, 1507.4422463688506, 28585.42829143447, 28672.85663571669, 28736.856315718287, 29466.85266573739, 29924.251893702833, 48192.5180748188, 48659.270110947655, 49108.50891491182, 49187.262191066446, 49210.26184607162, 215829.0, 216280.0, 216603.0, 217197.484075478, 217286.0, 30795.538066928566, 35162.0, 35182.0, 35202.29595408026, 35222.8238858804, 53252.201216982554, 53395.0, 53410.1988470181, 53786.731066344415, 54456.0, 37019.0, 37716.43425348677, 37791.0, 38186.42720359141, 38706.22587548177, 36374.636253638186, 42902.35646465243, 43007.78496107625, 43559.78220108879, 44574.10851783011, 37117.0, 37169.81415092907, 37376.252474950896, 37537.0, 43220.35169472398, 32767.836160819043, 34046.82976585101, 36834.26331473409, 37161.256774864894, 37415.6258437423, 27760.0, 28002.439951201268, 28133.296667582654, 28714.712852871206, 29583.260418488848], "unit": "score", "name": "ext.html", "value": 19289.534237256037}, {"lowerIsBetter": false, "replicates": [377.29257641921396, 381.33457117330244, 381.7327870490656, 382.2507884546289, 385.29491031412516, 17436.302547898067, 18305.633887322263, 19200.51998700033, 19665.60668786627, 19692.803071969276, 18047.4585762427, 18067.728984065216, 19080.141393637285, 19082.90458547709, 19085.809141908576, 5680.31836179658, 5846.50304724099, 5849.122631605251, 5893.55798315126, 5902.055671092626, 4354.869353919387, 6108.205933228674, 6427.967860160693, 6446.387593178664, 6462.192225971754, 5543.362513310981, 6369.07648390983, 6386.329435409285, 6392.264889537693, 6408.3591640835775, 5675.177099320596, 5682.488576028136, 5694.658320500763, 5697.31632204134, 5729.140628905656, 3967.504061992251, 5450.482204190595, 5644.6330988486025, 5651.095824668033, 5653.519450846683, 13638.181709097486, 13995.440182392693, 14056.718865622732, 14070.43718251279, 14193.78709319361, 2316.5598536278053, 2366.467544802406, 2656.7608915197725, 2770.34896799252, 3103.239706271955, 10058.245631577662, 10159.59361625534, 10628.468576571218, 10650.094741946943, 12695.49218031287, 1898.5823118913818, 1955.5502234486148, 1974.6149500847198, 2015.8811859418017, 2070.3995841206033, 62104.37895621076, 67146.3285367145, 67881.0, 68193.31806681919, 68824.6558767203, 10502.73743156412, 10742.24804263694, 10968.945155274172, 10976.341419514854, 11019.338839669645, 15432.15123168214, 15480.458183963507, 15509.302081406364, 15537.145456999973, 15547.30037148331, 8387.077421483631, 8424.410291279552, 8559.572021398904, 8639.308855291687, 8651.0, 8466.576671166416, 8492.915070849336, 8505.61724722389, 8533.957330213309, 8582.957085214533, 4856.223004319292, 4856.8300109495995, 4861.6353773467135, 4878.170710979142, 4917.532834380728, 1815.1650240889076, 1845.9293609706338, 1950.3758797185048, 1952.8340091092132, 2013.2349707111496, 1018.6485662446444, 1029.2897900448665, 1074.7742973975396, 1098.873629532598, 1168.4391492083678, 16344.346226150821, 16818.747718784227, 17184.484465466056, 17361.30554777795, 18001.36995205188, 884.8893888263967, 1038.2161468091695, 1063.2025980514613, 1087.9347239165518, 1090.7436752363187, 9418.576164072632, 9429.245660347156, 9543.570539325747, 9588.37675551087, 9699.854502182472, 466080.0, 483475.0, 485467.0, 488884.0, 506129.0, 78660.0, 81381.59309203416, 81566.18433815586, 81732.0, 82752.0, 1119.7704470583674, 1127.4531852051748, 1136.78969390663, 1148.6324376199536, 1151.8329842172839, 14882.553523394316, 14882.627934301729, 15021.924890375916, 15280.847191528386, 15323.77014344808, 33536.16159596029, 33706.325873482885, 33850.153746156546, 34153.65846341505, 34267.82866085654, 50673.493265068355, 51018.74490627672, 51083.74458127686, 51230.23154652608, 52636.0, 8278.71024514139, 8397.076321604742, 8430.283425908867, 8558.743237702629, 8584.313254939714, 9583.0, 10321.896781032394, 12979.480820767063, 13211.801822972855, 13767.242801645605, 11274.605388811353, 11484.82772758426, 11704.297742135499, 11764.235324703866, 11830.408479575815, 11047.337159770439, 11176.16178786578, 11401.714957126138, 11433.371164585695, 12037.699057523632, 11373.20387572862, 11445.771084578428, 11710.473028713557, 11747.765044698886, 11922.940385298018, 8349.457285276438, 8450.535220562928, 8534.445261058012, 8588.969323681198, 8775.210231078978, 8999.685011024583, 10816.4050977197, 11248.381339026431, 11303.547858085913, 11335.603253886075], "unit": "score", "name": "jquery.html", "value": 8919.70118669043}, {"lowerIsBetter": false, "replicates": [1216.8296438498605, 1577.9132147731873, 1590.3082159260723, 1822.4897028831924, 1933.2750218668, 7230.493865429416, 7309.89035164473, 7352.742654007111, 7364.447666425012, 7364.77905662831, 7620.618969051539, 7729.729459468906, 7750.14748377678, 7753.612319384037, 7753.767386978386, 2326.941826454335, 2347.0025239273327, 2348.3307257431634, 2348.6711860339565, 2349.9177528786495, 2350.8824558771994, 2377.5720370333333, 2392.7487613800563, 2398.796102331295, 2399.9760002399926, 2318.5015221727326, 2336.8013718833918, 2343.16817529777, 2354.81161507079, 2354.858708477488, 2291.702078729771, 2315.548468048731, 2325.3024092772184, 2326.7556906524824, 2338.8947497362487, 2344.5779759643256, 2364.7517010713973, 2365.4441206316674, 2365.5978483657645, 2368.39605900496, 7855.253750893713, 7860.6069696515515, 7897.8025549361155, 7898.881516777195, 7901.723439679641, 4710.74090924999, 4877.829275975359, 4914.090893184736, 4916.06594746997, 4924.335214745999, 3117.0804612639326, 3156.7474602031784, 3213.983930080358, 3219.2273854274804, 3223.06531105979, 1025.2003437318904, 1026.9589216431334, 1032.091759251861, 1046.6493724602267, 1070.882202957674, 10702.197335199813, 10707.411092389915, 10709.892901070967, 10713.839292410543, 10721.410322432263, 4224.598663126998, 4339.7613131278085, 4364.738115713068, 4390.736555806662, 4394.626456751148, 9212.078792120734, 9260.675876344296, 9266.21237194846, 9283.11810378013, 9285.535723213812, 4974.427940786856, 4981.651284410056, 5021.6735912165595, 5023.171176755867, 5024.648274620741, 3936.2521120987494, 4379.715318504351, 4431.889202769957, 4434.689571729948, 4577.679562430664, 3653.9634603654154, 3717.0, 3717.4423836424753, 3752.137008488063, 3777.0934975606206, 1160.3212120909363, 1163.4124766992616, 1166.854143232096, 1167.7781221568046, 1168.7428765671539, 1462.4588902106077, 1476.8892333074848, 1486.2642991719167, 1493.4548889655198, 1499.1230130373635, 7561.243875612395, 7587.355074818592, 7620.733274335372, 7623.580703061385, 7639.732609358646, 544.5453046705966, 556.0408295689983, 562.0809975689776, 574.8160588611688, 582.251806428737, 5884.558658100659, 5917.408259174048, 5952.0, 5957.702114894325, 6013.128096425994, 9373.343865929319, 9641.42151470914, 9654.372465789702, 9664.516774161264, 9673.0, 9283.814323713488, 9335.346525743133, 9380.5309734513, 9446.716598502057, 9530.761730956781, 7255.709771609182, 7360.889586656204, 7371.520851144658, 7371.889421658572, 7390.113186417664, 7088.610126442889, 7171.8565628688175, 7254.347108760237, 7309.195988441374, 7320.26797320285, 8395.874061888955, 8626.223639872442, 8669.913300867163, 8754.387192896436, 8767.473951562926, 8716.0, 8731.91268087311, 8869.423487473294, 8902.065283145177, 8911.465312081036, 6109.419605137505, 6666.766663166766, 6826.931730682828, 7063.71745130189, 7126.180489243596, 7202.171750248788, 7211.062561866924, 7220.530665506725, 7263.6005019724425, 7283.708651653875, 6491.221053473613, 6658.600483970978, 6691.59850408977, 6738.932610673831, 6766.93233067663, 6465.353464653497, 6701.698423570853, 6747.628880411428, 6823.829404264933, 6832.829179270558, 7148.213696493278, 7161.39128174111, 7172.175199852084, 7186.353228209487, 7197.856042879218, 6499.902501462577, 6547.0, 6560.376764207393, 6581.506387020897, 6598.670066496752, 6602.240742314503, 6675.899861501985, 6679.9332006679315, 6680.298568650222, 6686.0], "unit": "score", "name": "mootools.html", "value": 4499.230540692593}, {"lowerIsBetter": false, "replicates": [336.2585498974761, 338.7747148146483, 348.2894894415393, 350.9227969846633, 351.96304388039255, 5944.732487038083, 5987.640741555504, 6001.4298641628975, 6019.819405417834, 6064.605800622968, 5937.050071988483, 5939.732712027958, 5940.524758019359, 5951.077582974646, 5959.225300710912, 4416.24923762961, 4530.524294949032, 4624.283236098393, 4624.537546245382, 4666.929996050062, 4619.74591397473, 4645.070985802836, 4656.185167595674, 4659.0, 4659.394278743758, 4609.262517997121, 4616.746078965655, 4617.607503362218, 4624.768761561909, 4630.606398456119, 4397.978010109945, 4482.417285752864, 4568.360429539867, 4612.5156858530045, 4621.792019359137, 4100.0569868930315, 4100.2414553307435, 4103.097318589906, 4106.568810274908, 4110.219058378899, 5667.234923285386, 5669.574781891375, 5673.120666296731, 5676.914846277268, 5678.205051292823, 5387.218853266294, 5395.946040539584, 5397.487238712316, 5402.756875940592, 5403.2705584745945, 6282.654454005028, 6286.371362863677, 6289.811305660837, 6295.118683384329, 6296.622202667809, 4286.699931004831, 4435.0908063847155, 4458.398116254297, 4467.910641787179, 4557.79489922951, 6528.445082168021, 6584.308647591982, 6588.8023359299295, 6593.80218593443, 6594.769183078617, 4543.977280113579, 4552.11233809404, 4553.066621342617, 4560.771961401917, 4564.338170965191, 4608.493065762764, 4613.792379342937, 4615.630749540029, 4617.676762626651, 4621.653375996813, 5308.761105750174, 5313.070212712837, 5318.547923426475, 5319.547838433777, 5324.627276090637, 6261.8454975975055, 6299.055141728686, 6368.713407896656, 6379.840503987344, 6407.551471397051, 1598.8720902327786, 1611.9838801611834, 1616.4827255278199, 1622.3105180298562, 1628.5114465660492, 1012.6405126180247, 1050.8108540462638, 1060.984085238722, 1083.712816103733, 1086.7120213143523, 6000.969995150083, 6085.695715214221, 6088.269407671108, 6089.391060893964, 6092.51259899207, 6503.219613646298, 6503.479721622259, 6514.413702766774, 6521.706523206467, 6527.314631963671, 6063.605865618721, 6072.817815465543, 6076.8784624308155, 6082.513398928075, 6088.330283668793, 3459.100633835171, 3502.842372093262, 3503.5270238517473, 3507.3511400391008, 3513.0163554204864, 6612.0, 6754.932450675528, 6846.281140480278, 6861.897071543931, 6866.588004719633, 6769.086173366631, 6771.187457505131, 6775.864482710318, 6789.524733268722, 6798.354156355138, 6801.319868013159, 6807.829804254933, 6816.352446517573, 6823.863522729517, 6848.7260509579055, 6623.0, 6626.337366263335, 6630.9668451657435, 6632.038354438676, 6633.270340262471, 6277.843053923689, 6520.087187793808, 6521.119648847345, 6531.183602049744, 6532.967335163294, 6770.763023294161, 6801.421879140328, 6813.761518346834, 6829.52193346461, 6837.1111755471475, 4541.09178164375, 4571.748553829571, 4580.633549316113, 4600.723956562483, 4620.792064357045, 6565.080888675685, 6568.1789776277965, 6581.506387021088, 6587.0448784926875, 6605.2734199239, 6203.31763506023, 6408.359164083555, 6412.839679008062, 6418.29398766126, 6426.196725409324, 6241.063840423973, 6298.716557755004, 6302.527310451826, 6311.116443697978, 6326.398992095744, 6226.470749986302, 6229.688515574294, 6230.626162430269, 6233.2208473940755, 6236.781712640036, 6341.0805433212845, 6349.904751428639, 6350.174477317919, 6476.676166191766, 6478.1578394808375, 5991.580589358878, 6147.661878596541, 6181.629102253699, 6314.336994615499, 6314.463270622048], "unit": "score", "name": "prototype.html", "value": 4808.011957095024}, {"lowerIsBetter": false, "replicates": [733.7101844771317, 773.2653978720216, 810.4893916832394, 819.9631016604252, 923.09536654079, 14922.477713280037, 15118.395264189447, 15167.469138580153, 15226.0, 15234.314455849486, 14310.785338219936, 14368.640783980405, 14380.0, 14403.063800852937, 14407.711845763079, 779.4349096904756, 932.0632764072099, 950.5437390052779, 953.904609539044, 955.106974978394, 938.8122375524888, 941.6845356805444, 945.2910317262053, 946.0870260198907, 946.9147776700096, 835.064727505192, 990.4997976022099, 994.2791476179784, 999.1507218863944, 1000.1148983149928, 829.8879651247095, 832.0223737108903, 965.9227261819037, 981.0238812381726, 981.7692842182081, 729.8905164225356, 731.5171986488945, 732.6886073418829, 733.08730630365, 733.3912852332551, 14448.49430269946, 14682.926585367004, 14739.336729847182, 14810.259487025713, 14857.628559285997, 14206.147631142165, 14660.926695366456, 14748.262586870613, 14797.630059248497, 14884.255787210705, 11963.0, 12010.579629713005, 12035.217710848854, 12116.757664846653, 12284.692882677915, 3948.9802550987347, 3950.1309711863346, 3962.5244970603712, 3992.7205095643317, 3998.640122388999, 50559.74720126376, 50697.74651126758, 50870.0, 51584.74207628938, 53211.0, 10925.344479331106, 10930.508127134299, 11155.498002589902, 11242.100631949424, 11316.547338106548, 18241.0, 18345.54136146607, 18413.171407286703, 18456.446306610822, 18469.353572624892, 8217.178282171855, 8272.875906861402, 8280.544570048705, 8286.41995060352, 8724.43291186071, 4465.218586747306, 4641.303804429363, 4710.8351207707565, 4776.116418462596, 4860.781264843091, 3298.241404476984, 3329.8668053277597, 3338.6494418086236, 3346.7657263991287, 3347.8326083696206, 573.5652156595197, 597.0328068529011, 598.6707310978944, 599.4694695194784, 600.1447936690199, 739.5303981971487, 756.9129550101809, 759.8572026884134, 794.9721759738497, 805.1787177079347, 8933.821323573493, 9272.907270927204, 9409.247260219166, 9455.243580513543, 9571.61713531465, 747.1407880936966, 748.3360673205117, 762.1273641680245, 769.5882702754112, 776.3472860192779, 4336.609705126491, 4385.254506733863, 4436.378906953029, 4442.666799990014, 4531.501534831166, 60024.69987650034, 60730.0, 60845.69577152174, 60860.69569652212, 60922.0, 54450.455495445334, 54660.18009729857, 54993.72503137459, 55911.0, 55931.720341398846, 48491.51508484941, 48577.0, 49052.50947490479, 49190.75404622954, 49548.0, 8670.13298670128, 8702.869456958024, 8769.517676527852, 8841.60212790413, 8913.955430222808, 38276.0, 38913.2217355657, 39037.02407439837, 39386.21227575375, 40352.0, 44113.338299924886, 44314.0, 44670.553294467936, 45928.77035614801, 46010.76994615005, 12369.162741133752, 12475.563355282522, 12623.548291946543, 12715.10994230395, 12716.427760750603, 12884.742305153657, 13562.660933476742, 13827.654308642364, 14289.35697893618, 14300.785488217476, 10838.891611083789, 11890.28658280506, 12615.621531354074, 12733.108682392143, 13517.0, 12279.324637144686, 12282.508699652271, 12305.876941230474, 12315.0, 12318.322492263012, 10786.244962852525, 11172.441377931233, 11384.203105782515, 11536.192466527598, 11666.824997624874, 10287.125594324567, 10733.785324293314, 10879.891201087888, 10970.177236707439, 11139.610113645984, 10258.230632702727, 10571.629992950517, 10820.458977051274, 10822.945885270523, 10854.67435976922], "unit": "score", "name": "yui.html", "value": 6921.362480777792}], "name": "dromaeo_css", "value": 7173.752082374267}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0, 112.0, 124.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [148.0, 128.0, 150.0, 169.0, 125.0, 157.0, 150.0, 127.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 159.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 75.0, 170.0, 76.0, 75.0, 75.0, 78.0, 164.0, 74.0], "unit": "score", "name": "audio-fft", "value": 94.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 148.0, 94.0, 93.0, 93.0, 134.0, 92.0, 92.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 59.0, 55.0, 56.0, 56.0, 55.0, 56.0, 70.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 65.0, 67.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 85.0, 78.0, 79.0, 77.0, 79.0, 84.0, 78.0, 77.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 112.0, 111.0, 110.0, 112.0, 121.0, 112.0, 111.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.6}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 145.0, 136.0, 149.0, 134.0, 159.0, 148.0, 144.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1502.5999999999997}]} 17:13:02 INFO - Return code: 0 17:13:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:02 INFO - # TBPL SUCCESS # 17:13:02 INFO - Running post-action listener: _resource_record_post_action 17:13:02 INFO - Running post-run listener: _resource_record_post_run 17:13:03 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 460697600; Read time: 20; Write time: 390032 17:13:03 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 237826048; Read time: 0; Write time: 272204 17:13:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 222871552; Read time: 20; Write time: 117828 17:13:03 INFO - Running post-run listener: _upload_blobber_files 17:13:03 INFO - Blob upload gear active. 17:13:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:03 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 17:13:03 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'] 17:13:03 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 17:13:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:04 INFO - (blobuploader) - INFO - Done attempting. 17:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:05 INFO - (blobuploader) - INFO - Done attempting. 17:13:05 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:05 INFO - Return code: 0 17:13:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d794631c6b8412139c9f4e67b3f0b2b5262b161bed4b025b35548f86dedb4a84f78d36724546f62513764fd044a222505a6a39fc13ab2d06b810fda42c115146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14b77079f623b249efdba34670547340685fe95c218938d20d1bee93db1a7774c935e12592a8dd42543b1570f301ea701cebee01f48d057694e457df9cb2287a"} 17:13:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:05 INFO - Contents: 17:13:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d794631c6b8412139c9f4e67b3f0b2b5262b161bed4b025b35548f86dedb4a84f78d36724546f62513764fd044a222505a6a39fc13ab2d06b810fda42c115146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14b77079f623b249efdba34670547340685fe95c218938d20d1bee93db1a7774c935e12592a8dd42543b1570f301ea701cebee01f48d057694e457df9cb2287a"} 17:13:05 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:05 INFO - Copying logs to upload dir... 17:13:05 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.676361 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-30 17:13:05.183192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.186908) ========= 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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 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/d794631c6b8412139c9f4e67b3f0b2b5262b161bed4b025b35548f86dedb4a84f78d36724546f62513764fd044a222505a6a39fc13ab2d06b810fda42c115146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14b77079f623b249efdba34670547340685fe95c218938d20d1bee93db1a7774c935e12592a8dd42543b1570f301ea701cebee01f48d057694e457df9cb2287a"} build_url:https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/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/d794631c6b8412139c9f4e67b3f0b2b5262b161bed4b025b35548f86dedb4a84f78d36724546f62513764fd044a222505a6a39fc13ab2d06b810fda42c115146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14b77079f623b249efdba34670547340685fe95c218938d20d1bee93db1a7774c935e12592a8dd42543b1570f301ea701cebee01f48d057694e457df9cb2287a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.212706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.213032) ========= 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=7de08804244eb36560b44971000001c3-1464652348.893992-1683953030 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-30 17:13:05.297594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:13:05.297968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:13:05.298296) ========= ========= Total master_lag: 0.17 =========