builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1464652409.85 results: success (0) buildid: 20160526112438 builduid: 7b7803f5dee74ad79ba6e8f098a8fa00 revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:29.854801) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:29.855474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:29.855892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:29.872300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:29.872712) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:53:30-- 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% 19.2M=0.001s 2016-05-30 16:53:30 (19.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.007952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.008530) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.059352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.059718) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:53:30,241 truncating revision to first 12 chars 2016-05-30 16:53:30,241 Setting DEBUG logging. 2016-05-30 16:53:30,241 attempt 1/10 2016-05-30 16:53:30,241 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:53:30,683 unpacking tar archive at: mozilla-beta-417e1ec42d8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.774419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.850943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.851270) ========= script_repo_revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.851686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.851956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:53:30.862096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-30 16:53:30.862392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:31 INFO - MultiFileLogger online at 20160530 16:53:31 in /builds/slave/test 16:53:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:53:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:31 INFO - {'append_to_log': False, 16:53:31 INFO - 'base_work_dir': '/builds/slave/test', 16:53:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:31 INFO - 'branch': 'Mozilla-Beta', 16:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:31 INFO - 'config_files': ('talos/linux_config.py',), 16:53:31 INFO - 'default_actions': ('clobber', 16:53:31 INFO - 'read-buildbot-config', 16:53:31 INFO - 'download-and-extract', 16:53:31 INFO - 'populate-webroot', 16:53:31 INFO - 'create-virtualenv', 16:53:31 INFO - 'install', 16:53:31 INFO - 'run-tests'), 16:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:31 INFO - 'download_minidump_stackwalk': True, 16:53:31 INFO - 'download_symbols': 'ondemand', 16:53:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:31 INFO - 'installer_path': 'installer.exe', 16:53:31 INFO - 'log_level': 'info', 16:53:31 INFO - 'log_name': 'talos', 16:53:31 INFO - 'log_to_console': True, 16:53:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:31 INFO - 'opt_config_files': (), 16:53:31 INFO - 'pip_index': False, 16:53:31 INFO - 'sps_profile': False, 16:53:31 INFO - 'sps_profile_interval': 0, 16:53:31 INFO - 'suite': 'dromaeojs-e10s', 16:53:31 INFO - 'system_bits': '32', 16:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:31 INFO - 'title': 'talos-linux64-ix-041', 16:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:31 INFO - 'use_talos_json': True, 16:53:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:31 INFO - 'work_dir': 'build'} 16:53:31 INFO - ##### 16:53:31 INFO - ##### Running clobber step. 16:53:31 INFO - ##### 16:53:31 INFO - Running pre-action listener: _resource_record_pre_action 16:53:31 INFO - Running main action method: clobber 16:53:31 INFO - rmtree: /builds/slave/test/build 16:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:32 INFO - Running post-action listener: _resource_record_post_action 16:53:32 INFO - ##### 16:53:32 INFO - ##### Running read-buildbot-config step. 16:53:32 INFO - ##### 16:53:32 INFO - Running pre-action listener: _resource_record_pre_action 16:53:32 INFO - Running main action method: read_buildbot_config 16:53:32 INFO - Using buildbot properties: 16:53:32 INFO - { 16:53:32 INFO - "project": "", 16:53:32 INFO - "product": "firefox", 16:53:32 INFO - "script_repo_revision": "production", 16:53:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:53:32 INFO - "repository": "", 16:53:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:53:32 INFO - "buildid": "20160526112438", 16:53:32 INFO - "pgo_build": "True", 16:53:32 INFO - "basedir": "/builds/slave/test", 16:53:32 INFO - "buildnumber": 123, 16:53:32 INFO - "slavename": "talos-linux64-ix-041", 16:53:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:53:32 INFO - "platform": "ubuntu64_hw", 16:53:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:53:32 INFO - "branch": "mozilla-beta", 16:53:32 INFO - "repo_path": "releases/mozilla-beta", 16:53:32 INFO - "revision": "417e1ec42d8f68c55e52c336cdf81e83323db88c", 16:53:32 INFO - "stage_platform": "linux64-pgo", 16:53:32 INFO - "builduid": "7b7803f5dee74ad79ba6e8f098a8fa00", 16:53:32 INFO - "slavebuilddir": "test" 16:53:32 INFO - } 16:53:32 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:53:32 INFO - Running post-action listener: _resource_record_post_action 16:53:32 INFO - ##### 16:53:32 INFO - ##### Running download-and-extract step. 16:53:32 INFO - ##### 16:53:32 INFO - Running pre-action listener: _resource_record_pre_action 16:53:32 INFO - Running main action method: download_and_extract 16:53:32 INFO - mkdir: /builds/slave/test/build/tests 16:53:32 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:32 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:53:32 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:53:32 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:53:32 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:53:32 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:53:32 INFO - Downloaded 1412 bytes. 16:53:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:53:32 INFO - Using the following test package requirements: 16:53:32 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:53:32 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:53:32 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:53:32 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'jsshell-linux-x86_64.zip'], 16:53:32 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:53:32 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:53:32 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:53:32 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:53:32 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:53:32 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:53:32 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:53:32 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:53:32 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:53:32 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:32 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:53:32 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:53:32 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:53:32 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:53:32 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:53:33 INFO - Downloaded 23434090 bytes. 16:53:33 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:53:33 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:53:35 INFO - Return code: 0 16:53:35 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:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:35 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:53:35 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:53:35 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:53:35 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:53:35 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:53:36 INFO - Downloaded 23434090 bytes. 16:53:36 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:53:36 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:53:37 INFO - Return code: 0 16:53:37 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:37 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:53:37 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:53:37 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:53:37 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:53:37 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:53:38 INFO - Downloaded 10845194 bytes. 16:53:38 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:53:38 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:53:39 INFO - Return code: 0 16:53:39 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:39 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:53:39 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:53:39 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:53:39 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:53:39 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:53:40 INFO - Downloaded 53852157 bytes. 16:53:40 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:53:40 INFO - mkdir: /builds/slave/test/properties 16:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:40 INFO - Contents: 16:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - Running post-action listener: set_extra_try_arguments 16:53:41 INFO - ##### 16:53:41 INFO - ##### Running populate-webroot step. 16:53:41 INFO - ##### 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: populate_webroot 16:53:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:41 INFO - '--tppagecycles', 16:53:41 INFO - '7'], 16:53:41 INFO - 'tests': ['tsvgm']}}, 16:53:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:53:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:53:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['damp', 'tps']}, 16:53:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['damp', 'tps']}, 16:53:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:53:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:41 INFO - 'other': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other_l64': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other_nol64': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'svgr': {'tests': ['tsvgx', 16:53:41 INFO - 'tsvgr_opacity', 16:53:41 INFO - 'tart', 16:53:41 INFO - 'tscrollx', 16:53:41 INFO - 'cart']}, 16:53:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tsvgx', 16:53:41 INFO - 'tsvgr_opacity', 16:53:41 INFO - 'tart', 16:53:41 INFO - 'tscrollx', 16:53:41 INFO - 'cart']}, 16:53:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['tp5o']}, 16:53:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tp5o']}, 16:53:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--xperf_path', 16:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:41 INFO - 'tests': ['tp5n']}, 16:53:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s', 16:53:41 INFO - '--xperf_path', 16:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:41 INFO - 'tests': ['tp5n']}}, 16:53:41 INFO - 'talos.zip': {'path': '', 16:53:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - ##### 16:53:41 INFO - ##### Running create-virtualenv step. 16:53:41 INFO - ##### 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: create_virtualenv 16:53:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:41 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:53:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:41 INFO - Using real prefix '/usr' 16:53:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:41 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:43 INFO - Installing pip.................done. 16:53:43 INFO - Return code: 0 16:53:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:43 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:53:43 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:53:43 INFO - Using env: {'DISPLAY': ':0', 16:53:43 INFO - 'HOME': '/home/cltbld', 16:53:43 INFO - 'LANG': 'en_US.UTF-8', 16:53:43 INFO - 'LANGUAGE': 'en_US:en', 16:53:43 INFO - 'LOGNAME': 'cltbld', 16:53:43 INFO - 'MAIL': '/var/mail/cltbld', 16:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:43 INFO - 'MOZ_NO_REMOTE': '1', 16:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:43 INFO - 'NO_EM_RESTART': '1', 16:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:43 INFO - 'PWD': '/builds/slave/test', 16:53:43 INFO - 'SHELL': '/bin/bash', 16:53:43 INFO - 'SHLVL': '1', 16:53:43 INFO - 'TERM': 'linux', 16:53:43 INFO - 'TMOUT': '86400', 16:53:43 INFO - 'USER': 'cltbld', 16:53:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:43 INFO - '_': '/tools/buildbot/bin/python'} 16:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:44 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:53:44 INFO - Cleaning up... 16:53:44 INFO - Return code: 0 16:53:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:53: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:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:44 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:44 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:53:44 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:53:44 INFO - Using env: {'DISPLAY': ':0', 16:53:44 INFO - 'HOME': '/home/cltbld', 16:53:44 INFO - 'LANG': 'en_US.UTF-8', 16:53:44 INFO - 'LANGUAGE': 'en_US:en', 16:53:44 INFO - 'LOGNAME': 'cltbld', 16:53:44 INFO - 'MAIL': '/var/mail/cltbld', 16:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:44 INFO - 'MOZ_NO_REMOTE': '1', 16:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:44 INFO - 'NO_EM_RESTART': '1', 16:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:44 INFO - 'PWD': '/builds/slave/test', 16:53:44 INFO - 'SHELL': '/bin/bash', 16:53:44 INFO - 'SHLVL': '1', 16:53:44 INFO - 'TERM': 'linux', 16:53:44 INFO - 'TMOUT': '86400', 16:53:44 INFO - 'USER': 'cltbld', 16:53:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:44 INFO - '_': '/tools/buildbot/bin/python'} 16:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:44 INFO - Downloading/unpacking psutil>=0.7.1 16:53:44 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:44 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:44 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:44 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:44 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:44 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:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:46 INFO - Installing collected packages: psutil 16:53:46 INFO - Running setup.py install for psutil 16:53:46 INFO - building 'psutil._psutil_linux' extension 16:53:46 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:53:46 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:53:46 INFO - building 'psutil._psutil_posix' extension 16:53:46 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:53:46 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:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:46 INFO - Successfully installed psutil 16:53:46 INFO - Cleaning up... 16:53:46 INFO - Return code: 0 16:53:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:53:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:46 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:53:46 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:53:46 INFO - Using env: {'DISPLAY': ':0', 16:53:46 INFO - 'HOME': '/home/cltbld', 16:53:46 INFO - 'LANG': 'en_US.UTF-8', 16:53:46 INFO - 'LANGUAGE': 'en_US:en', 16:53:46 INFO - 'LOGNAME': 'cltbld', 16:53:46 INFO - 'MAIL': '/var/mail/cltbld', 16:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:46 INFO - 'MOZ_NO_REMOTE': '1', 16:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:46 INFO - 'NO_EM_RESTART': '1', 16:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:46 INFO - 'PWD': '/builds/slave/test', 16:53:46 INFO - 'SHELL': '/bin/bash', 16:53:46 INFO - 'SHLVL': '1', 16:53:46 INFO - 'TERM': 'linux', 16:53:46 INFO - 'TMOUT': '86400', 16:53:46 INFO - 'USER': 'cltbld', 16:53:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:46 INFO - '_': '/tools/buildbot/bin/python'} 16:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:47 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:47 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:47 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:47 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:47 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:47 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:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:48 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:48 INFO - Installing collected packages: mozsystemmonitor 16:53:48 INFO - Running setup.py install for mozsystemmonitor 16:53:49 INFO - Successfully installed mozsystemmonitor 16:53:49 INFO - Cleaning up... 16:53:49 INFO - Return code: 0 16:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:53:49 INFO - Using env: {'DISPLAY': ':0', 16:53:49 INFO - 'HOME': '/home/cltbld', 16:53:49 INFO - 'LANG': 'en_US.UTF-8', 16:53:49 INFO - 'LANGUAGE': 'en_US:en', 16:53:49 INFO - 'LOGNAME': 'cltbld', 16:53:49 INFO - 'MAIL': '/var/mail/cltbld', 16:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:49 INFO - 'MOZ_NO_REMOTE': '1', 16:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:49 INFO - 'NO_EM_RESTART': '1', 16:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:49 INFO - 'PWD': '/builds/slave/test', 16:53:49 INFO - 'SHELL': '/bin/bash', 16:53:49 INFO - 'SHLVL': '1', 16:53:49 INFO - 'TERM': 'linux', 16:53:49 INFO - 'TMOUT': '86400', 16:53:49 INFO - 'USER': 'cltbld', 16:53:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:49 INFO - '_': '/tools/buildbot/bin/python'} 16:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:49 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:49 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:49 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:49 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:49 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:49 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:49 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:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Downloading docopt-0.6.1.tar.gz 16:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:51 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:51 INFO - Running setup.py install for blobuploader 16:53:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:52 INFO - Running setup.py install for requests 16:53:52 INFO - Running setup.py install for docopt 16:53:52 INFO - Successfully installed blobuploader requests docopt 16:53:52 INFO - Cleaning up... 16:53:52 INFO - Return code: 0 16:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:52 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 16:53:52 INFO - 'HOME': '/home/cltbld', 16:53:52 INFO - 'LANG': 'en_US.UTF-8', 16:53:52 INFO - 'LANGUAGE': 'en_US:en', 16:53:52 INFO - 'LOGNAME': 'cltbld', 16:53:52 INFO - 'MAIL': '/var/mail/cltbld', 16:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:52 INFO - 'MOZ_NO_REMOTE': '1', 16:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:52 INFO - 'NO_EM_RESTART': '1', 16:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:52 INFO - 'PWD': '/builds/slave/test', 16:53:52 INFO - 'SHELL': '/bin/bash', 16:53:52 INFO - 'SHLVL': '1', 16:53:52 INFO - 'TERM': 'linux', 16:53:52 INFO - 'TMOUT': '86400', 16:53:52 INFO - 'USER': 'cltbld', 16:53:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:52 INFO - '_': '/tools/buildbot/bin/python'} 16:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:52 INFO - Running setup.py (path:/tmp/pip-4Wlt5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:52 INFO - Running setup.py (path:/tmp/pip-xbmsHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:52 INFO - Running setup.py (path:/tmp/pip-pLWgTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:52 INFO - Running setup.py (path:/tmp/pip-wNrH1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:53 INFO - Running setup.py (path:/tmp/pip-FV1mv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:53 INFO - Running setup.py (path:/tmp/pip-F51N57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:53 INFO - Running setup.py (path:/tmp/pip-fyAjgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:53 INFO - Running setup.py (path:/tmp/pip-lmjaQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:53 INFO - Running setup.py (path:/tmp/pip-hBI1YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:53 INFO - Running setup.py (path:/tmp/pip-E0PhZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:53 INFO - Running setup.py (path:/tmp/pip-38plsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:53 INFO - Running setup.py (path:/tmp/pip-hFgP7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:53 INFO - Running setup.py (path:/tmp/pip-vbi5UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:53 INFO - Running setup.py (path:/tmp/pip-6umRsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:53 INFO - Running setup.py (path:/tmp/pip-BWD3hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:53 INFO - Running setup.py (path:/tmp/pip-UYgv_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:53 INFO - Running setup.py (path:/tmp/pip-5bvaEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:53 INFO - Running setup.py install for manifestparser 16:53:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for mozcrash 16:53:54 INFO - Running setup.py install for mozdebug 16:53:54 INFO - Running setup.py install for mozdevice 16:53:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for mozfile 16:53:54 INFO - Running setup.py install for mozhttpd 16:53:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for mozinfo 16:53:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for mozInstall 16:53:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for mozleak 16:53:54 INFO - Running setup.py install for mozlog 16:53:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:54 INFO - Running setup.py install for moznetwork 16:53:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Running setup.py install for mozprocess 16:53:55 INFO - Running setup.py install for mozprofile 16:53:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Running setup.py install for mozrunner 16:53:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Running setup.py install for mozscreenshot 16:53:55 INFO - Running setup.py install for moztest 16:53:55 INFO - Running setup.py install for mozversion 16:53:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:55 INFO - Cleaning up... 16:53:55 INFO - Return code: 0 16:53:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:55 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 16:53:55 INFO - 'HOME': '/home/cltbld', 16:53:55 INFO - 'LANG': 'en_US.UTF-8', 16:53:55 INFO - 'LANGUAGE': 'en_US:en', 16:53:55 INFO - 'LOGNAME': 'cltbld', 16:53:55 INFO - 'MAIL': '/var/mail/cltbld', 16:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:55 INFO - 'MOZ_NO_REMOTE': '1', 16:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:55 INFO - 'NO_EM_RESTART': '1', 16:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:55 INFO - 'PWD': '/builds/slave/test', 16:53:55 INFO - 'SHELL': '/bin/bash', 16:53:55 INFO - 'SHLVL': '1', 16:53:55 INFO - 'TERM': 'linux', 16:53:55 INFO - 'TMOUT': '86400', 16:53:55 INFO - 'USER': 'cltbld', 16:53:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:55 INFO - '_': '/tools/buildbot/bin/python'} 16:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:55 INFO - Running setup.py (path:/tmp/pip-N3jYQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:56 INFO - Running setup.py (path:/tmp/pip-HyveKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:56 INFO - Running setup.py (path:/tmp/pip-d4xYbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:56 INFO - Running setup.py (path:/tmp/pip-At5n1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:56 INFO - Running setup.py (path:/tmp/pip-onhpDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:56 INFO - Running setup.py (path:/tmp/pip-h7Jo4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:56 INFO - Running setup.py (path:/tmp/pip-cGXxVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:56 INFO - Running setup.py (path:/tmp/pip-vRQyBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:56 INFO - Running setup.py (path:/tmp/pip-sspM9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:56 INFO - Running setup.py (path:/tmp/pip-hhVdeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:56 INFO - Running setup.py (path:/tmp/pip-COXcOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:56 INFO - Running setup.py (path:/tmp/pip-5csLLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:56 INFO - Running setup.py (path:/tmp/pip-vqXJ2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:56 INFO - Running setup.py (path:/tmp/pip-ujJYpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:56 INFO - Running setup.py (path:/tmp/pip-LucGqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:57 INFO - Running setup.py (path:/tmp/pip-hQhT9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:57 INFO - Running setup.py (path:/tmp/pip-sqK7kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:59 INFO - Downloading blessings-1.6.tar.gz 16:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:59 INFO - Installing collected packages: blessings 16:53:59 INFO - Running setup.py install for blessings 16:53:59 INFO - Successfully installed blessings 16:53:59 INFO - Cleaning up... 16:53:59 INFO - Return code: 0 16:53:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:59 INFO - Reading from file tmpfile_stdout 16:53:59 INFO - Current package versions: 16:53:59 INFO - argparse == 1.2.1 16:53:59 INFO - blessings == 1.6 16:53:59 INFO - blobuploader == 1.2.4 16:53:59 INFO - docopt == 0.6.1 16:53:59 INFO - manifestparser == 1.1 16:53:59 INFO - mozInstall == 1.12 16:53:59 INFO - mozcrash == 0.17 16:53:59 INFO - mozdebug == 0.1 16:53:59 INFO - mozdevice == 0.48 16:53:59 INFO - mozfile == 1.2 16:53:59 INFO - mozhttpd == 0.7 16:53:59 INFO - mozinfo == 0.9 16:53:59 INFO - mozleak == 0.1 16:53:59 INFO - mozlog == 3.1 16:53:59 INFO - moznetwork == 0.27 16:53:59 INFO - mozprocess == 0.22 16:53:59 INFO - mozprofile == 0.28 16:53:59 INFO - mozrunner == 6.11 16:53:59 INFO - mozscreenshot == 0.1 16:53:59 INFO - mozsystemmonitor == 0.0 16:53:59 INFO - moztest == 0.7 16:53:59 INFO - mozversion == 1.4 16:53:59 INFO - psutil == 3.1.1 16:53:59 INFO - requests == 1.2.3 16:53:59 INFO - wsgiref == 0.1.2 16:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 16:53:59 INFO - 'HOME': '/home/cltbld', 16:53:59 INFO - 'LANG': 'en_US.UTF-8', 16:53:59 INFO - 'LANGUAGE': 'en_US:en', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MAIL': '/var/mail/cltbld', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SHLVL': '1', 16:53:59 INFO - 'TERM': 'linux', 16:53:59 INFO - 'TMOUT': '86400', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - '_': '/tools/buildbot/bin/python'} 16:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Cleaning up... 16:53:59 INFO - Return code: 0 16:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 16:53:59 INFO - 'HOME': '/home/cltbld', 16:53:59 INFO - 'LANG': 'en_US.UTF-8', 16:53:59 INFO - 'LANGUAGE': 'en_US:en', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MAIL': '/var/mail/cltbld', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SHLVL': '1', 16:53:59 INFO - 'TERM': 'linux', 16:53:59 INFO - 'TMOUT': '86400', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - '_': '/tools/buildbot/bin/python'} 16:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:59 INFO - Downloading/unpacking jsonschema 16:53:59 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:59 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:59 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:59 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:59 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:59 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:54:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:01 INFO - Downloading/unpacking functools32 (from jsonschema) 16:54:01 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:54:01 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:54:01 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:54:01 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:54:01 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:54:01 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:54:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:02 INFO - warning: no files found matching '*.txt' 16:54:02 INFO - no previously-included directories found matching 'build' 16:54:02 INFO - no previously-included directories found matching 'dist' 16:54:02 INFO - no previously-included directories found matching '.git*' 16:54:02 INFO - Installing collected packages: jsonschema, functools32 16:54:02 INFO - Running setup.py install for functools32 16:54:02 INFO - warning: no files found matching '*.txt' 16:54:02 INFO - no previously-included directories found matching 'build' 16:54:02 INFO - no previously-included directories found matching 'dist' 16:54:02 INFO - no previously-included directories found matching '.git*' 16:54:02 INFO - Successfully installed jsonschema functools32 16:54:02 INFO - Cleaning up... 16:54:02 INFO - Return code: 0 16:54:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:02 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 0x7effa74abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', '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:54:02 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:54:02 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:54:02 INFO - Using env: {'DISPLAY': ':0', 16:54:02 INFO - 'HOME': '/home/cltbld', 16:54:02 INFO - 'LANG': 'en_US.UTF-8', 16:54:02 INFO - 'LANGUAGE': 'en_US:en', 16:54:02 INFO - 'LOGNAME': 'cltbld', 16:54:02 INFO - 'MAIL': '/var/mail/cltbld', 16:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:02 INFO - 'MOZ_NO_REMOTE': '1', 16:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:02 INFO - 'NO_EM_RESTART': '1', 16:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:02 INFO - 'PWD': '/builds/slave/test', 16:54:02 INFO - 'SHELL': '/bin/bash', 16:54:02 INFO - 'SHLVL': '1', 16:54:02 INFO - 'TERM': 'linux', 16:54:02 INFO - 'TMOUT': '86400', 16:54:02 INFO - 'USER': 'cltbld', 16:54:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:02 INFO - '_': '/tools/buildbot/bin/python'} 16:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:02 INFO - Downloading/unpacking flake8 16:54: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:54: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:54: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:54: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:54: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:54: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:54:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:54:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:54:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:05 INFO - no previously-included directories found matching 'docs/_build' 16:54:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:54:05 INFO - Running setup.py install for pep8 16:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:05 INFO - no previously-included directories found matching 'docs/_build' 16:54:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:54:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:54:05 INFO - Cleaning up... 16:54:05 INFO - Return code: 0 16:54:05 INFO - Running post-action listener: _resource_record_post_action 16:54:05 INFO - Running post-action listener: _start_resource_monitoring 16:54:05 INFO - Starting resource monitoring. 16:54:05 INFO - ##### 16:54:05 INFO - ##### Running install step. 16:54:05 INFO - ##### 16:54:05 INFO - Running pre-action listener: _resource_record_pre_action 16:54:05 INFO - Running main action method: install 16:54:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:05 INFO - Reading from file tmpfile_stdout 16:54:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:05 INFO - Reading from file tmpfile_stdout 16:54:05 INFO - Output received: 16:54:05 INFO - Usage: mozinstall [options] installer 16:54:05 INFO - Options: 16:54:05 INFO - -h, --help show this help message and exit 16:54:05 INFO - -d DEST, --destination=DEST 16:54:05 INFO - Directory to install application into. [default: 16:54:05 INFO - "/builds/slave/test"] 16:54:05 INFO - --app=APP Application being installed. [default: firefox] 16:54:05 INFO - mkdir: /builds/slave/test/build/application 16:54:05 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:54:05 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:54:18 INFO - Reading from file tmpfile_stdout 16:54:18 INFO - Output received: 16:54:18 INFO - /builds/slave/test/build/application/firefox/firefox 16:54:18 INFO - Running post-action listener: _resource_record_post_action 16:54:18 INFO - ##### 16:54:18 INFO - ##### Running run-tests step. 16:54:18 INFO - ##### 16:54:18 INFO - Running pre-action listener: _resource_record_pre_action 16:54:18 INFO - Running main action method: run_tests 16:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:54:18 INFO - Python 2.7.3 16:54:18 INFO - Return code: 0 16:54:18 INFO - grabbing minidump binary from tooltool 16:54:18 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:54:18 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 0xf29160>, '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 0xf2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:54:18 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:54:18 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:54:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:18 INFO - Return code: 0 16:54:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:54:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:54:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:54:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:54:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:54:19 INFO - Return code: 0 16:54:19 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-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:54:19 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-e10s --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-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:54:19 INFO - Using env: {'DISPLAY': ':0', 16:54:19 INFO - 'HOME': '/home/cltbld', 16:54:19 INFO - 'LANG': 'en_US.UTF-8', 16:54:19 INFO - 'LANGUAGE': 'en_US:en', 16:54:19 INFO - 'LOGNAME': 'cltbld', 16:54:19 INFO - 'MAIL': '/var/mail/cltbld', 16:54:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:54:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:19 INFO - 'MOZ_NO_REMOTE': '1', 16:54:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:19 INFO - 'NO_EM_RESTART': '1', 16:54:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:19 INFO - 'PWD': '/builds/slave/test', 16:54:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:54:19 INFO - 'SHELL': '/bin/bash', 16:54:19 INFO - 'SHLVL': '1', 16:54:19 INFO - 'TERM': 'linux', 16:54:19 INFO - 'TMOUT': '86400', 16:54:19 INFO - 'USER': 'cltbld', 16:54:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693', 16:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:19 INFO - '_': '/tools/buildbot/bin/python'} 16:54:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:54:19 INFO - mozversion application_buildid: 20160526112438 16:54:19 INFO - mozversion application_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:54:19 INFO - mozversion application_display_name: Firefox 16:54:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:19 INFO - mozversion application_name: Firefox 16:54:19 INFO - mozversion application_remotingname: firefox 16:54:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:54:19 INFO - mozversion application_vendor: Mozilla 16:54:19 INFO - mozversion application_version: 47.0 16:54:19 INFO - mozversion platform_buildid: 20160526112438 16:54:19 INFO - mozversion platform_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:54:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:54:19 INFO - mozversion platform_version: 47.0 16:54:19 INFO - using testdate: 1464652459 16:54:19 INFO - actual date: 1464652459 16:54:19 INFO - starting webserver on 'localhost:33195' 16:54:19 INFO - SUITE-START | Running 2 tests 16:54:19 INFO - TEST-START | dromaeo_css 16:54:19 INFO - operating with platform_type : linux_ 16:54:19 INFO - Initialising browser for dromaeo_css test... 16:54:19 INFO - TEST-INFO | started process 27748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1uCuGr/profile http://localhost:33195/getInfo.html) 16:54:23 INFO - PROCESS | 27748 | 16:54:23 INFO - PROCESS | 27748 | (process:27823): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:24 INFO - PROCESS | 27748 | __metrics Screen width/height:1600/1200 16:54:24 INFO - PROCESS | 27748 | colorDepth:24 16:54:24 INFO - PROCESS | 27748 | Browser inner width/height: 1024/697 16:54:24 INFO - PROCESS | 27748 | __metrics 16:54:25 ERROR - PROCESS | 27748 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:54:26 INFO - TEST-INFO | 27748: exit 0 16:54:26 INFO - Browser initialized. 16:54:26 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:26 INFO - TEST-INFO | started process 27873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1uCuGr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:27 INFO - PROCESS | 27873 | 16:54:27 INFO - PROCESS | 27873 | (process:27945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:37 INFO - PROCESS | 27873 | RSS: Main: 149585920 16:54:37 INFO - PROCESS | 27873 | 16:55:27 INFO - PROCESS | 27873 | 1464652527460 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:57:35 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33195/tests/dromaeo/cssquery-ext.html) 16:57:36 INFO - PROCESS | 27873 | RSS: Main: 152657920 16:57:36 INFO - PROCESS | 27873 | 17:00:38 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-ext.html (next: http://localhost:33195/tests/dromaeo/cssquery-jquery.html) 17:00:38 INFO - PROCESS | 27873 | RSS: Main: 152502272 17:00:38 INFO - PROCESS | 27873 | 17:03:40 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33195/tests/dromaeo/cssquery-mootools.html) 17:03:41 INFO - PROCESS | 27873 | RSS: Main: 151396352 17:03:41 INFO - PROCESS | 27873 | 17:06:42 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33195/tests/dromaeo/cssquery-prototype.html) 17:06:43 INFO - PROCESS | 27873 | RSS: Main: 152182784 17:06:43 INFO - PROCESS | 27873 | 17:09:45 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33195/tests/dromaeo/cssquery-yui.html) 17:09:46 INFO - PROCESS | 27873 | RSS: Main: 150749184 17:09:46 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-yui.html (next: http://localhost:33195/tests/dromaeo/cssquery-dojo.html) 17:12:48 INFO - PROCESS | 27873 | RSS: Main: 155049984 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | __start_tp_report 17:12:48 INFO - PROCESS | 27873 | _x_x_mozilla_page_load 17:12:48 INFO - PROCESS | 27873 | _x_x_mozilla_page_load_details 17:12:48 INFO - PROCESS | 27873 | |i|pagename|runs| 17:12:48 INFO - PROCESS | 27873 | |0;dojo.html;3259.429599820032;3364.4953257011443;3371.4100032494307;3395.711364534016;3426.6915977562016;5452.536534394576;5461.617686761928;5489.4236105208975;5491.505764481196;5507.917381239279;5397.163439666848;5436.483534064268;5472.2338872557775;5477.890442191154;5488.615796894219;5029.773660185282;5035.068512325222;5089.2620570017325;5096.668716533432;5099.821506247282;4910.337104490902;5017;5105.5149760772665;5112.769925353368;5122.974385128069;5093.236014597822;5138.922916156261;5185.740712964355;5189.299444574972;5206.140986737184;5071.467495912932;5097.9490205097845;5105.157648987913;5119.283300337956;5127.9743601282125;4568.337591049312;4991.650584459089;5021.874453138665;5021.949780502221;5068.189089745623;5318.202269659543;5341.919871201896;5342.2787923630585;5356.892862142774;5393.595480338951;5595.048841696921;5846.1523079153285;5862.413758624146;5928.644281343133;5930.762769489215;5907.468327850471;5909.290885093773;5916.615419997729;5975.850603734898;6002.819915402545;5548.639338442988;5564.387917329091;5564.805231816867;5568.1091025435735;5580.330360356783;5840.445157710011;5934.13954976526;5995.400459953969;6061.454469097803;6070.423309785563;5867.941320586825;5878.647281163144;5879.588428810028;5880.558958078162;5905.4685078343155;5940.435658612425;5964.463198312173;5966.254218222723;5986.880262394815;5994.910076348859;5678.943210567924;5898.675572843449;5908;5971.4924231439945;5985.34161242263;5829.591928565044;5835.183074369592;5852.853678658068;5862.765489380377;5884.764609415575;4417.712848664826;4488.147252022105;4492.640588752892;4492.797824097924;4520.886977825515;3893.1045859452483;3991.560928297885;4032.5362583303295;4076.0828813516723;4082.775447350424;5446;5549.472800083986;5626.887462250732;5656.519195868315;5661.264035675335;6006.609570377911;6012.368701286389;6016.127661489059;6021.2774467063355;6027.126066720301;5440.836774896759;5615.691136987505;5672.262605861211;5678.744456499468;5698.2592263005545;5114.974425127851;5116.181410974301;5116.232565115262;5125.692458452505;5130.871728206825;6143.539234557426;6149.108379285068;6150.600210986271;6154.630722156685;6166.383361663798;5758.942410575924;5885.293764748258;5951;5961.612495187799;5985.940140598538;6033.18551995475;6088.147659327787;6093.512518998558;6105.938940610537;6119.296280927751;5614.522765564972;5809.593328466966;5812.94187058124;5830.329512106162;5844.240248767633;5960.672163031075;6012.7294271757;6029.276486821609;6035.758569657164;6040.063790112539;5642.125470552071;5760.481556659921;5774.307083150049;5775.27809023872;5786.450287222707;5585.776568937197;5727.055035919193;5747.051736463437;5754.913676294943;5772.5959182856795;5685.516731077904;5724.4561766632105;5728.856778580569;5742.138679198154;5760.308762948473;5816.82549523515;5822.737976791139;5834.591578589628;5871.706414679164;5875.794347197828;5485.122380419114;5724.856878578069;5736.627119237236;5741.62679425836;5802.158686990447 17:12:48 INFO - PROCESS | 27873 | |1;ext.html;518.833973128599;541.4125673644096;569.7578529125121;587.7178954102031;600.7446835095085;39055.80472097639;39773.8011309943;40144.598554014454;40158.79920600393;40170.39744403836;43796.78101609495;44146.117077658506;44196.337054944204;44272.77863610686;44368.33447498282;8831.95584022079;8983.46099234048;9024;9024.097590240988;9026.23277021454;8877;9010.68462603809;9011.684591039315;9022.368434209608;9024.729258122266;9138.817223655524;9197;9227.754253175803;9275.350725449221;9288.628454861797;9168.495732734697;9262.583183756748;9272;9297;9309.394889332172;9133.406328588688;9264.212541933945;9274.44353338795;9279.02570230123;9296.256299496024;44080.11839763219;44483.77758111221;44524;44597.33104003443;44686;3595.1731101846462;3855.8843234703004;3943.3296339622334;4003.619656132663;4061.451704019949;29612.55581166284;29689.851550742325;30137.246568835737;30877.0736877894;30904.227394315323;4137.110521237918;4154.273002224599;4178.561251068655;4187.099773548671;4256.808443620044;293787;298987;299600;299900;300625.4906176431;47543.5245647546;48321;68473.65763171153;69988.6500567494;70075.29924700687;45910.08179836451;46164.53835461602;46166.07667846624;46375.30437043447;46426;14757.77863332051;14902.925485372503;14904.850951490347;14914.477993270184;14969.40122395092;12788.104832661624;12817.23096614206;12829.101962862696;12846.10077294599;12863.29251891155;15447.227638618024;15982.360705571647;16059.116748578706;16066.75899861503;16099.517014489584;6200.56596038273;6226.62640241587;6285.654289014148;6288.213973253343;6302;1092.317301686446;1120.4229821641861;1144.2905398652722;1153.400231879418;1170.7307319316606;30136.24659383489;30488.54267185994;30616;31110.68889311078;31308.373832523677;1144.4220668562323;1155.1625071822862;1155.7399585093456;1161.6631176958588;1166.7608140331213;15654.530329220353;15760.92119539418;15881.52355429339;16140;16319.428819991243;312290;472330;474559;476319;500464;56016.159757603666;57277.427225728046;57318.713406432704;57321.71339143361;57407.425925741045;1489.1883923261848;1515.8635722785002;1524.8322684504697;1526.6488707597314;1534.171547364433;30044.549331760478;32218.516722249653;32230.35539289248;32486.837565812966;32756.181095472803;51714;52424.73787631038;52479;52528.73735631297;52627.73686131545;302290;304814;308171;308546;309479;35226.11934701653;35354.46968295529;35581.64418355783;35652.108697282776;35707.10732231715;46742.532574673816;46902.29646555373;47375.56651426562;47825.28262076141;48371.758141209066;39759.403608946464;39893.20213595654;40203.79388618346;40398;40551.391729124676;39315.410268845415;39459;40374.39438408367;40623.59376406198;40892.59107408888;39711.60288397079;40005;40106.799466002485;40528.79735601421;40743.79628101959;34594.82702586471;35563.46654800232;35741.642583573834;35823.28353432969;36093.27813443769;27376.31559210956;27649.861750691118;27720.445591088468;27727.44545109127;28808.711912880604 17:12:48 INFO - PROCESS | 27873 | |2;jquery.html;370.45129508978243;370.9146896213871;372.5306114295988;377.582771038003;381.84344418788305;17417.82582174178;17644.73532897006;18360.17379217935;18436.26254949804;18491.630167396645;17500.299988000497;17667.82332176678;18245.996470194168;18257.54356141097;18336.72494912574;5478.45215478452;5653.8586535336535;5683.431656834325;5691.886162276752;5705.942940570582;5533.861653458655;5600.467955544217;5609.186667933147;5697.145428185764;5702.8289151325525;5507.917381239265;5524.806631767889;5542.168674698807;5570.442955704438;5631.267935168423;5485.122380419134;5486.533644640211;5499.312585926719;5500.4499550045075;5529.640573362739;5171.0692075426405;5358.437364076754;5361.597880159004;5362.570994320445;5372.865678358034;13381.732365352736;13674.042817002814;20524.897375513177;21634.350969470943;21699.457513562287;2396.5206958608346;2419.758024197584;2425.7695518925675;2533.227365653475;2965.3328001199775;10260.846087308697;10293.330933489375;10400.739981500446;10741.946290268499;10765.946170269177;1977.574821413403;1983.9504012399661;1996.3911007142815;2036.3483685220735;2043.7956204379443;65629.3437065628;71230.64384678044;72709.27290727077;73289.26710732932;73480.26519734788;10116.74708132288;10368.792624147474;10460.320079194827;10526.578936842441;10621.628243011457;15607.453739119077;15628.687426251412;15659.217039147998;15706.136162510944;15740;8000.199980001953;8166.224208700164;8286.212809783061;8286.875696864552;8337.416380853281;7766.223377662189;7898.328642065374;7951.602419878983;7970.521768693781;8043.879341809878;4702.905941881211;4704.08270387278;4932.087563800708;4957.157283261854;5011.949880501221;2010.266252817711;2025.43287879394;2047.5495391014251;2073.4919944613666;2122.6922096295953;482.4235039128208;490.5070404243784;982.415462799633;1058.9629362972414;1078.4392116099584;11655.30068195911;11699.23954942926;11700.414979251003;11816;12357;499.37328652541555;505.43643837121346;507.33032397235297;514.1234195696329;518.3774784923166;6521.217453905561;6524.151860258136;6561.868762624721;6601.2738598754095;6637.336266373421;480335;484705;493341;497964;505017;67632.6618366905;73663.26336736564;85629.57185214035;88052;88662.55668721744;1035.6634093919356;1035.9741006474749;1057.8889216632142;1085.9891401086047;1093.316677076827;16295.26671299818;16366;16475.505734827493;16495.17524123765;16811.32754689799;25341.61987570151;35199.82400087983;35886.820565897004;36539.63460365362;36852.81573592115;51542.742286288325;51610.22584661308;51931;51999;52034;8678.566071696516;8768.517731524827;8777.956110219407;8890;9118.498482583522;8258.463199891989;10144.137748291478;12788.87211127914;13012.739745205232;13537.59387218385;10894.945525272324;11059.889401106208;11237.04485118774;11487.770244594894;11769.588064417705;10620.09729173029;10793.838092428778;10965.396903170402;10972.286801357886;11516.884831151581;11272.774544509228;11607.129465290305;11915.82126268124;11969.042476601677;12048;8216.589170541329;8290.544020078954;8295.336373090258;8433.451825631315;8443.155684431507;10978.780424391307;11561;11563.768724625628;11645.6506304811;11818.645440636794 17:12:48 INFO - PROCESS | 27873 | |3;mootools.html;1568.419684716655;1586.904785712857;1819.8453131483823;1908.1890196666413;1926.8458523318136;7727.420443466742;7808.882866756989;7911.881321780171;7949.24482174194;7995.640196191171;8014.438989270753;8042.798930026752;8069.314108300801;8071.434999550034;8110.067342255642;2362.031567057507;2378.286514045788;2389.7371289158177;2401.86789726565;2402.627592723122;2380.464395511005;2381.071382160959;2434.732179460258;2438.280707191374;2440.9389765255833;2392.64110383443;2403.795677367426;2422.1643532981093;2424.2000139953775;2428;2394.988025059881;2406.95186096278;2418.238254949685;2419.455622484953;2424.7696468835434;2351.271105957159;2366.25462979161;2370.360002799252;2374.27584586701;2377;8051.154628763954;8056.516609003478;8089.352851771903;8117.228863257981;8133.146019667968;4795.880102997418;4871.951280487186;4900.6569540132205;4904.60763138948;4909.140900342426;3104.2394613319657;3144.339688665383;3165.841707914618;3233;3317.2370354818527;1005.6078129529416;1041.6354276003415;1049.2445439283704;1073.0985971783662;1080.637986274599;10868.728281792939;10948.507317170666;10970.067544258747;10995.835062474069;11008.119350451945;4199;4250.42619246404;4312.986448184674;4318.784060796947;4350.0647360817575;8921.55392230386;8935.597898094602;8939.597718102701;8951.552422378854;8952.68665596701;4953.50464953509;4985.252212168204;4989.0520801048415;4992.550670439605;5002.324686167393;4491.842785502492;4575.771211439414;4588.38056862326;4611;4623.098495793355;3528.3825330567047;3586.98206508971;3589.10272431892;3622.945655815165;3630.3283892479976;1082.2045796339685;1084.5065495199665;1084.9620263290747;1086.179934149712;1093.6336327330275;1334.159479527891;1355.9457621695021;1384.3147641917315;1465.7947887295786;1488.8436714145075;7324.96337518309;7455;7466.066741657293;7475.140358858801;7486.85026299471;1201.627495476405;1209.3167360441323;1223.3883058470765;1236.1964722930168;1246.962591122268;6050.727717252734;6098.603590766675;6128.111423843607;6164.537659675452;6164.599301045418;9172.908270917205;9439.952800235955;9561.426314421156;9612.903870961341;9651.662191823392;9425.528723563932;9532.809343813224;9630.807383852283;9650.565724542412;9681.273904457194;7512.21121782216;7577.16651168371;7588.392928565701;7614.390848731978;7682.7311044113185;7351.081114860643;7395.519291246052;7408.296211859864;7455.925440745523;7479.214682458263;8270.214329638675;8466.703665371682;8521.147885211429;8552.743417697478;8667.783305417162;8634.525101119247;8656.177663121993;8715.956420217859;8871.201591856763;8924.419912705653;6774.051632771515;6905.861882762216;6950.235474097744;7016.122984626922;7143.749968751069;7508.962455187689;7512.060992375953;7513.39892808585;7516;7517.924820751941;6840;7034.894476582753;7059.71761129549;7137.214906360193;7146.392556632536;6741.2921643226755;6748.122744043243;6774.525783195129;6822.624755638488;6843.623600702009;7065.929340706733;7103.325184107502;7137.321954414322;7154.034205382207;7223.349898509159;6583.835404114935;6628.83427914306;6630.336966303524;6642.368974947372;6683.43190828785;6548.377904099103;6659.833504162241;6751.493637977073;6753.831154220988;6757.391834734897 17:12:48 INFO - PROCESS | 27873 | |4;prototype.html;340.9318136372726;347.260335485416;354.69673429218017;355.7420869869345;357.65664961636827;6350.618962862226;6381.266154392246;6386.425221730044;6425.775097871576;6429.8714025719455;6327.55707100502;6361.55469117162;6385.584936979093;6396.136521569587;6423.614583125016;4826.879328016801;4899.461059283476;4928.063667903105;4931.432885218192;4941.110600091982;4919.77860996256;4925.605951523869;4930.186519224324;4937.284093806414;4940.135476291653;4890.73100979446;4896.46138924718;4898.363212782333;4899.559039686427;4901;4877.756112194394;4884.658073934826;4884.926726099111;4960.950390496085;4993.251012348141;4404.097160082176;4409.096135292258;4420.513743488214;4422.712523685982;4434.401355816955;5881;6149;6158.815235542941;6177.073438984144;6178.011518157074;5758.683272420015;5791.855203619901;5796.768129274824;5799.101139323411;5801.7099145042575;6828.590284582891;6839.658017099126;6840.931590684079;6841.863162736767;6849.691763870638;4838.491958344358;4839.0321935612665;4839.830605928811;4845.297431872394;4846.733429661367;7049.224585295665;7095.432365410807;7116.074910261685;7130.358267755875;7144.642767861586;4804.447488538863;4923.187674033816;4978.502149785065;4982.526659967298;4984.177610694267;5025.321581586439;5048.116579598555;5050.065737838511;5050.974745126251;5058.595312375001;5747.827565172968;5762.366139724627;5771;5780.53755699543;5783.652980821164;6866.553674011173;6869.450443964471;6870.862582748317;6872.41584465326;6877.243503214642;1774.8935063896208;1799.9100044997697;1801.0904493230835;1801.4685667728052;1803.6122233719814;1181.6159748081907;1201.873803250646;1210.6973256685828;1211.54567037361;1230.1757822258928;6520.706568204442;6552.148220731275;6555.213374395008;6556.8360790980605;6570.080188773575;6941.722331106699;7042.92957070433;7058.188308344504;7065;7065.975433562207;6661.666916654148;6668.766593169215;6681.031250468654;6684.231313398924;6689.4982876284475;3817.389217725206;3862.1503269280715;3862.806859657006;3866.2074274773604;3871.496705428276;7396.149442814038;7420.220876807965;7423.92353108807;7429.331360177502;7432.739854105081;7079.681414336264;7356.705731770776;7375.151857536452;7444.292792184734;7457.6271186441545;7347.448941329421;7442.627868606548;7467.738629147953;7470.36501897334;7481.85036299271;7123.358897699025;7146.178189508065;7155.42756579462;7159.355657990805;7172;6988.860222795617;7023.648817559204;7024.981377700307;7028.402585780266;7040.0847889774;7305.634718264172;7401.296876796696;7416.6291685414435;7465.664045117874;7472.215417381314;4809.110314591811;4825.396825396825;4848.757562121809;4856.368672072608;4856.781444835062;7212.89180662301;7214.74748383825;7227.349538541556;7229.385502232159;7231.3853322466075;6842.623655698984;6858.211305699909;6894.276101009523;6897.896531552131;6916.515843890879;6766.830829229112;6871.965640171967;6896.310368963063;6898.8620227596175;6900.551464154814;6707.765228216989;6758.7296508139125;6761;6771.28901465339;6789.490788191004;6892.965535172292;6893.724251029903;6912.619805910723;6913.274106218976;6932.792016239521;6724.8903930850865;6746.595204287759;6749;6792.898106528505;6810.557313774589 17:12:48 INFO - PROCESS | 27873 | |5;yui.html;894.6466145872381;898.1018981018983;900.3202582050551;905.8278927003869;910.5765818894213;13529;13672.974526910471;13694.246816425093;13735.17588944664;13747.725045499084;14435.350409231583;14454;14465.34905929233;14468.493602723907;14481.63795905103;779.0495595373649;934.7476181431043;949.4018768176039;954.3748844506824;954.7040417470606;936.9625214991427;942.9434233945951;944.4805357053593;945.5461378538272;947.1286416496805;977.1791694976218;977.481934574673;980.5244456438621;982.8673129127584;983.9114479696826;969.2246203037541;969.4231932000448;970.7379007667926;972.6255391674185;978.3542861711272;720.0854914258914;720.1286443403488;722.8590424867153;723.8045727653504;724.2467833453202;14811.777823332659;14858.108513489116;14878.256087195598;14901.254937253203;15011;14809.259537023107;14831.258437078102;14833.629159270997;14894.70210595782;14930.925345373204;11065;11104;11170.162237832114;11211.607593734261;11286.097112231002;3819.656230939229;3868.8065596720335;3885.7862817545024;3946.4277679736565;4004.6996475264473;49601;49706.254406183936;49720;49741;49758;10978.176636752116;10981.759816112022;11176.832347514794;11416.486258118404;11514.366709830872;21237.36287911365;21274.574508510053;21334.466638333855;21361.25235616746;21469.46326341854;8252.46358986664;8305.086440491541;8333.541655208901;8481.40630155883;8517.829643407098;4441;4554.225781617133;4565.863024109282;4596.954030459719;4615.30770384445;3321.7674762766856;3370.5955285365912;3383.3064221834957;3403.2512847173584;3411.3688967541084;559.2198882558807;567.8949394362056;568.8464114689011;574.3940143148934;582.2488989203964;604.9624893307998;612.9334957174484;623.0685125737052;695.4054283587561;759.502525845572;9186.08139186076;9309.72070837876;9452.810943781224;9456.810863782823;9720.27097967641;574.5977815529146;655.8557117434157;671.5467059734659;694.4513834071028;725.7858931615186;4201.621854033152;4345.348197770297;4355.716878402957;4387.934180987288;4445.644348452181;58942;60782;60860.69569652212;60965.39034609597;61027;53824.73087634615;54442.18336724952;55849.44150558442;56181;56207;48562;48632;48718;49437.50562494401;49830.25254621111;8173.6321865515;8406.15938406179;8573.18554737299;8705.956470217609;8796.252318552995;36370;38269.23461530698;38292.80853595714;38536.42195367128;39125;44444.77777611091;44465.555344447435;45956.080878381574;46128.769356153;46401.76799115983;11036.172287078341;11147.108231341312;11390.601328953448;11394.430278486208;11464.942675286904;12192.695182620506;12303.507859685871;13020.218786872818;13268.668283292609;13378.93310533441;12153;12384.876151238372;12778.424970876147;13011.284379359226;13217.867821321664;11950.820737688768;12553.748925021631;12773.3256155127;12911.806322904977;13243.271620060605;11614.419279036183;11626.82559761621;11656.708582285512;12274.38628068575;12689.111762176559;11001.944990274997;11036.944815275872;11114.331690837893;11240.437978101227;11398.829017564578;10143.825162692103;10638.095761860019;10853.620123295646;10978.176636752116;10983.450827458435 17:12:48 INFO - PROCESS | 27873 | __end_tp_report 17:12:48 INFO - PROCESS | 27873 | __start_cc_report 17:12:48 INFO - PROCESS | 27873 | _x_x_mozilla_cycle_collect,346 17:12:48 INFO - PROCESS | 27873 | __end_cc_report 17:12:48 INFO - PROCESS | 27873 | __startTimestamp1464653568550__endTimestamp 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | ------- Summary: start ------- 17:12:48 INFO - PROCESS | 27873 | Number of tests: 6 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#0] dojo.html Cycles:165 Average:5497.49 Median:5724.46 stddev:609.09 (10.6%) stddev-sans-first:585.11 17:12:48 INFO - PROCESS | 27873 | Values: 3259.4 3364.5 3371.4 3395.7 3426.7 5452.5 5461.6 5489.4 5491.5 5507.9 5397.2 5436.5 5472.2 5477.9 5488.6 5029.8 5035.1 5089.3 5096.7 5099.8 4910.3 5017.0 5105.5 5112.8 5123.0 5093.2 5138.9 5185.7 5189.3 5206.1 5071.5 5097.9 5105.2 5119.3 5128.0 4568.3 4991.7 5021.9 5021.9 5068.2 5318.2 5341.9 5342.3 5356.9 5393.6 5595.0 5846.2 5862.4 5928.6 5930.8 5907.5 5909.3 5916.6 5975.9 6002.8 5548.6 5564.4 5564.8 5568.1 5580.3 5840.4 5934.1 5995.4 6061.5 6070.4 5867.9 5878.6 5879.6 5880.6 5905.5 5940.4 5964.5 5966.3 5986.9 5994.9 5678.9 5898.7 5908.0 5971.5 5985.3 5829.6 5835.2 5852.9 5862.8 5884.8 4417.7 4488.1 4492.6 4492.8 4520.9 3893.1 3991.6 4032.5 4076.1 4082.8 5446.0 5549.5 5626.9 5656.5 5661.3 6006.6 6012.4 6016.1 6021.3 6027.1 5440.8 5615.7 5672.3 5678.7 5698.3 5115.0 5116.2 5116.2 5125.7 5130.9 6143.5 6149.1 6150.6 6154.6 6166.4 5758.9 5885.3 5951.0 5961.6 5985.9 6033.2 6088.1 6093.5 6105.9 6119.3 5614.5 5809.6 5812.9 5830.3 5844.2 5960.7 6012.7 6029.3 6035.8 6040.1 5642.1 5760.5 5774.3 5775.3 5786.5 5585.8 5727.1 5747.1 5754.9 5772.6 5685.5 5724.5 5728.9 5742.1 5760.3 5816.8 5822.7 5834.6 5871.7 5875.8 5485.1 5724.9 5736.6 5741.6 5802.2 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#1] ext.html Cycles:180 Average:52257.08 Median:40164.60 stddev:94789.32 (236.0%) stddev-sans-first:94975.63 17:12:48 INFO - PROCESS | 27873 | Values: 518.8 541.4 569.8 587.7 600.7 39055.8 39773.8 40144.6 40158.8 40170.4 43796.8 44146.1 44196.3 44272.8 44368.3 8832.0 8983.5 9024.0 9024.1 9026.2 8877.0 9010.7 9011.7 9022.4 9024.7 9138.8 9197.0 9227.8 9275.4 9288.6 9168.5 9262.6 9272.0 9297.0 9309.4 9133.4 9264.2 9274.4 9279.0 9296.3 44080.1 44483.8 44524.0 44597.3 44686.0 3595.2 3855.9 3943.3 4003.6 4061.5 29612.6 29689.9 30137.2 30877.1 30904.2 4137.1 4154.3 4178.6 4187.1 4256.8 293787.0 298987.0 299600.0 299900.0 300625.5 47543.5 48321.0 68473.7 69988.7 70075.3 45910.1 46164.5 46166.1 46375.3 46426.0 14757.8 14902.9 14904.9 14914.5 14969.4 12788.1 12817.2 12829.1 12846.1 12863.3 15447.2 15982.4 16059.1 16066.8 16099.5 6200.6 6226.6 6285.7 6288.2 6302.0 1092.3 1120.4 1144.3 1153.4 1170.7 30136.2 30488.5 30616.0 31110.7 31308.4 1144.4 1155.2 1155.7 1161.7 1166.8 15654.5 15760.9 15881.5 16140.0 16319.4 312290.0 472330.0 474559.0 476319.0 500464.0 56016.2 57277.4 57318.7 57321.7 57407.4 1489.2 1515.9 1524.8 1526.6 1534.2 30044.5 32218.5 32230.4 32486.8 32756.2 51714.0 52424.7 52479.0 52528.7 52627.7 302290.0 304814.0 308171.0 308546.0 309479.0 35226.1 35354.5 35581.6 35652.1 35707.1 46742.5 46902.3 47375.6 47825.3 48371.8 39759.4 39893.2 40203.8 40398.0 40551.4 39315.4 39459.0 40374.4 40623.6 40892.6 39711.6 40005.0 40106.8 40528.8 40743.8 34594.8 35563.5 35741.6 35823.3 36093.3 27376.3 27649.9 27720.4 27727.4 28808.7 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#2] jquery.html Cycles:180 Average:27447.08 Median:18611.63 stddev:80825.09 (434.3%) stddev-sans-first:81026.25 17:12:48 INFO - PROCESS | 27873 | Values: 370.5 370.9 372.5 377.6 381.8 17417.8 17644.7 18360.2 18436.3 18491.6 17500.3 17667.8 18246.0 18257.5 18336.7 5478.5 5653.9 5683.4 5691.9 5705.9 5533.9 5600.5 5609.2 5697.1 5702.8 5507.9 5524.8 5542.2 5570.4 5631.3 5485.1 5486.5 5499.3 5500.4 5529.6 5171.1 5358.4 5361.6 5362.6 5372.9 13381.7 13674.0 20524.9 21634.4 21699.5 2396.5 2419.8 2425.8 2533.2 2965.3 10260.8 10293.3 10400.7 10741.9 10765.9 1977.6 1984.0 1996.4 2036.3 2043.8 65629.3 71230.6 72709.3 73289.3 73480.3 10116.7 10368.8 10460.3 10526.6 10621.6 15607.5 15628.7 15659.2 15706.1 15740.0 8000.2 8166.2 8286.2 8286.9 8337.4 7766.2 7898.3 7951.6 7970.5 8043.9 4702.9 4704.1 4932.1 4957.2 5011.9 2010.3 2025.4 2047.5 2073.5 2122.7 482.4 490.5 982.4 1059.0 1078.4 11655.3 11699.2 11700.4 11816.0 12357.0 499.4 505.4 507.3 514.1 518.4 6521.2 6524.2 6561.9 6601.3 6637.3 480335.0 484705.0 493341.0 497964.0 505017.0 67632.7 73663.3 85629.6 88052.0 88662.6 1035.7 1036.0 1057.9 1086.0 1093.3 16295.3 16366.0 16475.5 16495.2 16811.3 25341.6 35199.8 35886.8 36539.6 36852.8 51542.7 51610.2 51931.0 51999.0 52034.0 8678.6 8768.5 8778.0 8890.0 9118.5 8258.5 10144.1 12788.9 13012.7 13537.6 10894.9 11059.9 11237.0 11487.8 11769.6 10620.1 10793.8 10965.4 10972.3 11516.9 11272.8 11607.1 11915.8 11969.0 12048.0 8216.6 8290.5 8295.3 8433.5 8443.2 10978.8 11561.0 11563.8 11645.7 11818.6 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#3] mootools.html Cycles:180 Average:5600.91 Median:6566.11 stddev:2839.77 (43.2%) stddev-sans-first:2831.56 17:12:48 INFO - PROCESS | 27873 | Values: 1568.4 1586.9 1819.8 1908.2 1926.8 7727.4 7808.9 7911.9 7949.2 7995.6 8014.4 8042.8 8069.3 8071.4 8110.1 2362.0 2378.3 2389.7 2401.9 2402.6 2380.5 2381.1 2434.7 2438.3 2440.9 2392.6 2403.8 2422.2 2424.2 2428.0 2395.0 2407.0 2418.2 2419.5 2424.8 2351.3 2366.3 2370.4 2374.3 2377.0 8051.2 8056.5 8089.4 8117.2 8133.1 4795.9 4872.0 4900.7 4904.6 4909.1 3104.2 3144.3 3165.8 3233.0 3317.2 1005.6 1041.6 1049.2 1073.1 1080.6 10868.7 10948.5 10970.1 10995.8 11008.1 4199.0 4250.4 4313.0 4318.8 4350.1 8921.6 8935.6 8939.6 8951.6 8952.7 4953.5 4985.3 4989.1 4992.6 5002.3 4491.8 4575.8 4588.4 4611.0 4623.1 3528.4 3587.0 3589.1 3622.9 3630.3 1082.2 1084.5 1085.0 1086.2 1093.6 1334.2 1355.9 1384.3 1465.8 1488.8 7325.0 7455.0 7466.1 7475.1 7486.9 1201.6 1209.3 1223.4 1236.2 1247.0 6050.7 6098.6 6128.1 6164.5 6164.6 9172.9 9440.0 9561.4 9612.9 9651.7 9425.5 9532.8 9630.8 9650.6 9681.3 7512.2 7577.2 7588.4 7614.4 7682.7 7351.1 7395.5 7408.3 7455.9 7479.2 8270.2 8466.7 8521.1 8552.7 8667.8 8634.5 8656.2 8716.0 8871.2 8924.4 6774.1 6905.9 6950.2 7016.1 7143.7 7509.0 7512.1 7513.4 7516.0 7517.9 6840.0 7034.9 7059.7 7137.2 7146.4 6741.3 6748.1 6774.5 6822.6 6843.6 7065.9 7103.3 7137.3 7154.0 7223.3 6583.8 6628.8 6630.3 6642.4 6683.4 6548.4 6659.8 6751.5 6753.8 6757.4 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#4] prototype.html Cycles:180 Average:5768.35 Median:6536.43 stddev:1732.38 (26.5%) stddev-sans-first:1688.66 17:12:48 INFO - PROCESS | 27873 | Values: 340.9 347.3 354.7 355.7 357.7 6350.6 6381.3 6386.4 6425.8 6429.9 6327.6 6361.6 6385.6 6396.1 6423.6 4826.9 4899.5 4928.1 4931.4 4941.1 4919.8 4925.6 4930.2 4937.3 4940.1 4890.7 4896.5 4898.4 4899.6 4901.0 4877.8 4884.7 4884.9 4961.0 4993.3 4404.1 4409.1 4420.5 4422.7 4434.4 5881.0 6149.0 6158.8 6177.1 6178.0 5758.7 5791.9 5796.8 5799.1 5801.7 6828.6 6839.7 6840.9 6841.9 6849.7 4838.5 4839.0 4839.8 4845.3 4846.7 7049.2 7095.4 7116.1 7130.4 7144.6 4804.4 4923.2 4978.5 4982.5 4984.2 5025.3 5048.1 5050.1 5051.0 5058.6 5747.8 5762.4 5771.0 5780.5 5783.7 6866.6 6869.5 6870.9 6872.4 6877.2 1774.9 1799.9 1801.1 1801.5 1803.6 1181.6 1201.9 1210.7 1211.5 1230.2 6520.7 6552.1 6555.2 6556.8 6570.1 6941.7 7042.9 7058.2 7065.0 7066.0 6661.7 6668.8 6681.0 6684.2 6689.5 3817.4 3862.2 3862.8 3866.2 3871.5 7396.1 7420.2 7423.9 7429.3 7432.7 7079.7 7356.7 7375.2 7444.3 7457.6 7347.4 7442.6 7467.7 7470.4 7481.9 7123.4 7146.2 7155.4 7159.4 7172.0 6988.9 7023.6 7025.0 7028.4 7040.1 7305.6 7401.3 7416.6 7465.7 7472.2 4809.1 4825.4 4848.8 4856.4 4856.8 7212.9 7214.7 7227.3 7229.4 7231.4 6842.6 6858.2 6894.3 6897.9 6916.5 6766.8 6872.0 6896.3 6898.9 6900.6 6707.8 6758.7 6761.0 6771.3 6789.5 6893.0 6893.7 6912.6 6913.3 6932.8 6724.9 6746.6 6749.0 6792.9 6810.6 17:12:48 INFO - PROCESS | 27873 | 17:12:48 INFO - PROCESS | 27873 | [#5] yui.html Cycles:180 Average:14804.83 Median:24445.21 stddev:16777.18 (68.6%) stddev-sans-first:16791.72 17:12:48 INFO - PROCESS | 27873 | Values: 894.6 898.1 900.3 905.8 910.6 13529.0 13673.0 13694.2 13735.2 13747.7 14435.4 14454.0 14465.3 14468.5 14481.6 779.0 934.7 949.4 954.4 954.7 937.0 942.9 944.5 945.5 947.1 977.2 977.5 980.5 982.9 983.9 969.2 969.4 970.7 972.6 978.4 720.1 720.1 722.9 723.8 724.2 14811.8 14858.1 14878.3 14901.3 15011.0 14809.3 14831.3 14833.6 14894.7 14930.9 11065.0 11104.0 11170.2 11211.6 11286.1 3819.7 3868.8 3885.8 3946.4 4004.7 49601.0 49706.3 49720.0 49741.0 49758.0 10978.2 10981.8 11176.8 11416.5 11514.4 21237.4 21274.6 21334.5 21361.3 21469.5 8252.5 8305.1 8333.5 8481.4 8517.8 4441.0 4554.2 4565.9 4597.0 4615.3 3321.8 3370.6 3383.3 3403.3 3411.4 559.2 567.9 568.8 574.4 582.2 605.0 612.9 623.1 695.4 759.5 9186.1 9309.7 9452.8 9456.8 9720.3 574.6 655.9 671.5 694.5 725.8 4201.6 4345.3 4355.7 4387.9 4445.6 58942.0 60782.0 60860.7 60965.4 61027.0 53824.7 54442.2 55849.4 56181.0 56207.0 48562.0 48632.0 48718.0 49437.5 49830.3 8173.6 8406.2 8573.2 8706.0 8796.3 36370.0 38269.2 38292.8 38536.4 39125.0 44444.8 44465.6 45956.1 46128.8 46401.8 11036.2 11147.1 11390.6 11394.4 11464.9 12192.7 12303.5 13020.2 13268.7 13378.9 12153.0 12384.9 12778.4 13011.3 13217.9 11950.8 12553.7 12773.3 12911.8 13243.3 11614.4 11626.8 11656.7 12274.4 12689.1 11001.9 11036.9 11114.3 11240.4 11398.8 10143.8 10638.1 10853.6 10978.2 10983.5 17:12:48 INFO - PROCESS | 27873 | -------- Summary: end -------- 17:12:48 INFO - PROCESS | 27873 | 17:12:49 INFO - TEST-INFO | 27873: exit 0 17:12:49 INFO - TEST-OK | dromaeo_css | took 1109471ms 17:12:49 INFO - TEST-START | kraken 17:12:49 INFO - operating with platform_type : linux_ 17:12:49 INFO - Initialising browser for kraken test... 17:12:49 INFO - TEST-INFO | started process 28116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzEPvEC/profile http://localhost:33195/getInfo.html) 17:12:52 INFO - PROCESS | 28116 | 17:12:52 INFO - PROCESS | 28116 | (process:28195): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:53 INFO - PROCESS | 28116 | __metrics Screen width/height:1600/1200 17:12:53 INFO - PROCESS | 28116 | colorDepth:24 17:12:53 INFO - PROCESS | 28116 | Browser inner width/height: 1024/697 17:12:53 INFO - PROCESS | 28116 | __metrics 17:12:54 ERROR - PROCESS | 28116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 17:12:55 INFO - TEST-INFO | 28116: exit 0 17:12:55 INFO - Browser initialized. 17:12:55 INFO - Running cycle 1/1 for kraken test... 17:12:55 INFO - TEST-INFO | started process 28245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzEPvEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:57 INFO - PROCESS | 28245 | 17:12:57 INFO - PROCESS | 28245 | (process:28312): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:13:07 INFO - PROCESS | 28245 | RSS: Main: 149798912 17:13:07 INFO - PROCESS | 28245 | 17:13:09 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:10 INFO - PROCESS | 28245 | RSS: Main: 153989120 17:13:10 INFO - PROCESS | 28245 | 17:13:12 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-dft) 17:13:13 INFO - PROCESS | 28245 | RSS: Main: 154214400 17:13:13 INFO - PROCESS | 28245 | 17:13:16 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-fft) 17:13:16 INFO - PROCESS | 28245 | RSS: Main: 154722304 17:13:16 INFO - PROCESS | 28245 | 17:13:19 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-oscillator) 17:13:19 INFO - PROCESS | 28245 | RSS: Main: 154918912 17:13:19 INFO - PROCESS | 28245 | 17:13:21 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:22 INFO - PROCESS | 28245 | RSS: Main: 154734592 17:13:22 INFO - PROCESS | 28245 | 17:13:25 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:26 INFO - PROCESS | 28245 | RSS: Main: 154742784 17:13:26 INFO - PROCESS | 28245 | 17:13:29 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:30 INFO - PROCESS | 28245 | RSS: Main: 154845184 17:13:30 INFO - PROCESS | 28245 | 17:13:32 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33195/tests/kraken/driver.html?testName=json-parse-financial) 17:13:33 INFO - PROCESS | 28245 | RSS: Main: 154570752 17:13:33 INFO - PROCESS | 28245 | 17:13:34 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:35 INFO - PROCESS | 28245 | RSS: Main: 154370048 17:13:35 INFO - PROCESS | 28245 | 17:13:37 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:37 INFO - PROCESS | 28245 | RSS: Main: 154611712 17:13:37 INFO - PROCESS | 28245 | 17:13:39 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:40 INFO - PROCESS | 28245 | RSS: Main: 154882048 17:13:40 INFO - PROCESS | 28245 | 17:13:42 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:43 INFO - PROCESS | 28245 | RSS: Main: 155111424 17:13:43 INFO - PROCESS | 28245 | 17:13:46 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:46 INFO - PROCESS | 28245 | RSS: Main: 155201536 17:13:46 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33195/tests/kraken/driver.html?testName=ai-astar) 17:13:48 INFO - PROCESS | 28245 | RSS: Main: 156516352 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | __start_tp_report 17:13:48 INFO - PROCESS | 28245 | _x_x_mozilla_page_load 17:13:48 INFO - PROCESS | 28245 | _x_x_mozilla_page_load_details 17:13:48 INFO - PROCESS | 28245 | |i|pagename|runs| 17:13:48 INFO - PROCESS | 28245 | |0;ai-astar;109;112;104;113;114;113;103;111;111;111 17:13:48 INFO - PROCESS | 28245 | |1;audio-beat-detection;162;135;153;174;129;151;149;129;171;134 17:13:48 INFO - PROCESS | 28245 | |2;audio-dft;162;165;163;161;162;164;164;162;163;164 17:13:48 INFO - PROCESS | 28245 | |3;audio-fft;76;76;76;156;76;75;76;77;162;76 17:13:48 INFO - PROCESS | 28245 | |4;audio-oscillator;93;94;147;92;93;93;150;94;94;146 17:13:48 INFO - PROCESS | 28245 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;116;117;117 17:13:48 INFO - PROCESS | 28245 | |6;imaging-darkroom;147;145;147;146;146;150;146;146;146;145 17:13:48 INFO - PROCESS | 28245 | |7;imaging-desaturate;96;101;95;96;97;96;96;96;95;96 17:13:48 INFO - PROCESS | 28245 | |8;json-parse-financial;59;59;61;58;57;58;61;57;67;59 17:13:48 INFO - PROCESS | 28245 | |9;json-stringify-tinderbox;65;64;64;65;64;65;64;64;65;65 17:13:48 INFO - PROCESS | 28245 | |10;stanford-crypto-aes;78;85;81;80;80;77;78;79;79;78 17:13:48 INFO - PROCESS | 28245 | |11;stanford-crypto-ccm;114;112;119;113;120;112;134;113;115;120 17:13:48 INFO - PROCESS | 28245 | |12;stanford-crypto-pbkdf2;136;145;151;160;145;148;143;145;151;153 17:13:48 INFO - PROCESS | 28245 | |13;stanford-crypto-sha256-iterative;69;68;68;66;68;66;66;67;67;67 17:13:48 INFO - PROCESS | 28245 | __end_tp_report 17:13:48 INFO - PROCESS | 28245 | __start_cc_report 17:13:48 INFO - PROCESS | 28245 | _x_x_mozilla_cycle_collect,831 17:13:48 INFO - PROCESS | 28245 | __end_cc_report 17:13:48 INFO - PROCESS | 28245 | __startTimestamp1464653628639__endTimestamp 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | ------- Summary: start ------- 17:13:48 INFO - PROCESS | 28245 | Number of tests: 14 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.75 (3.4%) stddev-sans-first:3.96 17:13:48 INFO - PROCESS | 28245 | Values: 109.0 112.0 104.0 113.0 114.0 113.0 103.0 111.0 111.0 111.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.00 stddev:16.73 (11.0%) stddev-sans-first:17.04 17:13:48 INFO - PROCESS | 28245 | Values: 162.0 135.0 153.0 174.0 129.0 151.0 149.0 129.0 171.0 134.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 17:13:48 INFO - PROCESS | 28245 | Values: 162.0 165.0 163.0 161.0 162.0 164.0 164.0 162.0 163.0 164.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.03 (46.1%) stddev-sans-first:36.63 17:13:48 INFO - PROCESS | 28245 | Values: 76.0 76.0 76.0 156.0 76.0 75.0 76.0 77.0 162.0 76.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.29 (28.3%) stddev-sans-first:27.19 17:13:48 INFO - PROCESS | 28245 | Values: 93.0 94.0 147.0 92.0 93.0 93.0 150.0 94.0 94.0 146.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 17:13:48 INFO - PROCESS | 28245 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 116.0 117.0 117.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.43 (1.0%) stddev-sans-first:1.50 17:13:48 INFO - PROCESS | 28245 | Values: 147.0 145.0 147.0 146.0 146.0 150.0 146.0 146.0 146.0 145.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 17:13:48 INFO - PROCESS | 28245 | Values: 96.0 101.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:2.95 (5.0%) stddev-sans-first:3.12 17:13:48 INFO - PROCESS | 28245 | Values: 59.0 59.0 61.0 58.0 57.0 58.0 61.0 57.0 67.0 59.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 17:13:48 INFO - PROCESS | 28245 | Values: 65.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:2.27 (2.9%) stddev-sans-first:2.35 17:13:48 INFO - PROCESS | 28245 | Values: 78.0 85.0 81.0 80.0 80.0 77.0 78.0 79.0 79.0 78.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:117.00 stddev:6.71 (5.7%) stddev-sans-first:7.02 17:13:48 INFO - PROCESS | 28245 | Values: 114.0 112.0 119.0 113.0 120.0 112.0 134.0 113.0 115.0 120.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.50 stddev:6.52 (4.4%) stddev-sans-first:5.36 17:13:48 INFO - PROCESS | 28245 | Values: 136.0 145.0 151.0 160.0 145.0 148.0 143.0 145.0 151.0 153.0 17:13:48 INFO - PROCESS | 28245 | 17:13:48 INFO - PROCESS | 28245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:0.87 17:13:48 INFO - PROCESS | 28245 | Values: 69.0 68.0 68.0 66.0 68.0 66.0 66.0 67.0 67.0 67.0 17:13:48 INFO - PROCESS | 28245 | -------- Summary: end -------- 17:13:48 INFO - PROCESS | 28245 | 17:13:49 INFO - TEST-INFO | 28245: exit 0 17:13:49 INFO - TEST-OK | kraken | took 60319ms 17:13:49 INFO - SUITE-END | took 1169s 17:13:49 INFO - Completed test suite (00:19:30) 17:13:49 INFO - javascript benchmark 17:13:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3259.429599820032, 3364.4953257011443, 3371.4100032494307, 3395.711364534016, 3426.6915977562016, 5452.536534394576, 5461.617686761928, 5489.4236105208975, 5491.505764481196, 5507.917381239279, 5397.163439666848, 5436.483534064268, 5472.2338872557775, 5477.890442191154, 5488.615796894219, 5029.773660185282, 5035.068512325222, 5089.2620570017325, 5096.668716533432, 5099.821506247282, 4910.337104490902, 5017.0, 5105.5149760772665, 5112.769925353368, 5122.974385128069, 5093.236014597822, 5138.922916156261, 5185.740712964355, 5189.299444574972, 5206.140986737184, 5071.467495912932, 5097.9490205097845, 5105.157648987913, 5119.283300337956, 5127.9743601282125, 4568.337591049312, 4991.650584459089, 5021.874453138665, 5021.949780502221, 5068.189089745623, 5318.202269659543, 5341.919871201896, 5342.2787923630585, 5356.892862142774, 5393.595480338951, 5595.048841696921, 5846.1523079153285, 5862.413758624146, 5928.644281343133, 5930.762769489215, 5907.468327850471, 5909.290885093773, 5916.615419997729, 5975.850603734898, 6002.819915402545, 5548.639338442988, 5564.387917329091, 5564.805231816867, 5568.1091025435735, 5580.330360356783, 5840.445157710011, 5934.13954976526, 5995.400459953969, 6061.454469097803, 6070.423309785563, 5867.941320586825, 5878.647281163144, 5879.588428810028, 5880.558958078162, 5905.4685078343155, 5940.435658612425, 5964.463198312173, 5966.254218222723, 5986.880262394815, 5994.910076348859, 5678.943210567924, 5898.675572843449, 5908.0, 5971.4924231439945, 5985.34161242263, 5829.591928565044, 5835.183074369592, 5852.853678658068, 5862.765489380377, 5884.764609415575, 4417.712848664826, 4488.147252022105, 4492.640588752892, 4492.797824097924, 4520.886977825515, 3893.1045859452483, 3991.560928297885, 4032.5362583303295, 4076.0828813516723, 4082.775447350424, 5446.0, 5549.472800083986, 5626.887462250732, 5656.519195868315, 5661.264035675335, 6006.609570377911, 6012.368701286389, 6016.127661489059, 6021.2774467063355, 6027.126066720301, 5440.836774896759, 5615.691136987505, 5672.262605861211, 5678.744456499468, 5698.2592263005545, 5114.974425127851, 5116.181410974301, 5116.232565115262, 5125.692458452505, 5130.871728206825, 6143.539234557426, 6149.108379285068, 6150.600210986271, 6154.630722156685, 6166.383361663798, 5758.942410575924, 5885.293764748258, 5951.0, 5961.612495187799, 5985.940140598538, 6033.18551995475, 6088.147659327787, 6093.512518998558, 6105.938940610537, 6119.296280927751, 5614.522765564972, 5809.593328466966, 5812.94187058124, 5830.329512106162, 5844.240248767633, 5960.672163031075, 6012.7294271757, 6029.276486821609, 6035.758569657164, 6040.063790112539, 5642.125470552071, 5760.481556659921, 5774.307083150049, 5775.27809023872, 5786.450287222707, 5585.776568937197, 5727.055035919193, 5747.051736463437, 5754.913676294943, 5772.5959182856795, 5685.516731077904, 5724.4561766632105, 5728.856778580569, 5742.138679198154, 5760.308762948473, 5816.82549523515, 5822.737976791139, 5834.591578589628, 5871.706414679164, 5875.794347197828, 5485.122380419114, 5724.856878578069, 5736.627119237236, 5741.62679425836, 5802.158686990447], "unit": "score", "name": "dojo.html", "value": 5458.375059206389}, {"lowerIsBetter": false, "replicates": [518.833973128599, 541.4125673644096, 569.7578529125121, 587.7178954102031, 600.7446835095085, 39055.80472097639, 39773.8011309943, 40144.598554014454, 40158.79920600393, 40170.39744403836, 43796.78101609495, 44146.117077658506, 44196.337054944204, 44272.77863610686, 44368.33447498282, 8831.95584022079, 8983.46099234048, 9024.0, 9024.097590240988, 9026.23277021454, 8877.0, 9010.68462603809, 9011.684591039315, 9022.368434209608, 9024.729258122266, 9138.817223655524, 9197.0, 9227.754253175803, 9275.350725449221, 9288.628454861797, 9168.495732734697, 9262.583183756748, 9272.0, 9297.0, 9309.394889332172, 9133.406328588688, 9264.212541933945, 9274.44353338795, 9279.02570230123, 9296.256299496024, 44080.11839763219, 44483.77758111221, 44524.0, 44597.33104003443, 44686.0, 3595.1731101846462, 3855.8843234703004, 3943.3296339622334, 4003.619656132663, 4061.451704019949, 29612.55581166284, 29689.851550742325, 30137.246568835737, 30877.0736877894, 30904.227394315323, 4137.110521237918, 4154.273002224599, 4178.561251068655, 4187.099773548671, 4256.808443620044, 293787.0, 298987.0, 299600.0, 299900.0, 300625.4906176431, 47543.5245647546, 48321.0, 68473.65763171153, 69988.6500567494, 70075.29924700687, 45910.08179836451, 46164.53835461602, 46166.07667846624, 46375.30437043447, 46426.0, 14757.77863332051, 14902.925485372503, 14904.850951490347, 14914.477993270184, 14969.40122395092, 12788.104832661624, 12817.23096614206, 12829.101962862696, 12846.10077294599, 12863.29251891155, 15447.227638618024, 15982.360705571647, 16059.116748578706, 16066.75899861503, 16099.517014489584, 6200.56596038273, 6226.62640241587, 6285.654289014148, 6288.213973253343, 6302.0, 1092.317301686446, 1120.4229821641861, 1144.2905398652722, 1153.400231879418, 1170.7307319316606, 30136.24659383489, 30488.54267185994, 30616.0, 31110.68889311078, 31308.373832523677, 1144.4220668562323, 1155.1625071822862, 1155.7399585093456, 1161.6631176958588, 1166.7608140331213, 15654.530329220353, 15760.92119539418, 15881.52355429339, 16140.0, 16319.428819991243, 312290.0, 472330.0, 474559.0, 476319.0, 500464.0, 56016.159757603666, 57277.427225728046, 57318.713406432704, 57321.71339143361, 57407.425925741045, 1489.1883923261848, 1515.8635722785002, 1524.8322684504697, 1526.6488707597314, 1534.171547364433, 30044.549331760478, 32218.516722249653, 32230.35539289248, 32486.837565812966, 32756.181095472803, 51714.0, 52424.73787631038, 52479.0, 52528.73735631297, 52627.73686131545, 302290.0, 304814.0, 308171.0, 308546.0, 309479.0, 35226.11934701653, 35354.46968295529, 35581.64418355783, 35652.108697282776, 35707.10732231715, 46742.532574673816, 46902.29646555373, 47375.56651426562, 47825.28262076141, 48371.758141209066, 39759.403608946464, 39893.20213595654, 40203.79388618346, 40398.0, 40551.391729124676, 39315.410268845415, 39459.0, 40374.39438408367, 40623.59376406198, 40892.59107408888, 39711.60288397079, 40005.0, 40106.799466002485, 40528.79735601421, 40743.79628101959, 34594.82702586471, 35563.46654800232, 35741.642583573834, 35823.28353432969, 36093.27813443769, 27376.31559210956, 27649.861750691118, 27720.445591088468, 27727.44545109127, 28808.711912880604], "unit": "score", "name": "ext.html", "value": 19559.867193278562}, {"lowerIsBetter": false, "replicates": [370.45129508978243, 370.9146896213871, 372.5306114295988, 377.582771038003, 381.84344418788305, 17417.82582174178, 17644.73532897006, 18360.17379217935, 18436.26254949804, 18491.630167396645, 17500.299988000497, 17667.82332176678, 18245.996470194168, 18257.54356141097, 18336.72494912574, 5478.45215478452, 5653.8586535336535, 5683.431656834325, 5691.886162276752, 5705.942940570582, 5533.861653458655, 5600.467955544217, 5609.186667933147, 5697.145428185764, 5702.8289151325525, 5507.917381239265, 5524.806631767889, 5542.168674698807, 5570.442955704438, 5631.267935168423, 5485.122380419134, 5486.533644640211, 5499.312585926719, 5500.4499550045075, 5529.640573362739, 5171.0692075426405, 5358.437364076754, 5361.597880159004, 5362.570994320445, 5372.865678358034, 13381.732365352736, 13674.042817002814, 20524.897375513177, 21634.350969470943, 21699.457513562287, 2396.5206958608346, 2419.758024197584, 2425.7695518925675, 2533.227365653475, 2965.3328001199775, 10260.846087308697, 10293.330933489375, 10400.739981500446, 10741.946290268499, 10765.946170269177, 1977.574821413403, 1983.9504012399661, 1996.3911007142815, 2036.3483685220735, 2043.7956204379443, 65629.3437065628, 71230.64384678044, 72709.27290727077, 73289.26710732932, 73480.26519734788, 10116.74708132288, 10368.792624147474, 10460.320079194827, 10526.578936842441, 10621.628243011457, 15607.453739119077, 15628.687426251412, 15659.217039147998, 15706.136162510944, 15740.0, 8000.199980001953, 8166.224208700164, 8286.212809783061, 8286.875696864552, 8337.416380853281, 7766.223377662189, 7898.328642065374, 7951.602419878983, 7970.521768693781, 8043.879341809878, 4702.905941881211, 4704.08270387278, 4932.087563800708, 4957.157283261854, 5011.949880501221, 2010.266252817711, 2025.43287879394, 2047.5495391014251, 2073.4919944613666, 2122.6922096295953, 482.4235039128208, 490.5070404243784, 982.415462799633, 1058.9629362972414, 1078.4392116099584, 11655.30068195911, 11699.23954942926, 11700.414979251003, 11816.0, 12357.0, 499.37328652541555, 505.43643837121346, 507.33032397235297, 514.1234195696329, 518.3774784923166, 6521.217453905561, 6524.151860258136, 6561.868762624721, 6601.2738598754095, 6637.336266373421, 480335.0, 484705.0, 493341.0, 497964.0, 505017.0, 67632.6618366905, 73663.26336736564, 85629.57185214035, 88052.0, 88662.55668721744, 1035.6634093919356, 1035.9741006474749, 1057.8889216632142, 1085.9891401086047, 1093.316677076827, 16295.26671299818, 16366.0, 16475.505734827493, 16495.17524123765, 16811.32754689799, 25341.61987570151, 35199.82400087983, 35886.820565897004, 36539.63460365362, 36852.81573592115, 51542.742286288325, 51610.22584661308, 51931.0, 51999.0, 52034.0, 8678.566071696516, 8768.517731524827, 8777.956110219407, 8890.0, 9118.498482583522, 8258.463199891989, 10144.137748291478, 12788.87211127914, 13012.739745205232, 13537.59387218385, 10894.945525272324, 11059.889401106208, 11237.04485118774, 11487.770244594894, 11769.588064417705, 10620.09729173029, 10793.838092428778, 10965.396903170402, 10972.286801357886, 11516.884831151581, 11272.774544509228, 11607.129465290305, 11915.82126268124, 11969.042476601677, 12048.0, 8216.589170541329, 8290.544020078954, 8295.336373090258, 8433.451825631315, 8443.155684431507, 10978.780424391307, 11561.0, 11563.768724625628, 11645.6506304811, 11818.645440636794], "unit": "score", "name": "jquery.html", "value": 8481.26683536414}, {"lowerIsBetter": false, "replicates": [1568.419684716655, 1586.904785712857, 1819.8453131483823, 1908.1890196666413, 1926.8458523318136, 7727.420443466742, 7808.882866756989, 7911.881321780171, 7949.24482174194, 7995.640196191171, 8014.438989270753, 8042.798930026752, 8069.314108300801, 8071.434999550034, 8110.067342255642, 2362.031567057507, 2378.286514045788, 2389.7371289158177, 2401.86789726565, 2402.627592723122, 2380.464395511005, 2381.071382160959, 2434.732179460258, 2438.280707191374, 2440.9389765255833, 2392.64110383443, 2403.795677367426, 2422.1643532981093, 2424.2000139953775, 2428.0, 2394.988025059881, 2406.95186096278, 2418.238254949685, 2419.455622484953, 2424.7696468835434, 2351.271105957159, 2366.25462979161, 2370.360002799252, 2374.27584586701, 2377.0, 8051.154628763954, 8056.516609003478, 8089.352851771903, 8117.228863257981, 8133.146019667968, 4795.880102997418, 4871.951280487186, 4900.6569540132205, 4904.60763138948, 4909.140900342426, 3104.2394613319657, 3144.339688665383, 3165.841707914618, 3233.0, 3317.2370354818527, 1005.6078129529416, 1041.6354276003415, 1049.2445439283704, 1073.0985971783662, 1080.637986274599, 10868.728281792939, 10948.507317170666, 10970.067544258747, 10995.835062474069, 11008.119350451945, 4199.0, 4250.42619246404, 4312.986448184674, 4318.784060796947, 4350.0647360817575, 8921.55392230386, 8935.597898094602, 8939.597718102701, 8951.552422378854, 8952.68665596701, 4953.50464953509, 4985.252212168204, 4989.0520801048415, 4992.550670439605, 5002.324686167393, 4491.842785502492, 4575.771211439414, 4588.38056862326, 4611.0, 4623.098495793355, 3528.3825330567047, 3586.98206508971, 3589.10272431892, 3622.945655815165, 3630.3283892479976, 1082.2045796339685, 1084.5065495199665, 1084.9620263290747, 1086.179934149712, 1093.6336327330275, 1334.159479527891, 1355.9457621695021, 1384.3147641917315, 1465.7947887295786, 1488.8436714145075, 7324.96337518309, 7455.0, 7466.066741657293, 7475.140358858801, 7486.85026299471, 1201.627495476405, 1209.3167360441323, 1223.3883058470765, 1236.1964722930168, 1246.962591122268, 6050.727717252734, 6098.603590766675, 6128.111423843607, 6164.537659675452, 6164.599301045418, 9172.908270917205, 9439.952800235955, 9561.426314421156, 9612.903870961341, 9651.662191823392, 9425.528723563932, 9532.809343813224, 9630.807383852283, 9650.565724542412, 9681.273904457194, 7512.21121782216, 7577.16651168371, 7588.392928565701, 7614.390848731978, 7682.7311044113185, 7351.081114860643, 7395.519291246052, 7408.296211859864, 7455.925440745523, 7479.214682458263, 8270.214329638675, 8466.703665371682, 8521.147885211429, 8552.743417697478, 8667.783305417162, 8634.525101119247, 8656.177663121993, 8715.956420217859, 8871.201591856763, 8924.419912705653, 6774.051632771515, 6905.861882762216, 6950.235474097744, 7016.122984626922, 7143.749968751069, 7508.962455187689, 7512.060992375953, 7513.39892808585, 7516.0, 7517.924820751941, 6840.0, 7034.894476582753, 7059.71761129549, 7137.214906360193, 7146.392556632536, 6741.2921643226755, 6748.122744043243, 6774.525783195129, 6822.624755638488, 6843.623600702009, 7065.929340706733, 7103.325184107502, 7137.321954414322, 7154.034205382207, 7223.349898509159, 6583.835404114935, 6628.83427914306, 6630.336966303524, 6642.368974947372, 6683.43190828785, 6548.377904099103, 6659.833504162241, 6751.493637977073, 6753.831154220988, 6757.391834734897], "unit": "score", "name": "mootools.html", "value": 4647.073401599294}, {"lowerIsBetter": false, "replicates": [340.9318136372726, 347.260335485416, 354.69673429218017, 355.7420869869345, 357.65664961636827, 6350.618962862226, 6381.266154392246, 6386.425221730044, 6425.775097871576, 6429.8714025719455, 6327.55707100502, 6361.55469117162, 6385.584936979093, 6396.136521569587, 6423.614583125016, 4826.879328016801, 4899.461059283476, 4928.063667903105, 4931.432885218192, 4941.110600091982, 4919.77860996256, 4925.605951523869, 4930.186519224324, 4937.284093806414, 4940.135476291653, 4890.73100979446, 4896.46138924718, 4898.363212782333, 4899.559039686427, 4901.0, 4877.756112194394, 4884.658073934826, 4884.926726099111, 4960.950390496085, 4993.251012348141, 4404.097160082176, 4409.096135292258, 4420.513743488214, 4422.712523685982, 4434.401355816955, 5881.0, 6149.0, 6158.815235542941, 6177.073438984144, 6178.011518157074, 5758.683272420015, 5791.855203619901, 5796.768129274824, 5799.101139323411, 5801.7099145042575, 6828.590284582891, 6839.658017099126, 6840.931590684079, 6841.863162736767, 6849.691763870638, 4838.491958344358, 4839.0321935612665, 4839.830605928811, 4845.297431872394, 4846.733429661367, 7049.224585295665, 7095.432365410807, 7116.074910261685, 7130.358267755875, 7144.642767861586, 4804.447488538863, 4923.187674033816, 4978.502149785065, 4982.526659967298, 4984.177610694267, 5025.321581586439, 5048.116579598555, 5050.065737838511, 5050.974745126251, 5058.595312375001, 5747.827565172968, 5762.366139724627, 5771.0, 5780.53755699543, 5783.652980821164, 6866.553674011173, 6869.450443964471, 6870.862582748317, 6872.41584465326, 6877.243503214642, 1774.8935063896208, 1799.9100044997697, 1801.0904493230835, 1801.4685667728052, 1803.6122233719814, 1181.6159748081907, 1201.873803250646, 1210.6973256685828, 1211.54567037361, 1230.1757822258928, 6520.706568204442, 6552.148220731275, 6555.213374395008, 6556.8360790980605, 6570.080188773575, 6941.722331106699, 7042.92957070433, 7058.188308344504, 7065.0, 7065.975433562207, 6661.666916654148, 6668.766593169215, 6681.031250468654, 6684.231313398924, 6689.4982876284475, 3817.389217725206, 3862.1503269280715, 3862.806859657006, 3866.2074274773604, 3871.496705428276, 7396.149442814038, 7420.220876807965, 7423.92353108807, 7429.331360177502, 7432.739854105081, 7079.681414336264, 7356.705731770776, 7375.151857536452, 7444.292792184734, 7457.6271186441545, 7347.448941329421, 7442.627868606548, 7467.738629147953, 7470.36501897334, 7481.85036299271, 7123.358897699025, 7146.178189508065, 7155.42756579462, 7159.355657990805, 7172.0, 6988.860222795617, 7023.648817559204, 7024.981377700307, 7028.402585780266, 7040.0847889774, 7305.634718264172, 7401.296876796696, 7416.6291685414435, 7465.664045117874, 7472.215417381314, 4809.110314591811, 4825.396825396825, 4848.757562121809, 4856.368672072608, 4856.781444835062, 7212.89180662301, 7214.74748383825, 7227.349538541556, 7229.385502232159, 7231.3853322466075, 6842.623655698984, 6858.211305699909, 6894.276101009523, 6897.896531552131, 6916.515843890879, 6766.830829229112, 6871.965640171967, 6896.310368963063, 6898.8620227596175, 6900.551464154814, 6707.765228216989, 6758.7296508139125, 6761.0, 6771.28901465339, 6789.490788191004, 6892.965535172292, 6893.724251029903, 6912.619805910723, 6913.274106218976, 6932.792016239521, 6724.8903930850865, 6746.595204287759, 6749.0, 6792.898106528505, 6810.557313774589], "unit": "score", "name": "prototype.html", "value": 5204.461011416715}, {"lowerIsBetter": false, "replicates": [894.6466145872381, 898.1018981018983, 900.3202582050551, 905.8278927003869, 910.5765818894213, 13529.0, 13672.974526910471, 13694.246816425093, 13735.17588944664, 13747.725045499084, 14435.350409231583, 14454.0, 14465.34905929233, 14468.493602723907, 14481.63795905103, 779.0495595373649, 934.7476181431043, 949.4018768176039, 954.3748844506824, 954.7040417470606, 936.9625214991427, 942.9434233945951, 944.4805357053593, 945.5461378538272, 947.1286416496805, 977.1791694976218, 977.481934574673, 980.5244456438621, 982.8673129127584, 983.9114479696826, 969.2246203037541, 969.4231932000448, 970.7379007667926, 972.6255391674185, 978.3542861711272, 720.0854914258914, 720.1286443403488, 722.8590424867153, 723.8045727653504, 724.2467833453202, 14811.777823332659, 14858.108513489116, 14878.256087195598, 14901.254937253203, 15011.0, 14809.259537023107, 14831.258437078102, 14833.629159270997, 14894.70210595782, 14930.925345373204, 11065.0, 11104.0, 11170.162237832114, 11211.607593734261, 11286.097112231002, 3819.656230939229, 3868.8065596720335, 3885.7862817545024, 3946.4277679736565, 4004.6996475264473, 49601.0, 49706.254406183936, 49720.0, 49741.0, 49758.0, 10978.176636752116, 10981.759816112022, 11176.832347514794, 11416.486258118404, 11514.366709830872, 21237.36287911365, 21274.574508510053, 21334.466638333855, 21361.25235616746, 21469.46326341854, 8252.46358986664, 8305.086440491541, 8333.541655208901, 8481.40630155883, 8517.829643407098, 4441.0, 4554.225781617133, 4565.863024109282, 4596.954030459719, 4615.30770384445, 3321.7674762766856, 3370.5955285365912, 3383.3064221834957, 3403.2512847173584, 3411.3688967541084, 559.2198882558807, 567.8949394362056, 568.8464114689011, 574.3940143148934, 582.2488989203964, 604.9624893307998, 612.9334957174484, 623.0685125737052, 695.4054283587561, 759.502525845572, 9186.08139186076, 9309.72070837876, 9452.810943781224, 9456.810863782823, 9720.27097967641, 574.5977815529146, 655.8557117434157, 671.5467059734659, 694.4513834071028, 725.7858931615186, 4201.621854033152, 4345.348197770297, 4355.716878402957, 4387.934180987288, 4445.644348452181, 58942.0, 60782.0, 60860.69569652212, 60965.39034609597, 61027.0, 53824.73087634615, 54442.18336724952, 55849.44150558442, 56181.0, 56207.0, 48562.0, 48632.0, 48718.0, 49437.50562494401, 49830.25254621111, 8173.6321865515, 8406.15938406179, 8573.18554737299, 8705.956470217609, 8796.252318552995, 36370.0, 38269.23461530698, 38292.80853595714, 38536.42195367128, 39125.0, 44444.77777611091, 44465.555344447435, 45956.080878381574, 46128.769356153, 46401.76799115983, 11036.172287078341, 11147.108231341312, 11390.601328953448, 11394.430278486208, 11464.942675286904, 12192.695182620506, 12303.507859685871, 13020.218786872818, 13268.668283292609, 13378.93310533441, 12153.0, 12384.876151238372, 12778.424970876147, 13011.284379359226, 13217.867821321664, 11950.820737688768, 12553.748925021631, 12773.3256155127, 12911.806322904977, 13243.271620060605, 11614.419279036183, 11626.82559761621, 11656.708582285512, 12274.38628068575, 12689.111762176559, 11001.944990274997, 11036.944815275872, 11114.331690837893, 11240.437978101227, 11398.829017564578, 10143.825162692103, 10638.095761860019, 10853.620123295646, 10978.176636752116, 10983.450827458435], "unit": "score", "name": "yui.html", "value": 6864.7215078199515}], "name": "dromaeo_css", "value": 7292.0672941518105}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 113.0, 114.0, 113.0, 103.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [162.0, 135.0, 153.0, 174.0, 129.0, 151.0, 149.0, 129.0, 171.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 163.0, 161.0, 162.0, 164.0, 164.0, 162.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 156.0, 76.0, 75.0, 76.0, 77.0, 162.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.6}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 147.0, 92.0, 93.0, 93.0, 150.0, 94.0, 94.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 150.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 101.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 61.0, 58.0, 57.0, 58.0, 61.0, 57.0, 67.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 85.0, 81.0, 80.0, 80.0, 77.0, 78.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [114.0, 112.0, 119.0, 113.0, 120.0, 112.0, 134.0, 113.0, 115.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [136.0, 145.0, 151.0, 160.0, 145.0, 148.0, 143.0, 145.0, 151.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1519.8}]} 17:13:49 INFO - Return code: 0 17:13:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:49 ERROR - # TBPL SUCCESS # 17:13:49 INFO - Running post-action listener: _resource_record_post_action 17:13:49 INFO - Running post-run listener: _resource_record_post_run 17:13:51 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 459608064; Read time: 16; Write time: 363288 17:13:51 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237654016; Read time: 0; Write time: 256804 17:13:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 221515776; Read time: 16; Write time: 106460 17:13:51 INFO - Running post-run listener: _upload_blobber_files 17:13:51 INFO - Blob upload gear active. 17:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:51 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:51 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:51 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:52 INFO - (blobuploader) - INFO - Done attempting. 17:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:53 INFO - (blobuploader) - INFO - Done attempting. 17:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:53 INFO - Return code: 0 17:13:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1194d9e20a265da790ae937e673ed7f0f2ca2b14f19d21247544dce46abeda72097119b6553c0902e8709c03f70bb329098c2e4db1e01ee0ecdf958301aec87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f00b7ca1865f5b78473c84855f4aab4814a2d2d66dad784f09b2a96cc5ac26aefec32a310f8fa061f411549abf0d92296962dbcbfbb2253c92a53b874c525fea"} 17:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:53 INFO - Contents: 17:13:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1194d9e20a265da790ae937e673ed7f0f2ca2b14f19d21247544dce46abeda72097119b6553c0902e8709c03f70bb329098c2e4db1e01ee0ecdf958301aec87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f00b7ca1865f5b78473c84855f4aab4814a2d2d66dad784f09b2a96cc5ac26aefec32a310f8fa061f411549abf0d92296962dbcbfbb2253c92a53b874c525fea"} 17:13:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:53 INFO - Copying logs to upload dir... 17:13:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.071321 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-30 17:13:52.949771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:52.952841) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1194d9e20a265da790ae937e673ed7f0f2ca2b14f19d21247544dce46abeda72097119b6553c0902e8709c03f70bb329098c2e4db1e01ee0ecdf958301aec87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f00b7ca1865f5b78473c84855f4aab4814a2d2d66dad784f09b2a96cc5ac26aefec32a310f8fa061f411549abf0d92296962dbcbfbb2253c92a53b874c525fea"} 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.011384 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1194d9e20a265da790ae937e673ed7f0f2ca2b14f19d21247544dce46abeda72097119b6553c0902e8709c03f70bb329098c2e4db1e01ee0ecdf958301aec87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f00b7ca1865f5b78473c84855f4aab4814a2d2d66dad784f09b2a96cc5ac26aefec32a310f8fa061f411549abf0d92296962dbcbfbb2253c92a53b874c525fea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:52.978277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:52.978602) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464652409.324333-1707483693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:53.062326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:13:53.062655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:13:53.062936) ========= ========= Total master_lag: 0.17 =========