builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1462417296.16 results: success (0) buildid: 20160504173005 builduid: 6753a0dedd48475fa2236151f1a13f2e revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:36.160858) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:36.161467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:36.161749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:36.196867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 20:01:36.197406) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 20:01:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2016-05-04 20:01:36 (19.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141591 ========= master_lag: 1.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 20:01:37.916342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:37.916891) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049785 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:37.984259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-04 20:01:37.984637) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 20:01:37,986 truncating revision to first 12 chars 2016-05-04 20:01:37,986 Setting DEBUG logging. 2016-05-04 20:01:37,986 attempt 1/10 2016-05-04 20:01:37,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29662e28a9c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 20:01:38,810 unpacking tar archive at: fx-team-29662e28a9c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.106583 ========= master_lag: 3.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-04 20:01:42.343323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:42.343614) ========= script_repo_revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:42.343982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:42.344247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:42.360701) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-04 20:01:42.361061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:42 INFO - MultiFileLogger online at 20160504 20:01:42 in /builds/slave/test 20:01:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:01:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:42 INFO - {'append_to_log': False, 20:01:42 INFO - 'base_work_dir': '/builds/slave/test', 20:01:42 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:42 INFO - 'branch': 'Fx-Team', 20:01:42 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:42 INFO - 'config_files': ('talos/linux_config.py',), 20:01:42 INFO - 'default_actions': ('clobber', 20:01:42 INFO - 'read-buildbot-config', 20:01:42 INFO - 'download-and-extract', 20:01:42 INFO - 'populate-webroot', 20:01:42 INFO - 'create-virtualenv', 20:01:42 INFO - 'install', 20:01:42 INFO - 'run-tests'), 20:01:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:42 INFO - 'download_minidump_stackwalk': True, 20:01:42 INFO - 'download_symbols': 'ondemand', 20:01:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:42 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:42 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:42 INFO - 'installer_path': 'installer.exe', 20:01:42 INFO - 'log_level': 'info', 20:01:42 INFO - 'log_name': 'talos', 20:01:42 INFO - 'log_to_console': True, 20:01:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:42 INFO - 'opt_config_files': (), 20:01:42 INFO - 'pip_index': False, 20:01:42 INFO - 'sps_profile': False, 20:01:42 INFO - 'sps_profile_interval': 0, 20:01:42 INFO - 'suite': 'dromaeojs', 20:01:42 INFO - 'system_bits': '32', 20:01:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:42 INFO - 'title': 'talos-linux64-ix-019', 20:01:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:42 INFO - 'use_talos_json': True, 20:01:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:42 INFO - 'work_dir': 'build'} 20:01:42 INFO - ##### 20:01:42 INFO - ##### Running clobber step. 20:01:42 INFO - ##### 20:01:42 INFO - Running pre-action listener: _resource_record_pre_action 20:01:42 INFO - Running main action method: clobber 20:01:42 INFO - rmtree: /builds/slave/test/build 20:01:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:43 INFO - Running post-action listener: _resource_record_post_action 20:01:43 INFO - ##### 20:01:43 INFO - ##### Running read-buildbot-config step. 20:01:43 INFO - ##### 20:01:43 INFO - Running pre-action listener: _resource_record_pre_action 20:01:43 INFO - Running main action method: read_buildbot_config 20:01:43 INFO - Using buildbot properties: 20:01:43 INFO - { 20:01:43 INFO - "project": "", 20:01:43 INFO - "product": "firefox", 20:01:43 INFO - "script_repo_revision": "production", 20:01:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:01:43 INFO - "repository": "", 20:01:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:01:43 INFO - "buildid": "20160504173005", 20:01:43 INFO - "pgo_build": "True", 20:01:43 INFO - "basedir": "/builds/slave/test", 20:01:43 INFO - "buildnumber": 644, 20:01:43 INFO - "slavename": "talos-linux64-ix-019", 20:01:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:01:43 INFO - "platform": "ubuntu64_hw", 20:01:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:43 INFO - "branch": "fx-team", 20:01:43 INFO - "repo_path": "integration/fx-team", 20:01:43 INFO - "revision": "29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5", 20:01:43 INFO - "stage_platform": "linux64-pgo", 20:01:43 INFO - "builduid": "6753a0dedd48475fa2236151f1a13f2e", 20:01:43 INFO - "slavebuilddir": "test" 20:01:43 INFO - } 20:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:01:43 INFO - Running post-action listener: _resource_record_post_action 20:01:43 INFO - ##### 20:01:43 INFO - ##### Running download-and-extract step. 20:01:43 INFO - ##### 20:01:43 INFO - Running pre-action listener: _resource_record_pre_action 20:01:43 INFO - Running main action method: download_and_extract 20:01:43 INFO - mkdir: /builds/slave/test/build/tests 20:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:43 INFO - https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:01:44 INFO - Downloaded 1361 bytes. 20:01:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:44 INFO - Using the following test package requirements: 20:01:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'jsshell-linux-x86_64.zip'], 20:01:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:44 INFO - https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:46 INFO - Downloaded 23879834 bytes. 20:01:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:47 INFO - Return code: 0 20:01:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:47 INFO - https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:49 INFO - Downloaded 23879834 bytes. 20:01:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:50 INFO - Return code: 0 20:01:50 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')]} 20:01:50 INFO - https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:01:51 INFO - Downloaded 10840152 bytes. 20:01:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:01:51 INFO - Return code: 0 20:01:51 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')]} 20:01:51 INFO - https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:01:53 INFO - Downloaded 58415926 bytes. 20:01:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:53 INFO - mkdir: /builds/slave/test/properties 20:01:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:53 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:53 INFO - Contents: 20:01:53 INFO - build_url:https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:54 INFO - Running post-action listener: _resource_record_post_action 20:01:54 INFO - Running post-action listener: set_extra_try_arguments 20:01:54 INFO - ##### 20:01:54 INFO - ##### Running populate-webroot step. 20:01:54 INFO - ##### 20:01:54 INFO - Running pre-action listener: _resource_record_pre_action 20:01:54 INFO - Running main action method: populate_webroot 20:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:54 INFO - '--tppagecycles', 20:01:54 INFO - '7'], 20:01:54 INFO - 'tests': ['tsvgm']}}, 20:01:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['damp', 'tps']}, 20:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'tests': ['damp', 'tps']}, 20:01:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['dromaeo_dom']}, 20:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['a11yr', 20:01:54 INFO - 'ts_paint', 20:01:54 INFO - 'tpaint', 20:01:54 INFO - 'sessionrestore', 20:01:54 INFO - 'sessionrestore_no_auto_restore', 20:01:54 INFO - 'tabpaint']}, 20:01:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['tsvgx', 20:01:54 INFO - 'tsvgr_opacity', 20:01:54 INFO - 'tart', 20:01:54 INFO - 'tscrollx', 20:01:54 INFO - 'cart']}, 20:01:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:54 INFO - 'tsvgr_opacity', 20:01:54 INFO - 'tart', 20:01:54 INFO - 'tscrollx', 20:01:54 INFO - 'cart']}, 20:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'talos_options': ['--disable-e10s'], 20:01:54 INFO - 'tests': ['tp5o']}, 20:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'tests': ['tp5o']}, 20:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'talos_options': ['--disable-e10s', 20:01:54 INFO - '--xperf_path', 20:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:54 INFO - 'tests': ['tp5n']}, 20:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:54 INFO - 'talos_options': ['--xperf_path', 20:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:54 INFO - 'tests': ['tp5n']}}, 20:01:54 INFO - 'talos.zip': {'path': '', 20:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:54 INFO - Running post-action listener: _resource_record_post_action 20:01:54 INFO - ##### 20:01:54 INFO - ##### Running create-virtualenv step. 20:01:54 INFO - ##### 20:01:54 INFO - Running pre-action listener: _resource_record_pre_action 20:01:54 INFO - Running main action method: create_virtualenv 20:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:54 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 20:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:54 INFO - Using real prefix '/usr' 20:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:54 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:57 INFO - Installing pip.................done. 20:01:57 INFO - Return code: 0 20:01:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:01:57 INFO - Using env: {'DISPLAY': ':0', 20:01:57 INFO - 'HOME': '/home/cltbld', 20:01:57 INFO - 'LANG': 'en_US.UTF-8', 20:01:57 INFO - 'LANGUAGE': 'en_US:en', 20:01:57 INFO - 'LOGNAME': 'cltbld', 20:01:57 INFO - 'MAIL': '/var/mail/cltbld', 20:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:57 INFO - 'MOZ_NO_REMOTE': '1', 20:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:57 INFO - 'NO_EM_RESTART': '1', 20:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:57 INFO - 'PWD': '/builds/slave/test', 20:01:57 INFO - 'SHELL': '/bin/bash', 20:01:57 INFO - 'SHLVL': '1', 20:01:57 INFO - 'TERM': 'linux', 20:01:57 INFO - 'TMOUT': '86400', 20:01:57 INFO - 'USER': 'cltbld', 20:01:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:57 INFO - '_': '/tools/buildbot/bin/python'} 20:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:58 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 20:01:58 INFO - Cleaning up... 20:01:58 INFO - Return code: 0 20:01:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:58 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:01:58 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 20:01:58 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 20:01:58 INFO - Using env: {'DISPLAY': ':0', 20:01:58 INFO - 'HOME': '/home/cltbld', 20:01:58 INFO - 'LANG': 'en_US.UTF-8', 20:01:58 INFO - 'LANGUAGE': 'en_US:en', 20:01:58 INFO - 'LOGNAME': 'cltbld', 20:01:58 INFO - 'MAIL': '/var/mail/cltbld', 20:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:58 INFO - 'MOZ_NO_REMOTE': '1', 20:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:58 INFO - 'NO_EM_RESTART': '1', 20:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:58 INFO - 'PWD': '/builds/slave/test', 20:01:58 INFO - 'SHELL': '/bin/bash', 20:01:58 INFO - 'SHLVL': '1', 20:01:58 INFO - 'TERM': 'linux', 20:01:58 INFO - 'TMOUT': '86400', 20:01:58 INFO - 'USER': 'cltbld', 20:01:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:58 INFO - '_': '/tools/buildbot/bin/python'} 20:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:58 INFO - Downloading/unpacking psutil>=0.7.1 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:00 INFO - Installing collected packages: psutil 20:02:00 INFO - Running setup.py install for psutil 20:02:00 INFO - building 'psutil._psutil_linux' extension 20:02:00 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 20:02:01 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 20:02:01 INFO - building 'psutil._psutil_posix' extension 20:02:01 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 20:02:01 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 20:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:02 INFO - Successfully installed psutil 20:02:02 INFO - Cleaning up... 20:02:02 INFO - Return code: 0 20:02:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:02:02 INFO - Using env: {'DISPLAY': ':0', 20:02:02 INFO - 'HOME': '/home/cltbld', 20:02:02 INFO - 'LANG': 'en_US.UTF-8', 20:02:02 INFO - 'LANGUAGE': 'en_US:en', 20:02:02 INFO - 'LOGNAME': 'cltbld', 20:02:02 INFO - 'MAIL': '/var/mail/cltbld', 20:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:02 INFO - 'MOZ_NO_REMOTE': '1', 20:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:02 INFO - 'NO_EM_RESTART': '1', 20:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:02 INFO - 'PWD': '/builds/slave/test', 20:02:02 INFO - 'SHELL': '/bin/bash', 20:02:02 INFO - 'SHLVL': '1', 20:02:02 INFO - 'TERM': 'linux', 20:02:02 INFO - 'TMOUT': '86400', 20:02:02 INFO - 'USER': 'cltbld', 20:02:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:02 INFO - '_': '/tools/buildbot/bin/python'} 20:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:02:04 INFO - Installing collected packages: mozsystemmonitor 20:02:04 INFO - Running setup.py install for mozsystemmonitor 20:02:04 INFO - Successfully installed mozsystemmonitor 20:02:04 INFO - Cleaning up... 20:02:04 INFO - Return code: 0 20:02:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:02:04 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')]} 20:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:04 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')]} 20:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:04 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:04 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 20:02:04 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 20:02:04 INFO - Using env: {'DISPLAY': ':0', 20:02:04 INFO - 'HOME': '/home/cltbld', 20:02:04 INFO - 'LANG': 'en_US.UTF-8', 20:02:04 INFO - 'LANGUAGE': 'en_US:en', 20:02:04 INFO - 'LOGNAME': 'cltbld', 20:02:04 INFO - 'MAIL': '/var/mail/cltbld', 20:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:04 INFO - 'MOZ_NO_REMOTE': '1', 20:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:04 INFO - 'NO_EM_RESTART': '1', 20:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:04 INFO - 'PWD': '/builds/slave/test', 20:02:04 INFO - 'SHELL': '/bin/bash', 20:02:04 INFO - 'SHLVL': '1', 20:02:04 INFO - 'TERM': 'linux', 20:02:04 INFO - 'TMOUT': '86400', 20:02:04 INFO - 'USER': 'cltbld', 20:02:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:04 INFO - '_': '/tools/buildbot/bin/python'} 20:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:04 INFO - Downloading/unpacking blobuploader==1.2.4 20:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:06 INFO - Downloading blobuploader-1.2.4.tar.gz 20:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:02:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:02:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:06 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 20:02:07 INFO - Downloading docopt-0.6.1.tar.gz 20:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:02:07 INFO - Installing collected packages: blobuploader, requests, docopt 20:02:07 INFO - Running setup.py install for blobuploader 20:02:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:02:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:02:07 INFO - Running setup.py install for requests 20:02:07 INFO - Running setup.py install for docopt 20:02:07 INFO - Successfully installed blobuploader requests docopt 20:02:07 INFO - Cleaning up... 20:02:07 INFO - Return code: 0 20:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:07 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')]} 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:07 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')]} 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:07 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:07 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 20:02:07 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 20:02:07 INFO - Using env: {'DISPLAY': ':0', 20:02:07 INFO - 'HOME': '/home/cltbld', 20:02:07 INFO - 'LANG': 'en_US.UTF-8', 20:02:07 INFO - 'LANGUAGE': 'en_US:en', 20:02:07 INFO - 'LOGNAME': 'cltbld', 20:02:07 INFO - 'MAIL': '/var/mail/cltbld', 20:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:07 INFO - 'MOZ_NO_REMOTE': '1', 20:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:07 INFO - 'NO_EM_RESTART': '1', 20:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:07 INFO - 'PWD': '/builds/slave/test', 20:02:07 INFO - 'SHELL': '/bin/bash', 20:02:07 INFO - 'SHLVL': '1', 20:02:07 INFO - 'TERM': 'linux', 20:02:07 INFO - 'TMOUT': '86400', 20:02:07 INFO - 'USER': 'cltbld', 20:02:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:07 INFO - '_': '/tools/buildbot/bin/python'} 20:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:08 INFO - Running setup.py (path:/tmp/pip-gbAybB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:08 INFO - Running setup.py (path:/tmp/pip-mmmJ8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:08 INFO - Running setup.py (path:/tmp/pip-ajX4Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:08 INFO - Running setup.py (path:/tmp/pip-KgSdXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:08 INFO - Running setup.py (path:/tmp/pip-QMZCVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:08 INFO - Running setup.py (path:/tmp/pip-jFPZRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:08 INFO - Running setup.py (path:/tmp/pip-IAZDaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:08 INFO - Running setup.py (path:/tmp/pip-tAtiQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:08 INFO - Running setup.py (path:/tmp/pip-L29LIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:08 INFO - Running setup.py (path:/tmp/pip-9bapYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:08 INFO - Running setup.py (path:/tmp/pip-xFN3Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:08 INFO - Running setup.py (path:/tmp/pip-pUdJCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:08 INFO - Running setup.py (path:/tmp/pip-FXWGve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:08 INFO - Running setup.py (path:/tmp/pip-7SD0cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:09 INFO - Running setup.py (path:/tmp/pip-NlLIRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:09 INFO - Running setup.py (path:/tmp/pip-rJWNCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:09 INFO - Running setup.py (path:/tmp/pip-WnFy73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:09 INFO - Running setup.py install for manifestparser 20:02:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Running setup.py install for mozcrash 20:02:09 INFO - Running setup.py install for mozdebug 20:02:09 INFO - Running setup.py install for mozdevice 20:02:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Running setup.py install for mozfile 20:02:09 INFO - Running setup.py install for mozhttpd 20:02:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Running setup.py install for mozinfo 20:02:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Running setup.py install for mozInstall 20:02:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Running setup.py install for mozleak 20:02:10 INFO - Running setup.py install for mozlog 20:02:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Running setup.py install for moznetwork 20:02:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Running setup.py install for mozprocess 20:02:10 INFO - Running setup.py install for mozprofile 20:02:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Running setup.py install for mozrunner 20:02:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:10 INFO - Running setup.py install for mozscreenshot 20:02:10 INFO - Running setup.py install for moztest 20:02:10 INFO - Running setup.py install for mozversion 20:02:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:11 INFO - Cleaning up... 20:02:11 INFO - Return code: 0 20:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:11 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')]} 20:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:11 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')]} 20:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:11 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:11 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 20:02:11 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 20:02:11 INFO - Using env: {'DISPLAY': ':0', 20:02:11 INFO - 'HOME': '/home/cltbld', 20:02:11 INFO - 'LANG': 'en_US.UTF-8', 20:02:11 INFO - 'LANGUAGE': 'en_US:en', 20:02:11 INFO - 'LOGNAME': 'cltbld', 20:02:11 INFO - 'MAIL': '/var/mail/cltbld', 20:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:11 INFO - 'MOZ_NO_REMOTE': '1', 20:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:11 INFO - 'NO_EM_RESTART': '1', 20:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:11 INFO - 'PWD': '/builds/slave/test', 20:02:11 INFO - 'SHELL': '/bin/bash', 20:02:11 INFO - 'SHLVL': '1', 20:02:11 INFO - 'TERM': 'linux', 20:02:11 INFO - 'TMOUT': '86400', 20:02:11 INFO - 'USER': 'cltbld', 20:02:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:11 INFO - '_': '/tools/buildbot/bin/python'} 20:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:11 INFO - Running setup.py (path:/tmp/pip-vJkBX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:11 INFO - Running setup.py (path:/tmp/pip-27PJSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:11 INFO - Running setup.py (path:/tmp/pip-cDOTod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:11 INFO - Running setup.py (path:/tmp/pip-SrvHL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:11 INFO - Running setup.py (path:/tmp/pip-vL5amn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:11 INFO - Running setup.py (path:/tmp/pip-cKRWT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:11 INFO - Running setup.py (path:/tmp/pip-vd1oOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:11 INFO - Running setup.py (path:/tmp/pip-BMkxBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:11 INFO - Running setup.py (path:/tmp/pip-bjgv_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:11 INFO - Running setup.py (path:/tmp/pip-xUAl2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:12 INFO - Running setup.py (path:/tmp/pip-iQez3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:12 INFO - Running setup.py (path:/tmp/pip-a7vxxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:12 INFO - Running setup.py (path:/tmp/pip-9TXrjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:12 INFO - Running setup.py (path:/tmp/pip-TM2Urn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:12 INFO - Running setup.py (path:/tmp/pip-k_D68S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:12 INFO - Running setup.py (path:/tmp/pip-fv4xWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:12 INFO - Running setup.py (path:/tmp/pip-Jw4W74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:15 INFO - Downloading blessings-1.6.tar.gz 20:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:15 INFO - Installing collected packages: blessings 20:02:15 INFO - Running setup.py install for blessings 20:02:15 INFO - Successfully installed blessings 20:02:15 INFO - Cleaning up... 20:02:15 INFO - Return code: 0 20:02:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:15 INFO - Reading from file tmpfile_stdout 20:02:15 INFO - Current package versions: 20:02:15 INFO - argparse == 1.2.1 20:02:15 INFO - blessings == 1.6 20:02:15 INFO - blobuploader == 1.2.4 20:02:15 INFO - docopt == 0.6.1 20:02:15 INFO - manifestparser == 1.1 20:02:15 INFO - mozInstall == 1.12 20:02:15 INFO - mozcrash == 0.17 20:02:15 INFO - mozdebug == 0.1 20:02:15 INFO - mozdevice == 0.48 20:02:15 INFO - mozfile == 1.2 20:02:15 INFO - mozhttpd == 0.7 20:02:15 INFO - mozinfo == 0.9 20:02:15 INFO - mozleak == 0.1 20:02:15 INFO - mozlog == 3.1 20:02:15 INFO - moznetwork == 0.27 20:02:15 INFO - mozprocess == 0.22 20:02:15 INFO - mozprofile == 0.28 20:02:15 INFO - mozrunner == 6.11 20:02:15 INFO - mozscreenshot == 0.1 20:02:15 INFO - mozsystemmonitor == 0.0 20:02:15 INFO - moztest == 0.7 20:02:15 INFO - mozversion == 1.4 20:02:15 INFO - psutil == 3.1.1 20:02:15 INFO - requests == 1.2.3 20:02:15 INFO - wsgiref == 0.1.2 20:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:15 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:15 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 20:02:15 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 20:02:15 INFO - Using env: {'DISPLAY': ':0', 20:02:15 INFO - 'HOME': '/home/cltbld', 20:02:15 INFO - 'LANG': 'en_US.UTF-8', 20:02:15 INFO - 'LANGUAGE': 'en_US:en', 20:02:15 INFO - 'LOGNAME': 'cltbld', 20:02:15 INFO - 'MAIL': '/var/mail/cltbld', 20:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:15 INFO - 'MOZ_NO_REMOTE': '1', 20:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:15 INFO - 'NO_EM_RESTART': '1', 20:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:15 INFO - 'PWD': '/builds/slave/test', 20:02:15 INFO - 'SHELL': '/bin/bash', 20:02:15 INFO - 'SHLVL': '1', 20:02:15 INFO - 'TERM': 'linux', 20:02:15 INFO - 'TMOUT': '86400', 20:02:15 INFO - 'USER': 'cltbld', 20:02:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:15 INFO - '_': '/tools/buildbot/bin/python'} 20:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 INFO - Cleaning up... 20:02:16 INFO - Return code: 0 20:02:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:16 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:16 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 20:02:16 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 20:02:16 INFO - Using env: {'DISPLAY': ':0', 20:02:16 INFO - 'HOME': '/home/cltbld', 20:02:16 INFO - 'LANG': 'en_US.UTF-8', 20:02:16 INFO - 'LANGUAGE': 'en_US:en', 20:02:16 INFO - 'LOGNAME': 'cltbld', 20:02:16 INFO - 'MAIL': '/var/mail/cltbld', 20:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:16 INFO - 'MOZ_NO_REMOTE': '1', 20:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:16 INFO - 'NO_EM_RESTART': '1', 20:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:16 INFO - 'PWD': '/builds/slave/test', 20:02:16 INFO - 'SHELL': '/bin/bash', 20:02:16 INFO - 'SHLVL': '1', 20:02:16 INFO - 'TERM': 'linux', 20:02:16 INFO - 'TMOUT': '86400', 20:02:16 INFO - 'USER': 'cltbld', 20:02:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:16 INFO - '_': '/tools/buildbot/bin/python'} 20:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:16 INFO - Downloading/unpacking jsonschema 20:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:02:18 INFO - Downloading/unpacking functools32 (from jsonschema) 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:02:18 INFO - warning: no files found matching '*.txt' 20:02:18 INFO - no previously-included directories found matching 'build' 20:02:18 INFO - no previously-included directories found matching 'dist' 20:02:18 INFO - no previously-included directories found matching '.git*' 20:02:18 INFO - Installing collected packages: jsonschema, functools32 20:02:18 INFO - Running setup.py install for functools32 20:02:18 INFO - warning: no files found matching '*.txt' 20:02:18 INFO - no previously-included directories found matching 'build' 20:02:18 INFO - no previously-included directories found matching 'dist' 20:02:18 INFO - no previously-included directories found matching '.git*' 20:02:18 INFO - Successfully installed jsonschema functools32 20:02:18 INFO - Cleaning up... 20:02:18 INFO - Return code: 0 20:02:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:18 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 0x7f0703c61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', '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 20:02:18 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 20:02:18 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 20:02:18 INFO - Using env: {'DISPLAY': ':0', 20:02:18 INFO - 'HOME': '/home/cltbld', 20:02:18 INFO - 'LANG': 'en_US.UTF-8', 20:02:18 INFO - 'LANGUAGE': 'en_US:en', 20:02:18 INFO - 'LOGNAME': 'cltbld', 20:02:18 INFO - 'MAIL': '/var/mail/cltbld', 20:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:18 INFO - 'MOZ_NO_REMOTE': '1', 20:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:18 INFO - 'NO_EM_RESTART': '1', 20:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:18 INFO - 'PWD': '/builds/slave/test', 20:02:18 INFO - 'SHELL': '/bin/bash', 20:02:18 INFO - 'SHLVL': '1', 20:02:18 INFO - 'TERM': 'linux', 20:02:18 INFO - 'TMOUT': '86400', 20:02:18 INFO - 'USER': 'cltbld', 20:02:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:18 INFO - '_': '/tools/buildbot/bin/python'} 20:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:18 INFO - Downloading/unpacking flake8 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:18 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 20:02:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:02:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:02:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 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 20:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:21 INFO - no previously-included directories found matching 'docs/_build' 20:02:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:02:21 INFO - Running setup.py install for pep8 20:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:21 INFO - no previously-included directories found matching 'docs/_build' 20:02:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:02:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:02:21 INFO - Cleaning up... 20:02:21 INFO - Return code: 0 20:02:21 INFO - Running post-action listener: _resource_record_post_action 20:02:21 INFO - Running post-action listener: _start_resource_monitoring 20:02:21 INFO - Starting resource monitoring. 20:02:21 INFO - ##### 20:02:21 INFO - ##### Running install step. 20:02:21 INFO - ##### 20:02:21 INFO - Running pre-action listener: _resource_record_pre_action 20:02:21 INFO - Running main action method: install 20:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:22 INFO - Reading from file tmpfile_stdout 20:02:22 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:22 INFO - Reading from file tmpfile_stdout 20:02:22 INFO - Output received: 20:02:22 INFO - Usage: mozinstall [options] installer 20:02:22 INFO - Options: 20:02:22 INFO - -h, --help show this help message and exit 20:02:22 INFO - -d DEST, --destination=DEST 20:02:22 INFO - Directory to install application into. [default: 20:02:22 INFO - "/builds/slave/test"] 20:02:22 INFO - --app=APP Application being installed. [default: firefox] 20:02:22 INFO - mkdir: /builds/slave/test/build/application 20:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:02:38 INFO - Reading from file tmpfile_stdout 20:02:38 INFO - Output received: 20:02:38 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:38 INFO - Running post-action listener: _resource_record_post_action 20:02:38 INFO - ##### 20:02:38 INFO - ##### Running run-tests step. 20:02:38 INFO - ##### 20:02:38 INFO - Running pre-action listener: _resource_record_pre_action 20:02:38 INFO - Running main action method: run_tests 20:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:38 INFO - Python 2.7.3 20:02:38 INFO - Return code: 0 20:02:38 INFO - grabbing minidump binary from tooltool 20:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:38 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 0x1e30810>, '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 0x1e31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e31ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:38 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 20:02:38 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 20:02:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:38 INFO - Return code: 0 20:02:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:02:39 INFO - Return code: 0 20:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:02:39 INFO - Using env: {'DISPLAY': ':0', 20:02:39 INFO - 'HOME': '/home/cltbld', 20:02:39 INFO - 'LANG': 'en_US.UTF-8', 20:02:39 INFO - 'LANGUAGE': 'en_US:en', 20:02:39 INFO - 'LOGNAME': 'cltbld', 20:02:39 INFO - 'MAIL': '/var/mail/cltbld', 20:02:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:39 INFO - 'MOZ_NO_REMOTE': '1', 20:02:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:39 INFO - 'NO_EM_RESTART': '1', 20:02:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:39 INFO - 'PWD': '/builds/slave/test', 20:02:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:39 INFO - 'SHELL': '/bin/bash', 20:02:39 INFO - 'SHLVL': '1', 20:02:39 INFO - 'TERM': 'linux', 20:02:39 INFO - 'TMOUT': '86400', 20:02:39 INFO - 'USER': 'cltbld', 20:02:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093', 20:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:39 INFO - '_': '/tools/buildbot/bin/python'} 20:02:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:02:39 INFO - mozversion application_buildid: 20160504173005 20:02:39 INFO - mozversion application_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 20:02:39 INFO - mozversion application_display_name: Nightly 20:02:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:39 INFO - mozversion application_name: Firefox 20:02:39 INFO - mozversion application_remotingname: firefox 20:02:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:39 INFO - mozversion application_vendor: Mozilla 20:02:39 INFO - mozversion application_version: 49.0a1 20:02:39 INFO - mozversion platform_buildid: 20160504173005 20:02:39 INFO - mozversion platform_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 20:02:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:39 INFO - mozversion platform_version: 49.0a1 20:02:39 INFO - using testdate: 1462417359 20:02:39 INFO - actual date: 1462417359 20:02:39 INFO - starting webserver on 'localhost:53320' 20:02:39 INFO - SUITE-START | Running 2 tests 20:02:39 INFO - TEST-START | dromaeo_css 20:02:39 INFO - operating with platform_type : linux_ 20:02:39 INFO - Initialising browser for dromaeo_css test... 20:02:39 INFO - TEST-INFO | started process 3291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewIUq0/profile http://localhost:53320/getInfo.html) 20:02:44 INFO - PROCESS | 3291 | __metrics Screen width/height:1600/1200 20:02:44 INFO - PROCESS | 3291 | colorDepth:24 20:02:44 INFO - PROCESS | 3291 | Browser inner width/height: 1024/697 20:02:44 INFO - PROCESS | 3291 | __metrics 20:02:45 ERROR - PROCESS | 3291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:02:46 INFO - TEST-INFO | 3291: exit 0 20:02:46 INFO - Browser initialized. 20:02:46 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:46 INFO - TEST-INFO | started process 3374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewIUq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:58 INFO - PROCESS | 3374 | RSS: Main: 154759168 20:02:58 INFO - PROCESS | 3374 | 20:03:49 INFO - PROCESS | 3374 | 1462417429376 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] 20:05:57 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53320/tests/dromaeo/cssquery-ext.html) 20:05:58 INFO - PROCESS | 3374 | RSS: Main: 290476032 20:05:58 INFO - PROCESS | 3374 | 20:09:00 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-ext.html (next: http://localhost:53320/tests/dromaeo/cssquery-jquery.html) 20:09:01 INFO - PROCESS | 3374 | RSS: Main: 246370304 20:09:01 INFO - PROCESS | 3374 | 20:12:03 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53320/tests/dromaeo/cssquery-mootools.html) 20:12:03 INFO - PROCESS | 3374 | RSS: Main: 241143808 20:12:03 INFO - PROCESS | 3374 | 20:15:05 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53320/tests/dromaeo/cssquery-prototype.html) 20:15:06 INFO - PROCESS | 3374 | RSS: Main: 231063552 20:15:06 INFO - PROCESS | 3374 | 20:18:09 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53320/tests/dromaeo/cssquery-yui.html) 20:18:09 INFO - PROCESS | 3374 | RSS: Main: 203587584 20:18:09 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:53320/tests/dromaeo/cssquery-yui.html (next: http://localhost:53320/tests/dromaeo/cssquery-dojo.html) 20:21:12 INFO - PROCESS | 3374 | RSS: Main: 264716288 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | __start_tp_report 20:21:12 INFO - PROCESS | 3374 | _x_x_mozilla_page_load 20:21:12 INFO - PROCESS | 3374 | _x_x_mozilla_page_load_details 20:21:12 INFO - PROCESS | 3374 | |i|pagename|runs| 20:21:12 INFO - PROCESS | 3374 | |0;dojo.html;3073.8770449182034;3110.5800716903213;3148.039847846407;3158.2262345725303;3183.1087295557245;5291.708956007418;5292.814751483699;5361.463853614637;5384.300040994675;5486.725663716818;5348.812791552296;5351.331083614548;5388.030154572176;5425.9186112208345;5434.701091439969;4834.685745426545;4856.684315519497;4859.514048595148;4863.076015557051;5064.468230835764;4933.555979961803;4955.876103097416;4999.500049995007;5006.5744411725045;5014.448410674823;4798.280257961316;4858.611311095104;4887.0225954809;4964.106460837048;4964.106460837048;4817.132916075105;4825.324454576327;4843.612510999112;4869.975650121763;4882.560569548722;4789;4806.303086052503;4807.711537307773;4815.566599006106;4855.514448555152;5211.348581427322;5225.764840582183;5251;5328.893422131536;5330.733463326818;5643.774249030034;5654.773809047633;5663.093904975225;5668.57485688575;5669.291338582677;5695.0033744095035;5698.7435565399655;5706.029974904276;5710.628809127394;5712.514436272922;5273.894522109536;5304.734763261821;5325.307709997675;5331.920021199685;5335.706536140549;5731.713414329351;5742.569307301969;5789.8263052108505;5805;5811.476967072984;5520.530754885799;5529.170624406291;5530.142827861688;5533.446655334515;5536.75084621193;5549.112142057252;5601.29983752031;5708.457696518824;5793.420657934257;5807.954568177768;5708.914366284509;5730;5730.8280751576685;5754.935336962675;5757.366689664133;5694.629849059798;5731.5701322400155;5758.251427314506;5758.3665796762325;5763.135529670499;4180.163967206571;4264.957350426456;4291.291936830388;4313.762743049162;4320.783960801948;3820.3505404081375;3844.1350696093155;3850.5186851643543;3883.281592905265;3888.650021498079;5273.630845840754;5406.053940560465;5407.107827208545;5414.431484694129;5428.131498960148;5724.284464441945;5750.338711048283;5760.884782304414;5806.79676211339;5811.82564523065;5349;5385.973070134624;5386.757595908193;5387.326584176978;5390.0836857734275;4713.410823647044;4768.690035147704;4793.32893394918;4793.616510679138;4833.927491087637;5832;5840.386759390203;5862.062070068769;5865.706714664249;5901.380355062656;5656.943430565806;5657.632253903483;5673.602847800779;5674.659520428788;5681.77272909079;5836.649801011953;5855.3266374367495;5867.354590994902;5885.293764748258;5988.431099045583;5545.639533430314;5582.609217354746;5582.944170558242;5585.357683866245;5599.888002239851;5624.634398764068;5652.293463317085;5665.12190610456;5666.518345940642;5678.119891416837;5438.592105592017;5556.305461817273;5560.97219513916;5656.632318899258;5681.0626246668835;5584.3857175711455;5587.5809314302405;5589.105743081088;5591.496765291144;5596.776128954796;5488.780448782004;5495.230667706444;5513;5513.476219759116;5548.639338442988;5557.499825015768;5579.832605021856;5611.410801865745;5679.37526872052;5689.829305120853;5453.345598528202;5528.308961379827;5550.333959924835;5561.443855614406;5586.245856809442 20:21:12 INFO - PROCESS | 3374 | |1;ext.html;596.988060238795;649.6654223075117;649.775827339568;656.6782276684426;659.8779225843219;30518.69481305186;31166.532502012487;31222.21944451387;38035.239295214145;39106.413403798964;41736.58263417365;42451.36322955158;42472;42500.787496062556;42633.78683106588;8631.784205394853;8863.379563430562;8869.645214191425;8871.334649901282;8873.423227490224;8775.25410340122;8897.911020889773;8929.241014513742;8932.196102350787;8936.64253429862;8983;9018.41380310281;9054.502002389865;9070.909290907106;9072.228860546862;8861.069587693264;8922.509261990588;8923.553822308924;8928.598213080362;8941.77645558863;8826.779330516723;8955.05971872957;8957.776055598597;8961.775955601097;8971.820563588757;40747.59252407467;40855.795721021204;41255.58744412548;41321.38017929703;41324.38013429801;3765.4351847223134;3853.0174805424717;3865.439511270878;3943.6647884929816;4138.172365526907;31685.366292674018;32134.487826190514;32734.836325818458;32838.83580582082;33135.6686433135;3781.6596506314563;3841.3661745811905;3846.5576458707046;3873.6707379872746;3970.086880017612;310593;311063;311723;311735;312931;45523;56406;57832.71083644639;57908.710456448294;58011.41988580144;48581.271280930814;48690.26964595534;48771.75614121907;52681.73659131757;54150.72924635352;14658.19379934114;14709;14756.852431475763;14757.778633320295;14775.187364695044;12786.808197877039;12866.035047371484;12876.549320773727;12878;12880.484780608858;14313.141211527342;14604.269786510631;14686;15488.070715756865;15851.524454266391;5681.835223779115;5812.709364531756;5845.649261044351;5871.854988277245;5875.061229794158;1007.8236308645958;1061.7451811565168;1104.6023431564631;1150.9194356394971;1162.436218434059;28810.855945720137;29807;30068.496575171153;30301.545476817864;30474.54288185679;1169.0764296206073;1217.7747116783423;1248.3570960955115;1260.464302671361;1283.940748882176;15946.9202653986;15984.920075399548;16571.42000029993;16819.57951051209;17013.149342532823;468103;468952;474199;474849;475382;55740.72129639407;55836;55964;56017.15974260389;56051.71974140103;1422.4594654031403;1441.2793603198402;1449.7970284160226;1457.883369330451;1531.540537838644;30132.548011779403;31211.843940780152;31451.370972580877;31703;31871.68128318687;50595;50596.49403505918;50762.49237507577;50963;51088.489115109856;384172;385554;385927;386875;386947;26005.869970650027;26786.59820102661;26823.195304140907;27665.170044898685;28224.85887570549;36271.63728362683;42648.78675606602;43094.13811723811;43362.13275734531;43679;36478.27043459063;36607.45088823616;37046.25907481781;37313.25373492569;37719.245615087;36615.63384366122;37049.44425833561;37051.258974819815;37406.812965934994;37594.24811503809;37138;38077;38159.23681526409;38206.235875282895;41056;33872.830635846665;35682.46476302806;35995;36051.098722532144;36360.27279454449;27144.592831107155;27226.31934201661;27417;27608.447831042864;27733 20:21:12 INFO - PROCESS | 3374 | |2;jquery.html;406.28696637401373;407.1632794607081;407.8348268951072;409.40636077687356;415.68670349505004;12906.612801615944;18081.54796130096;18787.624247515043;18813.81186188138;19054.047297635134;14988.7002259955;16700.49898503047;17936.9237845729;18539.44381668552;18754.812451875478;5475.72621368932;5687.658740475585;5689.715514224272;5695.800646977356;5724.427557244284;5656.604037717361;5676.375598684142;5697.145428185764;5702.914456283159;5705.058665320217;4038.4548086008454;5665.688387138705;5886.470217680408;6182.96908515459;6191.288001879797;6081.574289799693;6086.45221930024;6135.631862088289;6136.23297087864;6188.381161883798;5399.676019438846;5534.501894829445;5563.693996830173;5575.024370735146;5577.358603760579;22243.22148724787;22311.442213944618;22495.212667556556;23403.414914627272;23412.063517459283;2379.298107058422;2394.174009966559;2501.5997440409446;2917.4748545261846;3156.1793933577205;9804.264680148946;9848.704538863774;10251.231157663206;10413.062824345769;10456.111230545413;1919.4721451600783;1983.652860749363;2032.7255820464343;2047.7747447780732;2068.7620923593827;80009.59995199987;80665.59667201627;81346;81398.5930070346;82798.58600707017;10578.841317380246;10648.094911932572;10672.78654426907;10827.621033263798;10829.372160326222;15302.387904483696;15403;15409.383624655113;15413.306401211748;15428.460003900034;8258.958705206436;8446.61990210442;8459.196376344238;8562.957185214034;8590.398672093019;8300.12848650883;8383.11977242393;8431.704890328809;8463.534505602127;8573.571321433903;4006.1787333597126;4229.7250678706405;4437.023854751949;4545.4545454545005;4768.809247630125;1914.7893731689503;1953.4823271832975;1972.2801177570084;1973.7828838827718;1977.7626684797917;979.7991411760572;1040.016290608567;1043.5408420295198;1090.3675867996542;1097.7145942055124;18895.62208755817;19165.233390664496;19489.122989465508;19703.507412314808;19716.90141549283;986.7074132885799;991.3407583956588;1022.1465076660922;1064.377339256528;1117.4189421500773;8061.3147882429475;10651.73370665724;10689.30519516229;10714.839277410845;10813.459327033617;357204;361741;362326;501197;501602;87812.56093719491;95318;95790.52104739571;96062.51968740112;96865.51567242118;1084.0514549768952;1103.3986477369854;1105.4141305108305;1153.8846115388394;1167.7664467106613;17271.6457898052;17316.30734770595;17453.040082795567;17496.91251543734;17607.559811004827;38221.648969144895;38867;39987.60012399839;40070;41584.1683166341;51712.22431663453;52464.21303680524;53537.19694204512;53540.73229633827;54875.451245487035;8419.326453883798;8897.955510222408;8933.776655583402;8951.239144672776;9215.308851836273;9124.863127052966;13748.862511375159;13783.655408614864;13922.651933701738;14303.35634896453;11874.287542747463;12021.098417618889;12141.271523708252;12284.832940870603;12653.683657908627;11277.041451476716;11294.209405341548;11523.654290371302;11592.536298547964;12072.215306005082;12329.321887296284;12337.198082124993;12367.257964522158;12399.194052386567;12412.875871241173;8132.87800683002;8476;8758.124187581447;8782.56087195625;9018.278537716837;8978;11125;11728.237664551776;11740.178187526792;11791.174617776673 20:21:12 INFO - PROCESS | 3374 | |3;mootools.html;1354.3431435753664;1521.954341369759;1546.806649168854;1696.508012676324;1826.56162520995;8126.796830079251;8483.95758021209;8494.957525212372;8499.872501912469;8517.10570390108;8171.305439037674;8401.327893768499;8404.705835295767;8405.285550728195;8405.57972101394;2083.073032500538;2276.7837055479786;2316.6409206572966;2334.8132149428006;2359.528094381122;2330.883455827202;2343.121329501437;2347.3896786835376;2348.3072493614427;2349.882505874708;2143.3248526714115;2174.934751957444;2184.792444717757;2187.354730354541;2190.463336482564;1976.3675623800389;2225.710657614508;2281.1103669568884;2284.623037198877;2288.954220915589;2196.7034450349156;2199.472126689599;2210.2153735423854;2213.7564867864685;2266.784655457729;8596.312295016383;8652.524111173883;8687.956560217222;8693.304535637133;8707.738767836974;5018.84943451697;5208.401033881114;5221.216817477371;5229.686218826882;5236.895262094737;3197.392495425862;3229;3308.8676452942095;3362;3366.343563005215;1005.1506477026974;1045.4877110216016;1050.8056009638165;1053.1416895230363;1055.3193190392153;11549.711257218552;11587.942060289728;11743.412829358498;11760.58837940668;11793.764124717458;4614.538546145359;4622.884427889329;4660.487346391894;4716.64625153108;4718.457377401643;10002.849957250646;10065.446400448045;10081.848772268422;10107.848382274271;10120.595176193017;4741.407324084489;5210.244514545369;5253.553447956967;5258.132408152688;5262.631615786935;4598.816047358068;4677.134730074947;4680.9297860532115;4729.172394830891;4731.952680473151;3904.39481880309;3945.585713500099;4039.979800100981;4043.353063509824;4070.6946978976102;1265.873412658745;1277.9744405111846;1281.7756892543769;1285.884719636212;1305.5234839283594;1016.3343010328247;1016.6645007147623;1043.1289872956168;1050.1861057680205;1050.8371202463477;5694.800681976111;5808.361080281165;5865.272070725937;5882.382349853204;5974.910376344358;460.96312295016315;461.7160446325486;467.57684295712437;469.1953300090361;481.6556162343871;4204.2432362175105;4218.641415479658;4226.492820861455;4228.682848786353;4255.787210639455;9954;10456;10467.528961196764;10535.631252906265;10537.631182908715;10203.316452785355;10363.94818025905;10376.584936602452;10411.323263987817;10417.583296668048;7628.694852205849;7811.80470488231;8014.799630009296;8034.276915077554;8051.315638170821;5824.5631577631;5842.737076831638;5925.9407405925385;5996.490298324691;5997.520198384032;9050.366474346733;9319.813603728024;9534.570944307385;9566.091221333962;9862.55618497155;9409.48247846375;9565.952170239383;9770.902290977;9943.751406214902;9951.303408761607;6578.111954886029;7404.96297518509;7453.81365465846;7648.043994500687;7672.079350477979;8225.341972642054;8277.875831862648;8282.958585207036;8305.335573154012;8352.039515455557;7217.278272172741;7358.521696089737;7407.851842963003;7461.141968673672;7572;7385.556866588022;7486.962565187139;7547.962260188664;7613.467057305936;7626.847463050819;6829.146356705412;6835.726570937107;6896.206936202401;6899.6205208714;6902.620355880475;5206.8958620828125;5245.816396426107;5378.300820893259;5404.378496472798;5421.484958928895;5296;5368.3557973041925;5370.570354371563;5383;5433.56531477473 20:21:12 INFO - PROCESS | 3374 | |4;prototype.html;330.0280673416789;332.53849332185047;333.21029160888696;339.46364743704964;340.4790670274478;5224;5226.86932826679;5247.055530004598;5250.9737451312785;5285.577153827699;5154.484551544843;5167.261351483719;5180.6373553851245;5185.377754669445;5195.792168313263;3906.706996975217;3970.06703424695;4129.67850287908;4136.917261654765;4149.419081328601;4112.732672376286;4138.3999320098565;4144.668426525871;4147.419361289422;4150.356694712309;3875.3723436156884;4109.0959988802415;4110.753354798707;4113.753174809506;4113.9177216455655;3940.660175540316;4039.111395493016;4066.1867626474823;4081.7958302516604;4085.6527195188446;3609.350316942949;3619.3304238715923;3649.489071529988;3653.963460365389;3655.670989610948;4974.816117684684;4993.550580447777;4994.2009278515625;5000.124978128849;5012.27322038306;4567.972206253599;4637.443506779175;4655.301704744282;4667.696599721007;4672.742999135046;5329.840104796862;5347.839564813062;5376.677399356051;5381.865453363658;5391.56867450603;3985.2228815381013;3991.44119823225;4000.7999600020175;4009;4023.376376661622;5367.382750983609;5564.610477266593;5565.220869078333;5593.916091258634;5642.153676948491;4083.305838007546;4104.712670113064;4120.299549076604;4121.319982202963;4138.586141385837;4132.318167502389;4148.937765933513;4170.124273902515;4177.937330940038;4181.560936101726;4485.372047913294;4661.370714953506;4670.136024835417;4733.739644319596;4737.786799594027;5389.380221274603;5414.538074719803;5417.972910135424;5454.045542030129;5462.8361149165585;1490.2772155504572;1490.701859628057;1509.7810817431412;1520.8783297336408;1524.4755244755245;973.8003709239589;993.9453330066916;995.6266400099962;1037.7146284771748;1062.4953147255146;5473.17902314648;5484.2596249506605;5499.972500137474;5514.558835293167;5628.465295796893;5945.40545945402;5956.791512297049;5962.092130518279;5971.566349349142;5976.641401515923;5349.652272602269;5517.282753242052;5547.86268814892;5555.555555555546;5577.107662773937;3122.4223518649123;3123.4377811993604;3137.8901738439044;3138.905832825019;3179.2210908327147;5905.881882362329;6060.848478788065;6075.33171351151;6085.1785009023215;6094.177286066413;6079.513638908877;6087.239095113111;6089.939100609025;6108.786192483241;6147.293061297919;6044.788432404845;6064.302605200371;6095.116208149882;6148.78479253224;6196.8760624787255;5860.765569377178;5969.611975221596;5982.670953097621;5987.940120598738;5990.580659353804;5924.281958232064;5938.435848594377;5947.672877991579;5962.314333851663;5973.492253158356;6009.248843894513;6140.416660417253;6202.627842329474;6203.294094124152;6216.129741836056;4289.828406863815;4292.205941900758;4294.205571969195;4302.311630139163;4308.181445525465;5906.645601263938;5918.319393269657;5921.792737254175;5933.614315069507;5976.133460648269;5287.57699384056;5578.135389014709;5598.10430331145;5859.736311865891;5867.735951882261;5217.217417387422;5316;5513.421090785409;5524.33707955048;5540.36285827135;5437.374701909331;5453.590980676386;5463.535599474089;5468;5484.61607687458;5315.272536425599;5438.646487978269;5526.530244929226;5535.391106978149;5561.777528898799;5323.520883120537;5386.5152136307925;5408.918866217088;5418;5427.4301198373605 20:21:12 INFO - PROCESS | 3374 | |5;yui.html;684.6166146957704;761.6153842309633;768.3699366519453;772.8995230620019;779.5973900866993;14471.5658530244;14796;14812.25938703066;14832;14840;14329.283535823219;14711.558653240394;14835.332410041547;14849.143857017873;14872.107673539595;680.9523333366666;837.1461109668135;837.9790505237372;842.1241908415241;842.296682270302;806.3549160671439;835.173178553234;837.0123254559617;837.7696133563288;838.6016642095017;866.9609867555976;875.0855356152836;878.7715194049562;879.2658130461073;881.7883707910088;709.6061685764398;841.0622156295748;879.617366445595;880.0319648386755;880.1330689271063;631.3654776949137;631.4159402552621;633.1136409027353;634.3529599808215;634.8508100596356;14134.646633834134;14220.502282420066;14272.35774390155;14277.357518911675;14283.500077497341;12758;13127.571399291162;13232.338383080807;13376.184573553513;14312.141271523638;10685.572577096984;10908.781824363548;10963.397013164273;11208.383538905357;11376.488058037408;3786.6024067473068;3851.8651847185492;3864.574896761354;3869.9032524186837;3964.1278918637854;59199;60295.397046029415;60386.69806650982;60463.69768151175;61149.999999999556;9910.108090271766;10833.78332433347;10891.346519208873;10928.781424371467;11147.275427097213;18108.637827243645;18468.353607623936;18485.44543663692;18494;18537.721934170997;7610.885836712454;7678.61606919663;7683.270089341504;7951.522908625501;7966.6415011324625;4596.333531637893;4628.143793398232;4686.36734040907;4764.880877978078;4847.563719265283;3323.1692076980753;3346.4311067118647;3385.779924304912;3387.5088112224084;3391.593008838955;533.706461446203;534.2203907355475;541.0585581088877;548.8243761996202;551.2695678226366;612.4212619075021;637.6652257564815;658.4403257231411;688.6625553478759;689.582802404548;8796.340274479311;9033.141851524095;9158.633654653873;9408.294377921684;9648.228141748643;712.4976891291627;751.9624018799038;768.692522990797;793.3573805217792;805.5529181304432;3957.6240257175523;3979.6617287530885;3987.2623564640635;4091.3249313863475;4139.937900931488;58483;59598.404015959284;59892;60011.399886001454;60568.69715651482;50488;50828;51175.48824511782;52332.21501677478;53729.41911305434;47117.52882471269;47675.761621191676;47809.282860757114;48363.27455088106;49260.75369623129;7770.689172433039;7893.407994400328;8451.577421129043;8493.660253589787;8636.870446943176;31912.6808731919;32394.704211831264;32846.67153328436;33107.172320692174;33285.833570831994;39888.80055599703;41502.377464338664;41834.37248441337;41841.58158418377;42799.7860010698;11468.31190128595;11561.132915031574;11766.235194712317;11837.348945808064;11938.343391113573;12978.415971281504;13176.802347964596;13200.669983250496;13266.53567125146;13417.396217170055;11885.702857428634;12171.695707607381;12354.814677780021;12457.688557786129;12475.376231188586;11967.461464234304;12061.457234424648;12117.27296362221;12367.134300598871;12529.749405012031;12008.459619317326;12231.633051008128;12422.192557483735;12515.061370397074;12662.746745065231;10405.895941040493;10589.68571968295;10844.240903136704;10847.891521085005;10938.945305273422;10676.733081673021;10781.9460902695;10829.837552436877;10878.78242435131;10907.29102608328 20:21:12 INFO - PROCESS | 3374 | __end_tp_report 20:21:12 INFO - PROCESS | 3374 | __start_cc_report 20:21:12 INFO - PROCESS | 3374 | _x_x_mozilla_cycle_collect,1099 20:21:12 INFO - PROCESS | 3374 | __end_cc_report 20:21:12 INFO - PROCESS | 3374 | __startTimestamp1462418472432__endTimestamp 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | ------- Summary: start ------- 20:21:12 INFO - PROCESS | 3374 | Number of tests: 6 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#0] dojo.html Cycles:165 Average:5293.57 Median:5528.31 stddev:598.51 (10.8%) stddev-sans-first:574.46 20:21:12 INFO - PROCESS | 3374 | Values: 3073.9 3110.6 3148.0 3158.2 3183.1 5291.7 5292.8 5361.5 5384.3 5486.7 5348.8 5351.3 5388.0 5425.9 5434.7 4834.7 4856.7 4859.5 4863.1 5064.5 4933.6 4955.9 4999.5 5006.6 5014.4 4798.3 4858.6 4887.0 4964.1 4964.1 4817.1 4825.3 4843.6 4870.0 4882.6 4789.0 4806.3 4807.7 4815.6 4855.5 5211.3 5225.8 5251.0 5328.9 5330.7 5643.8 5654.8 5663.1 5668.6 5669.3 5695.0 5698.7 5706.0 5710.6 5712.5 5273.9 5304.7 5325.3 5331.9 5335.7 5731.7 5742.6 5789.8 5805.0 5811.5 5520.5 5529.2 5530.1 5533.4 5536.8 5549.1 5601.3 5708.5 5793.4 5808.0 5708.9 5730.0 5730.8 5754.9 5757.4 5694.6 5731.6 5758.3 5758.4 5763.1 4180.2 4265.0 4291.3 4313.8 4320.8 3820.4 3844.1 3850.5 3883.3 3888.7 5273.6 5406.1 5407.1 5414.4 5428.1 5724.3 5750.3 5760.9 5806.8 5811.8 5349.0 5386.0 5386.8 5387.3 5390.1 4713.4 4768.7 4793.3 4793.6 4833.9 5832.0 5840.4 5862.1 5865.7 5901.4 5656.9 5657.6 5673.6 5674.7 5681.8 5836.6 5855.3 5867.4 5885.3 5988.4 5545.6 5582.6 5582.9 5585.4 5599.9 5624.6 5652.3 5665.1 5666.5 5678.1 5438.6 5556.3 5561.0 5656.6 5681.1 5584.4 5587.6 5589.1 5591.5 5596.8 5488.8 5495.2 5513.0 5513.5 5548.6 5557.5 5579.8 5611.4 5679.4 5689.8 5453.3 5528.3 5550.3 5561.4 5586.2 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#1] ext.html Cycles:180 Average:54435.90 Median:21023.80 stddev:104564.32 (497.4%) stddev-sans-first:104779.52 20:21:12 INFO - PROCESS | 3374 | Values: 597.0 649.7 649.8 656.7 659.9 30518.7 31166.5 31222.2 38035.2 39106.4 41736.6 42451.4 42472.0 42500.8 42633.8 8631.8 8863.4 8869.6 8871.3 8873.4 8775.3 8897.9 8929.2 8932.2 8936.6 8983.0 9018.4 9054.5 9070.9 9072.2 8861.1 8922.5 8923.6 8928.6 8941.8 8826.8 8955.1 8957.8 8961.8 8971.8 40747.6 40855.8 41255.6 41321.4 41324.4 3765.4 3853.0 3865.4 3943.7 4138.2 31685.4 32134.5 32734.8 32838.8 33135.7 3781.7 3841.4 3846.6 3873.7 3970.1 310593.0 311063.0 311723.0 311735.0 312931.0 45523.0 56406.0 57832.7 57908.7 58011.4 48581.3 48690.3 48771.8 52681.7 54150.7 14658.2 14709.0 14756.9 14757.8 14775.2 12786.8 12866.0 12876.5 12878.0 12880.5 14313.1 14604.3 14686.0 15488.1 15851.5 5681.8 5812.7 5845.6 5871.9 5875.1 1007.8 1061.7 1104.6 1150.9 1162.4 28810.9 29807.0 30068.5 30301.5 30474.5 1169.1 1217.8 1248.4 1260.5 1283.9 15946.9 15984.9 16571.4 16819.6 17013.1 468103.0 468952.0 474199.0 474849.0 475382.0 55740.7 55836.0 55964.0 56017.2 56051.7 1422.5 1441.3 1449.8 1457.9 1531.5 30132.5 31211.8 31451.4 31703.0 31871.7 50595.0 50596.5 50762.5 50963.0 51088.5 384172.0 385554.0 385927.0 386875.0 386947.0 26005.9 26786.6 26823.2 27665.2 28224.9 36271.6 42648.8 43094.1 43362.1 43679.0 36478.3 36607.5 37046.3 37313.3 37719.2 36615.6 37049.4 37051.3 37406.8 37594.2 37138.0 38077.0 38159.2 38206.2 41056.0 33872.8 35682.5 35995.0 36051.1 36360.3 27144.6 27226.3 27417.0 27608.4 27733.0 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#2] jquery.html Cycles:180 Average:26782.62 Median:3036.83 stddev:70159.95 (2310.3%) stddev-sans-first:70328.82 20:21:12 INFO - PROCESS | 3374 | Values: 406.3 407.2 407.8 409.4 415.7 12906.6 18081.5 18787.6 18813.8 19054.0 14988.7 16700.5 17936.9 18539.4 18754.8 5475.7 5687.7 5689.7 5695.8 5724.4 5656.6 5676.4 5697.1 5702.9 5705.1 4038.5 5665.7 5886.5 6183.0 6191.3 6081.6 6086.5 6135.6 6136.2 6188.4 5399.7 5534.5 5563.7 5575.0 5577.4 22243.2 22311.4 22495.2 23403.4 23412.1 2379.3 2394.2 2501.6 2917.5 3156.2 9804.3 9848.7 10251.2 10413.1 10456.1 1919.5 1983.7 2032.7 2047.8 2068.8 80009.6 80665.6 81346.0 81398.6 82798.6 10578.8 10648.1 10672.8 10827.6 10829.4 15302.4 15403.0 15409.4 15413.3 15428.5 8259.0 8446.6 8459.2 8563.0 8590.4 8300.1 8383.1 8431.7 8463.5 8573.6 4006.2 4229.7 4437.0 4545.5 4768.8 1914.8 1953.5 1972.3 1973.8 1977.8 979.8 1040.0 1043.5 1090.4 1097.7 18895.6 19165.2 19489.1 19703.5 19716.9 986.7 991.3 1022.1 1064.4 1117.4 8061.3 10651.7 10689.3 10714.8 10813.5 357204.0 361741.0 362326.0 501197.0 501602.0 87812.6 95318.0 95790.5 96062.5 96865.5 1084.1 1103.4 1105.4 1153.9 1167.8 17271.6 17316.3 17453.0 17496.9 17607.6 38221.6 38867.0 39987.6 40070.0 41584.2 51712.2 52464.2 53537.2 53540.7 54875.5 8419.3 8898.0 8933.8 8951.2 9215.3 9124.9 13748.9 13783.7 13922.7 14303.4 11874.3 12021.1 12141.3 12284.8 12653.7 11277.0 11294.2 11523.7 11592.5 12072.2 12329.3 12337.2 12367.3 12399.2 12412.9 8132.9 8476.0 8758.1 8782.6 9018.3 8978.0 11125.0 11728.2 11740.2 11791.2 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#3] mootools.html Cycles:180 Average:5633.69 Median:4723.81 stddev:3151.20 (66.7%) stddev-sans-first:3143.63 20:21:12 INFO - PROCESS | 3374 | Values: 1354.3 1522.0 1546.8 1696.5 1826.6 8126.8 8484.0 8495.0 8499.9 8517.1 8171.3 8401.3 8404.7 8405.3 8405.6 2083.1 2276.8 2316.6 2334.8 2359.5 2330.9 2343.1 2347.4 2348.3 2349.9 2143.3 2174.9 2184.8 2187.4 2190.5 1976.4 2225.7 2281.1 2284.6 2289.0 2196.7 2199.5 2210.2 2213.8 2266.8 8596.3 8652.5 8688.0 8693.3 8707.7 5018.8 5208.4 5221.2 5229.7 5236.9 3197.4 3229.0 3308.9 3362.0 3366.3 1005.2 1045.5 1050.8 1053.1 1055.3 11549.7 11587.9 11743.4 11760.6 11793.8 4614.5 4622.9 4660.5 4716.6 4718.5 10002.8 10065.4 10081.8 10107.8 10120.6 4741.4 5210.2 5253.6 5258.1 5262.6 4598.8 4677.1 4680.9 4729.2 4732.0 3904.4 3945.6 4040.0 4043.4 4070.7 1265.9 1278.0 1281.8 1285.9 1305.5 1016.3 1016.7 1043.1 1050.2 1050.8 5694.8 5808.4 5865.3 5882.4 5974.9 461.0 461.7 467.6 469.2 481.7 4204.2 4218.6 4226.5 4228.7 4255.8 9954.0 10456.0 10467.5 10535.6 10537.6 10203.3 10363.9 10376.6 10411.3 10417.6 7628.7 7811.8 8014.8 8034.3 8051.3 5824.6 5842.7 5925.9 5996.5 5997.5 9050.4 9319.8 9534.6 9566.1 9862.6 9409.5 9566.0 9770.9 9943.8 9951.3 6578.1 7405.0 7453.8 7648.0 7672.1 8225.3 8277.9 8283.0 8305.3 8352.0 7217.3 7358.5 7407.9 7461.1 7572.0 7385.6 7487.0 7548.0 7613.5 7626.8 6829.1 6835.7 6896.2 6899.6 6902.6 5206.9 5245.8 5378.3 5404.4 5421.5 5296.0 5368.4 5370.6 5383.0 5433.6 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#4] prototype.html Cycles:180 Average:4727.82 Median:5319.76 stddev:1400.29 (26.3%) stddev-sans-first:1364.76 20:21:12 INFO - PROCESS | 3374 | Values: 330.0 332.5 333.2 339.5 340.5 5224.0 5226.9 5247.1 5251.0 5285.6 5154.5 5167.3 5180.6 5185.4 5195.8 3906.7 3970.1 4129.7 4136.9 4149.4 4112.7 4138.4 4144.7 4147.4 4150.4 3875.4 4109.1 4110.8 4113.8 4113.9 3940.7 4039.1 4066.2 4081.8 4085.7 3609.4 3619.3 3649.5 3654.0 3655.7 4974.8 4993.6 4994.2 5000.1 5012.3 4568.0 4637.4 4655.3 4667.7 4672.7 5329.8 5347.8 5376.7 5381.9 5391.6 3985.2 3991.4 4000.8 4009.0 4023.4 5367.4 5564.6 5565.2 5593.9 5642.2 4083.3 4104.7 4120.3 4121.3 4138.6 4132.3 4148.9 4170.1 4177.9 4181.6 4485.4 4661.4 4670.1 4733.7 4737.8 5389.4 5414.5 5418.0 5454.0 5462.8 1490.3 1490.7 1509.8 1520.9 1524.5 973.8 993.9 995.6 1037.7 1062.5 5473.2 5484.3 5500.0 5514.6 5628.5 5945.4 5956.8 5962.1 5971.6 5976.6 5349.7 5517.3 5547.9 5555.6 5577.1 3122.4 3123.4 3137.9 3138.9 3179.2 5905.9 6060.8 6075.3 6085.2 6094.2 6079.5 6087.2 6089.9 6108.8 6147.3 6044.8 6064.3 6095.1 6148.8 6196.9 5860.8 5969.6 5982.7 5987.9 5990.6 5924.3 5938.4 5947.7 5962.3 5973.5 6009.2 6140.4 6202.6 6203.3 6216.1 4289.8 4292.2 4294.2 4302.3 4308.2 5906.6 5918.3 5921.8 5933.6 5976.1 5287.6 5578.1 5598.1 5859.7 5867.7 5217.2 5316.0 5513.4 5524.3 5540.4 5437.4 5453.6 5463.5 5468.0 5484.6 5315.3 5438.6 5526.5 5535.4 5561.8 5323.5 5386.5 5408.9 5418.0 5427.4 20:21:12 INFO - PROCESS | 3374 | 20:21:12 INFO - PROCESS | 3374 | [#5] yui.html Cycles:180 Average:14514.64 Median:41668.37 stddev:16774.69 (40.3%) stddev-sans-first:16789.60 20:21:12 INFO - PROCESS | 3374 | Values: 684.6 761.6 768.4 772.9 779.6 14471.6 14796.0 14812.3 14832.0 14840.0 14329.3 14711.6 14835.3 14849.1 14872.1 681.0 837.1 838.0 842.1 842.3 806.4 835.2 837.0 837.8 838.6 867.0 875.1 878.8 879.3 881.8 709.6 841.1 879.6 880.0 880.1 631.4 631.4 633.1 634.4 634.9 14134.6 14220.5 14272.4 14277.4 14283.5 12758.0 13127.6 13232.3 13376.2 14312.1 10685.6 10908.8 10963.4 11208.4 11376.5 3786.6 3851.9 3864.6 3869.9 3964.1 59199.0 60295.4 60386.7 60463.7 61150.0 9910.1 10833.8 10891.3 10928.8 11147.3 18108.6 18468.4 18485.4 18494.0 18537.7 7610.9 7678.6 7683.3 7951.5 7966.6 4596.3 4628.1 4686.4 4764.9 4847.6 3323.2 3346.4 3385.8 3387.5 3391.6 533.7 534.2 541.1 548.8 551.3 612.4 637.7 658.4 688.7 689.6 8796.3 9033.1 9158.6 9408.3 9648.2 712.5 752.0 768.7 793.4 805.6 3957.6 3979.7 3987.3 4091.3 4139.9 58483.0 59598.4 59892.0 60011.4 60568.7 50488.0 50828.0 51175.5 52332.2 53729.4 47117.5 47675.8 47809.3 48363.3 49260.8 7770.7 7893.4 8451.6 8493.7 8636.9 31912.7 32394.7 32846.7 33107.2 33285.8 39888.8 41502.4 41834.4 41841.6 42799.8 11468.3 11561.1 11766.2 11837.3 11938.3 12978.4 13176.8 13200.7 13266.5 13417.4 11885.7 12171.7 12354.8 12457.7 12475.4 11967.5 12061.5 12117.3 12367.1 12529.7 12008.5 12231.6 12422.2 12515.1 12662.7 10405.9 10589.7 10844.2 10847.9 10938.9 10676.7 10781.9 10829.8 10878.8 10907.3 20:21:12 INFO - PROCESS | 3374 | -------- Summary: end -------- 20:21:12 INFO - PROCESS | 3374 | 20:21:13 INFO - TEST-INFO | 3374: exit 0 20:21:13 INFO - TEST-OK | dromaeo_css | took 1113149ms 20:21:13 INFO - TEST-START | kraken 20:21:13 INFO - operating with platform_type : linux_ 20:21:13 INFO - Initialising browser for kraken test... 20:21:13 INFO - TEST-INFO | started process 3554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVhwFM/profile http://localhost:53320/getInfo.html) 20:21:17 INFO - PROCESS | 3554 | __metrics Screen width/height:1600/1200 20:21:17 INFO - PROCESS | 3554 | colorDepth:24 20:21:17 INFO - PROCESS | 3554 | Browser inner width/height: 1024/697 20:21:17 INFO - PROCESS | 3554 | __metrics 20:21:18 ERROR - PROCESS | 3554 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:21:18 INFO - PROCESS | 3554 | console.error: PushService: 20:21:18 INFO - PROCESS | 3554 | stateChangeProcessEnqueue: Error transitioning state 20:21:18 INFO - PROCESS | 3554 | UnknownError 20:21:18 INFO - TEST-INFO | 3554: exit 0 20:21:18 INFO - Browser initialized. 20:21:18 INFO - Running cycle 1/1 for kraken test... 20:21:18 INFO - TEST-INFO | started process 3636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVhwFM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:30 INFO - PROCESS | 3636 | RSS: Main: 154210304 20:21:30 INFO - PROCESS | 3636 | 20:21:33 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53320/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:34 INFO - PROCESS | 3636 | RSS: Main: 209203200 20:21:34 INFO - PROCESS | 3636 | 20:21:36 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53320/tests/kraken/driver.html?testName=audio-dft) 20:21:37 INFO - PROCESS | 3636 | RSS: Main: 196521984 20:21:37 INFO - PROCESS | 3636 | 20:21:40 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53320/tests/kraken/driver.html?testName=audio-fft) 20:21:41 INFO - PROCESS | 3636 | RSS: Main: 266223616 20:21:41 INFO - PROCESS | 3636 | 20:21:43 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53320/tests/kraken/driver.html?testName=audio-oscillator) 20:21:43 INFO - PROCESS | 3636 | RSS: Main: 173944832 20:21:43 INFO - PROCESS | 3636 | 20:21:45 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:46 INFO - PROCESS | 3636 | RSS: Main: 178409472 20:21:46 INFO - PROCESS | 3636 | 20:21:49 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53320/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:50 INFO - PROCESS | 3636 | RSS: Main: 214908928 20:21:50 INFO - PROCESS | 3636 | 20:21:53 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53320/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:54 INFO - PROCESS | 3636 | RSS: Main: 214634496 20:21:54 INFO - PROCESS | 3636 | 20:21:56 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53320/tests/kraken/driver.html?testName=json-parse-financial) 20:21:57 INFO - PROCESS | 3636 | RSS: Main: 215482368 20:21:57 INFO - PROCESS | 3636 | 20:21:59 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:59 INFO - PROCESS | 3636 | RSS: Main: 201781248 20:21:59 INFO - PROCESS | 3636 | 20:22:01 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:02 INFO - PROCESS | 3636 | RSS: Main: 201195520 20:22:02 INFO - PROCESS | 3636 | 20:22:04 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:05 INFO - PROCESS | 3636 | RSS: Main: 214347776 20:22:05 INFO - PROCESS | 3636 | 20:22:07 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:08 INFO - PROCESS | 3636 | RSS: Main: 224272384 20:22:08 INFO - PROCESS | 3636 | 20:22:11 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:11 INFO - PROCESS | 3636 | RSS: Main: 221171712 20:22:11 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:53320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53320/tests/kraken/driver.html?testName=ai-astar) 20:22:13 INFO - PROCESS | 3636 | RSS: Main: 284565504 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | __start_tp_report 20:22:13 INFO - PROCESS | 3636 | _x_x_mozilla_page_load 20:22:13 INFO - PROCESS | 3636 | _x_x_mozilla_page_load_details 20:22:13 INFO - PROCESS | 3636 | |i|pagename|runs| 20:22:13 INFO - PROCESS | 3636 | |0;ai-astar;111;115;106;110;112;112;100;112;110;111 20:22:13 INFO - PROCESS | 3636 | |1;audio-beat-detection;151;127;153;184;125;159;157;128;177;130 20:22:13 INFO - PROCESS | 3636 | |2;audio-dft;161;160;161;161;161;159;159;160;160;161 20:22:13 INFO - PROCESS | 3636 | |3;audio-fft;75;77;122;125;74;75;74;131;102;74 20:22:13 INFO - PROCESS | 3636 | |4;audio-oscillator;92;92;141;93;93;93;164;92;93;150 20:22:13 INFO - PROCESS | 3636 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;118 20:22:13 INFO - PROCESS | 3636 | |6;imaging-darkroom;145;145;145;147;145;145;145;146;145;146 20:22:13 INFO - PROCESS | 3636 | |7;imaging-desaturate;94;94;95;95;95;96;96;96;96;96 20:22:13 INFO - PROCESS | 3636 | |8;json-parse-financial;58;56;58;57;56;57;56;81;57;54 20:22:13 INFO - PROCESS | 3636 | |9;json-stringify-tinderbox;58;58;58;58;58;60;61;58;59;58 20:22:13 INFO - PROCESS | 3636 | |10;stanford-crypto-aes;75;76;75;76;76;76;77;78;76;76 20:22:13 INFO - PROCESS | 3636 | |11;stanford-crypto-ccm;123;121;120;126;123;124;119;122;153;121 20:22:13 INFO - PROCESS | 3636 | |12;stanford-crypto-pbkdf2;168;163;164;164;165;163;166;164;160;166 20:22:13 INFO - PROCESS | 3636 | |13;stanford-crypto-sha256-iterative;69;68;71;68;67;67;68;69;67;66 20:22:13 INFO - PROCESS | 3636 | __end_tp_report 20:22:13 INFO - PROCESS | 3636 | __start_cc_report 20:22:13 INFO - PROCESS | 3636 | _x_x_mozilla_cycle_collect,1663 20:22:13 INFO - PROCESS | 3636 | __end_cc_report 20:22:13 INFO - PROCESS | 3636 | __startTimestamp1462418533563__endTimestamp 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | ------- Summary: start ------- 20:22:13 INFO - PROCESS | 3636 | Number of tests: 14 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.15 (3.7%) stddev-sans-first:4.38 20:22:13 INFO - PROCESS | 3636 | Values: 111.0 115.0 106.0 110.0 112.0 112.0 100.0 112.0 110.0 111.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:21.23 (13.7%) stddev-sans-first:22.50 20:22:13 INFO - PROCESS | 3636 | Values: 151.0 127.0 153.0 184.0 125.0 159.0 157.0 128.0 177.0 130.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 20:22:13 INFO - PROCESS | 3636 | Values: 161.0 160.0 161.0 161.0 161.0 159.0 159.0 160.0 160.0 161.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.00 stddev:24.44 (33.0%) stddev-sans-first:25.05 20:22:13 INFO - PROCESS | 3636 | Values: 75.0 77.0 122.0 125.0 74.0 75.0 74.0 131.0 102.0 74.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:29.07 (31.4%) stddev-sans-first:30.07 20:22:13 INFO - PROCESS | 3636 | Values: 92.0 92.0 141.0 93.0 93.0 93.0 164.0 92.0 93.0 150.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:22:13 INFO - PROCESS | 3636 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:22:13 INFO - PROCESS | 3636 | Values: 145.0 145.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 20:22:13 INFO - PROCESS | 3636 | Values: 94.0 94.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:57.00 stddev:7.82 (13.7%) stddev-sans-first:8.28 20:22:13 INFO - PROCESS | 3636 | Values: 58.0 56.0 58.0 57.0 56.0 57.0 56.0 81.0 57.0 54.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 20:22:13 INFO - PROCESS | 3636 | Values: 58.0 58.0 58.0 58.0 58.0 60.0 61.0 58.0 59.0 58.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:0.88 (1.2%) stddev-sans-first:0.83 20:22:13 INFO - PROCESS | 3636 | Values: 75.0 76.0 75.0 76.0 76.0 76.0 77.0 78.0 76.0 76.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:123.00 stddev:9.98 (8.1%) stddev-sans-first:10.55 20:22:13 INFO - PROCESS | 3636 | Values: 123.0 121.0 120.0 126.0 123.0 124.0 119.0 122.0 153.0 121.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:2.16 (1.3%) stddev-sans-first:1.83 20:22:13 INFO - PROCESS | 3636 | Values: 168.0 163.0 164.0 164.0 165.0 163.0 166.0 164.0 160.0 166.0 20:22:13 INFO - PROCESS | 3636 | 20:22:13 INFO - PROCESS | 3636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 20:22:13 INFO - PROCESS | 3636 | Values: 69.0 68.0 71.0 68.0 67.0 67.0 68.0 69.0 67.0 66.0 20:22:13 INFO - PROCESS | 3636 | -------- Summary: end -------- 20:22:13 INFO - PROCESS | 3636 | 20:22:14 INFO - TEST-INFO | 3636: exit 0 20:22:14 INFO - TEST-OK | kraken | took 61415ms 20:22:14 INFO - SUITE-END | took 1174s 20:22:14 INFO - Completed test suite (00:19:34) 20:22:14 INFO - javascript benchmark 20:22:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.8770449182034, 3110.5800716903213, 3148.039847846407, 3158.2262345725303, 3183.1087295557245, 5291.708956007418, 5292.814751483699, 5361.463853614637, 5384.300040994675, 5486.725663716818, 5348.812791552296, 5351.331083614548, 5388.030154572176, 5425.9186112208345, 5434.701091439969, 4834.685745426545, 4856.684315519497, 4859.514048595148, 4863.076015557051, 5064.468230835764, 4933.555979961803, 4955.876103097416, 4999.500049995007, 5006.5744411725045, 5014.448410674823, 4798.280257961316, 4858.611311095104, 4887.0225954809, 4964.106460837048, 4964.106460837048, 4817.132916075105, 4825.324454576327, 4843.612510999112, 4869.975650121763, 4882.560569548722, 4789.0, 4806.303086052503, 4807.711537307773, 4815.566599006106, 4855.514448555152, 5211.348581427322, 5225.764840582183, 5251.0, 5328.893422131536, 5330.733463326818, 5643.774249030034, 5654.773809047633, 5663.093904975225, 5668.57485688575, 5669.291338582677, 5695.0033744095035, 5698.7435565399655, 5706.029974904276, 5710.628809127394, 5712.514436272922, 5273.894522109536, 5304.734763261821, 5325.307709997675, 5331.920021199685, 5335.706536140549, 5731.713414329351, 5742.569307301969, 5789.8263052108505, 5805.0, 5811.476967072984, 5520.530754885799, 5529.170624406291, 5530.142827861688, 5533.446655334515, 5536.75084621193, 5549.112142057252, 5601.29983752031, 5708.457696518824, 5793.420657934257, 5807.954568177768, 5708.914366284509, 5730.0, 5730.8280751576685, 5754.935336962675, 5757.366689664133, 5694.629849059798, 5731.5701322400155, 5758.251427314506, 5758.3665796762325, 5763.135529670499, 4180.163967206571, 4264.957350426456, 4291.291936830388, 4313.762743049162, 4320.783960801948, 3820.3505404081375, 3844.1350696093155, 3850.5186851643543, 3883.281592905265, 3888.650021498079, 5273.630845840754, 5406.053940560465, 5407.107827208545, 5414.431484694129, 5428.131498960148, 5724.284464441945, 5750.338711048283, 5760.884782304414, 5806.79676211339, 5811.82564523065, 5349.0, 5385.973070134624, 5386.757595908193, 5387.326584176978, 5390.0836857734275, 4713.410823647044, 4768.690035147704, 4793.32893394918, 4793.616510679138, 4833.927491087637, 5832.0, 5840.386759390203, 5862.062070068769, 5865.706714664249, 5901.380355062656, 5656.943430565806, 5657.632253903483, 5673.602847800779, 5674.659520428788, 5681.77272909079, 5836.649801011953, 5855.3266374367495, 5867.354590994902, 5885.293764748258, 5988.431099045583, 5545.639533430314, 5582.609217354746, 5582.944170558242, 5585.357683866245, 5599.888002239851, 5624.634398764068, 5652.293463317085, 5665.12190610456, 5666.518345940642, 5678.119891416837, 5438.592105592017, 5556.305461817273, 5560.97219513916, 5656.632318899258, 5681.0626246668835, 5584.3857175711455, 5587.5809314302405, 5589.105743081088, 5591.496765291144, 5596.776128954796, 5488.780448782004, 5495.230667706444, 5513.0, 5513.476219759116, 5548.639338442988, 5557.499825015768, 5579.832605021856, 5611.410801865745, 5679.37526872052, 5689.829305120853, 5453.345598528202, 5528.308961379827, 5550.333959924835, 5561.443855614406, 5586.245856809442], "value": 5253.426008284434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.988060238795, 649.6654223075117, 649.775827339568, 656.6782276684426, 659.8779225843219, 30518.69481305186, 31166.532502012487, 31222.21944451387, 38035.239295214145, 39106.413403798964, 41736.58263417365, 42451.36322955158, 42472.0, 42500.787496062556, 42633.78683106588, 8631.784205394853, 8863.379563430562, 8869.645214191425, 8871.334649901282, 8873.423227490224, 8775.25410340122, 8897.911020889773, 8929.241014513742, 8932.196102350787, 8936.64253429862, 8983.0, 9018.41380310281, 9054.502002389865, 9070.909290907106, 9072.228860546862, 8861.069587693264, 8922.509261990588, 8923.553822308924, 8928.598213080362, 8941.77645558863, 8826.779330516723, 8955.05971872957, 8957.776055598597, 8961.775955601097, 8971.820563588757, 40747.59252407467, 40855.795721021204, 41255.58744412548, 41321.38017929703, 41324.38013429801, 3765.4351847223134, 3853.0174805424717, 3865.439511270878, 3943.6647884929816, 4138.172365526907, 31685.366292674018, 32134.487826190514, 32734.836325818458, 32838.83580582082, 33135.6686433135, 3781.6596506314563, 3841.3661745811905, 3846.5576458707046, 3873.6707379872746, 3970.086880017612, 310593.0, 311063.0, 311723.0, 311735.0, 312931.0, 45523.0, 56406.0, 57832.71083644639, 57908.710456448294, 58011.41988580144, 48581.271280930814, 48690.26964595534, 48771.75614121907, 52681.73659131757, 54150.72924635352, 14658.19379934114, 14709.0, 14756.852431475763, 14757.778633320295, 14775.187364695044, 12786.808197877039, 12866.035047371484, 12876.549320773727, 12878.0, 12880.484780608858, 14313.141211527342, 14604.269786510631, 14686.0, 15488.070715756865, 15851.524454266391, 5681.835223779115, 5812.709364531756, 5845.649261044351, 5871.854988277245, 5875.061229794158, 1007.8236308645958, 1061.7451811565168, 1104.6023431564631, 1150.9194356394971, 1162.436218434059, 28810.855945720137, 29807.0, 30068.496575171153, 30301.545476817864, 30474.54288185679, 1169.0764296206073, 1217.7747116783423, 1248.3570960955115, 1260.464302671361, 1283.940748882176, 15946.9202653986, 15984.920075399548, 16571.42000029993, 16819.57951051209, 17013.149342532823, 468103.0, 468952.0, 474199.0, 474849.0, 475382.0, 55740.72129639407, 55836.0, 55964.0, 56017.15974260389, 56051.71974140103, 1422.4594654031403, 1441.2793603198402, 1449.7970284160226, 1457.883369330451, 1531.540537838644, 30132.548011779403, 31211.843940780152, 31451.370972580877, 31703.0, 31871.68128318687, 50595.0, 50596.49403505918, 50762.49237507577, 50963.0, 51088.489115109856, 384172.0, 385554.0, 385927.0, 386875.0, 386947.0, 26005.869970650027, 26786.59820102661, 26823.195304140907, 27665.170044898685, 28224.85887570549, 36271.63728362683, 42648.78675606602, 43094.13811723811, 43362.13275734531, 43679.0, 36478.27043459063, 36607.45088823616, 37046.25907481781, 37313.25373492569, 37719.245615087, 36615.63384366122, 37049.44425833561, 37051.258974819815, 37406.812965934994, 37594.24811503809, 37138.0, 38077.0, 38159.23681526409, 38206.235875282895, 41056.0, 33872.830635846665, 35682.46476302806, 35995.0, 36051.098722532144, 36360.27279454449, 27144.592831107155, 27226.31934201661, 27417.0, 27608.447831042864, 27733.0], "value": 19138.739859471592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.28696637401373, 407.1632794607081, 407.8348268951072, 409.40636077687356, 415.68670349505004, 12906.612801615944, 18081.54796130096, 18787.624247515043, 18813.81186188138, 19054.047297635134, 14988.7002259955, 16700.49898503047, 17936.9237845729, 18539.44381668552, 18754.812451875478, 5475.72621368932, 5687.658740475585, 5689.715514224272, 5695.800646977356, 5724.427557244284, 5656.604037717361, 5676.375598684142, 5697.145428185764, 5702.914456283159, 5705.058665320217, 4038.4548086008454, 5665.688387138705, 5886.470217680408, 6182.96908515459, 6191.288001879797, 6081.574289799693, 6086.45221930024, 6135.631862088289, 6136.23297087864, 6188.381161883798, 5399.676019438846, 5534.501894829445, 5563.693996830173, 5575.024370735146, 5577.358603760579, 22243.22148724787, 22311.442213944618, 22495.212667556556, 23403.414914627272, 23412.063517459283, 2379.298107058422, 2394.174009966559, 2501.5997440409446, 2917.4748545261846, 3156.1793933577205, 9804.264680148946, 9848.704538863774, 10251.231157663206, 10413.062824345769, 10456.111230545413, 1919.4721451600783, 1983.652860749363, 2032.7255820464343, 2047.7747447780732, 2068.7620923593827, 80009.59995199987, 80665.59667201627, 81346.0, 81398.5930070346, 82798.58600707017, 10578.841317380246, 10648.094911932572, 10672.78654426907, 10827.621033263798, 10829.372160326222, 15302.387904483696, 15403.0, 15409.383624655113, 15413.306401211748, 15428.460003900034, 8258.958705206436, 8446.61990210442, 8459.196376344238, 8562.957185214034, 8590.398672093019, 8300.12848650883, 8383.11977242393, 8431.704890328809, 8463.534505602127, 8573.571321433903, 4006.1787333597126, 4229.7250678706405, 4437.023854751949, 4545.4545454545005, 4768.809247630125, 1914.7893731689503, 1953.4823271832975, 1972.2801177570084, 1973.7828838827718, 1977.7626684797917, 979.7991411760572, 1040.016290608567, 1043.5408420295198, 1090.3675867996542, 1097.7145942055124, 18895.62208755817, 19165.233390664496, 19489.122989465508, 19703.507412314808, 19716.90141549283, 986.7074132885799, 991.3407583956588, 1022.1465076660922, 1064.377339256528, 1117.4189421500773, 8061.3147882429475, 10651.73370665724, 10689.30519516229, 10714.839277410845, 10813.459327033617, 357204.0, 361741.0, 362326.0, 501197.0, 501602.0, 87812.56093719491, 95318.0, 95790.52104739571, 96062.51968740112, 96865.51567242118, 1084.0514549768952, 1103.3986477369854, 1105.4141305108305, 1153.8846115388394, 1167.7664467106613, 17271.6457898052, 17316.30734770595, 17453.040082795567, 17496.91251543734, 17607.559811004827, 38221.648969144895, 38867.0, 39987.60012399839, 40070.0, 41584.1683166341, 51712.22431663453, 52464.21303680524, 53537.19694204512, 53540.73229633827, 54875.451245487035, 8419.326453883798, 8897.955510222408, 8933.776655583402, 8951.239144672776, 9215.308851836273, 9124.863127052966, 13748.862511375159, 13783.655408614864, 13922.651933701738, 14303.35634896453, 11874.287542747463, 12021.098417618889, 12141.271523708252, 12284.832940870603, 12653.683657908627, 11277.041451476716, 11294.209405341548, 11523.654290371302, 11592.536298547964, 12072.215306005082, 12329.321887296284, 12337.198082124993, 12367.257964522158, 12399.194052386567, 12412.875871241173, 8132.87800683002, 8476.0, 8758.124187581447, 8782.56087195625, 9018.278537716837, 8978.0, 11125.0, 11728.237664551776, 11740.178187526792, 11791.174617776673], "value": 9213.971982482539, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.3431435753664, 1521.954341369759, 1546.806649168854, 1696.508012676324, 1826.56162520995, 8126.796830079251, 8483.95758021209, 8494.957525212372, 8499.872501912469, 8517.10570390108, 8171.305439037674, 8401.327893768499, 8404.705835295767, 8405.285550728195, 8405.57972101394, 2083.073032500538, 2276.7837055479786, 2316.6409206572966, 2334.8132149428006, 2359.528094381122, 2330.883455827202, 2343.121329501437, 2347.3896786835376, 2348.3072493614427, 2349.882505874708, 2143.3248526714115, 2174.934751957444, 2184.792444717757, 2187.354730354541, 2190.463336482564, 1976.3675623800389, 2225.710657614508, 2281.1103669568884, 2284.623037198877, 2288.954220915589, 2196.7034450349156, 2199.472126689599, 2210.2153735423854, 2213.7564867864685, 2266.784655457729, 8596.312295016383, 8652.524111173883, 8687.956560217222, 8693.304535637133, 8707.738767836974, 5018.84943451697, 5208.401033881114, 5221.216817477371, 5229.686218826882, 5236.895262094737, 3197.392495425862, 3229.0, 3308.8676452942095, 3362.0, 3366.343563005215, 1005.1506477026974, 1045.4877110216016, 1050.8056009638165, 1053.1416895230363, 1055.3193190392153, 11549.711257218552, 11587.942060289728, 11743.412829358498, 11760.58837940668, 11793.764124717458, 4614.538546145359, 4622.884427889329, 4660.487346391894, 4716.64625153108, 4718.457377401643, 10002.849957250646, 10065.446400448045, 10081.848772268422, 10107.848382274271, 10120.595176193017, 4741.407324084489, 5210.244514545369, 5253.553447956967, 5258.132408152688, 5262.631615786935, 4598.816047358068, 4677.134730074947, 4680.9297860532115, 4729.172394830891, 4731.952680473151, 3904.39481880309, 3945.585713500099, 4039.979800100981, 4043.353063509824, 4070.6946978976102, 1265.873412658745, 1277.9744405111846, 1281.7756892543769, 1285.884719636212, 1305.5234839283594, 1016.3343010328247, 1016.6645007147623, 1043.1289872956168, 1050.1861057680205, 1050.8371202463477, 5694.800681976111, 5808.361080281165, 5865.272070725937, 5882.382349853204, 5974.910376344358, 460.96312295016315, 461.7160446325486, 467.57684295712437, 469.1953300090361, 481.6556162343871, 4204.2432362175105, 4218.641415479658, 4226.492820861455, 4228.682848786353, 4255.787210639455, 9954.0, 10456.0, 10467.528961196764, 10535.631252906265, 10537.631182908715, 10203.316452785355, 10363.94818025905, 10376.584936602452, 10411.323263987817, 10417.583296668048, 7628.694852205849, 7811.80470488231, 8014.799630009296, 8034.276915077554, 8051.315638170821, 5824.5631577631, 5842.737076831638, 5925.9407405925385, 5996.490298324691, 5997.520198384032, 9050.366474346733, 9319.813603728024, 9534.570944307385, 9566.091221333962, 9862.55618497155, 9409.48247846375, 9565.952170239383, 9770.902290977, 9943.751406214902, 9951.303408761607, 6578.111954886029, 7404.96297518509, 7453.81365465846, 7648.043994500687, 7672.079350477979, 8225.341972642054, 8277.875831862648, 8282.958585207036, 8305.335573154012, 8352.039515455557, 7217.278272172741, 7358.521696089737, 7407.851842963003, 7461.141968673672, 7572.0, 7385.556866588022, 7486.962565187139, 7547.962260188664, 7613.467057305936, 7626.847463050819, 6829.146356705412, 6835.726570937107, 6896.206936202401, 6899.6205208714, 6902.620355880475, 5206.8958620828125, 5245.816396426107, 5378.300820893259, 5404.378496472798, 5421.484958928895, 5296.0, 5368.3557973041925, 5370.570354371563, 5383.0, 5433.56531477473], "value": 4465.54754571668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.0280673416789, 332.53849332185047, 333.21029160888696, 339.46364743704964, 340.4790670274478, 5224.0, 5226.86932826679, 5247.055530004598, 5250.9737451312785, 5285.577153827699, 5154.484551544843, 5167.261351483719, 5180.6373553851245, 5185.377754669445, 5195.792168313263, 3906.706996975217, 3970.06703424695, 4129.67850287908, 4136.917261654765, 4149.419081328601, 4112.732672376286, 4138.3999320098565, 4144.668426525871, 4147.419361289422, 4150.356694712309, 3875.3723436156884, 4109.0959988802415, 4110.753354798707, 4113.753174809506, 4113.9177216455655, 3940.660175540316, 4039.111395493016, 4066.1867626474823, 4081.7958302516604, 4085.6527195188446, 3609.350316942949, 3619.3304238715923, 3649.489071529988, 3653.963460365389, 3655.670989610948, 4974.816117684684, 4993.550580447777, 4994.2009278515625, 5000.124978128849, 5012.27322038306, 4567.972206253599, 4637.443506779175, 4655.301704744282, 4667.696599721007, 4672.742999135046, 5329.840104796862, 5347.839564813062, 5376.677399356051, 5381.865453363658, 5391.56867450603, 3985.2228815381013, 3991.44119823225, 4000.7999600020175, 4009.0, 4023.376376661622, 5367.382750983609, 5564.610477266593, 5565.220869078333, 5593.916091258634, 5642.153676948491, 4083.305838007546, 4104.712670113064, 4120.299549076604, 4121.319982202963, 4138.586141385837, 4132.318167502389, 4148.937765933513, 4170.124273902515, 4177.937330940038, 4181.560936101726, 4485.372047913294, 4661.370714953506, 4670.136024835417, 4733.739644319596, 4737.786799594027, 5389.380221274603, 5414.538074719803, 5417.972910135424, 5454.045542030129, 5462.8361149165585, 1490.2772155504572, 1490.701859628057, 1509.7810817431412, 1520.8783297336408, 1524.4755244755245, 973.8003709239589, 993.9453330066916, 995.6266400099962, 1037.7146284771748, 1062.4953147255146, 5473.17902314648, 5484.2596249506605, 5499.972500137474, 5514.558835293167, 5628.465295796893, 5945.40545945402, 5956.791512297049, 5962.092130518279, 5971.566349349142, 5976.641401515923, 5349.652272602269, 5517.282753242052, 5547.86268814892, 5555.555555555546, 5577.107662773937, 3122.4223518649123, 3123.4377811993604, 3137.8901738439044, 3138.905832825019, 3179.2210908327147, 5905.881882362329, 6060.848478788065, 6075.33171351151, 6085.1785009023215, 6094.177286066413, 6079.513638908877, 6087.239095113111, 6089.939100609025, 6108.786192483241, 6147.293061297919, 6044.788432404845, 6064.302605200371, 6095.116208149882, 6148.78479253224, 6196.8760624787255, 5860.765569377178, 5969.611975221596, 5982.670953097621, 5987.940120598738, 5990.580659353804, 5924.281958232064, 5938.435848594377, 5947.672877991579, 5962.314333851663, 5973.492253158356, 6009.248843894513, 6140.416660417253, 6202.627842329474, 6203.294094124152, 6216.129741836056, 4289.828406863815, 4292.205941900758, 4294.205571969195, 4302.311630139163, 4308.181445525465, 5906.645601263938, 5918.319393269657, 5921.792737254175, 5933.614315069507, 5976.133460648269, 5287.57699384056, 5578.135389014709, 5598.10430331145, 5859.736311865891, 5867.735951882261, 5217.217417387422, 5316.0, 5513.421090785409, 5524.33707955048, 5540.36285827135, 5437.374701909331, 5453.590980676386, 5463.535599474089, 5468.0, 5484.61607687458, 5315.272536425599, 5438.646487978269, 5526.530244929226, 5535.391106978149, 5561.777528898799, 5323.520883120537, 5386.5152136307925, 5408.918866217088, 5418.0, 5427.4301198373605], "value": 4290.299867906244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.6166146957704, 761.6153842309633, 768.3699366519453, 772.8995230620019, 779.5973900866993, 14471.5658530244, 14796.0, 14812.25938703066, 14832.0, 14840.0, 14329.283535823219, 14711.558653240394, 14835.332410041547, 14849.143857017873, 14872.107673539595, 680.9523333366666, 837.1461109668135, 837.9790505237372, 842.1241908415241, 842.296682270302, 806.3549160671439, 835.173178553234, 837.0123254559617, 837.7696133563288, 838.6016642095017, 866.9609867555976, 875.0855356152836, 878.7715194049562, 879.2658130461073, 881.7883707910088, 709.6061685764398, 841.0622156295748, 879.617366445595, 880.0319648386755, 880.1330689271063, 631.3654776949137, 631.4159402552621, 633.1136409027353, 634.3529599808215, 634.8508100596356, 14134.646633834134, 14220.502282420066, 14272.35774390155, 14277.357518911675, 14283.500077497341, 12758.0, 13127.571399291162, 13232.338383080807, 13376.184573553513, 14312.141271523638, 10685.572577096984, 10908.781824363548, 10963.397013164273, 11208.383538905357, 11376.488058037408, 3786.6024067473068, 3851.8651847185492, 3864.574896761354, 3869.9032524186837, 3964.1278918637854, 59199.0, 60295.397046029415, 60386.69806650982, 60463.69768151175, 61149.999999999556, 9910.108090271766, 10833.78332433347, 10891.346519208873, 10928.781424371467, 11147.275427097213, 18108.637827243645, 18468.353607623936, 18485.44543663692, 18494.0, 18537.721934170997, 7610.885836712454, 7678.61606919663, 7683.270089341504, 7951.522908625501, 7966.6415011324625, 4596.333531637893, 4628.143793398232, 4686.36734040907, 4764.880877978078, 4847.563719265283, 3323.1692076980753, 3346.4311067118647, 3385.779924304912, 3387.5088112224084, 3391.593008838955, 533.706461446203, 534.2203907355475, 541.0585581088877, 548.8243761996202, 551.2695678226366, 612.4212619075021, 637.6652257564815, 658.4403257231411, 688.6625553478759, 689.582802404548, 8796.340274479311, 9033.141851524095, 9158.633654653873, 9408.294377921684, 9648.228141748643, 712.4976891291627, 751.9624018799038, 768.692522990797, 793.3573805217792, 805.5529181304432, 3957.6240257175523, 3979.6617287530885, 3987.2623564640635, 4091.3249313863475, 4139.937900931488, 58483.0, 59598.404015959284, 59892.0, 60011.399886001454, 60568.69715651482, 50488.0, 50828.0, 51175.48824511782, 52332.21501677478, 53729.41911305434, 47117.52882471269, 47675.761621191676, 47809.282860757114, 48363.27455088106, 49260.75369623129, 7770.689172433039, 7893.407994400328, 8451.577421129043, 8493.660253589787, 8636.870446943176, 31912.6808731919, 32394.704211831264, 32846.67153328436, 33107.172320692174, 33285.833570831994, 39888.80055599703, 41502.377464338664, 41834.37248441337, 41841.58158418377, 42799.7860010698, 11468.31190128595, 11561.132915031574, 11766.235194712317, 11837.348945808064, 11938.343391113573, 12978.415971281504, 13176.802347964596, 13200.669983250496, 13266.53567125146, 13417.396217170055, 11885.702857428634, 12171.695707607381, 12354.814677780021, 12457.688557786129, 12475.376231188586, 11967.461464234304, 12061.457234424648, 12117.27296362221, 12367.134300598871, 12529.749405012031, 12008.459619317326, 12231.633051008128, 12422.192557483735, 12515.061370397074, 12662.746745065231, 10405.895941040493, 10589.68571968295, 10844.240903136704, 10847.891521085005, 10938.945305273422, 10676.733081673021, 10781.9460902695, 10829.837552436877, 10878.78242435131, 10907.29102608328], "value": 6614.354350131052, "unit": "score"}], "name": "dromaeo_css", "value": 6997.605996526084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 106.0, 110.0, 112.0, 112.0, 100.0, 112.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 153.0, 184.0, 125.0, 159.0, 157.0, 128.0, 177.0, 130.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 159.0, 160.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 122.0, 125.0, 74.0, 75.0, 74.0, 131.0, 102.0, 74.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 141.0, 93.0, 93.0, 93.0, 164.0, 92.0, 93.0, 150.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 81.0, 57.0, 54.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 60.0, 61.0, 58.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 76.0, 76.0, 76.0, 77.0, 78.0, 76.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 120.0, 126.0, 123.0, 124.0, 119.0, 122.0, 153.0, 121.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 164.0, 164.0, 165.0, 163.0, 166.0, 164.0, 160.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1531.3999999999996, "alertThreshold": 2.0}]} 20:22:14 INFO - Return code: 0 20:22:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:22:14 ERROR - # TBPL SUCCESS # 20:22:14 INFO - Running post-action listener: _resource_record_post_action 20:22:14 INFO - Running post-run listener: _resource_record_post_run 20:22:15 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8019968; Write bytes: 418447360; Read time: 1708; Write time: 441448 20:22:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 75841536; Read time: 0; Write time: 60224 20:22:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6283264; Write bytes: 333987840; Read time: 1676; Write time: 368252 20:22:15 INFO - Running post-run listener: _upload_blobber_files 20:22:15 INFO - Blob upload gear active. 20:22:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:22:15 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 20:22:15 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:22:15 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:22:16 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:18 INFO - (blobuploader) - INFO - Done attempting. 20:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:18 INFO - (blobuploader) - INFO - Done attempting. 20:22:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:18 INFO - Return code: 0 20:22:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:22:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cf92c1687ca41cfda4d25d3b0f0806e85bd2bf0bd4acfc62e82841d86c463bee3cae9936b6372715e16e137fd5a97e2a78b9566f724fdc25cdd3468dd79915", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cad1e228f99c50e465ab29421ddbd696cf98d1d32020175baaf02fb50980ef8c0753fdfe6588caf222e1d15be0a4087c5071afdd0edc209435ed8df297023ad"} 20:22:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:22:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:22:18 INFO - Contents: 20:22:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cf92c1687ca41cfda4d25d3b0f0806e85bd2bf0bd4acfc62e82841d86c463bee3cae9936b6372715e16e137fd5a97e2a78b9566f724fdc25cdd3468dd79915", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cad1e228f99c50e465ab29421ddbd696cf98d1d32020175baaf02fb50980ef8c0753fdfe6588caf222e1d15be0a4087c5071afdd0edc209435ed8df297023ad"} 20:22:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:18 INFO - Copying logs to upload dir... 20:22:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:22:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.579824 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-04 20:22:18.961198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:18.964946) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cf92c1687ca41cfda4d25d3b0f0806e85bd2bf0bd4acfc62e82841d86c463bee3cae9936b6372715e16e137fd5a97e2a78b9566f724fdc25cdd3468dd79915", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cad1e228f99c50e465ab29421ddbd696cf98d1d32020175baaf02fb50980ef8c0753fdfe6588caf222e1d15be0a4087c5071afdd0edc209435ed8df297023ad"} build_url:https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cf92c1687ca41cfda4d25d3b0f0806e85bd2bf0bd4acfc62e82841d86c463bee3cae9936b6372715e16e137fd5a97e2a78b9566f724fdc25cdd3468dd79915", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cad1e228f99c50e465ab29421ddbd696cf98d1d32020175baaf02fb50980ef8c0753fdfe6588caf222e1d15be0a4087c5071afdd0edc209435ed8df297023ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:18.990812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:18.991131) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462416023.221439-1189871093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004281 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:19.072541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 20:22:19.072854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 20:22:19.073150) ========= ========= Total master_lag: 4.96 =========