builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1462417307.07 results: success (0) buildid: 20160504173005 builduid: 6753a0dedd48475fa2236151f1a13f2e revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.072187) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.072579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.072904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.089674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.089959) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 20:01:47-- 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% 89.1M=0s 2016-05-04 20:01:47 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.201663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.201953) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019178 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:47.251334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 20:01:47.251670) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 20:01:47,882 truncating revision to first 12 chars 2016-05-04 20:01:47,882 Setting DEBUG logging. 2016-05-04 20:01:47,882 attempt 1/10 2016-05-04 20:01:47,882 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:48,852 unpacking tar archive at: fx-team-29662e28a9c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.250027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 20:01:48.514931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:48.515262) ========= script_repo_revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:48.515709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:48.516000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 20:01:48.526018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-04 20:01:48.526337) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:49 INFO - MultiFileLogger online at 20160504 20:01:49 in /builds/slave/test 20:01:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:49 INFO - {'append_to_log': False, 20:01:49 INFO - 'base_work_dir': '/builds/slave/test', 20:01:49 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:49 INFO - 'branch': 'Fx-Team', 20:01:49 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:49 INFO - 'config_files': ('talos/linux_config.py',), 20:01:49 INFO - 'default_actions': ('clobber', 20:01:49 INFO - 'read-buildbot-config', 20:01:49 INFO - 'download-and-extract', 20:01:49 INFO - 'populate-webroot', 20:01:49 INFO - 'create-virtualenv', 20:01:49 INFO - 'install', 20:01:49 INFO - 'run-tests'), 20:01:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:49 INFO - 'download_minidump_stackwalk': True, 20:01:49 INFO - 'download_symbols': 'ondemand', 20:01:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:49 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:49 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:49 INFO - 'installer_path': 'installer.exe', 20:01:49 INFO - 'log_level': 'info', 20:01:49 INFO - 'log_name': 'talos', 20:01:49 INFO - 'log_to_console': True, 20:01:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:49 INFO - 'opt_config_files': (), 20:01:49 INFO - 'pip_index': False, 20:01:49 INFO - 'sps_profile': False, 20:01:49 INFO - 'sps_profile_interval': 0, 20:01:49 INFO - 'suite': 'dromaeojs-e10s', 20:01:49 INFO - 'system_bits': '32', 20:01:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:49 INFO - 'title': 'talos-linux64-ix-042', 20:01:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:49 INFO - 'use_talos_json': True, 20:01:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:49 INFO - 'work_dir': 'build'} 20:01:49 INFO - ##### 20:01:49 INFO - ##### Running clobber step. 20:01:49 INFO - ##### 20:01:49 INFO - Running pre-action listener: _resource_record_pre_action 20:01:49 INFO - Running main action method: clobber 20:01:49 INFO - rmtree: /builds/slave/test/build 20:01:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:50 INFO - Running post-action listener: _resource_record_post_action 20:01:50 INFO - ##### 20:01:50 INFO - ##### Running read-buildbot-config step. 20:01:50 INFO - ##### 20:01:50 INFO - Running pre-action listener: _resource_record_pre_action 20:01:50 INFO - Running main action method: read_buildbot_config 20:01:50 INFO - Using buildbot properties: 20:01:50 INFO - { 20:01:50 INFO - "project": "", 20:01:50 INFO - "product": "firefox", 20:01:50 INFO - "script_repo_revision": "production", 20:01:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:01:50 INFO - "repository": "", 20:01:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:01:50 INFO - "buildid": "20160504173005", 20:01:50 INFO - "pgo_build": "True", 20:01:50 INFO - "basedir": "/builds/slave/test", 20:01:50 INFO - "buildnumber": 723, 20:01:50 INFO - "slavename": "talos-linux64-ix-042", 20:01:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:01:50 INFO - "platform": "ubuntu64_hw", 20:01:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:50 INFO - "branch": "fx-team", 20:01:50 INFO - "repo_path": "integration/fx-team", 20:01:50 INFO - "revision": "29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5", 20:01:50 INFO - "stage_platform": "linux64-pgo", 20:01:50 INFO - "builduid": "6753a0dedd48475fa2236151f1a13f2e", 20:01:50 INFO - "slavebuilddir": "test" 20:01:50 INFO - } 20:01:50 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:50 INFO - Running post-action listener: _resource_record_post_action 20:01:50 INFO - ##### 20:01:50 INFO - ##### Running download-and-extract step. 20:01:50 INFO - ##### 20:01:50 INFO - Running pre-action listener: _resource_record_pre_action 20:01:50 INFO - Running main action method: download_and_extract 20:01:50 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:50 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:51 INFO - Downloaded 1361 bytes. 20:01:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:51 INFO - Using the following test package requirements: 20:01:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'jsshell-linux-x86_64.zip'], 20:01:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:51 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:52 INFO - Downloaded 23879834 bytes. 20:01:52 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:52 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:54 INFO - Return code: 0 20:01:54 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:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:54 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:54 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:54 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:54 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:54 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:57 INFO - Downloaded 23879834 bytes. 20:01:57 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:57 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:58 INFO - Return code: 0 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 - 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:58 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:58 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:58 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:58 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:59 INFO - Downloaded 10840152 bytes. 20:01:59 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:59 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:59 INFO - Return code: 0 20:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:59 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:59 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:59 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:59 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:59 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:02:01 INFO - Downloaded 58415926 bytes. 20:02:01 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:02:01 INFO - mkdir: /builds/slave/test/properties 20:02:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:02:01 INFO - Writing to file /builds/slave/test/properties/build_url 20:02:01 INFO - Contents: 20:02:01 INFO - build_url:https://queue.taskcluster.net/v1/task/IxPUJCJKR9KxYNm9zaqpVg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:02:02 INFO - Running post-action listener: _resource_record_post_action 20:02:02 INFO - Running post-action listener: set_extra_try_arguments 20:02:02 INFO - ##### 20:02:02 INFO - ##### Running populate-webroot step. 20:02:02 INFO - ##### 20:02:02 INFO - Running pre-action listener: _resource_record_pre_action 20:02:02 INFO - Running main action method: populate_webroot 20:02:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:02:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:02:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:02:02 INFO - '--tppagecycles', 20:02:02 INFO - '7'], 20:02:02 INFO - 'tests': ['tsvgm']}}, 20:02:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:02:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:02:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:02:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:02:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['damp', 'tps']}, 20:02:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'tests': ['damp', 'tps']}, 20:02:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['dromaeo_dom']}, 20:02:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:02:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'other-e10s': {'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['a11yr', 20:02:02 INFO - 'ts_paint', 20:02:02 INFO - 'tpaint', 20:02:02 INFO - 'sessionrestore', 20:02:02 INFO - 'sessionrestore_no_auto_restore', 20:02:02 INFO - 'tabpaint']}, 20:02:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['tsvgx', 20:02:02 INFO - 'tsvgr_opacity', 20:02:02 INFO - 'tart', 20:02:02 INFO - 'tscrollx', 20:02:02 INFO - 'cart']}, 20:02:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:02:02 INFO - 'tsvgr_opacity', 20:02:02 INFO - 'tart', 20:02:02 INFO - 'tscrollx', 20:02:02 INFO - 'cart']}, 20:02:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'talos_options': ['--disable-e10s'], 20:02:02 INFO - 'tests': ['tp5o']}, 20:02:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'tests': ['tp5o']}, 20:02:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'talos_options': ['--disable-e10s', 20:02:02 INFO - '--xperf_path', 20:02:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:02 INFO - 'tests': ['tp5n']}, 20:02:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:02 INFO - 'talos_options': ['--xperf_path', 20:02:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:02 INFO - 'tests': ['tp5n']}}, 20:02:02 INFO - 'talos.zip': {'path': '', 20:02:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:02:02 INFO - Running post-action listener: _resource_record_post_action 20:02:02 INFO - ##### 20:02:02 INFO - ##### Running create-virtualenv step. 20:02:02 INFO - ##### 20:02:02 INFO - Running pre-action listener: _resource_record_pre_action 20:02:02 INFO - Running main action method: create_virtualenv 20:02:02 INFO - Creating virtualenv /builds/slave/test/build/venv 20:02:02 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:02:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:02:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:02:02 INFO - Using real prefix '/usr' 20:02:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:02:02 INFO - Installing distribute.............................................................................................................................................................................................done. 20:02:04 INFO - Installing pip.................done. 20:02:04 INFO - Return code: 0 20:02:04 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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', 'pip>=1.5'] 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 pip>=1.5 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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 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 - 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:02:04 INFO - Cleaning up... 20:02:04 INFO - Return code: 0 20:02:04 INFO - Installing psutil>=0.7.1 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', '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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:04 INFO - '_': '/tools/buildbot/bin/python'} 20:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:05 INFO - Downloading/unpacking psutil>=0.7.1 20:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:02:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:07 INFO - Installing collected packages: psutil 20:02:07 INFO - Running setup.py install for psutil 20:02:07 INFO - building 'psutil._psutil_linux' extension 20:02:07 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:07 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:07 INFO - building 'psutil._psutil_posix' extension 20:02:07 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:07 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:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:07 INFO - Successfully installed psutil 20:02:07 INFO - Cleaning up... 20:02:07 INFO - Return code: 0 20:02:07 INFO - Installing mozsystemmonitor==0.0.0 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', '--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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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', '--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:07 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: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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:07 INFO - '_': '/tools/buildbot/bin/python'} 20:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:02:09 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:09 INFO - Installing collected packages: mozsystemmonitor 20:02:09 INFO - Running setup.py install for mozsystemmonitor 20:02:09 INFO - Successfully installed mozsystemmonitor 20:02:09 INFO - Cleaning up... 20:02:10 INFO - Return code: 0 20:02:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:02:10 INFO - Using env: {'DISPLAY': ':0', 20:02:10 INFO - 'HOME': '/home/cltbld', 20:02:10 INFO - 'LANG': 'en_US.UTF-8', 20:02:10 INFO - 'LANGUAGE': 'en_US:en', 20:02:10 INFO - 'LOGNAME': 'cltbld', 20:02:10 INFO - 'MAIL': '/var/mail/cltbld', 20:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:10 INFO - 'MOZ_NO_REMOTE': '1', 20:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:10 INFO - 'NO_EM_RESTART': '1', 20:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:10 INFO - 'PWD': '/builds/slave/test', 20:02:10 INFO - 'SHELL': '/bin/bash', 20:02:10 INFO - 'SHLVL': '1', 20:02:10 INFO - 'TERM': 'linux', 20:02:10 INFO - 'TMOUT': '86400', 20:02:10 INFO - 'USER': 'cltbld', 20:02:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:10 INFO - '_': '/tools/buildbot/bin/python'} 20:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:10 INFO - Downloading/unpacking blobuploader==1.2.4 20:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - Downloading blobuploader-1.2.4.tar.gz 20:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:02:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:02:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:12 INFO - Downloading docopt-0.6.1.tar.gz 20:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:02:12 INFO - Installing collected packages: blobuploader, requests, docopt 20:02:12 INFO - Running setup.py install for blobuploader 20:02:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:02:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:02:12 INFO - Running setup.py install for requests 20:02:13 INFO - Running setup.py install for docopt 20:02:13 INFO - Successfully installed blobuploader requests docopt 20:02:13 INFO - Cleaning up... 20:02:13 INFO - Return code: 0 20:02:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:13 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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 20:02:13 INFO - 'HOME': '/home/cltbld', 20:02:13 INFO - 'LANG': 'en_US.UTF-8', 20:02:13 INFO - 'LANGUAGE': 'en_US:en', 20:02:13 INFO - 'LOGNAME': 'cltbld', 20:02:13 INFO - 'MAIL': '/var/mail/cltbld', 20:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:13 INFO - 'MOZ_NO_REMOTE': '1', 20:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:13 INFO - 'NO_EM_RESTART': '1', 20:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:13 INFO - 'PWD': '/builds/slave/test', 20:02:13 INFO - 'SHELL': '/bin/bash', 20:02:13 INFO - 'SHLVL': '1', 20:02:13 INFO - 'TERM': 'linux', 20:02:13 INFO - 'TMOUT': '86400', 20:02:13 INFO - 'USER': 'cltbld', 20:02:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:13 INFO - '_': '/tools/buildbot/bin/python'} 20:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:13 INFO - Running setup.py (path:/tmp/pip-p3Hd42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:13 INFO - Running setup.py (path:/tmp/pip-CmFy6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:13 INFO - Running setup.py (path:/tmp/pip-8SUfRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:13 INFO - Running setup.py (path:/tmp/pip-zAi69h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:13 INFO - Running setup.py (path:/tmp/pip-6Bdjkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:14 INFO - Running setup.py (path:/tmp/pip-L3TgJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:14 INFO - Running setup.py (path:/tmp/pip-NjwJoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:14 INFO - Running setup.py (path:/tmp/pip-ejZ7gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:14 INFO - Running setup.py (path:/tmp/pip-OTIlMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:14 INFO - Running setup.py (path:/tmp/pip-P5KIh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:14 INFO - Running setup.py (path:/tmp/pip-bRuZaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:14 INFO - Running setup.py (path:/tmp/pip-dzzhjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:14 INFO - Running setup.py (path:/tmp/pip-EmbNob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:14 INFO - Running setup.py (path:/tmp/pip-0c8cws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:14 INFO - Running setup.py (path:/tmp/pip-XWK8CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:14 INFO - Running setup.py (path:/tmp/pip-fXmisq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:14 INFO - Running setup.py (path:/tmp/pip-YXV5uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:14 INFO - Running setup.py install for manifestparser 20:02:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:14 INFO - Running setup.py install for mozcrash 20:02:15 INFO - Running setup.py install for mozdebug 20:02:15 INFO - Running setup.py install for mozdevice 20:02:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Running setup.py install for mozfile 20:02:15 INFO - Running setup.py install for mozhttpd 20:02:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Running setup.py install for mozinfo 20:02:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Running setup.py install for mozInstall 20:02:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Running setup.py install for mozleak 20:02:15 INFO - Running setup.py install for mozlog 20:02:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:15 INFO - Running setup.py install for moznetwork 20:02:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Running setup.py install for mozprocess 20:02:16 INFO - Running setup.py install for mozprofile 20:02:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Running setup.py install for mozrunner 20:02:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Running setup.py install for mozscreenshot 20:02:16 INFO - Running setup.py install for moztest 20:02:16 INFO - Running setup.py install for mozversion 20:02:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:16 INFO - Cleaning up... 20:02:16 INFO - Return code: 0 20:02:16 INFO - Installing None 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', '-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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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', '-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:16 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: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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:16 INFO - Running setup.py (path:/tmp/pip-2bSH9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:16 INFO - Running setup.py (path:/tmp/pip-7K6zNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:17 INFO - Running setup.py (path:/tmp/pip-e_gnuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:17 INFO - Running setup.py (path:/tmp/pip-z0sMrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:17 INFO - Running setup.py (path:/tmp/pip-73F4tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:17 INFO - Running setup.py (path:/tmp/pip-tt7Ikt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:17 INFO - Running setup.py (path:/tmp/pip-9e7Nu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:17 INFO - Running setup.py (path:/tmp/pip-ICMqz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:17 INFO - Running setup.py (path:/tmp/pip-bWPbTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:17 INFO - Running setup.py (path:/tmp/pip-RX7TzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:17 INFO - Running setup.py (path:/tmp/pip-h_YG2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:17 INFO - Running setup.py (path:/tmp/pip-cyGeAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:17 INFO - Running setup.py (path:/tmp/pip-i4N_S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:17 INFO - Running setup.py (path:/tmp/pip-9iUk20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:17 INFO - Running setup.py (path:/tmp/pip-xAXR9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:17 INFO - Running setup.py (path:/tmp/pip-H0uXT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:18 INFO - Running setup.py (path:/tmp/pip-XijRU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 20:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:20 INFO - Installing collected packages: blessings 20:02:20 INFO - Running setup.py install for blessings 20:02:20 INFO - Successfully installed blessings 20:02:20 INFO - Cleaning up... 20:02:20 INFO - Return code: 0 20:02:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:20 INFO - Reading from file tmpfile_stdout 20:02:20 INFO - Current package versions: 20:02:20 INFO - argparse == 1.2.1 20:02:20 INFO - blessings == 1.6 20:02:20 INFO - blobuploader == 1.2.4 20:02:20 INFO - docopt == 0.6.1 20:02:20 INFO - manifestparser == 1.1 20:02:20 INFO - mozInstall == 1.12 20:02:20 INFO - mozcrash == 0.17 20:02:20 INFO - mozdebug == 0.1 20:02:20 INFO - mozdevice == 0.48 20:02:20 INFO - mozfile == 1.2 20:02:20 INFO - mozhttpd == 0.7 20:02:20 INFO - mozinfo == 0.9 20:02:20 INFO - mozleak == 0.1 20:02:20 INFO - mozlog == 3.1 20:02:20 INFO - moznetwork == 0.27 20:02:20 INFO - mozprocess == 0.22 20:02:20 INFO - mozprofile == 0.28 20:02:20 INFO - mozrunner == 6.11 20:02:20 INFO - mozscreenshot == 0.1 20:02:20 INFO - mozsystemmonitor == 0.0 20:02:20 INFO - moztest == 0.7 20:02:20 INFO - mozversion == 1.4 20:02:20 INFO - psutil == 3.1.1 20:02:20 INFO - requests == 1.2.3 20:02:20 INFO - wsgiref == 0.1.2 20:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:20 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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 20:02:20 INFO - 'HOME': '/home/cltbld', 20:02:20 INFO - 'LANG': 'en_US.UTF-8', 20:02:20 INFO - 'LANGUAGE': 'en_US:en', 20:02:20 INFO - 'LOGNAME': 'cltbld', 20:02:20 INFO - 'MAIL': '/var/mail/cltbld', 20:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:20 INFO - 'MOZ_NO_REMOTE': '1', 20:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:20 INFO - 'NO_EM_RESTART': '1', 20:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:20 INFO - 'PWD': '/builds/slave/test', 20:02:20 INFO - 'SHELL': '/bin/bash', 20:02:20 INFO - 'SHLVL': '1', 20:02:20 INFO - 'TERM': 'linux', 20:02:20 INFO - 'TMOUT': '86400', 20:02:20 INFO - 'USER': 'cltbld', 20:02:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:20 INFO - '_': '/tools/buildbot/bin/python'} 20:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Cleaning up... 20:02:20 INFO - Return code: 0 20:02:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:02:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:20 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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 20:02:20 INFO - 'HOME': '/home/cltbld', 20:02:20 INFO - 'LANG': 'en_US.UTF-8', 20:02:20 INFO - 'LANGUAGE': 'en_US:en', 20:02:20 INFO - 'LOGNAME': 'cltbld', 20:02:20 INFO - 'MAIL': '/var/mail/cltbld', 20:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:20 INFO - 'MOZ_NO_REMOTE': '1', 20:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:20 INFO - 'NO_EM_RESTART': '1', 20:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:20 INFO - 'PWD': '/builds/slave/test', 20:02:20 INFO - 'SHELL': '/bin/bash', 20:02:20 INFO - 'SHLVL': '1', 20:02:20 INFO - 'TERM': 'linux', 20:02:20 INFO - 'TMOUT': '86400', 20:02:20 INFO - 'USER': 'cltbld', 20:02:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:20 INFO - '_': '/tools/buildbot/bin/python'} 20:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:20 INFO - Downloading/unpacking jsonschema 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:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:02:22 INFO - Downloading/unpacking functools32 (from jsonschema) 20:02:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading functools32-3.2.3-2.tar.gz 20:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:02:23 INFO - warning: no files found matching '*.txt' 20:02:23 INFO - no previously-included directories found matching 'build' 20:02:23 INFO - no previously-included directories found matching 'dist' 20:02:23 INFO - no previously-included directories found matching '.git*' 20:02:23 INFO - Installing collected packages: jsonschema, functools32 20:02:23 INFO - Running setup.py install for functools32 20:02:23 INFO - warning: no files found matching '*.txt' 20:02:23 INFO - no previously-included directories found matching 'build' 20:02:23 INFO - no previously-included directories found matching 'dist' 20:02:23 INFO - no previously-included directories found matching '.git*' 20:02:23 INFO - Successfully installed jsonschema functools32 20:02:23 INFO - Cleaning up... 20:02:23 INFO - Return code: 0 20:02:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:02:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:23 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 0x7f348ee51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 20:02:23 INFO - 'HOME': '/home/cltbld', 20:02:23 INFO - 'LANG': 'en_US.UTF-8', 20:02:23 INFO - 'LANGUAGE': 'en_US:en', 20:02:23 INFO - 'LOGNAME': 'cltbld', 20:02:23 INFO - 'MAIL': '/var/mail/cltbld', 20:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:23 INFO - 'MOZ_NO_REMOTE': '1', 20:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:23 INFO - 'NO_EM_RESTART': '1', 20:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:23 INFO - 'PWD': '/builds/slave/test', 20:02:23 INFO - 'SHELL': '/bin/bash', 20:02:23 INFO - 'SHLVL': '1', 20:02:23 INFO - 'TERM': 'linux', 20:02:23 INFO - 'TMOUT': '86400', 20:02:23 INFO - 'USER': 'cltbld', 20:02:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:23 INFO - '_': '/tools/buildbot/bin/python'} 20:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:23 INFO - Downloading/unpacking flake8 20:02:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:02:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:02:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:02:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:02:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:02:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:02:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:26 INFO - no previously-included directories found matching 'docs/_build' 20:02:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:02:26 INFO - Running setup.py install for pep8 20:02:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:26 INFO - no previously-included directories found matching 'docs/_build' 20:02:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:02:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:02:26 INFO - Cleaning up... 20:02:26 INFO - Return code: 0 20:02:26 INFO - Running post-action listener: _resource_record_post_action 20:02:26 INFO - Running post-action listener: _start_resource_monitoring 20:02:26 INFO - Starting resource monitoring. 20:02:26 INFO - ##### 20:02:26 INFO - ##### Running install step. 20:02:26 INFO - ##### 20:02:26 INFO - Running pre-action listener: _resource_record_pre_action 20:02:26 INFO - Running main action method: install 20:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:26 INFO - Reading from file tmpfile_stdout 20:02:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:26 INFO - Reading from file tmpfile_stdout 20:02:26 INFO - Output received: 20:02:26 INFO - Usage: mozinstall [options] installer 20:02:26 INFO - Options: 20:02:26 INFO - -h, --help show this help message and exit 20:02:26 INFO - -d DEST, --destination=DEST 20:02:26 INFO - Directory to install application into. [default: 20:02:26 INFO - "/builds/slave/test"] 20:02:26 INFO - --app=APP Application being installed. [default: firefox] 20:02:26 INFO - mkdir: /builds/slave/test/build/application 20:02:26 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:26 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:43 INFO - Reading from file tmpfile_stdout 20:02:43 INFO - Output received: 20:02:43 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:43 INFO - Running post-action listener: _resource_record_post_action 20:02:43 INFO - ##### 20:02:43 INFO - ##### Running run-tests step. 20:02:43 INFO - ##### 20:02:43 INFO - Running pre-action listener: _resource_record_pre_action 20:02:43 INFO - Running main action method: run_tests 20:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:43 INFO - Python 2.7.3 20:02:43 INFO - Return code: 0 20:02:43 INFO - grabbing minidump binary from tooltool 20:02: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:02:43 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 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:43 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:43 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:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:43 INFO - Return code: 0 20:02:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:02:44 INFO - Return code: 0 20:02:44 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-e10s', '--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-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:02:44 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-e10s --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-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:02:44 INFO - Using env: {'DISPLAY': ':0', 20:02:44 INFO - 'HOME': '/home/cltbld', 20:02:44 INFO - 'LANG': 'en_US.UTF-8', 20:02:44 INFO - 'LANGUAGE': 'en_US:en', 20:02:44 INFO - 'LOGNAME': 'cltbld', 20:02:44 INFO - 'MAIL': '/var/mail/cltbld', 20:02:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:44 INFO - 'MOZ_NO_REMOTE': '1', 20:02:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:44 INFO - 'NO_EM_RESTART': '1', 20:02:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:44 INFO - 'PWD': '/builds/slave/test', 20:02:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:44 INFO - 'SHELL': '/bin/bash', 20:02:44 INFO - 'SHLVL': '1', 20:02:44 INFO - 'TERM': 'linux', 20:02:44 INFO - 'TMOUT': '86400', 20:02:44 INFO - 'USER': 'cltbld', 20:02:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450', 20:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:44 INFO - '_': '/tools/buildbot/bin/python'} 20:02:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:02:44 INFO - mozversion application_buildid: 20160504173005 20:02:44 INFO - mozversion application_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 20:02:44 INFO - mozversion application_display_name: Nightly 20:02:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:44 INFO - mozversion application_name: Firefox 20:02:44 INFO - mozversion application_remotingname: firefox 20:02:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:44 INFO - mozversion application_vendor: Mozilla 20:02:44 INFO - mozversion application_version: 49.0a1 20:02:44 INFO - mozversion platform_buildid: 20160504173005 20:02:44 INFO - mozversion platform_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 20:02:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:44 INFO - mozversion platform_version: 49.0a1 20:02:44 INFO - using testdate: 1462417364 20:02:44 INFO - actual date: 1462417364 20:02:44 INFO - starting webserver on 'localhost:43267' 20:02:44 INFO - SUITE-START | Running 2 tests 20:02:44 INFO - TEST-START | dromaeo_css 20:02:44 INFO - operating with platform_type : linux_ 20:02:44 INFO - Initialising browser for dromaeo_css test... 20:02:44 INFO - TEST-INFO | started process 11619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwMI2J/profile http://localhost:43267/getInfo.html) 20:02:48 INFO - PROCESS | 11619 | 20:02:48 INFO - PROCESS | 11619 | (process:11686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:02:49 INFO - PROCESS | 11619 | __metrics Screen width/height:1600/1200 20:02:49 INFO - PROCESS | 11619 | colorDepth:24 20:02:49 INFO - PROCESS | 11619 | Browser inner width/height: 1024/697 20:02:49 INFO - PROCESS | 11619 | __metrics 20:02:49 ERROR - PROCESS | 11619 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:02:50 INFO - TEST-INFO | 11619: exit 0 20:02:50 INFO - Browser initialized. 20:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:50 INFO - TEST-INFO | started process 11737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwMI2J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:52 INFO - PROCESS | 11737 | 20:02:52 INFO - PROCESS | 11737 | (process:11797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:03:02 INFO - PROCESS | 11737 | RSS: Main: 164413440 20:03:02 INFO - PROCESS | 11737 | 20:03:51 INFO - PROCESS | 11737 | 1462417431996 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:59 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43267/tests/dromaeo/cssquery-ext.html) 20:06:00 INFO - PROCESS | 11737 | RSS: Main: 171356160 20:06:00 INFO - PROCESS | 11737 | 20:09:02 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-ext.html (next: http://localhost:43267/tests/dromaeo/cssquery-jquery.html) 20:09:03 INFO - PROCESS | 11737 | RSS: Main: 167002112 20:09:03 INFO - PROCESS | 11737 | 20:12:05 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43267/tests/dromaeo/cssquery-mootools.html) 20:12:05 INFO - PROCESS | 11737 | RSS: Main: 168308736 20:12:05 INFO - PROCESS | 11737 | 20:15:07 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43267/tests/dromaeo/cssquery-prototype.html) 20:15:08 INFO - PROCESS | 11737 | RSS: Main: 165928960 20:15:08 INFO - PROCESS | 11737 | 20:18:10 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43267/tests/dromaeo/cssquery-yui.html) 20:18:11 INFO - PROCESS | 11737 | RSS: Main: 166944768 20:18:11 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | Cycle 1(1): loaded http://localhost:43267/tests/dromaeo/cssquery-yui.html (next: http://localhost:43267/tests/dromaeo/cssquery-dojo.html) 20:21:13 INFO - PROCESS | 11737 | RSS: Main: 169078784 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | __start_tp_report 20:21:13 INFO - PROCESS | 11737 | _x_x_mozilla_page_load 20:21:13 INFO - PROCESS | 11737 | _x_x_mozilla_page_load_details 20:21:13 INFO - PROCESS | 11737 | |i|pagename|runs| 20:21:13 INFO - PROCESS | 11737 | |0;dojo.html;3150.070729134905;3151.3224656698803;3191.617005959285;3224.4196044711957;3231.062991732399;5453.7818487260565;5465.890682186354;5488.533474654654;5498.670079795215;5537.723113844307;5375.16684913839;5412.161115027167;5479.835604931858;5536.474034966682;5541.501264886159;4911.729854857973;4929.383827021622;4982.277569752384;4982.352294201749;5041.344625198719;866.3206519153525;4972.477889821571;4993.126202914494;5019.52314530119;5059.544640982311;4959.429665588449;4967.826126085606;4991.475895031006;4991.825286114987;5010.749462526877;4984.177610694231;5025.0954828130925;5097.7196254206;5098.337216161913;5119.0529751996;4973.975130124362;4994.550490455877;4996;4996.525330093636;5067.0879241736475;5356.839294821123;5385.407605163429;5413.810516631899;5414.539764120054;5487.835364939058;5750;5843.883122337572;5845.473907348359;5882.6764527950945;5920.940790592082;5881.588288819784;5898.292204935392;5904.498117660004;5935.792247271324;5954.434328738763;5489.258950041733;5495.2856128703015;5496.367917689477;5500.614956953015;5501.669899805985;5867.090600956859;5965.284165900033;5982.312034116046;5992.460678538865;6058.939410605925;5724.971375143181;5730.942690573041;5736.713164341766;5754.4533269339345;5757.913631295534;5785.27684039495;5796.710164491758;5804.1293805929445;5819.098039803837;5824.650520968671;5610.635308704921;5804.593678442468;5812.738426770806;5879.911801322984;5883.588148829626;5727.828165155052;5733.197352370671;5775.7400916957995;5785.768569257182;5803.738831752581;4281.100968796588;4283.978580107079;4293;4294.334378171388;4327.7619730914475;3837.328467518173;3856.460095586564;3873.1285460771664;3903.8048097595006;3910.9413358799643;5538.280023596987;5570.888582228333;5580.888382232414;5587.1339942309005;5609.887802243932;5745.396733342939;5770.105633626795;5792.449717276936;5829.09649004405;5872.295324560994;5515.090010148361;5566.972165139229;5570.6657600544095;5630.127330263816;5655.9253741788925;4874.512548745097;4910.21436570147;4915.754212289371;4918.139325618003;4986.675866068694;6060.2424696912885;6067.24159480065;6073.210482637229;6095.238095238095;6114.877702445926;5786.1610066540115;5905.763769449174;5951.7619295227705;5976.402359763989;5993.430624090704;6025.6083354581815;6032.638041717511;6033.366496517802;6038.5772995889865;6043.2748070231855;5654.6324488908085;5747.51146152565;5754.338251101177;5802.622829516068;5825.79609713658;5798.217240672624;5876.823695289148;5895.498882595028;5898.262717160355;5929.970350148395;5664.801731939362;5697.601167918206;5698.686572238566;5704.914426283526;5711.857203569944;5635.549156067586;5654.519365853948;5687.829365119053;5693.8861222774485;5707.286589176353;5628.662280263197;5631.408702086386;5668.5465162787705;5701.914471283017;5716.228309178207;5683.687397193194;5762.971185144215;5764.337101233412;5773.134029895549;5778.422157784188;5596.720163991866;5632.971835140798;5642.294713160855;5651.039323314964;5656.151577263443 20:21:13 INFO - PROCESS | 11737 | |1;ext.html;593.7595273914063;641.0448431836563;652.5073569455058;658.1805651963305;660.5970358081572;36101.45847812282;37181.62818371815;37214.25571488569;37410.62589374105;37459;41093.17813643725;42156.367654485206;42206;42225;42322.57677423225;8414.579271036455;8543.54759690854;8572.699955501559;8594.484330940133;8607.913920860805;8511.14888511147;8543.14568543147;8616.095309992455;8647.092055334193;8833.911660883405;8809.942806863186;8982.820343593125;8983.146601072887;8989.640414383417;8990.640374385017;8829.470231786081;8880.067592902717;8939.240164586017;8944.150305720947;8968.686095986674;8725.694600688945;8797.340199485001;8835.77910552235;8874.290056795506;8891.510966896818;41621.58378416238;42540.149197016195;42607;42662.36006459906;42787;3641.599424063351;3732.0813146196383;3774.4904437900805;3919.7648141111627;4368.432103826514;32145.1963700907;32150;32711;32798.18004549881;33029;3801.505804245458;3838.4626152338415;3867.245887052026;3889.6960741045605;3893.766374017568;313703;316370;316653;319545;319793;52749.208761868606;52933.20600191;53007.20489192665;58149.12776308359;58170.709146454;57276;58147.127793083135;58222.4177758217;58238;58329.4167058324;16134.596635083983;16221.83778162227;16310.673786524203;16316.34734610626;16318.184090795412;13634.590962271148;13686.52097176614;13719.245441500614;13723.1079979801;13748.175109493463;19511.219551218077;19860.40418787439;20233.392998210078;20338.694919576217;20392.592148156953;7223.674934627849;7301.882454088362;7311.159216690043;7410.555366678017;7597.962010189914;1069.6470164845582;1074.6238816414193;1093.3221402730198;1133.56924368741;1166.2186335155466;30669.38661226763;31498.842505787325;31884.681153188634;31935.84032079825;32098.679013210036;1134.2740645986576;1140.190464770006;1154.5381847260994;1156.9247998880046;1158.4902642837126;14547.3453694584;15050.172240526876;15511.301991410413;15525.767113493306;15576.221188940508;352025;360987;361815;363252;363350;51654.48345516572;52625;52667.73666131645;52850.47149528455;58055;1409.83082030155;1421.8009478672993;1431.6492459347526;1432.8567143285588;1515.8256800468087;29051.273718156368;29432.411351773273;29575.556366654087;29967.4006519864;30542.541861872534;49276;49743.25385119153;49915.251271230234;50199.24701129413;50210;414525;416949;418940;419671;421745;27842.44315113646;28176.85911570429;28258;28282.15153545397;40551.59448405596;43153;43295.13409731851;43359.56640433555;43369.78315108404;43807.17452962059;39704.01479925934;40610.79694601508;40910.386344204264;41047.794761026;41154.17691646091;39279.6072039276;39955.40066899057;40416.59583404128;40731.59268407396;41226.79386603048;32915.177120572174;39882.2023559533;40511.18977620372;40688.38967415432;41337;41111.1777764449;43164.784176078916;43779.12441751211;43935.12129757451;44389.33415998827;32953.17617059593;33332.50001250031;33555.83222083874;33946;34234.48648270328 20:21:13 INFO - PROCESS | 11737 | |2;jquery.html;397.3542992636965;402.8650402115291;405.58022446767603;411.5061925689173;415.5491291948236;13900.165990040605;18169.727454088184;18542.165602547884;18669.346572869934;18827.435176944695;17639.911800441012;17691.380801671945;18170.454886353396;18687.906560467178;18792.81207187931;5511.559075273968;5540.972295138518;5694.857628559298;5739.942600573982;5768.307803063638;5425.941941321444;5690.061139911931;5711.600187986843;5740.942590574104;5750.626209296403;5708.372079071299;5727.284089488814;5727.34135574408;5733.627314224583;5737.139429085629;5265.710385928773;5546.084895992177;5550.833474995757;5580.776768929238;5586.050371436865;5248.134057880445;5364.785408583652;5564.582656300794;5578.748956296977;5586.91619625706;13638.318084095756;13772.655683607889;13803.378847951866;18700;22174.223902163347;2322.175627652176;2350.5886469867874;2389.7729715676983;2489.684593328204;2507.5611767940536;10096.242781791321;10382.740431489197;10433.895661043443;10443.321184123008;10537.420441875694;1968;2005.5888542848681;2021.7674967378794;2047.0276618606042;2074.8962551872346;60162.39837601612;66145;69719.65140174267;81460;85428;9907.80184396308;10308.433036183082;10350.327228730108;10505.632302869515;10635.840462393071;14669.266536673336;14769.852301477062;14794;14852.405903763729;14852.62868428298;7927.960360198277;7931.603419828985;8027.397945154137;8108;8212.096669366365;7917.920820791834;8039.236272554098;8090.110087890327;8120.553369564613;8157.143499932422;4596.333531637893;4643.141018911445;4707.693999890064;4763.237881938873;4796.088743138793;1896.5922326699826;1932.3333449959741;1934.806519348082;1952.8144826241485;1989.303743689697;911.9498427586547;997.0826839307854;1019.5870672377699;1069.7379142110078;1112.8887111288968;17980;18068;18184.63630727378;18850.71723924142;18969.620607588047;1022.882368527614;1034.3121823987115;1034.3535290443472;1059.772148987956;1061.5010944855906;10268.819085805228;10441.530131144116;10623.36259824413;10679.519421626046;10708.518116684769;461215;466015;468166;472726;473234;98357;99914;100090.4995475018;100341;100618.496907515;1036.0263697655978;1056.9471526423647;1067.5516283161091;1069.2782371898936;1070.619929924881;16383.672326553164;16753.91623041877;16797.328106876077;16872.24074916656;17189.398371056952;39818.80090599528;40050.59949400469;42047.3692894613;42115;42861.14277714366;57681.13478297913;58196.70901645634;59126.40873591209;60004.09993850183;60898.39101608927;8446.662133514836;8512.574371281287;8692.826143477221;8769.429987050822;8800.603972821367;10184.338018028804;12892.226466412045;12967.286799226133;13377.063605547519;13671.79492307636;11382.715432114263;11534.82697759551;11599.478023488795;11725.706857328634;11962.76074478523;11357.318560886373;11477.139214558774;11540.3075815448;11605.419729013684;11693.415329233674;11535.423228838357;11722.824157637471;11767.52929882795;11805.364803651795;11990.460429280878;8508.574571271536;8533.104024077382;8759.693410730593;8826.911730882866;8838.469691818511;8629.39594228423;10540.789184216119;11457.08343332548;11516.19386642927;11589.304641721523 20:21:13 INFO - PROCESS | 11737 | |3;mootools.html;1500.8123984501933;1532.7394342961695;1668.8164301926793;1785.4465115814091;1831.6977698679727;7570.129435114964;7904.446688731791;8149.674013039478;8453.323734101272;8465.703700370488;8070.757877263692;8153.7553873383895;8193.508389496634;8201.466904651194;8237.464564803284;2268.115434980355;2310.2376215848813;2319.420144963759;2328.313147621447;2333.265021518216;2279.939827979989;2291.6677081823127;2345.8240631952585;2349.870757108367;2350.6356514740155;2229.9888500557477;2241.1931704586336;2268.965965510519;2316.9536609267802;2317.571249318873;2233.910643574255;2238.306125101216;2240.4622890506325;2247.438140464884;2250.459889626486;2243.25972429098;2246.4271610739156;2248.943776405603;2253.0649780341137;2270.0579259607243;8289.129641387688;8345.123762004963;8345.998480182418;8406.159384061606;8420.83158336836;4961.8511444656715;5117.334746482933;5117.948820511784;5133.562602471314;5137.152369858969;2978.19588711049;3012.1264833198347;3123.422166899131;3127.1712996056062;3138.9372212555622;1019.1439191079529;1019.7246743379246;1032.4579595712237;1039.6776999130218;2012.6679097948968;10981.39602321872;11116.555337786478;11135.888641113566;11190.664280071529;11230.98921097097;4492.2587773017085;4606.953930460652;4609.193391156534;4622.098690755271;4635.072985402933;9513.238940884712;9562.56968436422;9635.662751803653;9639.759006024766;9681.322307438553;5103.157978933435;5195.506426889439;5225.790968361223;5242.895142097213;5270.393904701008;4238.109996900624;4718;4862.610991120702;4862.854114376574;4865.781039853215;3914.37370020801;3948;3973.304671682444;4002.7598344099447;4054.412110244057;1274.1781550899802;1304.0480449272084;1321.8347706536683;1324.16577556139;1329.2423318708243;888;1023.7389465686202;1042.1923009667416;1042.8070806900748;1044.2481413382352;5708.20085188074;5811.157382179645;5825.533957283407;5835.803660249723;5837.270341207349;466.2656316301838;466.75728621116826;470.56472762695057;1068.2949253492657;1086.9510872010778;4103.363978583325;4142.813573389205;4166.416701661769;4169.854055108057;4201;9688.951555242178;10081.19350451962;10138.493075346203;10176.694699159038;10189.847152292721;9932.553035113437;9936.850947235796;10034.448105354275;10070.093691567648;10079.647212347532;7431.256874312526;7582.962085189649;7826.686932522749;7935.6032198391;7937.682492700343;5786.537077033911;5878.706064696834;5878.794242201502;5881.647101173943;5895.41045895407;8791.868121978048;8939.865902011345;9152.17630413266;9167.220786233245;9204.171624553823;9307.301952353737;9396.718098457057;9428.198603118537;9502.334836561651;9531.189848862925;6845.452363810983;7288.3076107769675;7334.266573342623;7481.551106933602;7542.585157816373;7936.404769642185;8010.759677209693;8013.398995075276;8036.4776289541;8083.434159608771;6936.098307220029;7179.174394944648;7266.818329541804;7268.38218751412;7471.21552237029;7042.295770422917;7149.785506434815;7199.604021778852;7225.674844632109;7337.523061001231;6709.832254193489;6778.288279730557;6796.150481189851;6808.38724514796;6819.113515242987;4719.362886010482;4873.366462359871;4889.926651100165;4962.082014827269;4985.227289770091;4983.700977941335;5029.874253143701;5073.44192138857;5088.872778180427;5149.819756308511 20:21:13 INFO - PROCESS | 11737 | |4;prototype.html;331.5375051802735;335.5889035930984;336.72893320876693;338.12257192585236;340.3040781601624;5571.3314402271735;5627.127795191742;5645.915311270334;5673.914891276634;5681.074246762921;5489.176623506476;5509.393966663663;5551.528120109796;5567.276254086963;5574.804881829137;4107.8973025674295;4151.273527132755;4269.380939763748;4278.74327540347;4285.271503844354;4295.548967358429;4305.634021108194;4323.524412314643;4330.761808100553;4333.4799824021;4281.143771245764;4298.26929421999;4302.11806579652;4331.5884990925815;4339.566043395666;4050.9797451012705;4242.3212286034395;4248.235317642823;4258.5528519505315;4302.935455968163;3739.1213064929993;3741.1021354874906;3745.850165993384;3746.7939263340504;3773.9433908491396;5318.095923692981;5319.521243088141;5339.252504649352;5343.251944727741;5370.388883335023;4634.768261586941;4859.441164266084;4888.804447822083;4942.159832828392;4944.53026962438;5721.596929289708;5733.741981610796;5778.0466223073145;5779.838516268323;5806.767729290823;4090.365993271048;4103.199876024177;4104.712670113093;4112.629863312286;4113.03343714227;5886.882262354772;6001.609895356788;6015.548833837436;6020.127081573148;6088.878222435526;4085.3259212230246;4087.3255912774653;4099.446574712435;4102.712810103264;4111.527174374925;4084.36692312692;4090.4865199876235;4101.302778527598;4109.568495308009;4157.605027522381;4630.471944258386;4732.905341893212;4744.908671005688;4802.423709154924;4813.253945638432;5848;5852.590318677737;5854.95076723152;5867.853303667357;5873.853153671107;1528.159512268248;1542.4909779772647;1545.3432291276163;1547.4119834463056;1558.1196623907456;964.4888209249109;997.3666721631816;1001.5893483671659;1035.089121573011;1041.5470418765779;5860.652050028517;5922.822315330547;5930.199423077829;5940.762369505258;5956.851078723066;6310.5267104967315;6310.8422289442215;6324.557280990287;6351.682415879188;6405.871882562323;5786.450287222707;5888.61723987948;5913.615614985012;5937.643741375531;5954.136650185699;3359.227377703093;3392.1350055736125;3394.3890099781784;3398.7424652878594;3412.368711788327;6382.819178452001;6488.837779055561;6508.023796430573;6511.851089140572;6587.143671322698;6469;6493.285738568754;6506.512011599149;6519.576227545194;6546.967265163644;5986.431289027535;6235.469985051322;6565.770198043046;6591.43972762311;6631.27056023837;6057;6057.666828324484;6086.573939824347;6093.177421048102;6142.877142457037;6021.5247264420495;6022.849428764141;6035.426634469718;6057.515398768;6062.363451837494;5991.191189189403;6256.343083976299;6274.529410294337;6284.277308109626;6304.401081897213;4154.854580089683;4229.492460904711;4233.407322974847;4237.110206856594;4287.614114729689;5771.884562308815;6050.15297858309;6095.238095238095;6151.292601350902;6153.200083989232;5947.6431414115295;5951.464368206882;5992.221011268507;6022.1870047543025;6065.695875386813;5882.147088672033;5887.735051922588;5888;5912.46787789101;6043.728032238648;5545.750441230073;5790.971045144747;5823.631446610128;5827.94172058274;5828.388019258086;5899.823005309848;5941.732622032106;5953.821385358447;5964.671943043174;5996.520278377632;5723.513501352431;5767.452092051249;5810.5351571875;5833.329167145833;5849.824505264849 20:21:13 INFO - PROCESS | 11737 | |5;yui.html;765.2691679446128;776.1617453150598;777.525709317316;783.7100272899028;790.5375355417083;14577.708445831076;15014.174220417872;15020.549383518484;15054.322555485001;15063.246837658127;14037;14061;14064;14073.366698498567;14111.15333080016;674.322306082389;800.5396896784343;827.8137419080704;831.6382373667444;832.6544484039116;817.840521098386;821.5645707774859;822.5106061893164;823.6417158536026;824.6783754335814;880.2825697056878;883.2889523933231;883.4390162246955;884.60192913189;885.8228354329128;869.9652013919435;873.8820259264982;875.2910142784333;878.2710350409145;879.2745984562697;624.1293395712955;628.4877824572958;631.119588174494;633.914421553089;639.0127253393472;14472.276386180754;14552.0541164825;14593.270336483134;14653.487127950471;14728.55814325572;13595.184288942597;14076.648083797885;14516.129032258099;14792;14870.405183792634;11780.705482362924;12047.759044819142;12058.819117713241;12094.637160885188;12181.93909030458;3839.827207775657;3899.415087736834;3913.960860391388;3925.725199236055;3934.291827471054;60632.69683651598;62059.379406205815;62559;63672;63744.362556374304;9194.264458843276;9574.856377154349;9997.350172238781;10015.449150296803;10103.343282686601;21167.576648467253;21228.363149105553;21251.89374053151;21331.14675412997;21361.67957480639;8261.752147435587;8328.33373330132;8353.874691879626;8369;8476.915230847735;4762.095201911626;4815.2054910940005;4842.104210721028;4892.633052521075;4953.777080031407;3238.740900727936;3356.412627790176;3358.378699940519;3358.697717205463;3360.4119279126544;593.5607650338718;596.4006173795308;601.1913975702673;613.2487702564323;622.3589702606323;570.9371969083397;584.3251045042982;618.4742968476759;645.7546132469631;658.6311665467258;8921.330900182513;8989.325800564984;9131.908680913239;9242.214411775074;9245.3528253023;609.600711533946;629.1443636654146;659.8911179655303;669.6919417068106;689.069755829636;4381.715188512737;4504.369388285642;4611.792469338888;4668.743219122913;4680.859574212711;65989.67005164943;66374.33625663682;66946.66526667336;67203;68677.3132268681;57362;59490.405095949354;59625;60284.69857650684;60739.39260607426;47483.76258118687;52301;52837;52977.7351113242;54263.72868135634;8807.427517211361;9215.677451289173;9242.168204861595;9267.907320926704;9311.953440232755;33944.32111357809;35142.12144696301;35294.47058294076;36326.81836590906;36348.818255908554;47107.29339059848;47849.5215047859;48014.519854801;48128.3529405886;49396.75301623469;11569.479373428048;11686.123540734648;11768.764624707286;11800.586979455678;12016.879831201577;13000.934995324962;13012.804807928078;13096.476140954255;13266.602001939957;13332.733345332845;12242.143049986415;12262.816057758962;12377.938110309391;12456.813147802972;13029.218246905217;11889.583864564698;11917.34454605005;11967.341796201292;12088.335141566946;12285;12228.327441990776;12387.62837114888;12526.248425094524;12590.874091258971;12621.93689031549;10475.633352832614;10764.892351076389;10815.188860835311;10872.238943273895;11184.608538701106;9736.561854716696;10750.46247687628;10923.235373523778;10945.83581246298;11002.449877506253 20:21:13 INFO - PROCESS | 11737 | __end_tp_report 20:21:13 INFO - PROCESS | 11737 | __start_cc_report 20:21:13 INFO - PROCESS | 11737 | _x_x_mozilla_cycle_collect,341 20:21:13 INFO - PROCESS | 11737 | __end_cc_report 20:21:13 INFO - PROCESS | 11737 | __startTimestamp1462418473718__endTimestamp 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | ------- Summary: start ------- 20:21:13 INFO - PROCESS | 11737 | Number of tests: 6 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#0] dojo.html Cycles:165 Average:5402.29 Median:5654.63 stddev:722.10 (12.8%) stddev-sans-first:702.37 20:21:13 INFO - PROCESS | 11737 | Values: 3150.1 3151.3 3191.6 3224.4 3231.1 5453.8 5465.9 5488.5 5498.7 5537.7 5375.2 5412.2 5479.8 5536.5 5541.5 4911.7 4929.4 4982.3 4982.4 5041.3 866.3 4972.5 4993.1 5019.5 5059.5 4959.4 4967.8 4991.5 4991.8 5010.7 4984.2 5025.1 5097.7 5098.3 5119.1 4974.0 4994.6 4996.0 4996.5 5067.1 5356.8 5385.4 5413.8 5414.5 5487.8 5750.0 5843.9 5845.5 5882.7 5920.9 5881.6 5898.3 5904.5 5935.8 5954.4 5489.3 5495.3 5496.4 5500.6 5501.7 5867.1 5965.3 5982.3 5992.5 6058.9 5725.0 5730.9 5736.7 5754.5 5757.9 5785.3 5796.7 5804.1 5819.1 5824.7 5610.6 5804.6 5812.7 5879.9 5883.6 5727.8 5733.2 5775.7 5785.8 5803.7 4281.1 4284.0 4293.0 4294.3 4327.8 3837.3 3856.5 3873.1 3903.8 3910.9 5538.3 5570.9 5580.9 5587.1 5609.9 5745.4 5770.1 5792.4 5829.1 5872.3 5515.1 5567.0 5570.7 5630.1 5655.9 4874.5 4910.2 4915.8 4918.1 4986.7 6060.2 6067.2 6073.2 6095.2 6114.9 5786.2 5905.8 5951.8 5976.4 5993.4 6025.6 6032.6 6033.4 6038.6 6043.3 5654.6 5747.5 5754.3 5802.6 5825.8 5798.2 5876.8 5895.5 5898.3 5930.0 5664.8 5697.6 5698.7 5704.9 5711.9 5635.5 5654.5 5687.8 5693.9 5707.3 5628.7 5631.4 5668.5 5701.9 5716.2 5683.7 5763.0 5764.3 5773.1 5778.4 5596.7 5633.0 5642.3 5651.0 5656.2 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#1] ext.html Cycles:180 Average:53536.93 Median:40581.20 stddev:96616.20 (238.1%) stddev-sans-first:96805.46 20:21:13 INFO - PROCESS | 11737 | Values: 593.8 641.0 652.5 658.2 660.6 36101.5 37181.6 37214.3 37410.6 37459.0 41093.2 42156.4 42206.0 42225.0 42322.6 8414.6 8543.5 8572.7 8594.5 8607.9 8511.1 8543.1 8616.1 8647.1 8833.9 8809.9 8982.8 8983.1 8989.6 8990.6 8829.5 8880.1 8939.2 8944.2 8968.7 8725.7 8797.3 8835.8 8874.3 8891.5 41621.6 42540.1 42607.0 42662.4 42787.0 3641.6 3732.1 3774.5 3919.8 4368.4 32145.2 32150.0 32711.0 32798.2 33029.0 3801.5 3838.5 3867.2 3889.7 3893.8 313703.0 316370.0 316653.0 319545.0 319793.0 52749.2 52933.2 53007.2 58149.1 58170.7 57276.0 58147.1 58222.4 58238.0 58329.4 16134.6 16221.8 16310.7 16316.3 16318.2 13634.6 13686.5 13719.2 13723.1 13748.2 19511.2 19860.4 20233.4 20338.7 20392.6 7223.7 7301.9 7311.2 7410.6 7598.0 1069.6 1074.6 1093.3 1133.6 1166.2 30669.4 31498.8 31884.7 31935.8 32098.7 1134.3 1140.2 1154.5 1156.9 1158.5 14547.3 15050.2 15511.3 15525.8 15576.2 352025.0 360987.0 361815.0 363252.0 363350.0 51654.5 52625.0 52667.7 52850.5 58055.0 1409.8 1421.8 1431.6 1432.9 1515.8 29051.3 29432.4 29575.6 29967.4 30542.5 49276.0 49743.3 49915.3 50199.2 50210.0 414525.0 416949.0 418940.0 419671.0 421745.0 27842.4 28176.9 28258.0 28282.2 40551.6 43153.0 43295.1 43359.6 43369.8 43807.2 39704.0 40610.8 40910.4 41047.8 41154.2 39279.6 39955.4 40416.6 40731.6 41226.8 32915.2 39882.2 40511.2 40688.4 41337.0 41111.2 43164.8 43779.1 43935.1 44389.3 32953.2 33332.5 33555.8 33946.0 34234.5 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#2] jquery.html Cycles:180 Average:28031.99 Median:2034.40 stddev:77461.82 (3807.6%) stddev-sans-first:77651.33 20:21:13 INFO - PROCESS | 11737 | Values: 397.4 402.9 405.6 411.5 415.5 13900.2 18169.7 18542.2 18669.3 18827.4 17639.9 17691.4 18170.5 18687.9 18792.8 5511.6 5541.0 5694.9 5739.9 5768.3 5425.9 5690.1 5711.6 5740.9 5750.6 5708.4 5727.3 5727.3 5733.6 5737.1 5265.7 5546.1 5550.8 5580.8 5586.1 5248.1 5364.8 5564.6 5578.7 5586.9 13638.3 13772.7 13803.4 18700.0 22174.2 2322.2 2350.6 2389.8 2489.7 2507.6 10096.2 10382.7 10433.9 10443.3 10537.4 1968.0 2005.6 2021.8 2047.0 2074.9 60162.4 66145.0 69719.7 81460.0 85428.0 9907.8 10308.4 10350.3 10505.6 10635.8 14669.3 14769.9 14794.0 14852.4 14852.6 7928.0 7931.6 8027.4 8108.0 8212.1 7917.9 8039.2 8090.1 8120.6 8157.1 4596.3 4643.1 4707.7 4763.2 4796.1 1896.6 1932.3 1934.8 1952.8 1989.3 911.9 997.1 1019.6 1069.7 1112.9 17980.0 18068.0 18184.6 18850.7 18969.6 1022.9 1034.3 1034.4 1059.8 1061.5 10268.8 10441.5 10623.4 10679.5 10708.5 461215.0 466015.0 468166.0 472726.0 473234.0 98357.0 99914.0 100090.5 100341.0 100618.5 1036.0 1056.9 1067.6 1069.3 1070.6 16383.7 16753.9 16797.3 16872.2 17189.4 39818.8 40050.6 42047.4 42115.0 42861.1 57681.1 58196.7 59126.4 60004.1 60898.4 8446.7 8512.6 8692.8 8769.4 8800.6 10184.3 12892.2 12967.3 13377.1 13671.8 11382.7 11534.8 11599.5 11725.7 11962.8 11357.3 11477.1 11540.3 11605.4 11693.4 11535.4 11722.8 11767.5 11805.4 11990.5 8508.6 8533.1 8759.7 8826.9 8838.5 8629.4 10540.8 11457.1 11516.2 11589.3 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#3] mootools.html Cycles:180 Average:5498.39 Median:4972.89 stddev:2992.57 (60.2%) stddev-sans-first:2985.88 20:21:13 INFO - PROCESS | 11737 | Values: 1500.8 1532.7 1668.8 1785.4 1831.7 7570.1 7904.4 8149.7 8453.3 8465.7 8070.8 8153.8 8193.5 8201.5 8237.5 2268.1 2310.2 2319.4 2328.3 2333.3 2279.9 2291.7 2345.8 2349.9 2350.6 2230.0 2241.2 2269.0 2317.0 2317.6 2233.9 2238.3 2240.5 2247.4 2250.5 2243.3 2246.4 2248.9 2253.1 2270.1 8289.1 8345.1 8346.0 8406.2 8420.8 4961.9 5117.3 5117.9 5133.6 5137.2 2978.2 3012.1 3123.4 3127.2 3138.9 1019.1 1019.7 1032.5 1039.7 2012.7 10981.4 11116.6 11135.9 11190.7 11231.0 4492.3 4607.0 4609.2 4622.1 4635.1 9513.2 9562.6 9635.7 9639.8 9681.3 5103.2 5195.5 5225.8 5242.9 5270.4 4238.1 4718.0 4862.6 4862.9 4865.8 3914.4 3948.0 3973.3 4002.8 4054.4 1274.2 1304.0 1321.8 1324.2 1329.2 888.0 1023.7 1042.2 1042.8 1044.2 5708.2 5811.2 5825.5 5835.8 5837.3 466.3 466.8 470.6 1068.3 1087.0 4103.4 4142.8 4166.4 4169.9 4201.0 9689.0 10081.2 10138.5 10176.7 10189.8 9932.6 9936.9 10034.4 10070.1 10079.6 7431.3 7583.0 7826.7 7935.6 7937.7 5786.5 5878.7 5878.8 5881.6 5895.4 8791.9 8939.9 9152.2 9167.2 9204.2 9307.3 9396.7 9428.2 9502.3 9531.2 6845.5 7288.3 7334.3 7481.6 7542.6 7936.4 8010.8 8013.4 8036.5 8083.4 6936.1 7179.2 7266.8 7268.4 7471.2 7042.3 7149.8 7199.6 7225.7 7337.5 6709.8 6778.3 6796.2 6808.4 6819.1 4719.4 4873.4 4889.9 4962.1 4985.2 4983.7 5029.9 5073.4 5088.9 5149.8 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#4] prototype.html Cycles:180 Average:4965.71 Median:5728.63 stddev:1504.57 (26.3%) stddev-sans-first:1468.03 20:21:13 INFO - PROCESS | 11737 | Values: 331.5 335.6 336.7 338.1 340.3 5571.3 5627.1 5645.9 5673.9 5681.1 5489.2 5509.4 5551.5 5567.3 5574.8 4107.9 4151.3 4269.4 4278.7 4285.3 4295.5 4305.6 4323.5 4330.8 4333.5 4281.1 4298.3 4302.1 4331.6 4339.6 4051.0 4242.3 4248.2 4258.6 4302.9 3739.1 3741.1 3745.9 3746.8 3773.9 5318.1 5319.5 5339.3 5343.3 5370.4 4634.8 4859.4 4888.8 4942.2 4944.5 5721.6 5733.7 5778.0 5779.8 5806.8 4090.4 4103.2 4104.7 4112.6 4113.0 5886.9 6001.6 6015.5 6020.1 6088.9 4085.3 4087.3 4099.4 4102.7 4111.5 4084.4 4090.5 4101.3 4109.6 4157.6 4630.5 4732.9 4744.9 4802.4 4813.3 5848.0 5852.6 5855.0 5867.9 5873.9 1528.2 1542.5 1545.3 1547.4 1558.1 964.5 997.4 1001.6 1035.1 1041.5 5860.7 5922.8 5930.2 5940.8 5956.9 6310.5 6310.8 6324.6 6351.7 6405.9 5786.5 5888.6 5913.6 5937.6 5954.1 3359.2 3392.1 3394.4 3398.7 3412.4 6382.8 6488.8 6508.0 6511.9 6587.1 6469.0 6493.3 6506.5 6519.6 6547.0 5986.4 6235.5 6565.8 6591.4 6631.3 6057.0 6057.7 6086.6 6093.2 6142.9 6021.5 6022.8 6035.4 6057.5 6062.4 5991.2 6256.3 6274.5 6284.3 6304.4 4154.9 4229.5 4233.4 4237.1 4287.6 5771.9 6050.2 6095.2 6151.3 6153.2 5947.6 5951.5 5992.2 6022.2 6065.7 5882.1 5887.7 5888.0 5912.5 6043.7 5545.8 5791.0 5823.6 5827.9 5828.4 5899.8 5941.7 5953.8 5964.7 5996.5 5723.5 5767.5 5810.5 5833.3 5849.8 20:21:13 INFO - PROCESS | 11737 | 20:21:13 INFO - PROCESS | 11737 | [#5] yui.html Cycles:180 Average:15526.30 Median:48071.44 stddev:18604.06 (38.7%) stddev-sans-first:18623.22 20:21:13 INFO - PROCESS | 11737 | Values: 765.3 776.2 777.5 783.7 790.5 14577.7 15014.2 15020.5 15054.3 15063.2 14037.0 14061.0 14064.0 14073.4 14111.2 674.3 800.5 827.8 831.6 832.7 817.8 821.6 822.5 823.6 824.7 880.3 883.3 883.4 884.6 885.8 870.0 873.9 875.3 878.3 879.3 624.1 628.5 631.1 633.9 639.0 14472.3 14552.1 14593.3 14653.5 14728.6 13595.2 14076.6 14516.1 14792.0 14870.4 11780.7 12047.8 12058.8 12094.6 12181.9 3839.8 3899.4 3914.0 3925.7 3934.3 60632.7 62059.4 62559.0 63672.0 63744.4 9194.3 9574.9 9997.4 10015.4 10103.3 21167.6 21228.4 21251.9 21331.1 21361.7 8261.8 8328.3 8353.9 8369.0 8476.9 4762.1 4815.2 4842.1 4892.6 4953.8 3238.7 3356.4 3358.4 3358.7 3360.4 593.6 596.4 601.2 613.2 622.4 570.9 584.3 618.5 645.8 658.6 8921.3 8989.3 9131.9 9242.2 9245.4 609.6 629.1 659.9 669.7 689.1 4381.7 4504.4 4611.8 4668.7 4680.9 65989.7 66374.3 66946.7 67203.0 68677.3 57362.0 59490.4 59625.0 60284.7 60739.4 47483.8 52301.0 52837.0 52977.7 54263.7 8807.4 9215.7 9242.2 9267.9 9312.0 33944.3 35142.1 35294.5 36326.8 36348.8 47107.3 47849.5 48014.5 48128.4 49396.8 11569.5 11686.1 11768.8 11800.6 12016.9 13000.9 13012.8 13096.5 13266.6 13332.7 12242.1 12262.8 12377.9 12456.8 13029.2 11889.6 11917.3 11967.3 12088.3 12285.0 12228.3 12387.6 12526.2 12590.9 12621.9 10475.6 10764.9 10815.2 10872.2 11184.6 9736.6 10750.5 10923.2 10945.8 11002.4 20:21:13 INFO - PROCESS | 11737 | -------- Summary: end -------- 20:21:13 INFO - PROCESS | 11737 | 20:21:14 INFO - TEST-INFO | 11737: exit 0 20:21:14 INFO - TEST-OK | dromaeo_css | took 1110108ms 20:21:14 INFO - TEST-START | kraken 20:21:14 INFO - operating with platform_type : linux_ 20:21:14 INFO - Initialising browser for kraken test... 20:21:14 INFO - TEST-INFO | started process 11967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxNRKZA/profile http://localhost:43267/getInfo.html) 20:21:18 INFO - PROCESS | 11967 | 20:21:18 INFO - PROCESS | 11967 | (process:12034): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:21:19 INFO - PROCESS | 11967 | __metrics Screen width/height:1600/1200 20:21:19 INFO - PROCESS | 11967 | colorDepth:24 20:21:19 INFO - PROCESS | 11967 | Browser inner width/height: 1024/697 20:21:19 INFO - PROCESS | 11967 | __metrics 20:21:19 ERROR - PROCESS | 11967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:21:20 INFO - TEST-INFO | 11967: exit 0 20:21:20 INFO - Browser initialized. 20:21:20 INFO - Running cycle 1/1 for kraken test... 20:21:20 INFO - TEST-INFO | started process 12085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxNRKZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:22 INFO - PROCESS | 12085 | 20:21:22 INFO - PROCESS | 12085 | (process:12150): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:21:32 INFO - PROCESS | 12085 | RSS: Main: 164909056 20:21:32 INFO - PROCESS | 12085 | 20:21:34 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43267/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:35 INFO - PROCESS | 12085 | RSS: Main: 169017344 20:21:35 INFO - PROCESS | 12085 | 20:21:38 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43267/tests/kraken/driver.html?testName=audio-dft) 20:21:39 INFO - PROCESS | 12085 | RSS: Main: 171581440 20:21:39 INFO - PROCESS | 12085 | 20:21:42 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43267/tests/kraken/driver.html?testName=audio-fft) 20:21:42 INFO - PROCESS | 12085 | RSS: Main: 164368384 20:21:42 INFO - PROCESS | 12085 | 20:21:44 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43267/tests/kraken/driver.html?testName=audio-oscillator) 20:21:45 INFO - PROCESS | 12085 | RSS: Main: 164495360 20:21:45 INFO - PROCESS | 12085 | 20:21:47 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:48 INFO - PROCESS | 12085 | RSS: Main: 165527552 20:21:48 INFO - PROCESS | 12085 | 20:21:51 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43267/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:51 INFO - PROCESS | 12085 | RSS: Main: 165564416 20:21:51 INFO - PROCESS | 12085 | 20:21:55 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43267/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:55 INFO - PROCESS | 12085 | RSS: Main: 165539840 20:21:55 INFO - PROCESS | 12085 | 20:21:58 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43267/tests/kraken/driver.html?testName=json-parse-financial) 20:21:59 INFO - PROCESS | 12085 | RSS: Main: 167878656 20:21:59 INFO - PROCESS | 12085 | 20:22:00 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:01 INFO - PROCESS | 12085 | RSS: Main: 168267776 20:22:01 INFO - PROCESS | 12085 | 20:22:03 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:03 INFO - PROCESS | 12085 | RSS: Main: 168673280 20:22:03 INFO - PROCESS | 12085 | 20:22:05 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:06 INFO - PROCESS | 12085 | RSS: Main: 168808448 20:22:06 INFO - PROCESS | 12085 | 20:22:09 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:09 INFO - PROCESS | 12085 | RSS: Main: 168857600 20:22:09 INFO - PROCESS | 12085 | 20:22:12 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:13 INFO - PROCESS | 12085 | RSS: Main: 168648704 20:22:13 INFO - PROCESS | 12085 | 20:22:14 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:43267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43267/tests/kraken/driver.html?testName=ai-astar) 20:22:15 INFO - PROCESS | 12085 | RSS: Main: 170037248 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | __start_tp_report 20:22:15 INFO - PROCESS | 12085 | _x_x_mozilla_page_load 20:22:15 INFO - PROCESS | 12085 | _x_x_mozilla_page_load_details 20:22:15 INFO - PROCESS | 12085 | |i|pagename|runs| 20:22:15 INFO - PROCESS | 12085 | |0;ai-astar;114;109;112;112;113;125;112;113;114;114 20:22:15 INFO - PROCESS | 12085 | |1;audio-beat-detection;163;132;163;179;129;156;152;132;182;128 20:22:15 INFO - PROCESS | 12085 | |2;audio-dft;165;163;161;163;162;165;177;163;166;164 20:22:15 INFO - PROCESS | 12085 | |3;audio-fft;76;77;72;160;75;77;75;76;167;73 20:22:15 INFO - PROCESS | 12085 | |4;audio-oscillator;93;94;148;93;93;93;155;94;93;166 20:22:15 INFO - PROCESS | 12085 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;117;117;119 20:22:15 INFO - PROCESS | 12085 | |6;imaging-darkroom;146;147;147;146;147;147;146;146;146;147 20:22:15 INFO - PROCESS | 12085 | |7;imaging-desaturate;95;97;95;95;95;97;95;96;95;95 20:22:15 INFO - PROCESS | 12085 | |8;json-parse-financial;56;61;61;60;58;59;58;76;55;55 20:22:15 INFO - PROCESS | 12085 | |9;json-stringify-tinderbox;58;59;58;59;59;58;58;58;63;59 20:22:15 INFO - PROCESS | 12085 | |10;stanford-crypto-aes;77;76;76;79;78;78;77;78;79;77 20:22:15 INFO - PROCESS | 12085 | |11;stanford-crypto-ccm;132;120;121;130;124;122;121;131;166;124 20:22:15 INFO - PROCESS | 12085 | |12;stanford-crypto-pbkdf2;176;168;173;167;171;165;165;168;169;165 20:22:15 INFO - PROCESS | 12085 | |13;stanford-crypto-sha256-iterative;68;68;66;72;71;69;70;70;69;68 20:22:15 INFO - PROCESS | 12085 | __end_tp_report 20:22:15 INFO - PROCESS | 12085 | __start_cc_report 20:22:15 INFO - PROCESS | 12085 | _x_x_mozilla_cycle_collect,894 20:22:15 INFO - PROCESS | 12085 | __end_cc_report 20:22:15 INFO - PROCESS | 12085 | __startTimestamp1462418535178__endTimestamp 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | ------- Summary: start ------- 20:22:15 INFO - PROCESS | 12085 | Number of tests: 14 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.21 (3.7%) stddev-sans-first:4.47 20:22:15 INFO - PROCESS | 12085 | Values: 114.0 109.0 112.0 112.0 113.0 125.0 112.0 113.0 114.0 114.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.50 stddev:20.52 (12.9%) stddev-sans-first:21.35 20:22:15 INFO - PROCESS | 12085 | Values: 163.0 132.0 163.0 179.0 129.0 156.0 152.0 132.0 182.0 128.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.51 (2.7%) stddev-sans-first:4.78 20:22:15 INFO - PROCESS | 12085 | Values: 165.0 163.0 161.0 163.0 162.0 165.0 177.0 163.0 166.0 164.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:37.33 (49.4%) stddev-sans-first:39.10 20:22:15 INFO - PROCESS | 12085 | Values: 76.0 77.0 72.0 160.0 75.0 77.0 75.0 76.0 167.0 73.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#4] audio-oscillator Cycles:10 Average:112.20 Median:93.00 stddev:30.76 (33.1%) stddev-sans-first:31.83 20:22:15 INFO - PROCESS | 12085 | Values: 93.0 94.0 148.0 93.0 93.0 93.0 155.0 94.0 93.0 166.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 20:22:15 INFO - PROCESS | 12085 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 119.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:22:15 INFO - PROCESS | 12085 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 20:22:15 INFO - PROCESS | 12085 | Values: 95.0 97.0 95.0 95.0 95.0 97.0 95.0 96.0 95.0 95.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.50 stddev:6.08 (10.2%) stddev-sans-first:6.28 20:22:15 INFO - PROCESS | 12085 | Values: 56.0 61.0 61.0 60.0 58.0 59.0 58.0 76.0 55.0 55.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.58 20:22:15 INFO - PROCESS | 12085 | Values: 58.0 59.0 58.0 59.0 59.0 58.0 58.0 58.0 63.0 59.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:1.08 (1.4%) stddev-sans-first:1.13 20:22:15 INFO - PROCESS | 12085 | Values: 77.0 76.0 76.0 79.0 78.0 78.0 77.0 78.0 79.0 77.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:127.00 stddev:13.71 (10.8%) stddev-sans-first:14.50 20:22:15 INFO - PROCESS | 12085 | Values: 132.0 120.0 121.0 130.0 124.0 122.0 121.0 131.0 166.0 124.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.50 stddev:3.68 (2.2%) stddev-sans-first:2.80 20:22:15 INFO - PROCESS | 12085 | Values: 176.0 168.0 173.0 167.0 171.0 165.0 165.0 168.0 169.0 165.0 20:22:15 INFO - PROCESS | 12085 | 20:22:15 INFO - PROCESS | 12085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.73 (2.5%) stddev-sans-first:1.79 20:22:15 INFO - PROCESS | 12085 | Values: 68.0 68.0 66.0 72.0 71.0 69.0 70.0 70.0 69.0 68.0 20:22:15 INFO - PROCESS | 12085 | -------- Summary: end -------- 20:22:15 INFO - PROCESS | 12085 | 20:22:16 INFO - TEST-INFO | 12085: exit 0 20:22:16 INFO - TEST-OK | kraken | took 61659ms 20:22:16 INFO - SUITE-END | took 1171s 20:22:16 INFO - Completed test suite (00:19:31) 20:22:16 INFO - javascript benchmark 20:22:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.070729134905, 3151.3224656698803, 3191.617005959285, 3224.4196044711957, 3231.062991732399, 5453.7818487260565, 5465.890682186354, 5488.533474654654, 5498.670079795215, 5537.723113844307, 5375.16684913839, 5412.161115027167, 5479.835604931858, 5536.474034966682, 5541.501264886159, 4911.729854857973, 4929.383827021622, 4982.277569752384, 4982.352294201749, 5041.344625198719, 866.3206519153525, 4972.477889821571, 4993.126202914494, 5019.52314530119, 5059.544640982311, 4959.429665588449, 4967.826126085606, 4991.475895031006, 4991.825286114987, 5010.749462526877, 4984.177610694231, 5025.0954828130925, 5097.7196254206, 5098.337216161913, 5119.0529751996, 4973.975130124362, 4994.550490455877, 4996.0, 4996.525330093636, 5067.0879241736475, 5356.839294821123, 5385.407605163429, 5413.810516631899, 5414.539764120054, 5487.835364939058, 5750.0, 5843.883122337572, 5845.473907348359, 5882.6764527950945, 5920.940790592082, 5881.588288819784, 5898.292204935392, 5904.498117660004, 5935.792247271324, 5954.434328738763, 5489.258950041733, 5495.2856128703015, 5496.367917689477, 5500.614956953015, 5501.669899805985, 5867.090600956859, 5965.284165900033, 5982.312034116046, 5992.460678538865, 6058.939410605925, 5724.971375143181, 5730.942690573041, 5736.713164341766, 5754.4533269339345, 5757.913631295534, 5785.27684039495, 5796.710164491758, 5804.1293805929445, 5819.098039803837, 5824.650520968671, 5610.635308704921, 5804.593678442468, 5812.738426770806, 5879.911801322984, 5883.588148829626, 5727.828165155052, 5733.197352370671, 5775.7400916957995, 5785.768569257182, 5803.738831752581, 4281.100968796588, 4283.978580107079, 4293.0, 4294.334378171388, 4327.7619730914475, 3837.328467518173, 3856.460095586564, 3873.1285460771664, 3903.8048097595006, 3910.9413358799643, 5538.280023596987, 5570.888582228333, 5580.888382232414, 5587.1339942309005, 5609.887802243932, 5745.396733342939, 5770.105633626795, 5792.449717276936, 5829.09649004405, 5872.295324560994, 5515.090010148361, 5566.972165139229, 5570.6657600544095, 5630.127330263816, 5655.9253741788925, 4874.512548745097, 4910.21436570147, 4915.754212289371, 4918.139325618003, 4986.675866068694, 6060.2424696912885, 6067.24159480065, 6073.210482637229, 6095.238095238095, 6114.877702445926, 5786.1610066540115, 5905.763769449174, 5951.7619295227705, 5976.402359763989, 5993.430624090704, 6025.6083354581815, 6032.638041717511, 6033.366496517802, 6038.5772995889865, 6043.2748070231855, 5654.6324488908085, 5747.51146152565, 5754.338251101177, 5802.622829516068, 5825.79609713658, 5798.217240672624, 5876.823695289148, 5895.498882595028, 5898.262717160355, 5929.970350148395, 5664.801731939362, 5697.601167918206, 5698.686572238566, 5704.914426283526, 5711.857203569944, 5635.549156067586, 5654.519365853948, 5687.829365119053, 5693.8861222774485, 5707.286589176353, 5628.662280263197, 5631.408702086386, 5668.5465162787705, 5701.914471283017, 5716.228309178207, 5683.687397193194, 5762.971185144215, 5764.337101233412, 5773.134029895549, 5778.422157784188, 5596.720163991866, 5632.971835140798, 5642.294713160855, 5651.039323314964, 5656.151577263443], "value": 5354.461547840277, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7595273914063, 641.0448431836563, 652.5073569455058, 658.1805651963305, 660.5970358081572, 36101.45847812282, 37181.62818371815, 37214.25571488569, 37410.62589374105, 37459.0, 41093.17813643725, 42156.367654485206, 42206.0, 42225.0, 42322.57677423225, 8414.579271036455, 8543.54759690854, 8572.699955501559, 8594.484330940133, 8607.913920860805, 8511.14888511147, 8543.14568543147, 8616.095309992455, 8647.092055334193, 8833.911660883405, 8809.942806863186, 8982.820343593125, 8983.146601072887, 8989.640414383417, 8990.640374385017, 8829.470231786081, 8880.067592902717, 8939.240164586017, 8944.150305720947, 8968.686095986674, 8725.694600688945, 8797.340199485001, 8835.77910552235, 8874.290056795506, 8891.510966896818, 41621.58378416238, 42540.149197016195, 42607.0, 42662.36006459906, 42787.0, 3641.599424063351, 3732.0813146196383, 3774.4904437900805, 3919.7648141111627, 4368.432103826514, 32145.1963700907, 32150.0, 32711.0, 32798.18004549881, 33029.0, 3801.505804245458, 3838.4626152338415, 3867.245887052026, 3889.6960741045605, 3893.766374017568, 313703.0, 316370.0, 316653.0, 319545.0, 319793.0, 52749.208761868606, 52933.20600191, 53007.20489192665, 58149.12776308359, 58170.709146454, 57276.0, 58147.127793083135, 58222.4177758217, 58238.0, 58329.4167058324, 16134.596635083983, 16221.83778162227, 16310.673786524203, 16316.34734610626, 16318.184090795412, 13634.590962271148, 13686.52097176614, 13719.245441500614, 13723.1079979801, 13748.175109493463, 19511.219551218077, 19860.40418787439, 20233.392998210078, 20338.694919576217, 20392.592148156953, 7223.674934627849, 7301.882454088362, 7311.159216690043, 7410.555366678017, 7597.962010189914, 1069.6470164845582, 1074.6238816414193, 1093.3221402730198, 1133.56924368741, 1166.2186335155466, 30669.38661226763, 31498.842505787325, 31884.681153188634, 31935.84032079825, 32098.679013210036, 1134.2740645986576, 1140.190464770006, 1154.5381847260994, 1156.9247998880046, 1158.4902642837126, 14547.3453694584, 15050.172240526876, 15511.301991410413, 15525.767113493306, 15576.221188940508, 352025.0, 360987.0, 361815.0, 363252.0, 363350.0, 51654.48345516572, 52625.0, 52667.73666131645, 52850.47149528455, 58055.0, 1409.83082030155, 1421.8009478672993, 1431.6492459347526, 1432.8567143285588, 1515.8256800468087, 29051.273718156368, 29432.411351773273, 29575.556366654087, 29967.4006519864, 30542.541861872534, 49276.0, 49743.25385119153, 49915.251271230234, 50199.24701129413, 50210.0, 414525.0, 416949.0, 418940.0, 419671.0, 421745.0, 27842.44315113646, 28176.85911570429, 28258.0, 28282.15153545397, 40551.59448405596, 43153.0, 43295.13409731851, 43359.56640433555, 43369.78315108404, 43807.17452962059, 39704.01479925934, 40610.79694601508, 40910.386344204264, 41047.794761026, 41154.17691646091, 39279.6072039276, 39955.40066899057, 40416.59583404128, 40731.59268407396, 41226.79386603048, 32915.177120572174, 39882.2023559533, 40511.18977620372, 40688.38967415432, 41337.0, 41111.1777764449, 43164.784176078916, 43779.12441751211, 43935.12129757451, 44389.33415998827, 32953.17617059593, 33332.50001250031, 33555.83222083874, 33946.0, 34234.48648270328], "value": 19792.38589154321, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3542992636965, 402.8650402115291, 405.58022446767603, 411.5061925689173, 415.5491291948236, 13900.165990040605, 18169.727454088184, 18542.165602547884, 18669.346572869934, 18827.435176944695, 17639.911800441012, 17691.380801671945, 18170.454886353396, 18687.906560467178, 18792.81207187931, 5511.559075273968, 5540.972295138518, 5694.857628559298, 5739.942600573982, 5768.307803063638, 5425.941941321444, 5690.061139911931, 5711.600187986843, 5740.942590574104, 5750.626209296403, 5708.372079071299, 5727.284089488814, 5727.34135574408, 5733.627314224583, 5737.139429085629, 5265.710385928773, 5546.084895992177, 5550.833474995757, 5580.776768929238, 5586.050371436865, 5248.134057880445, 5364.785408583652, 5564.582656300794, 5578.748956296977, 5586.91619625706, 13638.318084095756, 13772.655683607889, 13803.378847951866, 18700.0, 22174.223902163347, 2322.175627652176, 2350.5886469867874, 2389.7729715676983, 2489.684593328204, 2507.5611767940536, 10096.242781791321, 10382.740431489197, 10433.895661043443, 10443.321184123008, 10537.420441875694, 1968.0, 2005.5888542848681, 2021.7674967378794, 2047.0276618606042, 2074.8962551872346, 60162.39837601612, 66145.0, 69719.65140174267, 81460.0, 85428.0, 9907.80184396308, 10308.433036183082, 10350.327228730108, 10505.632302869515, 10635.840462393071, 14669.266536673336, 14769.852301477062, 14794.0, 14852.405903763729, 14852.62868428298, 7927.960360198277, 7931.603419828985, 8027.397945154137, 8108.0, 8212.096669366365, 7917.920820791834, 8039.236272554098, 8090.110087890327, 8120.553369564613, 8157.143499932422, 4596.333531637893, 4643.141018911445, 4707.693999890064, 4763.237881938873, 4796.088743138793, 1896.5922326699826, 1932.3333449959741, 1934.806519348082, 1952.8144826241485, 1989.303743689697, 911.9498427586547, 997.0826839307854, 1019.5870672377699, 1069.7379142110078, 1112.8887111288968, 17980.0, 18068.0, 18184.63630727378, 18850.71723924142, 18969.620607588047, 1022.882368527614, 1034.3121823987115, 1034.3535290443472, 1059.772148987956, 1061.5010944855906, 10268.819085805228, 10441.530131144116, 10623.36259824413, 10679.519421626046, 10708.518116684769, 461215.0, 466015.0, 468166.0, 472726.0, 473234.0, 98357.0, 99914.0, 100090.4995475018, 100341.0, 100618.496907515, 1036.0263697655978, 1056.9471526423647, 1067.5516283161091, 1069.2782371898936, 1070.619929924881, 16383.672326553164, 16753.91623041877, 16797.328106876077, 16872.24074916656, 17189.398371056952, 39818.80090599528, 40050.59949400469, 42047.3692894613, 42115.0, 42861.14277714366, 57681.13478297913, 58196.70901645634, 59126.40873591209, 60004.09993850183, 60898.39101608927, 8446.662133514836, 8512.574371281287, 8692.826143477221, 8769.429987050822, 8800.603972821367, 10184.338018028804, 12892.226466412045, 12967.286799226133, 13377.063605547519, 13671.79492307636, 11382.715432114263, 11534.82697759551, 11599.478023488795, 11725.706857328634, 11962.76074478523, 11357.318560886373, 11477.139214558774, 11540.3075815448, 11605.419729013684, 11693.415329233674, 11535.423228838357, 11722.824157637471, 11767.52929882795, 11805.364803651795, 11990.460429280878, 8508.574571271536, 8533.104024077382, 8759.693410730593, 8826.911730882866, 8838.469691818511, 8629.39594228423, 10540.789184216119, 11457.08343332548, 11516.19386642927, 11589.304641721523], "value": 9043.953347099132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.8123984501933, 1532.7394342961695, 1668.8164301926793, 1785.4465115814091, 1831.6977698679727, 7570.129435114964, 7904.446688731791, 8149.674013039478, 8453.323734101272, 8465.703700370488, 8070.757877263692, 8153.7553873383895, 8193.508389496634, 8201.466904651194, 8237.464564803284, 2268.115434980355, 2310.2376215848813, 2319.420144963759, 2328.313147621447, 2333.265021518216, 2279.939827979989, 2291.6677081823127, 2345.8240631952585, 2349.870757108367, 2350.6356514740155, 2229.9888500557477, 2241.1931704586336, 2268.965965510519, 2316.9536609267802, 2317.571249318873, 2233.910643574255, 2238.306125101216, 2240.4622890506325, 2247.438140464884, 2250.459889626486, 2243.25972429098, 2246.4271610739156, 2248.943776405603, 2253.0649780341137, 2270.0579259607243, 8289.129641387688, 8345.123762004963, 8345.998480182418, 8406.159384061606, 8420.83158336836, 4961.8511444656715, 5117.334746482933, 5117.948820511784, 5133.562602471314, 5137.152369858969, 2978.19588711049, 3012.1264833198347, 3123.422166899131, 3127.1712996056062, 3138.9372212555622, 1019.1439191079529, 1019.7246743379246, 1032.4579595712237, 1039.6776999130218, 2012.6679097948968, 10981.39602321872, 11116.555337786478, 11135.888641113566, 11190.664280071529, 11230.98921097097, 4492.2587773017085, 4606.953930460652, 4609.193391156534, 4622.098690755271, 4635.072985402933, 9513.238940884712, 9562.56968436422, 9635.662751803653, 9639.759006024766, 9681.322307438553, 5103.157978933435, 5195.506426889439, 5225.790968361223, 5242.895142097213, 5270.393904701008, 4238.109996900624, 4718.0, 4862.610991120702, 4862.854114376574, 4865.781039853215, 3914.37370020801, 3948.0, 3973.304671682444, 4002.7598344099447, 4054.412110244057, 1274.1781550899802, 1304.0480449272084, 1321.8347706536683, 1324.16577556139, 1329.2423318708243, 888.0, 1023.7389465686202, 1042.1923009667416, 1042.8070806900748, 1044.2481413382352, 5708.20085188074, 5811.157382179645, 5825.533957283407, 5835.803660249723, 5837.270341207349, 466.2656316301838, 466.75728621116826, 470.56472762695057, 1068.2949253492657, 1086.9510872010778, 4103.363978583325, 4142.813573389205, 4166.416701661769, 4169.854055108057, 4201.0, 9688.951555242178, 10081.19350451962, 10138.493075346203, 10176.694699159038, 10189.847152292721, 9932.553035113437, 9936.850947235796, 10034.448105354275, 10070.093691567648, 10079.647212347532, 7431.256874312526, 7582.962085189649, 7826.686932522749, 7935.6032198391, 7937.682492700343, 5786.537077033911, 5878.706064696834, 5878.794242201502, 5881.647101173943, 5895.41045895407, 8791.868121978048, 8939.865902011345, 9152.17630413266, 9167.220786233245, 9204.171624553823, 9307.301952353737, 9396.718098457057, 9428.198603118537, 9502.334836561651, 9531.189848862925, 6845.452363810983, 7288.3076107769675, 7334.266573342623, 7481.551106933602, 7542.585157816373, 7936.404769642185, 8010.759677209693, 8013.398995075276, 8036.4776289541, 8083.434159608771, 6936.098307220029, 7179.174394944648, 7266.818329541804, 7268.38218751412, 7471.21552237029, 7042.295770422917, 7149.785506434815, 7199.604021778852, 7225.674844632109, 7337.523061001231, 6709.832254193489, 6778.288279730557, 6796.150481189851, 6808.38724514796, 6819.113515242987, 4719.362886010482, 4873.366462359871, 4889.926651100165, 4962.082014827269, 4985.227289770091, 4983.700977941335, 5029.874253143701, 5073.44192138857, 5088.872778180427, 5149.819756308511], "value": 4459.619837209579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.5375051802735, 335.5889035930984, 336.72893320876693, 338.12257192585236, 340.3040781601624, 5571.3314402271735, 5627.127795191742, 5645.915311270334, 5673.914891276634, 5681.074246762921, 5489.176623506476, 5509.393966663663, 5551.528120109796, 5567.276254086963, 5574.804881829137, 4107.8973025674295, 4151.273527132755, 4269.380939763748, 4278.74327540347, 4285.271503844354, 4295.548967358429, 4305.634021108194, 4323.524412314643, 4330.761808100553, 4333.4799824021, 4281.143771245764, 4298.26929421999, 4302.11806579652, 4331.5884990925815, 4339.566043395666, 4050.9797451012705, 4242.3212286034395, 4248.235317642823, 4258.5528519505315, 4302.935455968163, 3739.1213064929993, 3741.1021354874906, 3745.850165993384, 3746.7939263340504, 3773.9433908491396, 5318.095923692981, 5319.521243088141, 5339.252504649352, 5343.251944727741, 5370.388883335023, 4634.768261586941, 4859.441164266084, 4888.804447822083, 4942.159832828392, 4944.53026962438, 5721.596929289708, 5733.741981610796, 5778.0466223073145, 5779.838516268323, 5806.767729290823, 4090.365993271048, 4103.199876024177, 4104.712670113093, 4112.629863312286, 4113.03343714227, 5886.882262354772, 6001.609895356788, 6015.548833837436, 6020.127081573148, 6088.878222435526, 4085.3259212230246, 4087.3255912774653, 4099.446574712435, 4102.712810103264, 4111.527174374925, 4084.36692312692, 4090.4865199876235, 4101.302778527598, 4109.568495308009, 4157.605027522381, 4630.471944258386, 4732.905341893212, 4744.908671005688, 4802.423709154924, 4813.253945638432, 5848.0, 5852.590318677737, 5854.95076723152, 5867.853303667357, 5873.853153671107, 1528.159512268248, 1542.4909779772647, 1545.3432291276163, 1547.4119834463056, 1558.1196623907456, 964.4888209249109, 997.3666721631816, 1001.5893483671659, 1035.089121573011, 1041.5470418765779, 5860.652050028517, 5922.822315330547, 5930.199423077829, 5940.762369505258, 5956.851078723066, 6310.5267104967315, 6310.8422289442215, 6324.557280990287, 6351.682415879188, 6405.871882562323, 5786.450287222707, 5888.61723987948, 5913.615614985012, 5937.643741375531, 5954.136650185699, 3359.227377703093, 3392.1350055736125, 3394.3890099781784, 3398.7424652878594, 3412.368711788327, 6382.819178452001, 6488.837779055561, 6508.023796430573, 6511.851089140572, 6587.143671322698, 6469.0, 6493.285738568754, 6506.512011599149, 6519.576227545194, 6546.967265163644, 5986.431289027535, 6235.469985051322, 6565.770198043046, 6591.43972762311, 6631.27056023837, 6057.0, 6057.666828324484, 6086.573939824347, 6093.177421048102, 6142.877142457037, 6021.5247264420495, 6022.849428764141, 6035.426634469718, 6057.515398768, 6062.363451837494, 5991.191189189403, 6256.343083976299, 6274.529410294337, 6284.277308109626, 6304.401081897213, 4154.854580089683, 4229.492460904711, 4233.407322974847, 4237.110206856594, 4287.614114729689, 5771.884562308815, 6050.15297858309, 6095.238095238095, 6151.292601350902, 6153.200083989232, 5947.6431414115295, 5951.464368206882, 5992.221011268507, 6022.1870047543025, 6065.695875386813, 5882.147088672033, 5887.735051922588, 5888.0, 5912.46787789101, 6043.728032238648, 5545.750441230073, 5790.971045144747, 5823.631446610128, 5827.94172058274, 5828.388019258086, 5899.823005309848, 5941.732622032106, 5953.821385358447, 5964.671943043174, 5996.520278377632, 5723.513501352431, 5767.452092051249, 5810.5351571875, 5833.329167145833, 5849.824505264849], "value": 4486.6444848174315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.2691679446128, 776.1617453150598, 777.525709317316, 783.7100272899028, 790.5375355417083, 14577.708445831076, 15014.174220417872, 15020.549383518484, 15054.322555485001, 15063.246837658127, 14037.0, 14061.0, 14064.0, 14073.366698498567, 14111.15333080016, 674.322306082389, 800.5396896784343, 827.8137419080704, 831.6382373667444, 832.6544484039116, 817.840521098386, 821.5645707774859, 822.5106061893164, 823.6417158536026, 824.6783754335814, 880.2825697056878, 883.2889523933231, 883.4390162246955, 884.60192913189, 885.8228354329128, 869.9652013919435, 873.8820259264982, 875.2910142784333, 878.2710350409145, 879.2745984562697, 624.1293395712955, 628.4877824572958, 631.119588174494, 633.914421553089, 639.0127253393472, 14472.276386180754, 14552.0541164825, 14593.270336483134, 14653.487127950471, 14728.55814325572, 13595.184288942597, 14076.648083797885, 14516.129032258099, 14792.0, 14870.405183792634, 11780.705482362924, 12047.759044819142, 12058.819117713241, 12094.637160885188, 12181.93909030458, 3839.827207775657, 3899.415087736834, 3913.960860391388, 3925.725199236055, 3934.291827471054, 60632.69683651598, 62059.379406205815, 62559.0, 63672.0, 63744.362556374304, 9194.264458843276, 9574.856377154349, 9997.350172238781, 10015.449150296803, 10103.343282686601, 21167.576648467253, 21228.363149105553, 21251.89374053151, 21331.14675412997, 21361.67957480639, 8261.752147435587, 8328.33373330132, 8353.874691879626, 8369.0, 8476.915230847735, 4762.095201911626, 4815.2054910940005, 4842.104210721028, 4892.633052521075, 4953.777080031407, 3238.740900727936, 3356.412627790176, 3358.378699940519, 3358.697717205463, 3360.4119279126544, 593.5607650338718, 596.4006173795308, 601.1913975702673, 613.2487702564323, 622.3589702606323, 570.9371969083397, 584.3251045042982, 618.4742968476759, 645.7546132469631, 658.6311665467258, 8921.330900182513, 8989.325800564984, 9131.908680913239, 9242.214411775074, 9245.3528253023, 609.600711533946, 629.1443636654146, 659.8911179655303, 669.6919417068106, 689.069755829636, 4381.715188512737, 4504.369388285642, 4611.792469338888, 4668.743219122913, 4680.859574212711, 65989.67005164943, 66374.33625663682, 66946.66526667336, 67203.0, 68677.3132268681, 57362.0, 59490.405095949354, 59625.0, 60284.69857650684, 60739.39260607426, 47483.76258118687, 52301.0, 52837.0, 52977.7351113242, 54263.72868135634, 8807.427517211361, 9215.677451289173, 9242.168204861595, 9267.907320926704, 9311.953440232755, 33944.32111357809, 35142.12144696301, 35294.47058294076, 36326.81836590906, 36348.818255908554, 47107.29339059848, 47849.5215047859, 48014.519854801, 48128.3529405886, 49396.75301623469, 11569.479373428048, 11686.123540734648, 11768.764624707286, 11800.586979455678, 12016.879831201577, 13000.934995324962, 13012.804807928078, 13096.476140954255, 13266.602001939957, 13332.733345332845, 12242.143049986415, 12262.816057758962, 12377.938110309391, 12456.813147802972, 13029.218246905217, 11889.583864564698, 11917.34454605005, 11967.341796201292, 12088.335141566946, 12285.0, 12228.327441990776, 12387.62837114888, 12526.248425094524, 12590.874091258971, 12621.93689031549, 10475.633352832614, 10764.892351076389, 10815.188860835311, 10872.238943273895, 11184.608538701106, 9736.561854716696, 10750.46247687628, 10923.235373523778, 10945.83581246298, 11002.449877506253], "value": 6812.40920174951, "unit": "score"}], "name": "dromaeo_css", "value": 7123.4319535209825, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 112.0, 112.0, 113.0, 125.0, 112.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 163.0, 179.0, 129.0, 156.0, 152.0, 132.0, 182.0, 128.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 163.0, 162.0, 165.0, 177.0, 163.0, 166.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 72.0, 160.0, 75.0, 77.0, 75.0, 76.0, 167.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 148.0, 93.0, 93.0, 93.0, 155.0, 94.0, 93.0, 166.0], "value": 112.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 61.0, 60.0, 58.0, 59.0, 58.0, 76.0, 55.0, 55.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 63.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 79.0, 78.0, 78.0, 77.0, 78.0, 79.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 120.0, 121.0, 130.0, 124.0, 122.0, 121.0, 131.0, 166.0, 124.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 168.0, 173.0, 167.0, 171.0, 165.0, 165.0, 168.0, 169.0, 165.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 72.0, 71.0, 69.0, 70.0, 70.0, 69.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1557.8999999999999, "alertThreshold": 2.0}]} 20:22:16 INFO - Return code: 0 20:22:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:22:16 ERROR - # TBPL SUCCESS # 20:22:16 INFO - Running post-action listener: _resource_record_post_action 20:22:16 INFO - Running post-run listener: _resource_record_post_run 20:22:17 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550760448; Read time: 4; Write time: 611628 20:22:17 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 260476928; Read time: 0; Write time: 354260 20:22:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290230272; Read time: 4; Write time: 257344 20:22:17 INFO - Running post-run listener: _upload_blobber_files 20:22:17 INFO - Blob upload gear active. 20:22:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:22:17 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:17 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:17 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:17 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:19 INFO - (blobuploader) - INFO - Done attempting. 20:22:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:19 INFO - Return code: 0 20:22:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:22:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217c2aefed1606bdb9a2745f8e44c47bb64fabf2472f5834a54a2c928ee5a49c1e4cb51fab72ca33e6716bf8c7f151a7b0942df1bc9c91726a9ac393793a584d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f44769d82e7f8ee1cfe08d3647902e6770166d010738b85d350092c1eda0adf4c0b8d639dc15be5c1ad67a19d5615a5dabe7ff3cdbdecb23cbd7a99c255472e"} 20:22:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:22:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:22:19 INFO - Contents: 20:22:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217c2aefed1606bdb9a2745f8e44c47bb64fabf2472f5834a54a2c928ee5a49c1e4cb51fab72ca33e6716bf8c7f151a7b0942df1bc9c91726a9ac393793a584d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f44769d82e7f8ee1cfe08d3647902e6770166d010738b85d350092c1eda0adf4c0b8d639dc15be5c1ad67a19d5615a5dabe7ff3cdbdecb23cbd7a99c255472e"} 20:22:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:19 INFO - Copying logs to upload dir... 20:22:19 INFO - mkdir: /builds/slave/test/build/upload/logs 20:22:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.506832 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-04 20:22:19.041808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:19.045131) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217c2aefed1606bdb9a2745f8e44c47bb64fabf2472f5834a54a2c928ee5a49c1e4cb51fab72ca33e6716bf8c7f151a7b0942df1bc9c91726a9ac393793a584d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f44769d82e7f8ee1cfe08d3647902e6770166d010738b85d350092c1eda0adf4c0b8d639dc15be5c1ad67a19d5615a5dabe7ff3cdbdecb23cbd7a99c255472e"} 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.011325 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217c2aefed1606bdb9a2745f8e44c47bb64fabf2472f5834a54a2c928ee5a49c1e4cb51fab72ca33e6716bf8c7f151a7b0942df1bc9c91726a9ac393793a584d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f44769d82e7f8ee1cfe08d3647902e6770166d010738b85d350092c1eda0adf4c0b8d639dc15be5c1ad67a19d5615a5dabe7ff3cdbdecb23cbd7a99c255472e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:19.071659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:19.072154) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462416011.139306-1504343450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 20:22:19.154893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 20:22:19.155205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 20:22:19.155567) ========= ========= Total master_lag: 0.17 =========