builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1465288870.12 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.123174) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.124098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.124784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.157653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.157969) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 01:41:10-- 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% 30.2M=0s 2016-06-07 01:41:10 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084811 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.260299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.261016) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.314027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:10.314906) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 01:41:10,784 truncating revision to first 12 chars 2016-06-07 01:41:10,784 Setting DEBUG logging. 2016-06-07 01:41:10,785 attempt 1/10 2016-06-07 01:41:10,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:41:11,107 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665272 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:11.022511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:11.022863) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:11.023290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:11.023586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:41:11.034110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-07 01:41:11.034408) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:41:11 INFO - MultiFileLogger online at 20160607 01:41:11 in /builds/slave/test 01:41:11 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 01:41:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:41:11 INFO - {'append_to_log': False, 01:41:11 INFO - 'base_work_dir': '/builds/slave/test', 01:41:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:41:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:41:11 INFO - 'branch': 'Mozilla-Beta', 01:41:11 INFO - 'buildbot_json_path': 'buildprops.json', 01:41:11 INFO - 'config_files': ('talos/linux_config.py',), 01:41:11 INFO - 'default_actions': ('clobber', 01:41:11 INFO - 'read-buildbot-config', 01:41:11 INFO - 'download-and-extract', 01:41:11 INFO - 'populate-webroot', 01:41:11 INFO - 'create-virtualenv', 01:41:11 INFO - 'install', 01:41:11 INFO - 'run-tests'), 01:41:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:41:11 INFO - 'download_minidump_stackwalk': True, 01:41:11 INFO - 'download_symbols': 'ondemand', 01:41:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:41:11 INFO - 'tooltool.py': '/tools/tooltool.py', 01:41:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:41:11 INFO - '/tools/misc-python/virtualenv.py')}, 01:41:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:41:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:41:11 INFO - 'installer_path': 'installer.exe', 01:41:11 INFO - 'log_level': 'info', 01:41:11 INFO - 'log_name': 'talos', 01:41:11 INFO - 'log_to_console': True, 01:41:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:41:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:41:11 INFO - 'opt_config_files': (), 01:41:11 INFO - 'pip_index': False, 01:41:11 INFO - 'sps_profile': False, 01:41:11 INFO - 'sps_profile_interval': 0, 01:41:11 INFO - 'suite': 'dromaeojs-e10s', 01:41:11 INFO - 'system_bits': '32', 01:41:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:41:11 INFO - 'title': 'talos-linux64-ix-067', 01:41:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:41:11 INFO - 'use_talos_json': True, 01:41:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:41:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:41:11 INFO - 'work_dir': 'build'} 01:41:11 INFO - ##### 01:41:11 INFO - ##### Running clobber step. 01:41:11 INFO - ##### 01:41:11 INFO - Running pre-action listener: _resource_record_pre_action 01:41:11 INFO - Running main action method: clobber 01:41:11 INFO - rmtree: /builds/slave/test/build 01:41:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - ##### 01:41:12 INFO - ##### Running read-buildbot-config step. 01:41:12 INFO - ##### 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: read_buildbot_config 01:41:12 INFO - Using buildbot properties: 01:41:12 INFO - { 01:41:12 INFO - "project": "", 01:41:12 INFO - "product": "firefox", 01:41:12 INFO - "script_repo_revision": "production", 01:41:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 01:41:12 INFO - "repository": "", 01:41:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 01:41:12 INFO - "buildid": "20160606120332", 01:41:12 INFO - "pgo_build": "True", 01:41:12 INFO - "basedir": "/builds/slave/test", 01:41:12 INFO - "buildnumber": 132, 01:41:12 INFO - "slavename": "talos-linux64-ix-067", 01:41:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:41:12 INFO - "platform": "ubuntu64_hw", 01:41:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:41:12 INFO - "branch": "mozilla-beta", 01:41:12 INFO - "repo_path": "releases/mozilla-beta", 01:41:12 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:41:12 INFO - "stage_platform": "linux64-pgo", 01:41:12 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:41:12 INFO - "slavebuilddir": "test" 01:41:12 INFO - } 01:41:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - ##### 01:41:12 INFO - ##### Running download-and-extract step. 01:41:12 INFO - ##### 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: download_and_extract 01:41:12 INFO - mkdir: /builds/slave/test/build/tests 01:41:12 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')]} 01:41:12 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:41:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:41:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:41:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:41:13 INFO - Downloaded 1327 bytes. 01:41:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:41:13 INFO - Using the following test package requirements: 01:41:13 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:41:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:41:13 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 01:41:13 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'jsshell-linux-x86_64.zip'], 01:41:13 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:41:13 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:41:13 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 01:41:13 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 01:41:13 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:41:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:41:13 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:41:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:13 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:41:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:41:14 INFO - Downloaded 24177984 bytes. 01:41:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:41:15 INFO - Return code: 0 01:41:15 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:41:15 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')]} 01:41:15 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:41:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:41:16 INFO - Downloaded 24177984 bytes. 01:41:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:41:18 INFO - Return code: 0 01:41: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')]} 01:41:18 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:41:19 INFO - Downloaded 10840145 bytes. 01:41:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:41:19 INFO - Return code: 0 01:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:19 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:41:20 INFO - Downloaded 56008216 bytes. 01:41:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:41:20 INFO - mkdir: /builds/slave/test/properties 01:41:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:41:20 INFO - Writing to file /builds/slave/test/properties/build_url 01:41:20 INFO - Contents: 01:41:20 INFO - build_url:https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:41:21 INFO - Running post-action listener: _resource_record_post_action 01:41:21 INFO - Running post-action listener: set_extra_try_arguments 01:41:21 INFO - ##### 01:41:21 INFO - ##### Running populate-webroot step. 01:41:21 INFO - ##### 01:41:21 INFO - Running pre-action listener: _resource_record_pre_action 01:41:21 INFO - Running main action method: populate_webroot 01:41:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:41:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:41:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:41:21 INFO - '--tppagecycles', 01:41:21 INFO - '7'], 01:41:21 INFO - 'tests': ['tsvgm']}}, 01:41:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:41:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:41:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:41:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:41:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['damp', 'tps']}, 01:41:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'tests': ['damp', 'tps']}, 01:41:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['dromaeo_dom']}, 01:41:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:41:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'other-e10s': {'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['a11yr', 01:41:21 INFO - 'ts_paint', 01:41:21 INFO - 'tpaint', 01:41:21 INFO - 'sessionrestore', 01:41:21 INFO - 'sessionrestore_no_auto_restore', 01:41:21 INFO - 'tabpaint']}, 01:41:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['tsvgx', 01:41:21 INFO - 'tsvgr_opacity', 01:41:21 INFO - 'tart', 01:41:21 INFO - 'tscrollx', 01:41:21 INFO - 'cart']}, 01:41:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:41:21 INFO - 'tsvgr_opacity', 01:41:21 INFO - 'tart', 01:41:21 INFO - 'tscrollx', 01:41:21 INFO - 'cart']}, 01:41:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'talos_options': ['--disable-e10s'], 01:41:21 INFO - 'tests': ['tp5o']}, 01:41:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'tests': ['tp5o']}, 01:41:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'talos_options': ['--disable-e10s', 01:41:21 INFO - '--xperf_path', 01:41:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:21 INFO - 'tests': ['tp5n']}, 01:41:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:21 INFO - 'talos_options': ['--xperf_path', 01:41:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:21 INFO - 'tests': ['tp5n']}}, 01:41:21 INFO - 'talos.zip': {'path': '', 01:41:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:41:21 INFO - Running post-action listener: _resource_record_post_action 01:41:21 INFO - ##### 01:41:21 INFO - ##### Running create-virtualenv step. 01:41:21 INFO - ##### 01:41:21 INFO - Running pre-action listener: _resource_record_pre_action 01:41:21 INFO - Running main action method: create_virtualenv 01:41:21 INFO - Creating virtualenv /builds/slave/test/build/venv 01:41:21 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 01:41:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:41:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:41:21 INFO - Using real prefix '/usr' 01:41:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:41:22 INFO - Installing distribute.............................................................................................................................................................................................done. 01:41:24 INFO - Installing pip.................done. 01:41:24 INFO - Return code: 0 01:41:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:24 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:24 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 01:41:24 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 01:41:24 INFO - Using env: {'DISPLAY': ':0', 01:41:24 INFO - 'HOME': '/home/cltbld', 01:41:24 INFO - 'LANG': 'en_US.UTF-8', 01:41:24 INFO - 'LANGUAGE': 'en_US:en', 01:41:24 INFO - 'LOGNAME': 'cltbld', 01:41:24 INFO - 'MAIL': '/var/mail/cltbld', 01:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:24 INFO - 'MOZ_NO_REMOTE': '1', 01:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:24 INFO - 'NO_EM_RESTART': '1', 01:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:24 INFO - 'PWD': '/builds/slave/test', 01:41:24 INFO - 'SHELL': '/bin/bash', 01:41:24 INFO - 'SHLVL': '1', 01:41:24 INFO - 'TERM': 'linux', 01:41:24 INFO - 'TMOUT': '86400', 01:41:24 INFO - 'USER': 'cltbld', 01:41:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:24 INFO - '_': '/tools/buildbot/bin/python'} 01:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:24 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 01:41:24 INFO - Cleaning up... 01:41:24 INFO - Return code: 0 01:41:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:24 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:24 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 01:41:24 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 01:41:24 INFO - Using env: {'DISPLAY': ':0', 01:41:24 INFO - 'HOME': '/home/cltbld', 01:41:24 INFO - 'LANG': 'en_US.UTF-8', 01:41:24 INFO - 'LANGUAGE': 'en_US:en', 01:41:24 INFO - 'LOGNAME': 'cltbld', 01:41:24 INFO - 'MAIL': '/var/mail/cltbld', 01:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:24 INFO - 'MOZ_NO_REMOTE': '1', 01:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:24 INFO - 'NO_EM_RESTART': '1', 01:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:24 INFO - 'PWD': '/builds/slave/test', 01:41:24 INFO - 'SHELL': '/bin/bash', 01:41:24 INFO - 'SHLVL': '1', 01:41:24 INFO - 'TERM': 'linux', 01:41:24 INFO - 'TMOUT': '86400', 01:41:24 INFO - 'USER': 'cltbld', 01:41:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:24 INFO - '_': '/tools/buildbot/bin/python'} 01:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:24 INFO - Downloading/unpacking psutil>=0.7.1 01:41:24 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 01:41:24 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 01:41:24 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 01:41:24 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 01:41:24 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 01:41:24 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 01:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:41:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:26 INFO - Installing collected packages: psutil 01:41:26 INFO - Running setup.py install for psutil 01:41:26 INFO - building 'psutil._psutil_linux' extension 01:41:26 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 01:41:26 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 01:41:26 INFO - building 'psutil._psutil_posix' extension 01:41:26 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 01:41:27 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 01:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:27 INFO - Successfully installed psutil 01:41:27 INFO - Cleaning up... 01:41:27 INFO - Return code: 0 01:41:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:41:27 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')]} 01:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:27 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')]} 01:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:27 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:27 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 01:41:27 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 01:41:27 INFO - Using env: {'DISPLAY': ':0', 01:41:27 INFO - 'HOME': '/home/cltbld', 01:41:27 INFO - 'LANG': 'en_US.UTF-8', 01:41:27 INFO - 'LANGUAGE': 'en_US:en', 01:41:27 INFO - 'LOGNAME': 'cltbld', 01:41:27 INFO - 'MAIL': '/var/mail/cltbld', 01:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:27 INFO - 'MOZ_NO_REMOTE': '1', 01:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:27 INFO - 'NO_EM_RESTART': '1', 01:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:27 INFO - 'PWD': '/builds/slave/test', 01:41:27 INFO - 'SHELL': '/bin/bash', 01:41:27 INFO - 'SHLVL': '1', 01:41:27 INFO - 'TERM': 'linux', 01:41:27 INFO - 'TMOUT': '86400', 01:41:27 INFO - 'USER': 'cltbld', 01:41:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:27 INFO - '_': '/tools/buildbot/bin/python'} 01:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:41:27 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 01:41:27 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 01:41:27 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 01:41:27 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 01:41:27 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 01:41:27 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 01:41:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:41:29 INFO - Installing collected packages: mozsystemmonitor 01:41:29 INFO - Running setup.py install for mozsystemmonitor 01:41:29 INFO - Successfully installed mozsystemmonitor 01:41:29 INFO - Cleaning up... 01:41:29 INFO - Return code: 0 01:41:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:29 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:29 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 01:41:29 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 01:41:29 INFO - Using env: {'DISPLAY': ':0', 01:41:29 INFO - 'HOME': '/home/cltbld', 01:41:29 INFO - 'LANG': 'en_US.UTF-8', 01:41:29 INFO - 'LANGUAGE': 'en_US:en', 01:41:29 INFO - 'LOGNAME': 'cltbld', 01:41:29 INFO - 'MAIL': '/var/mail/cltbld', 01:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:29 INFO - 'MOZ_NO_REMOTE': '1', 01:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:29 INFO - 'NO_EM_RESTART': '1', 01:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:29 INFO - 'PWD': '/builds/slave/test', 01:41:29 INFO - 'SHELL': '/bin/bash', 01:41:29 INFO - 'SHLVL': '1', 01:41:29 INFO - 'TERM': 'linux', 01:41:29 INFO - 'TMOUT': '86400', 01:41:29 INFO - 'USER': 'cltbld', 01:41:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:29 INFO - '_': '/tools/buildbot/bin/python'} 01:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:29 INFO - Downloading/unpacking blobuploader==1.2.4 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:29 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 01:41:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:41:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:41:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:31 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 01:41:32 INFO - Downloading docopt-0.6.1.tar.gz 01:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:41:32 INFO - Installing collected packages: blobuploader, requests, docopt 01:41:32 INFO - Running setup.py install for blobuploader 01:41:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:41:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:41:32 INFO - Running setup.py install for requests 01:41:32 INFO - Running setup.py install for docopt 01:41:32 INFO - Successfully installed blobuploader requests docopt 01:41:32 INFO - Cleaning up... 01:41:32 INFO - Return code: 0 01:41:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:32 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:32 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 01:41:32 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 01:41:32 INFO - Using env: {'DISPLAY': ':0', 01:41:32 INFO - 'HOME': '/home/cltbld', 01:41:32 INFO - 'LANG': 'en_US.UTF-8', 01:41:32 INFO - 'LANGUAGE': 'en_US:en', 01:41:32 INFO - 'LOGNAME': 'cltbld', 01:41:32 INFO - 'MAIL': '/var/mail/cltbld', 01:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:32 INFO - 'MOZ_NO_REMOTE': '1', 01:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:32 INFO - 'NO_EM_RESTART': '1', 01:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:32 INFO - 'PWD': '/builds/slave/test', 01:41:32 INFO - 'SHELL': '/bin/bash', 01:41:32 INFO - 'SHLVL': '1', 01:41:32 INFO - 'TERM': 'linux', 01:41:32 INFO - 'TMOUT': '86400', 01:41:32 INFO - 'USER': 'cltbld', 01:41:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:32 INFO - '_': '/tools/buildbot/bin/python'} 01:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:33 INFO - Running setup.py (path:/tmp/pip-Vs4n3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:33 INFO - Running setup.py (path:/tmp/pip-XD6li9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:33 INFO - Running setup.py (path:/tmp/pip-8WvUCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:33 INFO - Running setup.py (path:/tmp/pip-fEUN0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:33 INFO - Running setup.py (path:/tmp/pip-2S9Ehw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:33 INFO - Running setup.py (path:/tmp/pip-qvt4DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:33 INFO - Running setup.py (path:/tmp/pip-h_Y831-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:33 INFO - Running setup.py (path:/tmp/pip-qG9JaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:33 INFO - Running setup.py (path:/tmp/pip-1k8eXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:33 INFO - Running setup.py (path:/tmp/pip-JPIX8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:33 INFO - Running setup.py (path:/tmp/pip-RZuBLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:33 INFO - Running setup.py (path:/tmp/pip-7_SPlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:33 INFO - Running setup.py (path:/tmp/pip-ZHydjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:34 INFO - Running setup.py (path:/tmp/pip-7B87pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:34 INFO - Running setup.py (path:/tmp/pip-k2OCJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:34 INFO - Running setup.py (path:/tmp/pip-dUkc5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:34 INFO - Running setup.py (path:/tmp/pip-jXrYXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:34 INFO - Running setup.py install for manifestparser 01:41:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:34 INFO - Running setup.py install for mozcrash 01:41:34 INFO - Running setup.py install for mozdebug 01:41:34 INFO - Running setup.py install for mozdevice 01:41:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:34 INFO - Running setup.py install for mozfile 01:41:34 INFO - Running setup.py install for mozhttpd 01:41:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:34 INFO - Running setup.py install for mozinfo 01:41:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for mozInstall 01:41:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for mozleak 01:41:35 INFO - Running setup.py install for mozlog 01:41:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for moznetwork 01:41:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for mozprocess 01:41:35 INFO - Running setup.py install for mozprofile 01:41:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for mozrunner 01:41:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:35 INFO - Running setup.py install for mozscreenshot 01:41:35 INFO - Running setup.py install for moztest 01:41:35 INFO - Running setup.py install for mozversion 01:41:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:36 INFO - Cleaning up... 01:41:36 INFO - Return code: 0 01:41:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:36 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')]} 01:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:36 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')]} 01:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:36 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:36 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 01:41:36 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 01:41:36 INFO - Using env: {'DISPLAY': ':0', 01:41:36 INFO - 'HOME': '/home/cltbld', 01:41:36 INFO - 'LANG': 'en_US.UTF-8', 01:41:36 INFO - 'LANGUAGE': 'en_US:en', 01:41:36 INFO - 'LOGNAME': 'cltbld', 01:41:36 INFO - 'MAIL': '/var/mail/cltbld', 01:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:36 INFO - 'MOZ_NO_REMOTE': '1', 01:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:36 INFO - 'NO_EM_RESTART': '1', 01:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:36 INFO - 'PWD': '/builds/slave/test', 01:41:36 INFO - 'SHELL': '/bin/bash', 01:41:36 INFO - 'SHLVL': '1', 01:41:36 INFO - 'TERM': 'linux', 01:41:36 INFO - 'TMOUT': '86400', 01:41:36 INFO - 'USER': 'cltbld', 01:41:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:36 INFO - '_': '/tools/buildbot/bin/python'} 01:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:36 INFO - Running setup.py (path:/tmp/pip-IfzWH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:36 INFO - Running setup.py (path:/tmp/pip-PAUsRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:36 INFO - Running setup.py (path:/tmp/pip-3ddr68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:36 INFO - Running setup.py (path:/tmp/pip-GbdZSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:36 INFO - Running setup.py (path:/tmp/pip-O326x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:36 INFO - Running setup.py (path:/tmp/pip-t08RgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:36 INFO - Running setup.py (path:/tmp/pip-TmODxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:36 INFO - Running setup.py (path:/tmp/pip-2VrpAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:36 INFO - Running setup.py (path:/tmp/pip-sAfAUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:36 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)) 01:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:36 INFO - Running setup.py (path:/tmp/pip-zm5HNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:37 INFO - Running setup.py (path:/tmp/pip-z7Y6yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:37 INFO - Running setup.py (path:/tmp/pip-9xSeHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:37 INFO - Running setup.py (path:/tmp/pip-RflWFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:37 INFO - Running setup.py (path:/tmp/pip-KiBhUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:37 INFO - Running setup.py (path:/tmp/pip-L77J9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:37 INFO - Running setup.py (path:/tmp/pip-aILQUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:37 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)) 01:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:37 INFO - Running setup.py (path:/tmp/pip-m7iaup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:37 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)) 01:41:37 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)) 01:41:37 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)) 01:41:37 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)) 01:41:37 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)) 01:41:37 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)) 01:41:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:37 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 01:41:37 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 01:41:37 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 01:41:37 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 01:41:37 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 01:41:37 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 01:41:39 INFO - Downloading blessings-1.6.tar.gz 01:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:39 INFO - Installing collected packages: blessings 01:41:39 INFO - Running setup.py install for blessings 01:41:39 INFO - Successfully installed blessings 01:41:39 INFO - Cleaning up... 01:41:39 INFO - Return code: 0 01:41:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:39 INFO - Reading from file tmpfile_stdout 01:41:39 INFO - Current package versions: 01:41:39 INFO - argparse == 1.2.1 01:41:39 INFO - blessings == 1.6 01:41:39 INFO - blobuploader == 1.2.4 01:41:39 INFO - docopt == 0.6.1 01:41:39 INFO - manifestparser == 1.1 01:41:39 INFO - mozInstall == 1.12 01:41:39 INFO - mozcrash == 0.17 01:41:39 INFO - mozdebug == 0.1 01:41:39 INFO - mozdevice == 0.48 01:41:39 INFO - mozfile == 1.2 01:41:39 INFO - mozhttpd == 0.7 01:41:39 INFO - mozinfo == 0.9 01:41:39 INFO - mozleak == 0.1 01:41:39 INFO - mozlog == 3.1 01:41:39 INFO - moznetwork == 0.27 01:41:39 INFO - mozprocess == 0.22 01:41:39 INFO - mozprofile == 0.28 01:41:39 INFO - mozrunner == 6.11 01:41:39 INFO - mozscreenshot == 0.1 01:41:39 INFO - mozsystemmonitor == 0.0 01:41:39 INFO - moztest == 0.7 01:41:39 INFO - mozversion == 1.4 01:41:39 INFO - psutil == 3.1.1 01:41:39 INFO - requests == 1.2.3 01:41:39 INFO - wsgiref == 0.1.2 01:41:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:39 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:39 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 01:41:39 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 01:41:39 INFO - Using env: {'DISPLAY': ':0', 01:41:39 INFO - 'HOME': '/home/cltbld', 01:41:39 INFO - 'LANG': 'en_US.UTF-8', 01:41:39 INFO - 'LANGUAGE': 'en_US:en', 01:41:39 INFO - 'LOGNAME': 'cltbld', 01:41:39 INFO - 'MAIL': '/var/mail/cltbld', 01:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:39 INFO - 'MOZ_NO_REMOTE': '1', 01:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:39 INFO - 'NO_EM_RESTART': '1', 01:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:39 INFO - 'PWD': '/builds/slave/test', 01:41:39 INFO - 'SHELL': '/bin/bash', 01:41:39 INFO - 'SHLVL': '1', 01:41:39 INFO - 'TERM': 'linux', 01:41:39 INFO - 'TMOUT': '86400', 01:41:39 INFO - 'USER': 'cltbld', 01:41:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:39 INFO - '_': '/tools/buildbot/bin/python'} 01:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 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)) 01:41:40 INFO - Cleaning up... 01:41:40 INFO - Return code: 0 01:41:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:40 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:40 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 01:41:40 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 01:41:40 INFO - Using env: {'DISPLAY': ':0', 01:41:40 INFO - 'HOME': '/home/cltbld', 01:41:40 INFO - 'LANG': 'en_US.UTF-8', 01:41:40 INFO - 'LANGUAGE': 'en_US:en', 01:41:40 INFO - 'LOGNAME': 'cltbld', 01:41:40 INFO - 'MAIL': '/var/mail/cltbld', 01:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:40 INFO - 'MOZ_NO_REMOTE': '1', 01:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:40 INFO - 'NO_EM_RESTART': '1', 01:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:40 INFO - 'PWD': '/builds/slave/test', 01:41:40 INFO - 'SHELL': '/bin/bash', 01:41:40 INFO - 'SHLVL': '1', 01:41:40 INFO - 'TERM': 'linux', 01:41:40 INFO - 'TMOUT': '86400', 01:41:40 INFO - 'USER': 'cltbld', 01:41:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:40 INFO - '_': '/tools/buildbot/bin/python'} 01:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:40 INFO - Downloading/unpacking jsonschema 01:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:42 INFO - Downloading/unpacking functools32 (from jsonschema) 01:41:42 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 01:41:42 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 01:41:42 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 01:41:42 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 01:41:42 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 01:41:42 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 01:41:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:42 INFO - warning: no files found matching '*.txt' 01:41:42 INFO - no previously-included directories found matching 'build' 01:41:42 INFO - no previously-included directories found matching 'dist' 01:41:42 INFO - no previously-included directories found matching '.git*' 01:41:42 INFO - Installing collected packages: jsonschema, functools32 01:41:42 INFO - Running setup.py install for functools32 01:41:42 INFO - warning: no files found matching '*.txt' 01:41:42 INFO - no previously-included directories found matching 'build' 01:41:42 INFO - no previously-included directories found matching 'dist' 01:41:42 INFO - no previously-included directories found matching '.git*' 01:41:42 INFO - Successfully installed jsonschema functools32 01:41:42 INFO - Cleaning up... 01:41:42 INFO - Return code: 0 01:41:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:42 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 0x7fd8f6e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', '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 01:41:42 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 01:41:42 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 01:41:42 INFO - Using env: {'DISPLAY': ':0', 01:41:42 INFO - 'HOME': '/home/cltbld', 01:41:42 INFO - 'LANG': 'en_US.UTF-8', 01:41:42 INFO - 'LANGUAGE': 'en_US:en', 01:41:42 INFO - 'LOGNAME': 'cltbld', 01:41:42 INFO - 'MAIL': '/var/mail/cltbld', 01:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:42 INFO - 'MOZ_NO_REMOTE': '1', 01:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:42 INFO - 'NO_EM_RESTART': '1', 01:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:42 INFO - 'PWD': '/builds/slave/test', 01:41:42 INFO - 'SHELL': '/bin/bash', 01:41:42 INFO - 'SHLVL': '1', 01:41:42 INFO - 'TERM': 'linux', 01:41:42 INFO - 'TMOUT': '86400', 01:41:42 INFO - 'USER': 'cltbld', 01:41:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:42 INFO - '_': '/tools/buildbot/bin/python'} 01:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:43 INFO - Downloading/unpacking flake8 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:41:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:41:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 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 01:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:41:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:45 INFO - no previously-included directories found matching 'docs/_build' 01:41:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:41:45 INFO - Running setup.py install for pep8 01:41:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:45 INFO - no previously-included directories found matching 'docs/_build' 01:41:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:41:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:41:45 INFO - Cleaning up... 01:41:45 INFO - Return code: 0 01:41:45 INFO - Running post-action listener: _resource_record_post_action 01:41:45 INFO - Running post-action listener: _start_resource_monitoring 01:41:46 INFO - Starting resource monitoring. 01:41:46 INFO - ##### 01:41:46 INFO - ##### Running install step. 01:41:46 INFO - ##### 01:41:46 INFO - Running pre-action listener: _resource_record_pre_action 01:41:46 INFO - Running main action method: install 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:46 INFO - Reading from file tmpfile_stdout 01:41:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:46 INFO - Reading from file tmpfile_stdout 01:41:46 INFO - Output received: 01:41:46 INFO - Usage: mozinstall [options] installer 01:41:46 INFO - Options: 01:41:46 INFO - -h, --help show this help message and exit 01:41:46 INFO - -d DEST, --destination=DEST 01:41:46 INFO - Directory to install application into. [default: 01:41:46 INFO - "/builds/slave/test"] 01:41:46 INFO - --app=APP Application being installed. [default: firefox] 01:41:46 INFO - mkdir: /builds/slave/test/build/application 01:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:41:59 INFO - Reading from file tmpfile_stdout 01:41:59 INFO - Output received: 01:41:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:41:59 INFO - Running post-action listener: _resource_record_post_action 01:41:59 INFO - ##### 01:41:59 INFO - ##### Running run-tests step. 01:41:59 INFO - ##### 01:41:59 INFO - Running pre-action listener: _resource_record_pre_action 01:41:59 INFO - Running main action method: run_tests 01:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:41:59 INFO - Python 2.7.3 01:41:59 INFO - Return code: 0 01:41:59 INFO - grabbing minidump binary from tooltool 01:41: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')]} 01:41:59 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 0x14de410>, '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 0x14df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:41:59 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 01:41:59 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 01:41:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:59 INFO - Return code: 0 01:41:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:41:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:41:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:41:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:41:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:42:00 INFO - Return code: 0 01:42:00 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 01:42:00 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 01:42:00 INFO - Using env: {'DISPLAY': ':0', 01:42:00 INFO - 'HOME': '/home/cltbld', 01:42:00 INFO - 'LANG': 'en_US.UTF-8', 01:42:00 INFO - 'LANGUAGE': 'en_US:en', 01:42:00 INFO - 'LOGNAME': 'cltbld', 01:42:00 INFO - 'MAIL': '/var/mail/cltbld', 01:42:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:42:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:00 INFO - 'MOZ_NO_REMOTE': '1', 01:42:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:00 INFO - 'NO_EM_RESTART': '1', 01:42:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:00 INFO - 'PWD': '/builds/slave/test', 01:42:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:42:00 INFO - 'SHELL': '/bin/bash', 01:42:00 INFO - 'SHLVL': '1', 01:42:00 INFO - 'TERM': 'linux', 01:42:00 INFO - 'TMOUT': '86400', 01:42:00 INFO - 'USER': 'cltbld', 01:42:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315', 01:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:00 INFO - '_': '/tools/buildbot/bin/python'} 01:42:00 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 01:42:00 INFO - mozversion application_buildid: 20160606120332 01:42:00 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:42:00 INFO - mozversion application_display_name: Firefox 01:42:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:42:00 INFO - mozversion application_name: Firefox 01:42:00 INFO - mozversion application_remotingname: firefox 01:42:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:42:00 INFO - mozversion application_vendor: Mozilla 01:42:00 INFO - mozversion application_version: 48.0 01:42:00 INFO - mozversion platform_buildid: 20160606120332 01:42:00 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:42:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:42:00 INFO - mozversion platform_version: 48.0 01:42:00 INFO - using testdate: 1465288920 01:42:00 INFO - actual date: 1465288920 01:42:00 INFO - starting webserver on 'localhost:45216' 01:42:00 INFO - SUITE-START | Running 2 tests 01:42:00 INFO - TEST-START | dromaeo_css 01:42:00 INFO - operating with platform_type : linux_ 01:42:00 INFO - Initialising browser for dromaeo_css test... 01:42:00 INFO - TEST-INFO | started process 13772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtH9gs/profile http://localhost:45216/getInfo.html) 01:42:04 INFO - PROCESS | 13772 | 01:42:04 INFO - PROCESS | 13772 | (process:13849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:42:05 INFO - PROCESS | 13772 | __metrics Screen width/height:1600/1200 01:42:05 INFO - PROCESS | 13772 | colorDepth:24 01:42:05 INFO - PROCESS | 13772 | Browser inner width/height: 1024/697 01:42:05 INFO - PROCESS | 13772 | __metrics 01:42:05 ERROR - PROCESS | 13772 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:42:06 INFO - TEST-INFO | 13772: exit 0 01:42:06 INFO - Browser initialized. 01:42:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:42:06 INFO - TEST-INFO | started process 13899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtH9gs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:42:08 INFO - PROCESS | 13899 | 01:42:08 INFO - PROCESS | 13899 | (process:13969): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:42:18 INFO - PROCESS | 13899 | RSS: Main: 151400448 01:42:18 INFO - PROCESS | 13899 | 01:43:07 INFO - PROCESS | 13899 | 1465288987809 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] 01:45:15 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45216/tests/dromaeo/cssquery-ext.html) 01:45:16 INFO - PROCESS | 13899 | RSS: Main: 155639808 01:45:16 INFO - PROCESS | 13899 | 01:48:17 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-ext.html (next: http://localhost:45216/tests/dromaeo/cssquery-jquery.html) 01:48:18 INFO - PROCESS | 13899 | RSS: Main: 153243648 01:48:18 INFO - PROCESS | 13899 | 01:51:20 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45216/tests/dromaeo/cssquery-mootools.html) 01:51:20 INFO - PROCESS | 13899 | RSS: Main: 153006080 01:51:20 INFO - PROCESS | 13899 | 01:54:22 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45216/tests/dromaeo/cssquery-prototype.html) 01:54:23 INFO - PROCESS | 13899 | RSS: Main: 154402816 01:54:23 INFO - PROCESS | 13899 | 01:57:25 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45216/tests/dromaeo/cssquery-yui.html) 01:57:25 INFO - PROCESS | 13899 | RSS: Main: 152756224 01:57:25 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:45216/tests/dromaeo/cssquery-yui.html (next: http://localhost:45216/tests/dromaeo/cssquery-dojo.html) 02:00:28 INFO - PROCESS | 13899 | RSS: Main: 156561408 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | __start_tp_report 02:00:28 INFO - PROCESS | 13899 | _x_x_mozilla_page_load 02:00:28 INFO - PROCESS | 13899 | _x_x_mozilla_page_load_details 02:00:28 INFO - PROCESS | 13899 | |i|pagename|runs| 02:00:28 INFO - PROCESS | 13899 | |0;dojo.html;3298.4227760141976;3340.2317466982577;3366.1584603849037;3394.983025084874;3399.6770306820845;5579.6652200867975;5606.299212598426;5622.915656265154;5632.464915832999;5634.943650563493;5598.384177740456;5625.38120806712;5631.380548139701;5639.351474580424;5650.51970582501;5071.6703414278045;5100.642954993152;5119.7952081916865;5121.359830021247;5164.147915593922;5048.873778155557;5101.872453188681;5174.456682048387;5199.090159222121;5206.114960456713;5083.440821509631;5114.335136432277;5127.820526281581;5143.562797162245;5150.3047088642925;5104.6937183768905;5105.770240339175;5118.718470484122;5132.743362831843;5154.845354639367;4934.432540257881;4978.87552811179;5011.974940125312;5047.293378926916;5109.514596113363;5454.481824226692;5463.808766693147;5466.535344495683;5474.507294343528;5546.334439867242;5974.940250597482;6005;6006.939930600725;6009.939900601025;6014.6391216527145;5778.393268706809;5907.054871220584;5949.0481522956115;6048.969755151196;6051.606645568024;5648.9152662709685;5653.519450846683;5655.321361436613;5669.489745922846;5680.857978550569;6136.478399336106;6140.201773769381;6141.048137538689;6143.539234557426;6177.382261773877;5729.799457019068;5868.119782032729;5943.732532036069;5974.581779275496;5993.130996005642;6023.156758053876;6023.216981792339;6029.728662210211;6029.909551356734;6035.155078289043;5933.436323549256;5972.552058595623;5974.462298393166;5984.31180414258;5988.3113441953865;5819.039858423313;5919.200907877382;6038.486728628028;6044.425779550936;6079.6960151992225;4565.931511027337;4574.4968053514085;4576.427946506687;4580.312953057001;4605.907881842344;3971.801409929492;4105.548389677133;4109;4114.321137012359;4128.793560322032;5637.577181711388;5734.655920644691;5783.277090363705;5809.186713860063;5821.2141360916585;6030.396960303934;6044.15381846533;6044.274687037584;6061.212042434456;6074;5556.388797232301;5743.396943320975;5805.88388232233;5813.360530341659;5813.970930145322;5185.818496352609;5196.636235463557;5203.14148165556;5217.2695822584865;5232.189010703271;6150.477209437158;6199.721012554446;6200.534959878028;6213.161223234896;6218.906716399258;5918.053111502311;6016.969915150396;6069.393060693896;6074.119252708244;6078.483328917003;6187.041008643668;6188.2883468399905;6189;6190.721417536131;6205.131281620667;5948.851278718067;5953.464188223081;5958.880822383615;5961.791337303347;5984.222051133499;5863.853403664943;5989.221401217814;6034.487068599218;6083;6112.877742445037;5900.852478688067;5908.586398952032;5931.495822855106;5935.258092738408;5941.554383421347;5842.3281322646735;5888.205092312654;5895.056790913433;5898.085796701518;5908.586398952032;5596.608237423341;5720.856978575569;5800;5811.360750317546;5814.651120932757;5884.558658100746;5885.14665373527;5893.32226793907;5939.46544810969;5944.3164036136395;5631.211630371833;5763.625364351304;5812.447817457335;5814.953308404528;5820.1560773688425 02:00:28 INFO - PROCESS | 13899 | |1;ext.html;604.7006731667825;653.0954627840441;665.6172700697099;665.7603262825379;667.9499037572181;38373;38900.80549597248;39158.21683566327;39528.80235598825;39604;42872.57127428725;43445.56554434455;43455.78272108643;43468.34797478032;43553.12893742131;8832.60253288602;8974.05772393899;8978.955105224464;8979.012308646044;8994.640214391417;8831.249343805785;8887.644494220256;8946.86579701305;9166.49584272868;9166.67916622915;9139.497327646977;9219.40073895198;9229.123233292827;9270.39742416744;9274.02622724611;9119.270458363348;9148.2681385489;9154.130357616015;9164.816703665889;9223;9138.17756401927;9158.725238242796;9178.678746243917;9191.586378612978;9198.724038278862;43244.56755432437;43724.56275437269;43826.78086609547;43911.34132988008;44018.119637607386;3894.2990261752875;3925.6663183629425;3968.940465893014;3970.8411663533425;3994.7802870842092;33952.83023584891;33978.15054623629;33991.320173596636;34033;34383.312333753434;4663.44038715353;4665.300204969281;4694.990577025922;4707.552782485693;4737.549932756383;314400;316274.9999999977;316844;318573;319080;60346.698266508385;60560.394396055475;60828.69585652043;60864.39135608676;60906.39093609096;64650;68032;68693.3130668687;68736.31263687299;68854.65572672205;16591.087490187914;16674.416395426102;16684.998900066035;16725.581860453585;16728.66542669164;14110.294485275695;14170.64573385653;14170.716585668435;14173.645658858612;14177.362018709182;19607.901960490108;19900.303489377802;19957.101930413166;19972.50068748264;19983.200671972958;7285.635718214068;7451.85096298071;7493.550386976799;7732.7680169595005;7734.1492435832015;1121.9453713509274;1163.662537864027;1166.6616681162538;1206.4932728254155;1227.2881728597392;32000.359992800015;32540.511892321632;32775.67224327774;33050.83474582612;33118.834405827816;1234.3889774561649;1240.7456471423336;1253.360785999147;1266.2782214137853;1391.9025668203128;16887.746683799753;17144.228509717093;17206.39777607803;17289.82710172907;17433.21550530229;497160;509540;572767;576689;582751;55799.16301255485;56622;56708.71645641828;56833.14750278749;56855.715721421126;1480.9851901481063;1491.6569189086572;1495.4915328788263;1511.22927307072;1512.0927443534013;32753;32843.83578082094;33457.49813752747;33567.49648755222;34631.307373852884;53272.46727532675;54147;54289;54316.185257221965;54322.72838635781;435363;437348;437472;439296;439484;30261.394772103995;30404.087877363716;30409.23976900595;30550.236244093187;30837.537436938914;47980;48640;49106;49307.75346123247;50346.49653503418;41534.37698434466;41831.16337673169;41908.79045604752;41981.37027944522;43265.567344326155;41504.45298957951;41756.3736543946;41891.7905410471;41945;42146.78926605347;43180;43351.34972975345;43568.12863742771;44280.778596106815;44342;32687.34625307528;33273.66726332706;33938.830305848314;34088.65911340954;34191.4871276936;27943;29548.261293467836;29810.850945745133;29821.5526767103;29835.254118647208 02:00:28 INFO - PROCESS | 13899 | |2;jquery.html;403.7375705791236;419.60766683151274;420.31908308540153;422.54365285491673;423.2973264381127;18999.240030398803;19075.809241907577;19492.61014779707;19736.309229176964;19778.7033194502;17822.821771782277;18169.273229070823;18653.25386984519;21241.68137477939;21282.36152915411;5801.941980580193;5925.4370834770625;5943.762249510036;5979.431953964367;6012.969935150318;5812.099124635688;5913.793017244398;5946.345901950782;5956.285245770514;5984.222051133368;5886.117082437626;5888.558358123137;5919.2009078774245;5926.170336152921;5936;5726;5883.14694369314;5890.793822216223;5892.292924849045;5896.410358964112;5297.152455607084;5304.257403963448;5304.761285742151;5382.650127741724;5627.437256274381;13812.37844297009;13935.303234838217;13966.650833729136;14037.01740878139;17796.644067118585;2465.2111324376206;2584.160147951923;3043.6043314369213;3093.8453077346267;3145.433821912055;10218.437985910772;10534.525946332433;10623.84064239037;10921.453927303603;11030.724231894186;1988.6917527783216;2059.258666879922;2065.8037486438916;2069.0999415254414;2107.020235590458;52356.73821630906;60641.6967915162;61514.384856151315;69875.65062174707;70453;11468.713282168013;11519.424028798527;11696.47365868538;11821.349825759493;11921;16577;16629.16854157287;16692.08193549342;16712.49862504127;16727.581810454594;8780.912190878138;8939.463632182089;9191.402558833654;9275.16523512887;9322.394044387092;9109.180173784258;9113.270938324918;9208.171264586219;9210.907890921138;9331.440113593206;4950.8762280943265;4968.403791545038;4989.226669866177;5051.924221136685;5056.696598204119;2076.5535409886947;2076.709260703503;2083.624947509463;2105.3999610111046;2167.5231449081175;1036.853712814482;1057.9682609521726;1130.6438471881331;1191.4221602522944;1200.2798321007326;19365.709514357295;19670.803291967182;19884.204631814853;19933.800661993195;20128.59742805136;1087.260662749338;1087.608460954056;1095.0363679961583;1101.1026013798728;1175.1304035014027;11153.10775137987;11510.136739744385;11531.711707207387;11555.711107222218;11589.6523104307;451065.74467127456;453576;457766;458832;469315;77447.22552774513;87995.56002220076;95587.52206238924;95626;95926.52036739772;504.7249249159217;511.51150651128086;515.0857228419585;518.5929045699108;519.8258583374536;10669.89330106689;10932.672019839418;11054.944725276322;11125.610603628835;11192.552297908318;36405.81797090998;36558;37104;37578.248435031695;40515.594844051186;58242.41757582539;59709;59900;60060.69969650298;60300.69849650723;9239.491827949527;9308.674196403093;9320.95339523298;9387.061293870558;9443;9310.95344523273;13879.722405552035;14264;14459.638509037359;14464.783028254795;12447.875521245034;12598.874011260137;12687.746245074863;12730;12746.42641081172;11651.30092194471;11933.940330298294;11941.522339106687;11970.880291196976;12611.936940315607;12934.288614126313;12965.740685186433;13005.674858128245;13006;13047.478100876238;9053;9066.184043436122;9134.588943497425;9191.540422978691;9215.677451289173;9241.722748317561;12838.101332906981;12915.160514566523;12937.547185848827;13098.869011310146 02:00:28 INFO - PROCESS | 13899 | |3;mootools.html;1494.7085318362917;1552.371289627701;1729.1613567419806;1850.0842083168834;1866.0762922353438;7487.962560187191;8114.9594252028655;8282.62728177232;8493.065762766091;8532.957335213323;8243.134470880561;8291.91708082919;8374.41379103463;8487.872681909776;8507.617157227924;2424.0909658877877;2464.556379851635;2484.416162201881;2489.4149874779414;2490.066225165563;2374.3351861478814;2393.1265088242753;2477.6283557466436;2477.838940468873;2490.3151633300895;2408.3256688127353;2414.3239892830034;2414.4068892137243;2430.3924018995253;2433.197044975154;2393.0667039854384;2395.3652282145244;2408.5544174327806;2409.289259668402;2441.9023239070416;2437.9634305485433;2445.4864478459544;2453.2272334214845;2453.30080926935;2463.864487453189;8420.663173473054;8465.280451161658;8470.66117355305;8470.703525376644;8478.491290522588;5350.518453339179;5482.259894914216;5484.61607687462;5486.643368181056;5492.917606235909;3487.9302413951577;3495.1087472694553;3585.6772890439725;3598.1184609770776;3600.531930848999;1137.2778285788502;1146.311898597795;1148.9195756297063;1155.0643978377457;1161.0595417711681;11803.822942655866;11900.761984760344;11911.344876031815;11918.225315354473;11923.761524769543;4484.417025786627;4527.162474942146;4568.200564901129;4595.977020114878;4636.9536304637195;9616.08647178517;9617.615295388106;9625.229981601455;9630.711078667651;9635.181009614122;5314.707691077027;5329.333833270841;5358.624896257303;5361.276227709287;5361.490658387447;4218.156368726267;4867.342908707279;4887.657863949489;4944.060628480577;4947.332110165082;3901.551321597996;3945.408188771707;3947.210557888434;3975.1453437511072;3999.300122478555;1170.9063274937985;1189.1141099880645;1204.0848954794244;1209.2284802763818;1211.1521934645784;968.970930872075;1078.471548941029;1083.707399002265;1085.782843431317;1088.8421178929011;6085.908711369333;6155.938440615626;6195.569174872353;6239.06414037898;6256.624602523863;477.38417441500076;478.86591754308847;480.0902290160197;1086.8098082835472;1092.6012005617893;3912.139329347539;3989.2420440116284;3999.300122478555;4012.0972781124015;4059.127287633114;10121.544530496145;10363.689089327332;10527.947360263302;10537.631182908715;10612.522436490377;10193.74515637115;10340.327878687862;10425.582976681;10430.16558675304;10491.94754026225;7959.721409750747;7984.880226796603;8153.836923261501;8233.423660343838;8257.587120643944;5695.117256825199;5712.8571785704025;5777.566682498746;5783.003369944477;5838.532917366685;9346.485943272914;9350.579223935076;9398.201152901807;9399.483028433502;9504.667336643184;9595;9605.327627066039;9636.807263854824;9688.224942004763;9715.70852874415;7234.240404757425;7414.962925185555;7435.182129965591;7633.084029916224;7641.121271053677;8194.385421093322;8232.711855085043;8237.50574965504;8257.05043919957;8261.17388261169;7256.7097316106765;7348.816279593053;7442.776716698508;7575.810604734926;7615.657295421608;7361.889571656322;7370.078740157481;7421.962890185515;7472.8879066815125;7488.775336739906;6766.729330826712;6784.491163162684;6809.8638027238185;6815.591064536144;6820.897686534805;4839.41926968766;4970.65205435616;5001.8749531260555;5117.385913690381;5198.610104242272;5028.446870844277;5154.381474222967;5157.045946499759;5166.689998600096;5196.2725218470205 02:00:28 INFO - PROCESS | 13899 | |4;prototype.html;355.3603513675384;359.04315000523604;361.9420892657175;369.6266770561732;371.76392990451075;6514.543981921267;6609.140811694485;6657.833554161149;6664.766733164341;6709.261981182072;6652.2349929757975;6659.267480577145;6673.199216094075;6698.196216454033;6707.631080290582;5007.824726134595;5022.271770593262;5023.2214006829;5040.470750571192;5048.671836330626;5036.06832735945;5041.873953151182;5044.218146187347;5046.343975283226;5054.342935418391;4999.725015124167;5008.749562521859;5008.874778130539;5015.899682006358;5026.447090820026;4727.409073865767;4872.512748725135;5003.724795136266;5004.549590536851;5029.9748501257445;4213.747175169499;4232.555581663912;4241.384999175102;4247.065645557972;4259.10558782656;6282.277538083134;6285.748570057192;6350.428461438492;6351.428371446592;6354.682265886687;5804.535637149018;5857.209276747627;5862.091375836752;5863;5866.296044474648;7005;7013.158420989514;7027.332403421667;7029.9648501757165;7030.6484675766005;4652.8138874444985;4768;4787.8563643090765;4787.928181077286;4797.616190704735;7224.674889629927;7304.086989126359;7341.853162936764;7344.265573442613;7408.814779630498;4864.708117512961;4865.9756701216265;4883.316335713003;4885.291632713237;4898.90202195954;4955.554000140005;4956;4967.5032496750755;4968.677035992649;4977.1538838397555;5780.335261444903;5784.681842498703;5796.275465566804;5798.5071268941765;5799.855003624859;6927.376536111774;7049.189343225492;7074.151101867808;7082.079329687108;7119.786406407816;1708.8205738397537;1726.4993151986034;1732.1512458895302;1733.7399390091587;1734.9826501735074;1120.971975700614;1125.4654039331251;1147.0307590086363;1149.350616901448;1174.1780753472433;6743.561668491532;6761.492888033417;6834.179898412123;6838.076859623987;6861.210960739579;7218.855622887513;7232.783016509513;7237.8552428951125;7243.0946131733535;7244.49288549807;6780.525363224626;6793.830154246183;6811.727530898807;6816.318368163244;6844.691988860513;3866.3620502617314;3915.4126880968083;3944.684425245973;3946.3883098119836;3958.129211573449;7375.8156046099275;7437.702491900372;7439.55362678241;7457.403407727477;7457.589832559262;7334.3765779908235;7349.595772232472;7395.334419902235;7398.667059982206;7401.851962960711;7436.814079648052;7440.107187137578;7448.292412220831;7450.627468626547;7459.328660420588;7068.399186069241;7234.5659260444545;7236.782896513113;7240.855182896418;7283.526570772883;7060.082189315356;7097.290270972861;7105.147382314155;7111.43108551325;7112.537685050455;7379.483436159418;7404.074490688664;7419.07261592301;7428.9628551856895;7429.294217049372;5010.173321402073;5012.1980483122525;5017.247412888096;5017.347744793154;5020.698758074527;7095.751648692271;7136.607486588287;7208.495405321577;7212.42300615939;7214.6392680364725;6950.721971121098;6964.094667693167;6975.197852247056;6978.057962175244;7012.368886800213;6916.827079323057;6943.40981016599;6951.409130223786;6958.02587637721;6973.79078627642;6850.965745171242;6853.00631408433;6857.931420685929;6860.382565569123;6868.038474613458;6879.724811007503;7009.894851577128;7013.05323781283;7023.964880175567;7039.859202816017;6842.521023528305;6870;6958.373746362851;7015.0178974944565;7029.5430796998035 02:00:28 INFO - PROCESS | 13899 | |5;yui.html;909.8316811389889;926.1340646495527;930.1163894300414;930.7673081729567;931.4225180388152;14055.226962517057;14801.407943682254;15586;15659.686806263868;15665.608359790982;14506.057106288084;14521.12873227607;14561.271936403191;14596.635084122876;14649.92675036626;872.598604641864;887.5429153985702;905.9365844390895;908.6774195160722;913.3241401362977;912.5756523216703;917.7659696777346;917.9036201198878;918.0498184379169;918.6646873891015;957.1194501059008;960.5677445149676;962.2350231565922;964.1033838530165;964.1708131007329;944.4663764972769;947.9905200948006;948.3645957208687;949.3402085550545;954.2413781044087;690.2958981838497;698.3191388396324;703.1070540413697;703.8768215562257;707.5118168463795;15005.3247603857;15062.397504099932;15109.54671359861;15128.697426051527;15134.470293539673;13459.66350841227;13485.460581576725;13689.589312320646;13691.589252322447;13830.170189788645;12106.334151621657;12373.319467429288;12410.937945310216;12420.192687475284;12434.191777534521;4038.5557588665224;4050.9594904050878;4068.2677118118727;4072.2466343726505;4083.020075181965;55935.720321398134;56042.43957560413;57220.713896430665;57342.42657573413;57776.13335800009;11652.30086194831;11709.297442153327;11740.29558226492;11741.221574445137;11940;20086.09612567438;20221.89889050575;20310.18759249643;20341.084651190733;20365;8865.512396818109;9035.954820225857;9065.728028159167;9075.954620226856;9385.483798391155;5200.349956255468;5212.713300768418;5234.13636749932;5274.604404669589;5402.135658294654;3700.5189325388064;3748.7750734955443;3751.9624803751612;3771.189194323179;3772.981135094362;639.7249182851418;650.9707063182168;660.9140811694546;661.609650306312;662.0565693886193;723.6128671160903;811.2860682599274;819.5615345790093;822.9218224268685;844.8225872566707;9705.320627556004;9970;10127.291089623803;10231.59073637061;10296.124829389437;705.6753893209078;757.1822431773671;763.2520130272364;771.4599780153915;797.4218691448654;4787.281907713871;4871.318015477836;4886.438059623189;4914.533119353656;5056.57019153376;60549.09176362358;61830.69084654638;62021;62736.05895911565;63136.684316578125;55280.17079743807;56895.146572801445;57183.71408142932;57220;57510.424895750504;50921;50951;51109.48890511122;51872.74063629658;52661.47338526566;9750.073742994404;9784.951075244579;10153.593856245667;10276;10411.687649370531;34339.82830085834;34956.47565286574;35709.64290357167;35981.820090899375;36411;48554.757226213645;48912.26631600458;49380.753096234286;49474.25788613246;50046.749766250934;11950.760984780081;12006.75986480283;12207.572734954234;12447.688807779878;12692.111552191258;12918;12981.221126732426;13101.737965240833;13144.868551314747;13329.800052999406;13348.199108053548;13503.257320847448;13541.796873046715;13758.243296618783;13843.653908652364;12302.384880755748;12376;12572.371381430708;12624.74750505003;14640.560783176521;12301.200421972542;13025.934870325967;13346.399412026289;13390.665233369244;13914.234717090658;11071.446427678746;11193.776124477303;11375.146863985068;11510.36692981894;11579.594714184963;10252.743681408025;10272.589096436059;10635.89364106349;10755.300905441121;10826.837597435888 02:00:28 INFO - PROCESS | 13899 | __end_tp_report 02:00:28 INFO - PROCESS | 13899 | __start_cc_report 02:00:28 INFO - PROCESS | 13899 | _x_x_mozilla_cycle_collect,309 02:00:28 INFO - PROCESS | 13899 | __end_cc_report 02:00:28 INFO - PROCESS | 13899 | __startTimestamp1465290028314__endTimestamp 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | ------- Summary: start ------- 02:00:28 INFO - PROCESS | 13899 | Number of tests: 6 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#0] dojo.html Cycles:165 Average:5585.24 Median:5813.97 stddev:623.60 (10.7%) stddev-sans-first:599.15 02:00:28 INFO - PROCESS | 13899 | Values: 3298.4 3340.2 3366.2 3395.0 3399.7 5579.7 5606.3 5622.9 5632.5 5634.9 5598.4 5625.4 5631.4 5639.4 5650.5 5071.7 5100.6 5119.8 5121.4 5164.1 5048.9 5101.9 5174.5 5199.1 5206.1 5083.4 5114.3 5127.8 5143.6 5150.3 5104.7 5105.8 5118.7 5132.7 5154.8 4934.4 4978.9 5012.0 5047.3 5109.5 5454.5 5463.8 5466.5 5474.5 5546.3 5974.9 6005.0 6006.9 6009.9 6014.6 5778.4 5907.1 5949.0 6049.0 6051.6 5648.9 5653.5 5655.3 5669.5 5680.9 6136.5 6140.2 6141.0 6143.5 6177.4 5729.8 5868.1 5943.7 5974.6 5993.1 6023.2 6023.2 6029.7 6029.9 6035.2 5933.4 5972.6 5974.5 5984.3 5988.3 5819.0 5919.2 6038.5 6044.4 6079.7 4565.9 4574.5 4576.4 4580.3 4605.9 3971.8 4105.5 4109.0 4114.3 4128.8 5637.6 5734.7 5783.3 5809.2 5821.2 6030.4 6044.2 6044.3 6061.2 6074.0 5556.4 5743.4 5805.9 5813.4 5814.0 5185.8 5196.6 5203.1 5217.3 5232.2 6150.5 6199.7 6200.5 6213.2 6218.9 5918.1 6017.0 6069.4 6074.1 6078.5 6187.0 6188.3 6189.0 6190.7 6205.1 5948.9 5953.5 5958.9 5961.8 5984.2 5863.9 5989.2 6034.5 6083.0 6112.9 5900.9 5908.6 5931.5 5935.3 5941.6 5842.3 5888.2 5895.1 5898.1 5908.6 5596.6 5720.9 5800.0 5811.4 5814.7 5884.6 5885.1 5893.3 5939.5 5944.3 5631.2 5763.6 5812.4 5815.0 5820.2 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#1] ext.html Cycles:180 Average:60352.29 Median:43212.28 stddev:117942.70 (272.9%) stddev-sans-first:118188.24 02:00:28 INFO - PROCESS | 13899 | Values: 604.7 653.1 665.6 665.8 667.9 38373.0 38900.8 39158.2 39528.8 39604.0 42872.6 43445.6 43455.8 43468.3 43553.1 8832.6 8974.1 8979.0 8979.0 8994.6 8831.2 8887.6 8946.9 9166.5 9166.7 9139.5 9219.4 9229.1 9270.4 9274.0 9119.3 9148.3 9154.1 9164.8 9223.0 9138.2 9158.7 9178.7 9191.6 9198.7 43244.6 43724.6 43826.8 43911.3 44018.1 3894.3 3925.7 3968.9 3970.8 3994.8 33952.8 33978.2 33991.3 34033.0 34383.3 4663.4 4665.3 4695.0 4707.6 4737.5 314400.0 316275.0 316844.0 318573.0 319080.0 60346.7 60560.4 60828.7 60864.4 60906.4 64650.0 68032.0 68693.3 68736.3 68854.7 16591.1 16674.4 16685.0 16725.6 16728.7 14110.3 14170.6 14170.7 14173.6 14177.4 19607.9 19900.3 19957.1 19972.5 19983.2 7285.6 7451.9 7493.6 7732.8 7734.1 1121.9 1163.7 1166.7 1206.5 1227.3 32000.4 32540.5 32775.7 33050.8 33118.8 1234.4 1240.7 1253.4 1266.3 1391.9 16887.7 17144.2 17206.4 17289.8 17433.2 497160.0 509540.0 572767.0 576689.0 582751.0 55799.2 56622.0 56708.7 56833.1 56855.7 1481.0 1491.7 1495.5 1511.2 1512.1 32753.0 32843.8 33457.5 33567.5 34631.3 53272.5 54147.0 54289.0 54316.2 54322.7 435363.0 437348.0 437472.0 439296.0 439484.0 30261.4 30404.1 30409.2 30550.2 30837.5 47980.0 48640.0 49106.0 49307.8 50346.5 41534.4 41831.2 41908.8 41981.4 43265.6 41504.5 41756.4 41891.8 41945.0 42146.8 43180.0 43351.3 43568.1 44280.8 44342.0 32687.3 33273.7 33938.8 34088.7 34191.5 27943.0 29548.3 29810.9 29821.6 29835.3 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#2] jquery.html Cycles:180 Average:27439.38 Median:3068.72 stddev:75401.24 (2457.1%) stddev-sans-first:75585.43 02:00:28 INFO - PROCESS | 13899 | Values: 403.7 419.6 420.3 422.5 423.3 18999.2 19075.8 19492.6 19736.3 19778.7 17822.8 18169.3 18653.3 21241.7 21282.4 5801.9 5925.4 5943.8 5979.4 6013.0 5812.1 5913.8 5946.3 5956.3 5984.2 5886.1 5888.6 5919.2 5926.2 5936.0 5726.0 5883.1 5890.8 5892.3 5896.4 5297.2 5304.3 5304.8 5382.7 5627.4 13812.4 13935.3 13966.7 14037.0 17796.6 2465.2 2584.2 3043.6 3093.8 3145.4 10218.4 10534.5 10623.8 10921.5 11030.7 1988.7 2059.3 2065.8 2069.1 2107.0 52356.7 60641.7 61514.4 69875.7 70453.0 11468.7 11519.4 11696.5 11821.3 11921.0 16577.0 16629.2 16692.1 16712.5 16727.6 8780.9 8939.5 9191.4 9275.2 9322.4 9109.2 9113.3 9208.2 9210.9 9331.4 4950.9 4968.4 4989.2 5051.9 5056.7 2076.6 2076.7 2083.6 2105.4 2167.5 1036.9 1058.0 1130.6 1191.4 1200.3 19365.7 19670.8 19884.2 19933.8 20128.6 1087.3 1087.6 1095.0 1101.1 1175.1 11153.1 11510.1 11531.7 11555.7 11589.7 451065.7 453576.0 457766.0 458832.0 469315.0 77447.2 87995.6 95587.5 95626.0 95926.5 504.7 511.5 515.1 518.6 519.8 10669.9 10932.7 11054.9 11125.6 11192.6 36405.8 36558.0 37104.0 37578.2 40515.6 58242.4 59709.0 59900.0 60060.7 60300.7 9239.5 9308.7 9321.0 9387.1 9443.0 9311.0 13879.7 14264.0 14459.6 14464.8 12447.9 12598.9 12687.7 12730.0 12746.4 11651.3 11933.9 11941.5 11970.9 12611.9 12934.3 12965.7 13005.7 13006.0 13047.5 9053.0 9066.2 9134.6 9191.5 9215.7 9241.7 12838.1 12915.2 12937.5 13098.9 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#3] mootools.html Cycles:180 Average:5657.60 Median:4986.26 stddev:3089.54 (62.0%) stddev-sans-first:3082.37 02:00:28 INFO - PROCESS | 13899 | Values: 1494.7 1552.4 1729.2 1850.1 1866.1 7488.0 8115.0 8282.6 8493.1 8533.0 8243.1 8291.9 8374.4 8487.9 8507.6 2424.1 2464.6 2484.4 2489.4 2490.1 2374.3 2393.1 2477.6 2477.8 2490.3 2408.3 2414.3 2414.4 2430.4 2433.2 2393.1 2395.4 2408.6 2409.3 2441.9 2438.0 2445.5 2453.2 2453.3 2463.9 8420.7 8465.3 8470.7 8470.7 8478.5 5350.5 5482.3 5484.6 5486.6 5492.9 3487.9 3495.1 3585.7 3598.1 3600.5 1137.3 1146.3 1148.9 1155.1 1161.1 11803.8 11900.8 11911.3 11918.2 11923.8 4484.4 4527.2 4568.2 4596.0 4637.0 9616.1 9617.6 9625.2 9630.7 9635.2 5314.7 5329.3 5358.6 5361.3 5361.5 4218.2 4867.3 4887.7 4944.1 4947.3 3901.6 3945.4 3947.2 3975.1 3999.3 1170.9 1189.1 1204.1 1209.2 1211.2 969.0 1078.5 1083.7 1085.8 1088.8 6085.9 6155.9 6195.6 6239.1 6256.6 477.4 478.9 480.1 1086.8 1092.6 3912.1 3989.2 3999.3 4012.1 4059.1 10121.5 10363.7 10527.9 10537.6 10612.5 10193.7 10340.3 10425.6 10430.2 10491.9 7959.7 7984.9 8153.8 8233.4 8257.6 5695.1 5712.9 5777.6 5783.0 5838.5 9346.5 9350.6 9398.2 9399.5 9504.7 9595.0 9605.3 9636.8 9688.2 9715.7 7234.2 7415.0 7435.2 7633.1 7641.1 8194.4 8232.7 8237.5 8257.1 8261.2 7256.7 7348.8 7442.8 7575.8 7615.7 7361.9 7370.1 7422.0 7472.9 7488.8 6766.7 6784.5 6809.9 6815.6 6820.9 4839.4 4970.7 5001.9 5117.4 5198.6 5028.4 5154.4 5157.0 5166.7 5196.3 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#4] prototype.html Cycles:180 Average:5845.23 Median:6752.53 stddev:1779.35 (26.4%) stddev-sans-first:1735.98 02:00:28 INFO - PROCESS | 13899 | Values: 355.4 359.0 361.9 369.6 371.8 6514.5 6609.1 6657.8 6664.8 6709.3 6652.2 6659.3 6673.2 6698.2 6707.6 5007.8 5022.3 5023.2 5040.5 5048.7 5036.1 5041.9 5044.2 5046.3 5054.3 4999.7 5008.7 5008.9 5015.9 5026.4 4727.4 4872.5 5003.7 5004.5 5030.0 4213.7 4232.6 4241.4 4247.1 4259.1 6282.3 6285.7 6350.4 6351.4 6354.7 5804.5 5857.2 5862.1 5863.0 5866.3 7005.0 7013.2 7027.3 7030.0 7030.6 4652.8 4768.0 4787.9 4787.9 4797.6 7224.7 7304.1 7341.9 7344.3 7408.8 4864.7 4866.0 4883.3 4885.3 4898.9 4955.6 4956.0 4967.5 4968.7 4977.2 5780.3 5784.7 5796.3 5798.5 5799.9 6927.4 7049.2 7074.2 7082.1 7119.8 1708.8 1726.5 1732.2 1733.7 1735.0 1121.0 1125.5 1147.0 1149.4 1174.2 6743.6 6761.5 6834.2 6838.1 6861.2 7218.9 7232.8 7237.9 7243.1 7244.5 6780.5 6793.8 6811.7 6816.3 6844.7 3866.4 3915.4 3944.7 3946.4 3958.1 7375.8 7437.7 7439.6 7457.4 7457.6 7334.4 7349.6 7395.3 7398.7 7401.9 7436.8 7440.1 7448.3 7450.6 7459.3 7068.4 7234.6 7236.8 7240.9 7283.5 7060.1 7097.3 7105.1 7111.4 7112.5 7379.5 7404.1 7419.1 7429.0 7429.3 5010.2 5012.2 5017.2 5017.3 5020.7 7095.8 7136.6 7208.5 7212.4 7214.6 6950.7 6964.1 6975.2 6978.1 7012.4 6916.8 6943.4 6951.4 6958.0 6973.8 6851.0 6853.0 6857.9 6860.4 6868.0 6879.7 7009.9 7013.1 7024.0 7039.9 6842.5 6870.0 6958.4 7015.0 7029.5 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - PROCESS | 13899 | [#5] yui.html Cycles:180 Average:15459.13 Median:4435.15 stddev:17585.95 (396.5%) stddev-sans-first:17601.34 02:00:28 INFO - PROCESS | 13899 | Values: 909.8 926.1 930.1 930.8 931.4 14055.2 14801.4 15586.0 15659.7 15665.6 14506.1 14521.1 14561.3 14596.6 14649.9 872.6 887.5 905.9 908.7 913.3 912.6 917.8 917.9 918.0 918.7 957.1 960.6 962.2 964.1 964.2 944.5 948.0 948.4 949.3 954.2 690.3 698.3 703.1 703.9 707.5 15005.3 15062.4 15109.5 15128.7 15134.5 13459.7 13485.5 13689.6 13691.6 13830.2 12106.3 12373.3 12410.9 12420.2 12434.2 4038.6 4051.0 4068.3 4072.2 4083.0 55935.7 56042.4 57220.7 57342.4 57776.1 11652.3 11709.3 11740.3 11741.2 11940.0 20086.1 20221.9 20310.2 20341.1 20365.0 8865.5 9036.0 9065.7 9076.0 9385.5 5200.3 5212.7 5234.1 5274.6 5402.1 3700.5 3748.8 3752.0 3771.2 3773.0 639.7 651.0 660.9 661.6 662.1 723.6 811.3 819.6 822.9 844.8 9705.3 9970.0 10127.3 10231.6 10296.1 705.7 757.2 763.3 771.5 797.4 4787.3 4871.3 4886.4 4914.5 5056.6 60549.1 61830.7 62021.0 62736.1 63136.7 55280.2 56895.1 57183.7 57220.0 57510.4 50921.0 50951.0 51109.5 51872.7 52661.5 9750.1 9785.0 10153.6 10276.0 10411.7 34339.8 34956.5 35709.6 35981.8 36411.0 48554.8 48912.3 49380.8 49474.3 50046.7 11950.8 12006.8 12207.6 12447.7 12692.1 12918.0 12981.2 13101.7 13144.9 13329.8 13348.2 13503.3 13541.8 13758.2 13843.7 12302.4 12376.0 12572.4 12624.7 14640.6 12301.2 13025.9 13346.4 13390.7 13914.2 11071.4 11193.8 11375.1 11510.4 11579.6 10252.7 10272.6 10635.9 10755.3 10826.8 02:00:28 INFO - PROCESS | 13899 | -------- Summary: end -------- 02:00:28 INFO - PROCESS | 13899 | 02:00:28 INFO - TEST-INFO | 13899: exit 0 02:00:28 INFO - TEST-OK | dromaeo_css | took 1108246ms 02:00:28 INFO - TEST-START | kraken 02:00:28 INFO - operating with platform_type : linux_ 02:00:28 INFO - Initialising browser for kraken test... 02:00:28 INFO - TEST-INFO | started process 14138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXF6Io/profile http://localhost:45216/getInfo.html) 02:00:32 INFO - PROCESS | 14138 | 02:00:32 INFO - PROCESS | 14138 | (process:14214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:00:33 INFO - PROCESS | 14138 | __metrics Screen width/height:1600/1200 02:00:33 INFO - PROCESS | 14138 | colorDepth:24 02:00:33 INFO - PROCESS | 14138 | Browser inner width/height: 1024/697 02:00:33 INFO - PROCESS | 14138 | __metrics 02:00:33 ERROR - PROCESS | 14138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:00:34 INFO - TEST-INFO | 14138: exit 0 02:00:34 INFO - Browser initialized. 02:00:34 INFO - Running cycle 1/1 for kraken test... 02:00:34 INFO - TEST-INFO | started process 14264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXF6Io/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:36 INFO - PROCESS | 14264 | 02:00:36 INFO - PROCESS | 14264 | (process:14331): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:00:46 INFO - PROCESS | 14264 | RSS: Main: 150892544 02:00:46 INFO - PROCESS | 14264 | 02:00:48 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45216/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:49 INFO - PROCESS | 14264 | RSS: Main: 156573696 02:00:49 INFO - PROCESS | 14264 | 02:00:52 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45216/tests/kraken/driver.html?testName=audio-dft) 02:00:52 INFO - PROCESS | 14264 | RSS: Main: 156065792 02:00:52 INFO - PROCESS | 14264 | 02:00:55 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45216/tests/kraken/driver.html?testName=audio-fft) 02:00:56 INFO - PROCESS | 14264 | RSS: Main: 156446720 02:00:56 INFO - PROCESS | 14264 | 02:00:58 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45216/tests/kraken/driver.html?testName=audio-oscillator) 02:00:58 INFO - PROCESS | 14264 | RSS: Main: 156418048 02:00:58 INFO - PROCESS | 14264 | 02:01:01 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45216/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:01:01 INFO - PROCESS | 14264 | RSS: Main: 156246016 02:01:01 INFO - PROCESS | 14264 | 02:01:04 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45216/tests/kraken/driver.html?testName=imaging-darkroom) 02:01:05 INFO - PROCESS | 14264 | RSS: Main: 157048832 02:01:05 INFO - PROCESS | 14264 | 02:01:08 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45216/tests/kraken/driver.html?testName=imaging-desaturate) 02:01:09 INFO - PROCESS | 14264 | RSS: Main: 156921856 02:01:09 INFO - PROCESS | 14264 | 02:01:12 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45216/tests/kraken/driver.html?testName=json-parse-financial) 02:01:12 INFO - PROCESS | 14264 | RSS: Main: 156999680 02:01:12 INFO - PROCESS | 14264 | 02:01:14 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45216/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:01:14 INFO - PROCESS | 14264 | RSS: Main: 156205056 02:01:14 INFO - PROCESS | 14264 | 02:01:16 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:01:17 INFO - PROCESS | 14264 | RSS: Main: 156282880 02:01:17 INFO - PROCESS | 14264 | 02:01:19 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:01:19 INFO - PROCESS | 14264 | RSS: Main: 156905472 02:01:19 INFO - PROCESS | 14264 | 02:01:22 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:22 INFO - PROCESS | 14264 | RSS: Main: 157138944 02:01:22 INFO - PROCESS | 14264 | 02:01:25 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:26 INFO - PROCESS | 14264 | RSS: Main: 157343744 02:01:26 INFO - PROCESS | 14264 | 02:01:27 INFO - PROCESS | 14264 | Cycle 1(1): loaded http://localhost:45216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45216/tests/kraken/driver.html?testName=ai-astar) 02:01:28 INFO - PROCESS | 14264 | RSS: Main: 158789632 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | __start_tp_report 02:01:28 INFO - PROCESS | 14264 | _x_x_mozilla_page_load 02:01:28 INFO - PROCESS | 14264 | _x_x_mozilla_page_load_details 02:01:28 INFO - PROCESS | 14264 | |i|pagename|runs| 02:01:28 INFO - PROCESS | 14264 | |0;ai-astar;107;110;104;107;113;109;101;110;110;109 02:01:28 INFO - PROCESS | 14264 | |1;audio-beat-detection;160;125;160;177;128;159;156;128;200;127 02:01:28 INFO - PROCESS | 14264 | |2;audio-dft;165;162;161;160;163;163;161;163;163;163 02:01:28 INFO - PROCESS | 14264 | |3;audio-fft;77;75;75;177;75;77;76;77;167;76 02:01:28 INFO - PROCESS | 14264 | |4;audio-oscillator;94;94;159;93;92;93;145;94;93;148 02:01:28 INFO - PROCESS | 14264 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;117;117 02:01:28 INFO - PROCESS | 14264 | |6;imaging-darkroom;147;146;146;147;146;146;147;147;147;147 02:01:28 INFO - PROCESS | 14264 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 02:01:28 INFO - PROCESS | 14264 | |8;json-parse-financial;55;55;54;55;58;55;59;78;54;53 02:01:28 INFO - PROCESS | 14264 | |9;json-stringify-tinderbox;61;58;62;59;59;59;58;58;59;58 02:01:28 INFO - PROCESS | 14264 | |10;stanford-crypto-aes;74;74;73;74;74;75;74;81;77;74 02:01:28 INFO - PROCESS | 14264 | |11;stanford-crypto-ccm;116;113;117;113;115;112;134;112;135;135 02:01:28 INFO - PROCESS | 14264 | |12;stanford-crypto-pbkdf2;167;164;157;156;173;159;163;159;159;159 02:01:28 INFO - PROCESS | 14264 | |13;stanford-crypto-sha256-iterative;66;67;67;66;70;65;64;69;66;64 02:01:28 INFO - PROCESS | 14264 | __end_tp_report 02:01:28 INFO - PROCESS | 14264 | __start_cc_report 02:01:28 INFO - PROCESS | 14264 | _x_x_mozilla_cycle_collect,841 02:01:28 INFO - PROCESS | 14264 | __end_cc_report 02:01:28 INFO - PROCESS | 14264 | __startTimestamp1465290088114__endTimestamp 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | ------- Summary: start ------- 02:01:28 INFO - PROCESS | 14264 | Number of tests: 14 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:3.43 (3.1%) stddev-sans-first:3.62 02:01:28 INFO - PROCESS | 14264 | Values: 107.0 110.0 104.0 107.0 113.0 109.0 101.0 110.0 110.0 109.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:159.50 stddev:25.01 (15.7%) stddev-sans-first:26.36 02:01:28 INFO - PROCESS | 14264 | Values: 160.0 125.0 160.0 177.0 128.0 159.0 156.0 128.0 200.0 127.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.17 02:01:28 INFO - PROCESS | 14264 | Values: 165.0 162.0 161.0 160.0 163.0 163.0 161.0 163.0 163.0 163.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:40.55 (53.4%) stddev-sans-first:42.48 02:01:28 INFO - PROCESS | 14264 | Values: 77.0 75.0 75.0 177.0 75.0 77.0 76.0 77.0 167.0 76.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:93.00 stddev:27.94 (30.0%) stddev-sans-first:28.99 02:01:28 INFO - PROCESS | 14264 | Values: 94.0 94.0 159.0 93.0 92.0 93.0 145.0 94.0 93.0 148.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:01:28 INFO - PROCESS | 14264 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:01:28 INFO - PROCESS | 14264 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:01:28 INFO - PROCESS | 14264 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:55.00 stddev:7.40 (13.4%) stddev-sans-first:7.79 02:01:28 INFO - PROCESS | 14264 | Values: 55.0 55.0 54.0 55.0 58.0 55.0 59.0 78.0 54.0 53.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:1.37 (2.3%) stddev-sans-first:1.27 02:01:28 INFO - PROCESS | 14264 | Values: 61.0 58.0 62.0 59.0 59.0 59.0 58.0 58.0 59.0 58.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.00 stddev:2.36 (3.2%) stddev-sans-first:2.47 02:01:28 INFO - PROCESS | 14264 | Values: 74.0 74.0 73.0 74.0 74.0 75.0 74.0 81.0 77.0 74.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:116.50 stddev:10.12 (8.7%) stddev-sans-first:10.62 02:01:28 INFO - PROCESS | 14264 | Values: 116.0 113.0 117.0 113.0 115.0 112.0 134.0 112.0 135.0 135.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.00 stddev:5.23 (3.2%) stddev-sans-first:5.17 02:01:28 INFO - PROCESS | 14264 | Values: 167.0 164.0 157.0 156.0 173.0 159.0 163.0 159.0 159.0 159.0 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - PROCESS | 14264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.96 (2.9%) stddev-sans-first:2.07 02:01:28 INFO - PROCESS | 14264 | Values: 66.0 67.0 67.0 66.0 70.0 65.0 64.0 69.0 66.0 64.0 02:01:28 INFO - PROCESS | 14264 | -------- Summary: end -------- 02:01:28 INFO - PROCESS | 14264 | 02:01:28 INFO - TEST-INFO | 14264: exit 0 02:01:28 INFO - TEST-OK | kraken | took 59984ms 02:01:28 INFO - SUITE-END | took 1168s 02:01:29 INFO - Completed test suite (00:19:28) 02:01:29 INFO - javascript benchmark 02:01:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.4227760141976, 3340.2317466982577, 3366.1584603849037, 3394.983025084874, 3399.6770306820845, 5579.6652200867975, 5606.299212598426, 5622.915656265154, 5632.464915832999, 5634.943650563493, 5598.384177740456, 5625.38120806712, 5631.380548139701, 5639.351474580424, 5650.51970582501, 5071.6703414278045, 5100.642954993152, 5119.7952081916865, 5121.359830021247, 5164.147915593922, 5048.873778155557, 5101.872453188681, 5174.456682048387, 5199.090159222121, 5206.114960456713, 5083.440821509631, 5114.335136432277, 5127.820526281581, 5143.562797162245, 5150.3047088642925, 5104.6937183768905, 5105.770240339175, 5118.718470484122, 5132.743362831843, 5154.845354639367, 4934.432540257881, 4978.87552811179, 5011.974940125312, 5047.293378926916, 5109.514596113363, 5454.481824226692, 5463.808766693147, 5466.535344495683, 5474.507294343528, 5546.334439867242, 5974.940250597482, 6005.0, 6006.939930600725, 6009.939900601025, 6014.6391216527145, 5778.393268706809, 5907.054871220584, 5949.0481522956115, 6048.969755151196, 6051.606645568024, 5648.9152662709685, 5653.519450846683, 5655.321361436613, 5669.489745922846, 5680.857978550569, 6136.478399336106, 6140.201773769381, 6141.048137538689, 6143.539234557426, 6177.382261773877, 5729.799457019068, 5868.119782032729, 5943.732532036069, 5974.581779275496, 5993.130996005642, 6023.156758053876, 6023.216981792339, 6029.728662210211, 6029.909551356734, 6035.155078289043, 5933.436323549256, 5972.552058595623, 5974.462298393166, 5984.31180414258, 5988.3113441953865, 5819.039858423313, 5919.200907877382, 6038.486728628028, 6044.425779550936, 6079.6960151992225, 4565.931511027337, 4574.4968053514085, 4576.427946506687, 4580.312953057001, 4605.907881842344, 3971.801409929492, 4105.548389677133, 4109.0, 4114.321137012359, 4128.793560322032, 5637.577181711388, 5734.655920644691, 5783.277090363705, 5809.186713860063, 5821.2141360916585, 6030.396960303934, 6044.15381846533, 6044.274687037584, 6061.212042434456, 6074.0, 5556.388797232301, 5743.396943320975, 5805.88388232233, 5813.360530341659, 5813.970930145322, 5185.818496352609, 5196.636235463557, 5203.14148165556, 5217.2695822584865, 5232.189010703271, 6150.477209437158, 6199.721012554446, 6200.534959878028, 6213.161223234896, 6218.906716399258, 5918.053111502311, 6016.969915150396, 6069.393060693896, 6074.119252708244, 6078.483328917003, 6187.041008643668, 6188.2883468399905, 6189.0, 6190.721417536131, 6205.131281620667, 5948.851278718067, 5953.464188223081, 5958.880822383615, 5961.791337303347, 5984.222051133499, 5863.853403664943, 5989.221401217814, 6034.487068599218, 6083.0, 6112.877742445037, 5900.852478688067, 5908.586398952032, 5931.495822855106, 5935.258092738408, 5941.554383421347, 5842.3281322646735, 5888.205092312654, 5895.056790913433, 5898.085796701518, 5908.586398952032, 5596.608237423341, 5720.856978575569, 5800.0, 5811.360750317546, 5814.651120932757, 5884.558658100746, 5885.14665373527, 5893.32226793907, 5939.46544810969, 5944.3164036136395, 5631.211630371833, 5763.625364351304, 5812.447817457335, 5814.953308404528, 5820.1560773688425], "value": 5544.350072010568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.7006731667825, 653.0954627840441, 665.6172700697099, 665.7603262825379, 667.9499037572181, 38373.0, 38900.80549597248, 39158.21683566327, 39528.80235598825, 39604.0, 42872.57127428725, 43445.56554434455, 43455.78272108643, 43468.34797478032, 43553.12893742131, 8832.60253288602, 8974.05772393899, 8978.955105224464, 8979.012308646044, 8994.640214391417, 8831.249343805785, 8887.644494220256, 8946.86579701305, 9166.49584272868, 9166.67916622915, 9139.497327646977, 9219.40073895198, 9229.123233292827, 9270.39742416744, 9274.02622724611, 9119.270458363348, 9148.2681385489, 9154.130357616015, 9164.816703665889, 9223.0, 9138.17756401927, 9158.725238242796, 9178.678746243917, 9191.586378612978, 9198.724038278862, 43244.56755432437, 43724.56275437269, 43826.78086609547, 43911.34132988008, 44018.119637607386, 3894.2990261752875, 3925.6663183629425, 3968.940465893014, 3970.8411663533425, 3994.7802870842092, 33952.83023584891, 33978.15054623629, 33991.320173596636, 34033.0, 34383.312333753434, 4663.44038715353, 4665.300204969281, 4694.990577025922, 4707.552782485693, 4737.549932756383, 314400.0, 316274.9999999977, 316844.0, 318573.0, 319080.0, 60346.698266508385, 60560.394396055475, 60828.69585652043, 60864.39135608676, 60906.39093609096, 64650.0, 68032.0, 68693.3130668687, 68736.31263687299, 68854.65572672205, 16591.087490187914, 16674.416395426102, 16684.998900066035, 16725.581860453585, 16728.66542669164, 14110.294485275695, 14170.64573385653, 14170.716585668435, 14173.645658858612, 14177.362018709182, 19607.901960490108, 19900.303489377802, 19957.101930413166, 19972.50068748264, 19983.200671972958, 7285.635718214068, 7451.85096298071, 7493.550386976799, 7732.7680169595005, 7734.1492435832015, 1121.9453713509274, 1163.662537864027, 1166.6616681162538, 1206.4932728254155, 1227.2881728597392, 32000.359992800015, 32540.511892321632, 32775.67224327774, 33050.83474582612, 33118.834405827816, 1234.3889774561649, 1240.7456471423336, 1253.360785999147, 1266.2782214137853, 1391.9025668203128, 16887.746683799753, 17144.228509717093, 17206.39777607803, 17289.82710172907, 17433.21550530229, 497160.0, 509540.0, 572767.0, 576689.0, 582751.0, 55799.16301255485, 56622.0, 56708.71645641828, 56833.14750278749, 56855.715721421126, 1480.9851901481063, 1491.6569189086572, 1495.4915328788263, 1511.22927307072, 1512.0927443534013, 32753.0, 32843.83578082094, 33457.49813752747, 33567.49648755222, 34631.307373852884, 53272.46727532675, 54147.0, 54289.0, 54316.185257221965, 54322.72838635781, 435363.0, 437348.0, 437472.0, 439296.0, 439484.0, 30261.394772103995, 30404.087877363716, 30409.23976900595, 30550.236244093187, 30837.537436938914, 47980.0, 48640.0, 49106.0, 49307.75346123247, 50346.49653503418, 41534.37698434466, 41831.16337673169, 41908.79045604752, 41981.37027944522, 43265.567344326155, 41504.45298957951, 41756.3736543946, 41891.7905410471, 41945.0, 42146.78926605347, 43180.0, 43351.34972975345, 43568.12863742771, 44280.778596106815, 44342.0, 32687.34625307528, 33273.66726332706, 33938.830305848314, 34088.65911340954, 34191.4871276936, 27943.0, 29548.261293467836, 29810.850945745133, 29821.5526767103, 29835.254118647208], "value": 20861.16335607476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.7375705791236, 419.60766683151274, 420.31908308540153, 422.54365285491673, 423.2973264381127, 18999.240030398803, 19075.809241907577, 19492.61014779707, 19736.309229176964, 19778.7033194502, 17822.821771782277, 18169.273229070823, 18653.25386984519, 21241.68137477939, 21282.36152915411, 5801.941980580193, 5925.4370834770625, 5943.762249510036, 5979.431953964367, 6012.969935150318, 5812.099124635688, 5913.793017244398, 5946.345901950782, 5956.285245770514, 5984.222051133368, 5886.117082437626, 5888.558358123137, 5919.2009078774245, 5926.170336152921, 5936.0, 5726.0, 5883.14694369314, 5890.793822216223, 5892.292924849045, 5896.410358964112, 5297.152455607084, 5304.257403963448, 5304.761285742151, 5382.650127741724, 5627.437256274381, 13812.37844297009, 13935.303234838217, 13966.650833729136, 14037.01740878139, 17796.644067118585, 2465.2111324376206, 2584.160147951923, 3043.6043314369213, 3093.8453077346267, 3145.433821912055, 10218.437985910772, 10534.525946332433, 10623.84064239037, 10921.453927303603, 11030.724231894186, 1988.6917527783216, 2059.258666879922, 2065.8037486438916, 2069.0999415254414, 2107.020235590458, 52356.73821630906, 60641.6967915162, 61514.384856151315, 69875.65062174707, 70453.0, 11468.713282168013, 11519.424028798527, 11696.47365868538, 11821.349825759493, 11921.0, 16577.0, 16629.16854157287, 16692.08193549342, 16712.49862504127, 16727.581810454594, 8780.912190878138, 8939.463632182089, 9191.402558833654, 9275.16523512887, 9322.394044387092, 9109.180173784258, 9113.270938324918, 9208.171264586219, 9210.907890921138, 9331.440113593206, 4950.8762280943265, 4968.403791545038, 4989.226669866177, 5051.924221136685, 5056.696598204119, 2076.5535409886947, 2076.709260703503, 2083.624947509463, 2105.3999610111046, 2167.5231449081175, 1036.853712814482, 1057.9682609521726, 1130.6438471881331, 1191.4221602522944, 1200.2798321007326, 19365.709514357295, 19670.803291967182, 19884.204631814853, 19933.800661993195, 20128.59742805136, 1087.260662749338, 1087.608460954056, 1095.0363679961583, 1101.1026013798728, 1175.1304035014027, 11153.10775137987, 11510.136739744385, 11531.711707207387, 11555.711107222218, 11589.6523104307, 451065.74467127456, 453576.0, 457766.0, 458832.0, 469315.0, 77447.22552774513, 87995.56002220076, 95587.52206238924, 95626.0, 95926.52036739772, 504.7249249159217, 511.51150651128086, 515.0857228419585, 518.5929045699108, 519.8258583374536, 10669.89330106689, 10932.672019839418, 11054.944725276322, 11125.610603628835, 11192.552297908318, 36405.81797090998, 36558.0, 37104.0, 37578.248435031695, 40515.594844051186, 58242.41757582539, 59709.0, 59900.0, 60060.69969650298, 60300.69849650723, 9239.491827949527, 9308.674196403093, 9320.95339523298, 9387.061293870558, 9443.0, 9310.95344523273, 13879.722405552035, 14264.0, 14459.638509037359, 14464.783028254795, 12447.875521245034, 12598.874011260137, 12687.746245074863, 12730.0, 12746.42641081172, 11651.30092194471, 11933.940330298294, 11941.522339106687, 11970.880291196976, 12611.936940315607, 12934.288614126313, 12965.740685186433, 13005.674858128245, 13006.0, 13047.478100876238, 9053.0, 9066.184043436122, 9134.588943497425, 9191.540422978691, 9215.677451289173, 9241.722748317561, 12838.101332906981, 12915.160514566523, 12937.547185848827, 13098.869011310146], "value": 9158.018926231432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7085318362917, 1552.371289627701, 1729.1613567419806, 1850.0842083168834, 1866.0762922353438, 7487.962560187191, 8114.9594252028655, 8282.62728177232, 8493.065762766091, 8532.957335213323, 8243.134470880561, 8291.91708082919, 8374.41379103463, 8487.872681909776, 8507.617157227924, 2424.0909658877877, 2464.556379851635, 2484.416162201881, 2489.4149874779414, 2490.066225165563, 2374.3351861478814, 2393.1265088242753, 2477.6283557466436, 2477.838940468873, 2490.3151633300895, 2408.3256688127353, 2414.3239892830034, 2414.4068892137243, 2430.3924018995253, 2433.197044975154, 2393.0667039854384, 2395.3652282145244, 2408.5544174327806, 2409.289259668402, 2441.9023239070416, 2437.9634305485433, 2445.4864478459544, 2453.2272334214845, 2453.30080926935, 2463.864487453189, 8420.663173473054, 8465.280451161658, 8470.66117355305, 8470.703525376644, 8478.491290522588, 5350.518453339179, 5482.259894914216, 5484.61607687462, 5486.643368181056, 5492.917606235909, 3487.9302413951577, 3495.1087472694553, 3585.6772890439725, 3598.1184609770776, 3600.531930848999, 1137.2778285788502, 1146.311898597795, 1148.9195756297063, 1155.0643978377457, 1161.0595417711681, 11803.822942655866, 11900.761984760344, 11911.344876031815, 11918.225315354473, 11923.761524769543, 4484.417025786627, 4527.162474942146, 4568.200564901129, 4595.977020114878, 4636.9536304637195, 9616.08647178517, 9617.615295388106, 9625.229981601455, 9630.711078667651, 9635.181009614122, 5314.707691077027, 5329.333833270841, 5358.624896257303, 5361.276227709287, 5361.490658387447, 4218.156368726267, 4867.342908707279, 4887.657863949489, 4944.060628480577, 4947.332110165082, 3901.551321597996, 3945.408188771707, 3947.210557888434, 3975.1453437511072, 3999.300122478555, 1170.9063274937985, 1189.1141099880645, 1204.0848954794244, 1209.2284802763818, 1211.1521934645784, 968.970930872075, 1078.471548941029, 1083.707399002265, 1085.782843431317, 1088.8421178929011, 6085.908711369333, 6155.938440615626, 6195.569174872353, 6239.06414037898, 6256.624602523863, 477.38417441500076, 478.86591754308847, 480.0902290160197, 1086.8098082835472, 1092.6012005617893, 3912.139329347539, 3989.2420440116284, 3999.300122478555, 4012.0972781124015, 4059.127287633114, 10121.544530496145, 10363.689089327332, 10527.947360263302, 10537.631182908715, 10612.522436490377, 10193.74515637115, 10340.327878687862, 10425.582976681, 10430.16558675304, 10491.94754026225, 7959.721409750747, 7984.880226796603, 8153.836923261501, 8233.423660343838, 8257.587120643944, 5695.117256825199, 5712.8571785704025, 5777.566682498746, 5783.003369944477, 5838.532917366685, 9346.485943272914, 9350.579223935076, 9398.201152901807, 9399.483028433502, 9504.667336643184, 9595.0, 9605.327627066039, 9636.807263854824, 9688.224942004763, 9715.70852874415, 7234.240404757425, 7414.962925185555, 7435.182129965591, 7633.084029916224, 7641.121271053677, 8194.385421093322, 8232.711855085043, 8237.50574965504, 8257.05043919957, 8261.17388261169, 7256.7097316106765, 7348.816279593053, 7442.776716698508, 7575.810604734926, 7615.657295421608, 7361.889571656322, 7370.078740157481, 7421.962890185515, 7472.8879066815125, 7488.775336739906, 6766.729330826712, 6784.491163162684, 6809.8638027238185, 6815.591064536144, 6820.897686534805, 4839.41926968766, 4970.65205435616, 5001.8749531260555, 5117.385913690381, 5198.610104242272, 5028.446870844277, 5154.381474222967, 5157.045946499759, 5166.689998600096, 5196.2725218470205], "value": 4581.138485352385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.3603513675384, 359.04315000523604, 361.9420892657175, 369.6266770561732, 371.76392990451075, 6514.543981921267, 6609.140811694485, 6657.833554161149, 6664.766733164341, 6709.261981182072, 6652.2349929757975, 6659.267480577145, 6673.199216094075, 6698.196216454033, 6707.631080290582, 5007.824726134595, 5022.271770593262, 5023.2214006829, 5040.470750571192, 5048.671836330626, 5036.06832735945, 5041.873953151182, 5044.218146187347, 5046.343975283226, 5054.342935418391, 4999.725015124167, 5008.749562521859, 5008.874778130539, 5015.899682006358, 5026.447090820026, 4727.409073865767, 4872.512748725135, 5003.724795136266, 5004.549590536851, 5029.9748501257445, 4213.747175169499, 4232.555581663912, 4241.384999175102, 4247.065645557972, 4259.10558782656, 6282.277538083134, 6285.748570057192, 6350.428461438492, 6351.428371446592, 6354.682265886687, 5804.535637149018, 5857.209276747627, 5862.091375836752, 5863.0, 5866.296044474648, 7005.0, 7013.158420989514, 7027.332403421667, 7029.9648501757165, 7030.6484675766005, 4652.8138874444985, 4768.0, 4787.8563643090765, 4787.928181077286, 4797.616190704735, 7224.674889629927, 7304.086989126359, 7341.853162936764, 7344.265573442613, 7408.814779630498, 4864.708117512961, 4865.9756701216265, 4883.316335713003, 4885.291632713237, 4898.90202195954, 4955.554000140005, 4956.0, 4967.5032496750755, 4968.677035992649, 4977.1538838397555, 5780.335261444903, 5784.681842498703, 5796.275465566804, 5798.5071268941765, 5799.855003624859, 6927.376536111774, 7049.189343225492, 7074.151101867808, 7082.079329687108, 7119.786406407816, 1708.8205738397537, 1726.4993151986034, 1732.1512458895302, 1733.7399390091587, 1734.9826501735074, 1120.971975700614, 1125.4654039331251, 1147.0307590086363, 1149.350616901448, 1174.1780753472433, 6743.561668491532, 6761.492888033417, 6834.179898412123, 6838.076859623987, 6861.210960739579, 7218.855622887513, 7232.783016509513, 7237.8552428951125, 7243.0946131733535, 7244.49288549807, 6780.525363224626, 6793.830154246183, 6811.727530898807, 6816.318368163244, 6844.691988860513, 3866.3620502617314, 3915.4126880968083, 3944.684425245973, 3946.3883098119836, 3958.129211573449, 7375.8156046099275, 7437.702491900372, 7439.55362678241, 7457.403407727477, 7457.589832559262, 7334.3765779908235, 7349.595772232472, 7395.334419902235, 7398.667059982206, 7401.851962960711, 7436.814079648052, 7440.107187137578, 7448.292412220831, 7450.627468626547, 7459.328660420588, 7068.399186069241, 7234.5659260444545, 7236.782896513113, 7240.855182896418, 7283.526570772883, 7060.082189315356, 7097.290270972861, 7105.147382314155, 7111.43108551325, 7112.537685050455, 7379.483436159418, 7404.074490688664, 7419.07261592301, 7428.9628551856895, 7429.294217049372, 5010.173321402073, 5012.1980483122525, 5017.247412888096, 5017.347744793154, 5020.698758074527, 7095.751648692271, 7136.607486588287, 7208.495405321577, 7212.42300615939, 7214.6392680364725, 6950.721971121098, 6964.094667693167, 6975.197852247056, 6978.057962175244, 7012.368886800213, 6916.827079323057, 6943.40981016599, 6951.409130223786, 6958.02587637721, 6973.79078627642, 6850.965745171242, 6853.00631408433, 6857.931420685929, 6860.382565569123, 6868.038474613458, 6879.724811007503, 7009.894851577128, 7013.05323781283, 7023.964880175567, 7039.859202816017, 6842.521023528305, 6870.0, 6958.373746362851, 7015.0178974944565, 7029.5430796998035], "value": 5259.405735984807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.8316811389889, 926.1340646495527, 930.1163894300414, 930.7673081729567, 931.4225180388152, 14055.226962517057, 14801.407943682254, 15586.0, 15659.686806263868, 15665.608359790982, 14506.057106288084, 14521.12873227607, 14561.271936403191, 14596.635084122876, 14649.92675036626, 872.598604641864, 887.5429153985702, 905.9365844390895, 908.6774195160722, 913.3241401362977, 912.5756523216703, 917.7659696777346, 917.9036201198878, 918.0498184379169, 918.6646873891015, 957.1194501059008, 960.5677445149676, 962.2350231565922, 964.1033838530165, 964.1708131007329, 944.4663764972769, 947.9905200948006, 948.3645957208687, 949.3402085550545, 954.2413781044087, 690.2958981838497, 698.3191388396324, 703.1070540413697, 703.8768215562257, 707.5118168463795, 15005.3247603857, 15062.397504099932, 15109.54671359861, 15128.697426051527, 15134.470293539673, 13459.66350841227, 13485.460581576725, 13689.589312320646, 13691.589252322447, 13830.170189788645, 12106.334151621657, 12373.319467429288, 12410.937945310216, 12420.192687475284, 12434.191777534521, 4038.5557588665224, 4050.9594904050878, 4068.2677118118727, 4072.2466343726505, 4083.020075181965, 55935.720321398134, 56042.43957560413, 57220.713896430665, 57342.42657573413, 57776.13335800009, 11652.30086194831, 11709.297442153327, 11740.29558226492, 11741.221574445137, 11940.0, 20086.09612567438, 20221.89889050575, 20310.18759249643, 20341.084651190733, 20365.0, 8865.512396818109, 9035.954820225857, 9065.728028159167, 9075.954620226856, 9385.483798391155, 5200.349956255468, 5212.713300768418, 5234.13636749932, 5274.604404669589, 5402.135658294654, 3700.5189325388064, 3748.7750734955443, 3751.9624803751612, 3771.189194323179, 3772.981135094362, 639.7249182851418, 650.9707063182168, 660.9140811694546, 661.609650306312, 662.0565693886193, 723.6128671160903, 811.2860682599274, 819.5615345790093, 822.9218224268685, 844.8225872566707, 9705.320627556004, 9970.0, 10127.291089623803, 10231.59073637061, 10296.124829389437, 705.6753893209078, 757.1822431773671, 763.2520130272364, 771.4599780153915, 797.4218691448654, 4787.281907713871, 4871.318015477836, 4886.438059623189, 4914.533119353656, 5056.57019153376, 60549.09176362358, 61830.69084654638, 62021.0, 62736.05895911565, 63136.684316578125, 55280.17079743807, 56895.146572801445, 57183.71408142932, 57220.0, 57510.424895750504, 50921.0, 50951.0, 51109.48890511122, 51872.74063629658, 52661.47338526566, 9750.073742994404, 9784.951075244579, 10153.593856245667, 10276.0, 10411.687649370531, 34339.82830085834, 34956.47565286574, 35709.64290357167, 35981.820090899375, 36411.0, 48554.757226213645, 48912.26631600458, 49380.753096234286, 49474.25788613246, 50046.749766250934, 11950.760984780081, 12006.75986480283, 12207.572734954234, 12447.688807779878, 12692.111552191258, 12918.0, 12981.221126732426, 13101.737965240833, 13144.868551314747, 13329.800052999406, 13348.199108053548, 13503.257320847448, 13541.796873046715, 13758.243296618783, 13843.653908652364, 12302.384880755748, 12376.0, 12572.371381430708, 12624.74750505003, 14640.560783176521, 12301.200421972542, 13025.934870325967, 13346.399412026289, 13390.665233369244, 13914.234717090658, 11071.446427678746, 11193.776124477303, 11375.146863985068, 11510.36692981894, 11579.594714184963, 10252.743681408025, 10272.589096436059, 10635.89364106349, 10755.300905441121, 10826.837597435888], "value": 7208.698162364084, "unit": "score"}], "name": "dromaeo_css", "value": 7541.644408455353, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 107.0, 113.0, 109.0, 101.0, 110.0, 110.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 160.0, 177.0, 128.0, 159.0, 156.0, 128.0, 200.0, 127.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 160.0, 163.0, 163.0, 161.0, 163.0, 163.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 177.0, 75.0, 77.0, 76.0, 77.0, 167.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 159.0, 93.0, 92.0, 93.0, 145.0, 94.0, 93.0, 148.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 58.0, 55.0, 59.0, 78.0, 54.0, 53.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 62.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 74.0, 75.0, 74.0, 81.0, 77.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 117.0, 113.0, 115.0, 112.0, 134.0, 112.0, 135.0, 135.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 157.0, 156.0, 173.0, 159.0, 163.0, 159.0, 159.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 70.0, 65.0, 64.0, 69.0, 66.0, 64.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1527.1, "alertThreshold": 2.0}]} 02:01:29 INFO - Return code: 0 02:01:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:01:29 ERROR - # TBPL SUCCESS # 02:01:29 INFO - Running post-action listener: _resource_record_post_action 02:01:29 INFO - Running post-run listener: _resource_record_post_run 02:01:30 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 468885504; Read time: 16; Write time: 323552 02:01:30 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242487296; Read time: 0; Write time: 216960 02:01:30 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222715904; Read time: 16; Write time: 106284 02:01:30 INFO - Running post-run listener: _upload_blobber_files 02:01:30 INFO - Blob upload gear active. 02:01:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:01:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:31 INFO - (blobuploader) - INFO - Done attempting. 02:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:32 INFO - (blobuploader) - INFO - Done attempting. 02:01:32 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:32 INFO - Return code: 0 02:01:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8afabac56a9ce632a8c4d597c9fe2e7ca4a472b4feab55e65b52742c79f0d05a74d9936c7f10d0f7dffebd57129b4453ac4fc18f86850fcaf8207dd781e09e56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09dd49e6ed85ddfe0cdddbd5ca9f4d3bdb8b5362043c6eb3bd3f8917e7268c2a6cd79dbc932b0ad3f890afee17f87228bd0874de342ea2410835fa919de53a74"} 02:01:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:32 INFO - Contents: 02:01:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8afabac56a9ce632a8c4d597c9fe2e7ca4a472b4feab55e65b52742c79f0d05a74d9936c7f10d0f7dffebd57129b4453ac4fc18f86850fcaf8207dd781e09e56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09dd49e6ed85ddfe0cdddbd5ca9f4d3bdb8b5362043c6eb3bd3f8917e7268c2a6cd79dbc932b0ad3f890afee17f87228bd0874de342ea2410835fa919de53a74"} 02:01:32 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:32 INFO - Copying logs to upload dir... 02:01:32 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.040648 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-07 02:01:32.073877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:01:32.077047) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 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/8afabac56a9ce632a8c4d597c9fe2e7ca4a472b4feab55e65b52742c79f0d05a74d9936c7f10d0f7dffebd57129b4453ac4fc18f86850fcaf8207dd781e09e56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09dd49e6ed85ddfe0cdddbd5ca9f4d3bdb8b5362043c6eb3bd3f8917e7268c2a6cd79dbc932b0ad3f890afee17f87228bd0874de342ea2410835fa919de53a74"} build_url:https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.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/8afabac56a9ce632a8c4d597c9fe2e7ca4a472b4feab55e65b52742c79f0d05a74d9936c7f10d0f7dffebd57129b4453ac4fc18f86850fcaf8207dd781e09e56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09dd49e6ed85ddfe0cdddbd5ca9f4d3bdb8b5362043c6eb3bd3f8917e7268c2a6cd79dbc932b0ad3f890afee17f87228bd0874de342ea2410835fa919de53a74"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:01:32.101981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:01:32.102281) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465288869.775525-1935150315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:01:32.188441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:01:32.189161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:01:32.189753) ========= ========= Total master_lag: 0.19 =========