builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1464136132.75 results: success (0) buildid: 20160524143019 builduid: f57f4315fb9a4e98bb13933478fb0447 revision: ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.751317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.751834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.752114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.766864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.767148) ========= 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=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 17:28:52-- 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% 42.7M=0s 2016-05-24 17:28:52 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.884057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.884406) ========= 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=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.934609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:52.935013) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 --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 ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 --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=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 17:28:53,072 truncating revision to first 12 chars 2016-05-24 17:28:53,072 Setting DEBUG logging. 2016-05-24 17:28:53,072 attempt 1/10 2016-05-24 17:28:53,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce6147a6f839?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 17:28:53,643 unpacking tar archive at: fx-team-ce6147a6f839/testing/mozharness/ program finished with exit code 0 elapsedTime=0.840640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:53.789170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:53.789502) ========= script_repo_revision: ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:53.789977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:53.790253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 17:28:53.798861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 17:28:53.799179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:28:54 INFO - MultiFileLogger online at 20160524 17:28:54 in /builds/slave/test 17:28:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:28:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:28:54 INFO - {'append_to_log': False, 17:28:54 INFO - 'base_work_dir': '/builds/slave/test', 17:28:54 INFO - 'blob_upload_branch': 'Fx-Team', 17:28:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:28:54 INFO - 'branch': 'Fx-Team', 17:28:54 INFO - 'buildbot_json_path': 'buildprops.json', 17:28:54 INFO - 'config_files': ('talos/linux_config.py',), 17:28:54 INFO - 'default_actions': ('clobber', 17:28:54 INFO - 'read-buildbot-config', 17:28:54 INFO - 'download-and-extract', 17:28:54 INFO - 'populate-webroot', 17:28:54 INFO - 'create-virtualenv', 17:28:54 INFO - 'install', 17:28:54 INFO - 'run-tests'), 17:28:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:28:54 INFO - 'download_minidump_stackwalk': True, 17:28:54 INFO - 'download_symbols': 'ondemand', 17:28:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:28:54 INFO - 'tooltool.py': '/tools/tooltool.py', 17:28:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:28:54 INFO - '/tools/misc-python/virtualenv.py')}, 17:28:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:28:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:28:54 INFO - 'installer_path': 'installer.exe', 17:28:54 INFO - 'log_level': 'info', 17:28:54 INFO - 'log_name': 'talos', 17:28:54 INFO - 'log_to_console': True, 17:28:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:28:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:28:54 INFO - 'opt_config_files': (), 17:28:54 INFO - 'pip_index': False, 17:28:54 INFO - 'sps_profile': False, 17:28:54 INFO - 'sps_profile_interval': 0, 17:28:54 INFO - 'suite': 'dromaeojs', 17:28:54 INFO - 'system_bits': '32', 17:28:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:28:54 INFO - 'title': 'talos-linux64-ix-035', 17:28:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:28:54 INFO - 'use_talos_json': True, 17:28:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:28:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:28:54 INFO - 'work_dir': 'build'} 17:28:54 INFO - ##### 17:28:54 INFO - ##### Running clobber step. 17:28:54 INFO - ##### 17:28:54 INFO - Running pre-action listener: _resource_record_pre_action 17:28:54 INFO - Running main action method: clobber 17:28:54 INFO - rmtree: /builds/slave/test/build 17:28:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:28:54 INFO - Running post-action listener: _resource_record_post_action 17:28:54 INFO - ##### 17:28:54 INFO - ##### Finished clobber step (success) 17:28:54 INFO - ##### 17:28:54 INFO - ##### 17:28:54 INFO - ##### Running read-buildbot-config step. 17:28:54 INFO - ##### 17:28:54 INFO - Running pre-action listener: _resource_record_pre_action 17:28:54 INFO - Running main action method: read_buildbot_config 17:28:54 INFO - Using buildbot properties: 17:28:54 INFO - { 17:28:54 INFO - "project": "", 17:28:54 INFO - "product": "firefox", 17:28:54 INFO - "script_repo_revision": "production", 17:28:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:28:54 INFO - "repository": "", 17:28:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:28:54 INFO - "buildid": "20160524143019", 17:28:54 INFO - "pgo_build": "True", 17:28:54 INFO - "basedir": "/builds/slave/test", 17:28:54 INFO - "buildnumber": 121, 17:28:54 INFO - "slavename": "talos-linux64-ix-035", 17:28:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:28:54 INFO - "platform": "ubuntu64_hw", 17:28:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:28:54 INFO - "branch": "fx-team", 17:28:54 INFO - "repo_path": "integration/fx-team", 17:28:54 INFO - "revision": "ce6147a6f839a8efbf1770ecc0ea08c7c562cf63", 17:28:54 INFO - "stage_platform": "linux64-pgo", 17:28:54 INFO - "builduid": "f57f4315fb9a4e98bb13933478fb0447", 17:28:54 INFO - "slavebuilddir": "test" 17:28:54 INFO - } 17:28:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:28:54 INFO - Running post-action listener: _resource_record_post_action 17:28:54 INFO - ##### 17:28:55 INFO - ##### Finished read-buildbot-config step (success) 17:28:55 INFO - ##### 17:28:55 INFO - ##### 17:28:55 INFO - ##### Running download-and-extract step. 17:28:55 INFO - ##### 17:28:55 INFO - Running pre-action listener: _resource_record_pre_action 17:28:55 INFO - Running main action method: download_and_extract 17:28:55 INFO - mkdir: /builds/slave/test/build/tests 17:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:55 INFO - https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:55 INFO - Downloaded 1361 bytes. 17:28:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:28:55 INFO - Using the following test package requirements: 17:28:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:28:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:28:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:28:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'jsshell-linux-x86_64.zip'], 17:28:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:28:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:28:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:28:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:28:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:28:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:28:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:55 INFO - https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:56 INFO - Downloaded 24417004 bytes. 17:28:56 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'] 17:28:56 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 17:28:58 INFO - Return code: 0 17:28:58 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 17:28: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')]} 17:28:58 INFO - https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:28:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:28:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:28:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:28:59 INFO - Downloaded 24417004 bytes. 17:28:59 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'] 17:28:59 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 17:29:01 INFO - Return code: 0 17:29:01 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')]} 17:29:01 INFO - https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:29:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:29:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:29:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:29:01 INFO - Downloaded 10840359 bytes. 17:29:01 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'] 17:29:01 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 17:29:02 INFO - Return code: 0 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:02 INFO - https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cF7cpE2aR_iR3l_8ny2eEw/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 17:29:03 INFO - Downloaded 58625158 bytes. 17:29:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:03 INFO - mkdir: /builds/slave/test/properties 17:29:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:29:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:29:03 INFO - Contents: 17:29:03 INFO - build_url:https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:04 INFO - Running post-action listener: _resource_record_post_action 17:29:04 INFO - Running post-action listener: set_extra_try_arguments 17:29:04 INFO - ##### 17:29:04 INFO - ##### Finished download-and-extract step (success) 17:29:04 INFO - ##### 17:29:04 INFO - ##### 17:29:04 INFO - ##### Running populate-webroot step. 17:29:04 INFO - ##### 17:29:04 INFO - Running pre-action listener: _resource_record_pre_action 17:29:04 INFO - Running main action method: populate_webroot 17:29:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:29:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:29:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:29:04 INFO - '--tppagecycles', 17:29:04 INFO - '7'], 17:29:04 INFO - 'tests': ['tsvgm']}}, 17:29:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:29:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:29:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:29:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:29:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['damp', 'tps']}, 17:29:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'tests': ['damp', 'tps']}, 17:29:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['dromaeo_dom']}, 17:29:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:29:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['a11yr', 17:29:04 INFO - 'ts_paint', 17:29:04 INFO - 'tpaint', 17:29:04 INFO - 'sessionrestore', 17:29:04 INFO - 'sessionrestore_no_auto_restore', 17:29:04 INFO - 'tabpaint']}, 17:29:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['tsvgx', 17:29:04 INFO - 'tsvgr_opacity', 17:29:04 INFO - 'tart', 17:29:04 INFO - 'tscrollx', 17:29:04 INFO - 'cart']}, 17:29:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:29:04 INFO - 'tsvgr_opacity', 17:29:04 INFO - 'tart', 17:29:04 INFO - 'tscrollx', 17:29:04 INFO - 'cart']}, 17:29:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'talos_options': ['--disable-e10s'], 17:29:04 INFO - 'tests': ['tp5o']}, 17:29:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'tests': ['tp5o']}, 17:29:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'talos_options': ['--disable-e10s', 17:29:04 INFO - '--xperf_path', 17:29:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:04 INFO - 'tests': ['tp5n']}, 17:29:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:04 INFO - 'talos_options': ['--xperf_path', 17:29:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:04 INFO - 'tests': ['tp5n']}}, 17:29:04 INFO - 'talos.zip': {'path': '', 17:29:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:29:04 INFO - Running post-action listener: _resource_record_post_action 17:29:04 INFO - ##### 17:29:04 INFO - ##### Finished populate-webroot step (success) 17:29:04 INFO - ##### 17:29:04 INFO - ##### 17:29:04 INFO - ##### Running create-virtualenv step. 17:29:04 INFO - ##### 17:29:04 INFO - Running pre-action listener: _resource_record_pre_action 17:29:04 INFO - Running main action method: create_virtualenv 17:29:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:29:04 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 17:29:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:29:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:29:04 INFO - Using real prefix '/usr' 17:29:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:29:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:29:07 INFO - Installing pip.................done. 17:29:07 INFO - Return code: 0 17:29:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29: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', 'pip>=1.5'] in /builds/slave/test/build 17:29: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 pip>=1.5 17:29:07 INFO - Using env: {'DISPLAY': ':0', 17:29:07 INFO - 'HOME': '/home/cltbld', 17:29:07 INFO - 'LANG': 'en_US.UTF-8', 17:29:07 INFO - 'LANGUAGE': 'en_US:en', 17:29:07 INFO - 'LOGNAME': 'cltbld', 17:29:07 INFO - 'MAIL': '/var/mail/cltbld', 17:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:07 INFO - 'MOZ_NO_REMOTE': '1', 17:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:07 INFO - 'NO_EM_RESTART': '1', 17:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:07 INFO - 'PWD': '/builds/slave/test', 17:29:07 INFO - 'SHELL': '/bin/bash', 17:29:07 INFO - 'SHLVL': '1', 17:29:07 INFO - 'TERM': 'linux', 17:29:07 INFO - 'TMOUT': '86400', 17:29:07 INFO - 'USER': 'cltbld', 17:29:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:07 INFO - '_': '/tools/buildbot/bin/python'} 17:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:07 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 17:29:07 INFO - Cleaning up... 17:29:07 INFO - Return code: 0 17:29:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:29: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 psutil>=3.1.1 17:29:07 INFO - Using env: {'DISPLAY': ':0', 17:29:07 INFO - 'HOME': '/home/cltbld', 17:29:07 INFO - 'LANG': 'en_US.UTF-8', 17:29:07 INFO - 'LANGUAGE': 'en_US:en', 17:29:07 INFO - 'LOGNAME': 'cltbld', 17:29:07 INFO - 'MAIL': '/var/mail/cltbld', 17:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:07 INFO - 'MOZ_NO_REMOTE': '1', 17:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:07 INFO - 'NO_EM_RESTART': '1', 17:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:07 INFO - 'PWD': '/builds/slave/test', 17:29:07 INFO - 'SHELL': '/bin/bash', 17:29:07 INFO - 'SHLVL': '1', 17:29:07 INFO - 'TERM': 'linux', 17:29:07 INFO - 'TMOUT': '86400', 17:29:07 INFO - 'USER': 'cltbld', 17:29:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:07 INFO - '_': '/tools/buildbot/bin/python'} 17:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:07 INFO - Downloading/unpacking psutil>=3.1.1 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:29:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:09 INFO - Installing collected packages: psutil 17:29:09 INFO - Running setup.py install for psutil 17:29:09 INFO - building 'psutil._psutil_linux' extension 17:29:09 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 17:29:10 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 17:29:10 INFO - building 'psutil._psutil_posix' extension 17:29:10 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 17:29:10 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 17:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:10 INFO - Successfully installed psutil 17:29:10 INFO - Cleaning up... 17:29:10 INFO - Return code: 0 17:29:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:29: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 mozsystemmonitor==0.3 17:29:10 INFO - Using env: {'DISPLAY': ':0', 17:29:10 INFO - 'HOME': '/home/cltbld', 17:29:10 INFO - 'LANG': 'en_US.UTF-8', 17:29:10 INFO - 'LANGUAGE': 'en_US:en', 17:29:10 INFO - 'LOGNAME': 'cltbld', 17:29:10 INFO - 'MAIL': '/var/mail/cltbld', 17:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:10 INFO - 'MOZ_NO_REMOTE': '1', 17:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:10 INFO - 'NO_EM_RESTART': '1', 17:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:10 INFO - 'PWD': '/builds/slave/test', 17:29:10 INFO - 'SHELL': '/bin/bash', 17:29:10 INFO - 'SHLVL': '1', 17:29:10 INFO - 'TERM': 'linux', 17:29:10 INFO - 'TMOUT': '86400', 17:29:10 INFO - 'USER': 'cltbld', 17:29:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:10 INFO - '_': '/tools/buildbot/bin/python'} 17:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:29:12 INFO - Installing collected packages: mozsystemmonitor 17:29:12 INFO - Running setup.py install for mozsystemmonitor 17:29:12 INFO - Successfully installed mozsystemmonitor 17:29:12 INFO - Cleaning up... 17:29:12 INFO - Return code: 0 17:29:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:12 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 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29:12 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 17:29:12 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 17:29:12 INFO - Using env: {'DISPLAY': ':0', 17:29:12 INFO - 'HOME': '/home/cltbld', 17:29:12 INFO - 'LANG': 'en_US.UTF-8', 17:29:12 INFO - 'LANGUAGE': 'en_US:en', 17:29:12 INFO - 'LOGNAME': 'cltbld', 17:29:12 INFO - 'MAIL': '/var/mail/cltbld', 17:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:12 INFO - 'MOZ_NO_REMOTE': '1', 17:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:12 INFO - 'NO_EM_RESTART': '1', 17:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:12 INFO - 'PWD': '/builds/slave/test', 17:29:12 INFO - 'SHELL': '/bin/bash', 17:29:12 INFO - 'SHLVL': '1', 17:29:12 INFO - 'TERM': 'linux', 17:29:12 INFO - 'TMOUT': '86400', 17:29:12 INFO - 'USER': 'cltbld', 17:29:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:12 INFO - '_': '/tools/buildbot/bin/python'} 17:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:29:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:29:14 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 17:29:14 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 17:29:14 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 17:29:14 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 17:29:14 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 17:29:14 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 17:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:15 INFO - Downloading docopt-0.6.1.tar.gz 17:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:29:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:29:15 INFO - Running setup.py install for blobuploader 17:29:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:29:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:29:15 INFO - Running setup.py install for requests 17:29:15 INFO - Running setup.py install for docopt 17:29:16 INFO - Successfully installed blobuploader requests docopt 17:29:16 INFO - Cleaning up... 17:29:16 INFO - Return code: 0 17:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:16 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 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29:16 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 17:29:16 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 17:29:16 INFO - Using env: {'DISPLAY': ':0', 17:29:16 INFO - 'HOME': '/home/cltbld', 17:29:16 INFO - 'LANG': 'en_US.UTF-8', 17:29:16 INFO - 'LANGUAGE': 'en_US:en', 17:29:16 INFO - 'LOGNAME': 'cltbld', 17:29:16 INFO - 'MAIL': '/var/mail/cltbld', 17:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:16 INFO - 'MOZ_NO_REMOTE': '1', 17:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:16 INFO - 'NO_EM_RESTART': '1', 17:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:16 INFO - 'PWD': '/builds/slave/test', 17:29:16 INFO - 'SHELL': '/bin/bash', 17:29:16 INFO - 'SHLVL': '1', 17:29:16 INFO - 'TERM': 'linux', 17:29:16 INFO - 'TMOUT': '86400', 17:29:16 INFO - 'USER': 'cltbld', 17:29:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:16 INFO - '_': '/tools/buildbot/bin/python'} 17:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:16 INFO - Running setup.py (path:/tmp/pip-c5BPy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:16 INFO - Running setup.py (path:/tmp/pip-ycjSFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:16 INFO - Running setup.py (path:/tmp/pip-h87Urp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:16 INFO - Running setup.py (path:/tmp/pip-d5SgNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:16 INFO - Running setup.py (path:/tmp/pip-yNZ_IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:16 INFO - Running setup.py (path:/tmp/pip-ZwWfJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:16 INFO - Running setup.py (path:/tmp/pip-Xrby5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:16 INFO - Running setup.py (path:/tmp/pip-w2XpvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:16 INFO - Running setup.py (path:/tmp/pip-JZxVna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:16 INFO - Running setup.py (path:/tmp/pip-pQktlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:17 INFO - Running setup.py (path:/tmp/pip-iIT2ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:17 INFO - Running setup.py (path:/tmp/pip-g67AOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:17 INFO - Running setup.py (path:/tmp/pip-CSdcPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:17 INFO - Running setup.py (path:/tmp/pip-Lq4Haw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:17 INFO - Running setup.py (path:/tmp/pip-n5yQy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:17 INFO - Running setup.py (path:/tmp/pip-F66Jv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:17 INFO - Running setup.py (path:/tmp/pip-dv9gup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:29:17 INFO - Running setup.py install for manifestparser 17:29:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:29:17 INFO - Running setup.py install for mozcrash 17:29:17 INFO - Running setup.py install for mozdebug 17:29:17 INFO - Running setup.py install for mozdevice 17:29:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:29:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:29:17 INFO - Running setup.py install for mozfile 17:29:18 INFO - Running setup.py install for mozhttpd 17:29:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for mozinfo 17:29:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for mozInstall 17:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for mozleak 17:29:18 INFO - Running setup.py install for mozlog 17:29:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for moznetwork 17:29:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for mozprocess 17:29:18 INFO - Running setup.py install for mozprofile 17:29:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:29:18 INFO - Running setup.py install for mozrunner 17:29:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:29:19 INFO - Running setup.py install for mozscreenshot 17:29:19 INFO - Running setup.py install for moztest 17:29:19 INFO - Running setup.py install for mozversion 17:29:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:29:19 INFO - Cleaning up... 17:29:19 INFO - Return code: 0 17:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:19 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 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29:19 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 17:29:19 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 17:29:19 INFO - Using env: {'DISPLAY': ':0', 17:29:19 INFO - 'HOME': '/home/cltbld', 17:29:19 INFO - 'LANG': 'en_US.UTF-8', 17:29:19 INFO - 'LANGUAGE': 'en_US:en', 17:29:19 INFO - 'LOGNAME': 'cltbld', 17:29:19 INFO - 'MAIL': '/var/mail/cltbld', 17:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:19 INFO - 'MOZ_NO_REMOTE': '1', 17:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:19 INFO - 'NO_EM_RESTART': '1', 17:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:19 INFO - 'PWD': '/builds/slave/test', 17:29:19 INFO - 'SHELL': '/bin/bash', 17:29:19 INFO - 'SHLVL': '1', 17:29:19 INFO - 'TERM': 'linux', 17:29:19 INFO - 'TMOUT': '86400', 17:29:19 INFO - 'USER': 'cltbld', 17:29:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:19 INFO - '_': '/tools/buildbot/bin/python'} 17:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:19 INFO - Running setup.py (path:/tmp/pip-3Wzqty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:19 INFO - Running setup.py (path:/tmp/pip-2fpkFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:19 INFO - Running setup.py (path:/tmp/pip-MXXBO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:19 INFO - Running setup.py (path:/tmp/pip-AKSE09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:19 INFO - Running setup.py (path:/tmp/pip-NFWNL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:19 INFO - Running setup.py (path:/tmp/pip-RcDvJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:19 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)) 17:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:19 INFO - Running setup.py (path:/tmp/pip-f8LC22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:20 INFO - Running setup.py (path:/tmp/pip-rPtfvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:20 INFO - Running setup.py (path:/tmp/pip-IdMHOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:20 INFO - Running setup.py (path:/tmp/pip-Oq7cUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:20 INFO - Running setup.py (path:/tmp/pip-_F5y0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:20 INFO - Running setup.py (path:/tmp/pip-RlQEe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:20 INFO - Running setup.py (path:/tmp/pip-1GUe4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:20 INFO - Running setup.py (path:/tmp/pip-lXKcQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:20 INFO - Running setup.py (path:/tmp/pip-_vpt_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:20 INFO - Running setup.py (path:/tmp/pip-rC931X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:20 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)) 17:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:20 INFO - Running setup.py (path:/tmp/pip-t4xWqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:20 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)) 17:29:20 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)) 17:29:20 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)) 17:29:20 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)) 17:29:20 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)) 17:29:20 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)) 17:29:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:22 INFO - Downloading blessings-1.6.tar.gz 17:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:29:22 INFO - Installing collected packages: blessings 17:29:22 INFO - Running setup.py install for blessings 17:29:22 INFO - Successfully installed blessings 17:29:22 INFO - Cleaning up... 17:29:22 INFO - Return code: 0 17:29:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:29:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:23 INFO - Reading from file tmpfile_stdout 17:29:23 INFO - Current package versions: 17:29:23 INFO - argparse == 1.2.1 17:29:23 INFO - blessings == 1.6 17:29:23 INFO - blobuploader == 1.2.4 17:29:23 INFO - docopt == 0.6.1 17:29:23 INFO - manifestparser == 1.1 17:29:23 INFO - mozInstall == 1.12 17:29:23 INFO - mozcrash == 0.17 17:29:23 INFO - mozdebug == 0.1 17:29:23 INFO - mozdevice == 0.48 17:29:23 INFO - mozfile == 1.2 17:29:23 INFO - mozhttpd == 0.7 17:29:23 INFO - mozinfo == 0.9 17:29:23 INFO - mozleak == 0.1 17:29:23 INFO - mozlog == 3.2 17:29:23 INFO - moznetwork == 0.27 17:29:23 INFO - mozprocess == 0.22 17:29:23 INFO - mozprofile == 0.28 17:29:23 INFO - mozrunner == 6.11 17:29:23 INFO - mozscreenshot == 0.1 17:29:23 INFO - mozsystemmonitor == 0.3 17:29:23 INFO - moztest == 0.7 17:29:23 INFO - mozversion == 1.4 17:29:23 INFO - psutil == 3.1.1 17:29:23 INFO - requests == 1.2.3 17:29:23 INFO - wsgiref == 0.1.2 17:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:23 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 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29:23 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 17:29:23 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 17:29:23 INFO - Using env: {'DISPLAY': ':0', 17:29:23 INFO - 'HOME': '/home/cltbld', 17:29:23 INFO - 'LANG': 'en_US.UTF-8', 17:29:23 INFO - 'LANGUAGE': 'en_US:en', 17:29:23 INFO - 'LOGNAME': 'cltbld', 17:29:23 INFO - 'MAIL': '/var/mail/cltbld', 17:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:23 INFO - 'MOZ_NO_REMOTE': '1', 17:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:23 INFO - 'NO_EM_RESTART': '1', 17:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:23 INFO - 'PWD': '/builds/slave/test', 17:29:23 INFO - 'SHELL': '/bin/bash', 17:29:23 INFO - 'SHLVL': '1', 17:29:23 INFO - 'TERM': 'linux', 17:29:23 INFO - 'TMOUT': '86400', 17:29:23 INFO - 'USER': 'cltbld', 17:29:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:23 INFO - '_': '/tools/buildbot/bin/python'} 17:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 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)) 17:29:23 INFO - Cleaning up... 17:29:23 INFO - Return code: 0 17:29:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29: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', 'jsonschema'] in /builds/slave/test/build 17:29: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 jsonschema 17:29:23 INFO - Using env: {'DISPLAY': ':0', 17:29:23 INFO - 'HOME': '/home/cltbld', 17:29:23 INFO - 'LANG': 'en_US.UTF-8', 17:29:23 INFO - 'LANGUAGE': 'en_US:en', 17:29:23 INFO - 'LOGNAME': 'cltbld', 17:29:23 INFO - 'MAIL': '/var/mail/cltbld', 17:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:23 INFO - 'MOZ_NO_REMOTE': '1', 17:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:23 INFO - 'NO_EM_RESTART': '1', 17:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:23 INFO - 'PWD': '/builds/slave/test', 17:29:23 INFO - 'SHELL': '/bin/bash', 17:29:23 INFO - 'SHLVL': '1', 17:29:23 INFO - 'TERM': 'linux', 17:29:23 INFO - 'TMOUT': '86400', 17:29:23 INFO - 'USER': 'cltbld', 17:29:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:23 INFO - '_': '/tools/buildbot/bin/python'} 17:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:23 INFO - Downloading/unpacking jsonschema 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:29:25 INFO - Downloading/unpacking functools32 (from jsonschema) 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29: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 17:29:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:29:25 INFO - warning: no files found matching '*.txt' 17:29:25 INFO - no previously-included directories found matching 'build' 17:29:25 INFO - no previously-included directories found matching 'dist' 17:29:25 INFO - no previously-included directories found matching '.git*' 17:29:25 INFO - Installing collected packages: jsonschema, functools32 17:29:25 INFO - Running setup.py install for functools32 17:29:25 INFO - warning: no files found matching '*.txt' 17:29:25 INFO - no previously-included directories found matching 'build' 17:29:25 INFO - no previously-included directories found matching 'dist' 17:29:25 INFO - no previously-included directories found matching '.git*' 17:29:25 INFO - Successfully installed jsonschema functools32 17:29:25 INFO - Cleaning up... 17:29:25 INFO - Return code: 0 17:29:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:29:25 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')]} 17:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:25 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')]} 17:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:25 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 0x7f3d8d54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c38770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', '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 17:29:25 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 17:29:25 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 17:29:25 INFO - Using env: {'DISPLAY': ':0', 17:29:25 INFO - 'HOME': '/home/cltbld', 17:29:25 INFO - 'LANG': 'en_US.UTF-8', 17:29:25 INFO - 'LANGUAGE': 'en_US:en', 17:29:25 INFO - 'LOGNAME': 'cltbld', 17:29:25 INFO - 'MAIL': '/var/mail/cltbld', 17:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:25 INFO - 'MOZ_NO_REMOTE': '1', 17:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:25 INFO - 'NO_EM_RESTART': '1', 17:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:25 INFO - 'PWD': '/builds/slave/test', 17:29:25 INFO - 'SHELL': '/bin/bash', 17:29:25 INFO - 'SHLVL': '1', 17:29:25 INFO - 'TERM': 'linux', 17:29:25 INFO - 'TMOUT': '86400', 17:29:25 INFO - 'USER': 'cltbld', 17:29:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:25 INFO - '_': '/tools/buildbot/bin/python'} 17:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:26 INFO - Downloading/unpacking flake8 17:29:26 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 17:29:26 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 17:29:26 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 17:29:26 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 17:29:26 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 17:29:26 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 17:29:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:29:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:29:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:29:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:29:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:29:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:29:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:29:28 INFO - no previously-included directories found matching 'docs/_build' 17:29:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:29:28 INFO - Running setup.py install for pep8 17:29:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:29:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:29:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:29:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:29:28 INFO - no previously-included directories found matching 'docs/_build' 17:29:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:29:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:29:28 INFO - Cleaning up... 17:29:28 INFO - Return code: 0 17:29:28 INFO - Running post-action listener: _resource_record_post_action 17:29:28 INFO - Running post-action listener: _start_resource_monitoring 17:29:28 INFO - Starting resource monitoring. 17:29:28 INFO - ##### 17:29:28 INFO - ##### Finished create-virtualenv step (success) 17:29:28 INFO - ##### 17:29:28 INFO - ##### 17:29:28 INFO - ##### Running install step. 17:29:28 INFO - ##### 17:29:28 INFO - Running pre-action listener: _resource_record_pre_action 17:29:28 INFO - Running main action method: install 17:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:29 INFO - Reading from file tmpfile_stdout 17:29:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:29:29 INFO - Reading from file tmpfile_stdout 17:29:29 INFO - Output received: 17:29:29 INFO - Usage: mozinstall [options] installer 17:29:29 INFO - Options: 17:29:29 INFO - -h, --help show this help message and exit 17:29:29 INFO - -d DEST, --destination=DEST 17:29:29 INFO - Directory to install application into. [default: 17:29:29 INFO - "/builds/slave/test"] 17:29:29 INFO - --app=APP Application being installed. [default: firefox] 17:29:29 INFO - mkdir: /builds/slave/test/build/application 17:29:29 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'] 17:29:29 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 17:29:45 INFO - Reading from file tmpfile_stdout 17:29:45 INFO - Output received: 17:29:45 INFO - /builds/slave/test/build/application/firefox/firefox 17:29:45 INFO - Running post-action listener: _resource_record_post_action 17:29:45 INFO - ##### 17:29:45 INFO - ##### Finished install step (success) 17:29:45 INFO - ##### 17:29:45 INFO - ##### 17:29:45 INFO - ##### Running run-tests step. 17:29:45 INFO - ##### 17:29:45 INFO - Running pre-action listener: _resource_record_pre_action 17:29:45 INFO - Running main action method: run_tests 17:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:45 INFO - Python 2.7.3 17:29:45 INFO - Return code: 0 17:29:45 INFO - grabbing minidump binary from tooltool 17:29:45 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')]} 17:29:45 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc79c0>, '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 0x1cc88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29:45 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 17:29:45 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 17:29:45 INFO - Calling ['/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'] with output_timeout 600 17:29:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:45 INFO - Return code: 0 17:29:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:29:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:29:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:29:46 INFO - Return code: 0 17:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:29:46 INFO - Using env: {'DISPLAY': ':0', 17:29:46 INFO - 'HOME': '/home/cltbld', 17:29:46 INFO - 'LANG': 'en_US.UTF-8', 17:29:46 INFO - 'LANGUAGE': 'en_US:en', 17:29:46 INFO - 'LOGNAME': 'cltbld', 17:29:46 INFO - 'MAIL': '/var/mail/cltbld', 17:29:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:46 INFO - 'MOZ_NO_REMOTE': '1', 17:29:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:46 INFO - 'NO_EM_RESTART': '1', 17:29:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:46 INFO - 'PWD': '/builds/slave/test', 17:29:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:46 INFO - 'SHELL': '/bin/bash', 17:29:46 INFO - 'SHLVL': '1', 17:29:46 INFO - 'TERM': 'linux', 17:29:46 INFO - 'TMOUT': '86400', 17:29:46 INFO - 'USER': 'cltbld', 17:29:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043', 17:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:46 INFO - '_': '/tools/buildbot/bin/python'} 17:29:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:29:47 INFO - mozversion application_buildid: 20160524143019 17:29:47 INFO - mozversion application_changeset: ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 17:29:47 INFO - mozversion application_display_name: Nightly 17:29:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:47 INFO - mozversion application_name: Firefox 17:29:47 INFO - mozversion application_remotingname: firefox 17:29:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:29:47 INFO - mozversion application_vendor: Mozilla 17:29:47 INFO - mozversion application_version: 49.0a1 17:29:47 INFO - mozversion platform_buildid: 20160524143019 17:29:47 INFO - mozversion platform_changeset: ce6147a6f839a8efbf1770ecc0ea08c7c562cf63 17:29:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:29:47 INFO - mozversion platform_version: 49.0a1 17:29:47 INFO - using testdate: 1464136187 17:29:47 INFO - actual date: 1464136187 17:29:47 INFO - starting webserver on 'localhost:34927' 17:29:47 INFO - SUITE-START | Running 2 tests 17:29:47 INFO - TEST-START | dromaeo_css 17:29:47 INFO - operating with platform_type : linux_ 17:29:47 INFO - Initialising browser for dromaeo_css test... 17:29:47 INFO - TEST-INFO | started process 24142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz2qLe/profile http://localhost:34927/getInfo.html) 17:29:50 INFO - PROCESS | 24142 | __metrics Screen width/height:1600/1200 17:29:50 INFO - PROCESS | 24142 | colorDepth:24 17:29:50 INFO - PROCESS | 24142 | Browser inner width/height: 1024/697 17:29:50 INFO - PROCESS | 24142 | __metrics 17:29:51 ERROR - PROCESS | 24142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:29:52 INFO - TEST-INFO | 24142: exit 0 17:29:52 INFO - Browser initialized. 17:29:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:52 INFO - TEST-INFO | started process 24221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz2qLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:04 INFO - PROCESS | 24221 | RSS: Main: 153128960 17:30:04 INFO - PROCESS | 24221 | 17:30:55 INFO - PROCESS | 24221 | 1464136255553 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] 17:33:03 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34927/tests/dromaeo/cssquery-ext.html) 17:33:04 INFO - PROCESS | 24221 | RSS: Main: 261005312 17:33:04 INFO - PROCESS | 24221 | 17:36:06 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-ext.html (next: http://localhost:34927/tests/dromaeo/cssquery-jquery.html) 17:36:07 INFO - PROCESS | 24221 | RSS: Main: 242008064 17:36:07 INFO - PROCESS | 24221 | 17:39:09 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34927/tests/dromaeo/cssquery-mootools.html) 17:39:09 INFO - PROCESS | 24221 | RSS: Main: 242278400 17:39:09 INFO - PROCESS | 24221 | 17:42:11 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34927/tests/dromaeo/cssquery-prototype.html) 17:42:12 INFO - PROCESS | 24221 | RSS: Main: 236793856 17:42:12 INFO - PROCESS | 24221 | 17:45:15 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34927/tests/dromaeo/cssquery-yui.html) 17:45:15 INFO - PROCESS | 24221 | RSS: Main: 220127232 17:45:15 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | Cycle 1(1): loaded http://localhost:34927/tests/dromaeo/cssquery-yui.html (next: http://localhost:34927/tests/dromaeo/cssquery-dojo.html) 17:48:18 INFO - PROCESS | 24221 | RSS: Main: 283529216 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | __start_tp_report 17:48:18 INFO - PROCESS | 24221 | _x_x_mozilla_page_load 17:48:18 INFO - PROCESS | 24221 | _x_x_mozilla_page_load_details 17:48:18 INFO - PROCESS | 24221 | |i|pagename|runs| 17:48:18 INFO - PROCESS | 24221 | |0;dojo.html;3111.2221944513885;3137.0432018234437;3156.873725050998;3180.2526406294533;3186.060112266881;5324.54741346986;5378.273933019042;5413.756380962856;5488.1493368527845;5497.312835895513;5269.972355390701;5278.181881808326;5302.390225124112;5359.892802143955;5438.755256013479;4758.881027974302;4815.325854380372;4900.9754951225195;5023.623228257877;5052.646314757969;4951.084049450845;4960.206366981283;4987.750612469362;5011.624128190382;5017;4784.258439941815;4798.664093513456;4860.611151107921;4866.683665561727;4882.218844984785;4922.630802689777;4946.060248552763;4952.683119072901;4962.206047032458;4984.750762461898;4771.6898401603785;4874.707517548923;4910.1898186799135;4911.214205727067;4964.776585053682;5280.894382112375;5347.866303342409;5351.25082488452;5413.485718856702;5420.214068959979;5834.5040671542965;5836.6789826559525;5841.561882858802;5865.736041878083;5874.383189765099;5701.828945131652;5727.971360143172;5770.163326317703;5845.88308233833;5858.736356863908;5453.945460545344;5486.341639003345;5496.0931446311315;5507.917381239285;5508.862278443031;6012.518998480198;6014.188084608521;6014.729337179838;6018.6990650467305;6031.336552979169;5533.335999679984;5594.804181853697;5647.745851436695;5670.347909990404;5752.7698892043845;5782;5818.592698511064;5826.359100498942;5832.679202643895;5839.824805255849;5771.249737534094;5771.509421699118;5773.653580785166;5780.624259423208;5781.624194427349;5636.549076073904;5652.85867853307;5754.856128596819;5778.855528611818;5818.44724751148;4419;4419.845305414295;4419.955800442019;4423.336499525032;4463.910721785546;3840.2127563849344;3943.664788492953;3944.526656801202;3966.1076257841755;3967.1668949520345;5418.268533747893;5527.55779537636;5542.97228513863;5550.084236101079;5567.721613919369;5888.440598143169;5891.204687367236;5898.14476900847;5900.321463031806;5944.346121926585;5396.64921780083;5438.8912221755345;5558.471945165203;5560.054790685593;5574.665520068809;4996.625253106032;5005.72468514228;5007.098722229961;5010.2735103409805;5047.646664733434;6016.217891674054;6032.698365081728;6033.155358249848;6033.185519954838;6033.637981721111;5684.204211410323;5780.653160810197;5823.941760582509;5866.501347385435;5868.94131058684;6056.0915862619195;6057.121717351048;6059.484943779652;6066.423689749467;6105.389461053859;5713.22871412354;5736.4550367715;5753.568482363923;5754.424557544212;5761.049426844524;5638.37977822431;5751.568632352507;5787.5369970401425;5824.068149096293;5870.9412905872105;5697.401772813795;5704.258446402107;5707.6290041147195;5712.314522257356;5712.828615141552;5644.689542075225;5680.602357835077;5700.173474846207;5701.087825947829;5701.173329867063;5418.83743487696;5517.751701173537;5522.944770552243;5578.107502799695;5605.691686957257;5699.5725320600295;5710.914336284876;5752.511036561939;5767.106098554731;5781.624194427349;5438.483344082306;5502.394736578893;5548.306461692288;5569.972150139223;5591.217229587943 17:48:18 INFO - PROCESS | 24221 | |1;ext.html;567.3248833887674;614.9446549810517;636.1793286660205;650.6681592387881;650.873079749449;31013.379732405338;31559;34187.31625367497;34319.82840085802;42883;45136.77431612845;45676.543234567645;45811;45889.54110458894;45957.54042459575;8676.262517686004;8829.161229683203;8876.023637399881;8878.334124940655;8880.24517915978;8580.785480363009;8723.38936274461;8724.258438032775;8726.563671816384;8735.781605459882;8744.387892847502;8769.868451973225;8773.210411063003;8780.385373023892;8790.340724445692;8677.349198810114;8733.650653973833;8746.781330466725;8765.035846056928;8765.298776097961;8641.092685268082;8717.607707653171;8732.607032683482;8736.825263494758;8742.737717868475;41650;42128.578714212774;42177;42184.57815421837;42200.36699449511;3561.127523756696;3613.6205698401554;3885.9896426929204;4056.2293164298985;4215.620594146541;32127;32264.35471290561;32464.350712985844;32767.18082047944;34378;4246.426732391149;4292.29177185764;4409.338599210112;4421.801018954155;4453.732776033448;337984;338280;339630;340531;340864;57216.141757873665;58464;58567.414325856196;58576.707116465;58604.7069764657;60742.392576074555;60930.211629895086;61080.38919610836;61137.38862611406;61174.082388764204;14401.567952961428;14607.123572585679;14621.78067328991;14630.926845365919;14633.487827926185;10575.682729518127;10621.5220315086;10650.680479585624;10681.946590267155;10696.732581685521;14635.853641463662;16809.6638067238;16833;16868;16890.071046092336;5828.184054232411;5890.410958904075;5981;6013.579049466495;6115.969420152871;1029.264076185531;1167.6146871532374;1180.2387460088196;1184.1829137894824;1188.2751521571834;31778;31980.520292195637;32054;32253.677463225536;32529.51205731916;954.7517645412242;1098.0995583621514;1136.6078702847503;1206.927584344942;1250.0999280518013;16508;16580;16631.750523742154;16657.497856480688;16837.242324095445;486749;488472;489423;491869;494664;57036.71481642648;57146.14280785791;57169;57218.7139064302;57336.71331643315;1262.6275248801626;1352.2089577597217;1369.8835598974;1382.2328607622867;1399.0626280392162;29888;33736;33796.49305260374;34126.488102677984;34547.481787772704;51333.89328853608;52106.478935210165;52149;52200.47799521956;52221.21668174904;447547;454096;455172;455728;671765;43552;44317;44841.32738008998;47599.28601071056;48667.513324867716;48744.2688359682;48753.512464876316;48792;49124.508754913426;50429.74785126051;40772;41030.79484602558;41225;42151.57848421476;43056.56943430525;40501.39247911225;41041.79479102585;41156.50169735606;41612.79193604013;42208.36687449752;40645.187096257316;41107.58892411038;42168.15663686648;42260.36609450799;42296;36337.27325453423;37154.8142259287;37250.254994899406;37953.2409351817;38176.23647526978;28032.439351212455;28640.713592863805;28681.697745338366;28736.712632873405;28967.710322896502 17:48:18 INFO - PROCESS | 24221 | |2;jquery.html;394.2824060210415;396.36185740957063;397.70172370721957;399.5305516018678;419.45680343954575;17819.198136083876;19031.42905712831;19440.02799860005;19505.12226949787;20479.488012799688;17545.91227043866;18464.261429542803;18502.72245916309;19375.70936435951;19775;5043.268726034741;5127.564157046646;5254.21186821976;5275.788968441258;5278.1291086970605;5111.488851114896;5164.354455693038;5164.535191832734;5187.740612969355;5202.947970520303;4892.168331383673;5062.26597143414;5071.492850714936;5190.818321358754;5194.480551944813;4996.9500304996845;5001.599872010267;5034.119029169918;5041.369828771403;5052.545270925616;4784.6889952153;4922.433920099199;4927.679700819471;5079.415867175285;5096.184610462308;12861.485540578366;12993;13178.670533236746;13340.933295333558;13410.46358145673;2169.8372622053253;2255.379770563108;2325.1513197682893;2329.6854924585305;2414.360194548446;9130.358792539499;9419.576119074658;9491.952540237324;9594.904050959542;9854.704358869174;1897.8576606754548;1915.9712604310946;1928.6364699384426;1935.2742721479444;1960.235508151822;57555.71222143904;62363;67676.66161669209;74596.62701686457;78631.606841966;10059;10916.181286403551;10957.232993690524;11072.280301780358;11114.166437517219;15030;15400.767938564888;15425.305861236271;15425.537233883002;15466.144062712321;6487.545871789024;7133.821654458577;7492.325690687864;7565;7566.31903128721;6153.507719382439;6282.780102696383;6645.501587380869;6988.6855091521;7027.402670772939;4642.814287428465;4678.719276843401;4691.976540117277;4759.690620109682;4772.832950846704;1964.88210707358;1968.2914150905663;2000.7699114602008;2006.3278801601334;2057.1668474267944;864.6930339729305;971.6502059258661;976.8681228034125;1029.1869423155624;1075.5106426576046;17609.207585658674;19006.524836879187;19053.618927621646;19364.70952935707;19666.410007699793;957.2246480350938;962.6871266838166;1017.1405162637559;1041.7031146123318;1056.5404049238605;10368.481575921174;10936.671899843017;10966.122710183166;10977.28647637901;11033.558657653764;446883;449434;462169;462679;477144;80694.59652701698;85575;99075.50462247642;99606.50196749115;101421.49289253507;952.5046975572664;1016.4307987527009;1077.1060020183386;1081.1242893256488;1086.6414083352474;17514.562135946704;17765.289388424317;18151.636967260845;18157.762033860945;18342.449726508225;42544.57455425406;42843;42877;43015;43718.469853554976;54437;57513;57947;58507;61169.38830611637;8331.708390206313;8529.91470085316;8545.871811922701;8665.350098742494;8699.56502174876;12612.684682883002;13328.067430222758;13394.397252123872;13505.189688618715;13727.862721372658;11970.76058478843;11973.401329933295;12023;12435.813462797883;12453.315067671365;11712.648620541397;11774.411279435823;11849.822252666045;12152.270863748203;12242.75514489723;12359.876401235873;12377.876221238033;12395.690107747378;12509.311987840756;12614.432350544064;8676.956615216883;8692.087330830173;8734.213920747163;8808.075152108937;8932.910670893469;11723.472443739882;11797.35114568707;11806.232594881305;12063.638090857288;12353.258804471761 17:48:18 INFO - PROCESS | 24221 | |3;mootools.html;1389.235920243867;1508.5851390867513;1540.214490609789;1696.7624532565444;1828.0676854804053;8325.41722079454;8680.392372533917;8687.565621718912;8929.464232146076;8949.776255593613;8509.574521273942;8719.912800871989;8728.563571821414;8734.825303493926;8735.995360533541;2065.2461851424196;2275.7382900966395;2278.9544209115807;2311.9422014449688;2354.540864531417;2249.898754556049;2258.6499092640665;2263.852849564773;2265.229821860567;2265.4676151104477;2208.1167532986774;2276.521930394611;2277.2826559633745;2280.1677387753434;2282.691836602054;2003.559216972271;2247.5841969235744;2318.675385446039;2321.9071237150492;2337.6844126043106;2176.5646870625937;2182.225310014938;2196.9890150549145;2197.637389830676;2232.05137816429;8669.69656062041;8706;8716.607752651145;8718.694845680435;8720.040795512488;5020.0963826511215;5144.948550514522;5144.996725638502;5160.7419629018395;5164.92252616211;3297.8186199759;3354.077628652116;3359.2945481448924;3551.254236610315;3561.3767590671528;1110.783397237539;1129.24904938216;1138.5844166879112;1143.2054721968236;1145.4444594371723;12094.455749491293;12131.696707582292;12148.3318417487;12156.574519891761;12156.696082597917;4331.263685173528;4399.36209249657;4464.196444639996;4487.685861989695;4508.706934049276;10194.082532572103;10221.540030698636;10226.795464090677;10230.795384092276;10235.846462303072;4661;5084.51697088776;5088.262201980766;5089.491050894955;5092.236164575269;4652.674312798072;4782.163121453732;4783.234682450791;4820.855374338776;4821.373221481185;3882.7476214045996;3982.482277303932;4010.598940105966;4038.8384464621085;4085.305498065336;1230.563150081726;1269.7143142792797;1291;1298.7662220800157;1311.0756916373934;823.7569916874536;850.9787255318543;887.1572006593633;944.3248077624531;1012.7417508535276;5935.52515798735;6177.505799536027;6202.503799696014;6260.373962603703;6294.402031806971;454.3003774187714;463.1547425947659;466.40766226891657;482.2645465664889;483.28473858689335;4249.87250382489;4289.721168124124;4472.463304403493;4574.039451715177;4602.378678878308;10943.726406839893;11060.944695276472;11162.665120046411;11164.832527512093;11165.83251251232;10850.565977360817;11086.279391839505;11292.548298067984;11358.716032099099;11397.943010285062;8213.589320534069;8231.46495477792;8267.214614611603;8333.916660833314;8412.915870841336;6193.163922870535;6243.562950593415;6261.96869015652;6287.591306565058;6380.074889140956;10314.896851031393;10342.896571034193;10446.843297350393;10447.84328235062;10457.738556536147;9750.75623109428;10184.949075254577;10199.490025498548;10465.319754215952;10506.474676266309;7089.822754430974;7461.552306861606;7737.883931741141;7836.608169591384;8063.27430531255;8588.355873309652;8656;8722.91277087221;8725.476471411735;8732.170443807829;7730.188330225245;7801.4929029612895;7888.211178882296;8021.077576078592;8087.47431416956;7527.322540971339;7571.621418929141;7690.538567685957;7786.33816125613;7848.215178482106;7077.221505634273;7154.034205382207;7155.248698886542;7158.212596614472;7168.713251469882;5075.187969924942;5240;5372.865678358073;5419.184573168033;5460.481254280837;5332.893342133058;5411.648242864201;5496.917546236889;5603.131514615078;5636.887262254814 17:48:18 INFO - PROCESS | 24221 | |4;prototype.html;324.539154400751;331.43986662540306;333.21860237742493;339.3586122228986;340.10891464363374;5194.610404219679;5211.921821172681;5223.686578805275;5248.448912864147;5261.184516399954;5066.797328106881;5158.406783219922;5162.122439185338;5174.793008279674;5182.792688292464;3887.3197190491624;3929.7052721045893;4048.7570745755347;4071.7760523171214;4116.58834116589;3999.300122478569;4053.371727382246;4054.4729185205883;4059.2084543514025;4065.125997910449;4015.1969606078756;4021.7989100544855;4022.074922767765;4035.737677050997;4039.9596004039877;3847.365184744514;3888.747231429962;4004.939925901114;4018.2365350583295;4041.4746083009313;3512.4028915084496;3546.219831637036;3553.9111522211892;3556.8399422025814;3568.750187486877;4981.775820088104;5018.64869459138;5021.49785021495;5034.949650503521;5047.596192304607;4402.2296098183015;4570;4579.3131030345385;4597.54024597541;4614.630829533629;5215.348081489814;5314.4951229633125;5339.332583427072;5371.113766228567;5392.73036348181;3899.629535194152;3904.492415985932;3905.2189562087697;3906.3945088511327;3916.295066887959;5326.227696983954;5568.693721845297;5590.161475778625;5631.8592035199035;5660.518855897212;3979.880603581897;3986.940195897064;3991.6071339361893;3998.580149084304;4003.979980100081;4044.4337792709043;4049.190161967618;4052.979735101306;4055.9594404055583;4060.3706425504092;4512.571305725951;4629.907401851944;4631.861044168681;4647.279671650899;4652.1626107300335;5336.519713225828;5412.83761487156;5440.319960004999;5441.510264076173;5460.535854452337;1356.3353956561411;1388.5348408283137;1389.5136702154166;1395.0165133580801;1405.6626409661608;903.1600611431431;904.4482865452069;914.2503147419053;919.5678031325266;946.1153821177221;5190.506901844319;5241.820590367213;5260.526552610283;5268.6575372600655;5278.947210527922;5489.3687225969525;5535.142052981794;5548.833534993957;5549;5556.138798486241;5105.463926287686;5181.740912954338;5259.973700131475;5312.256284120226;5320.228566857784;2854.4148449568206;2900.9854950725535;2929.29696872749;2932.765378769693;2942.8822847086303;5472.495063857471;5675;5702.515286200636;5711.543076553866;5713.942860571424;5461.225101841917;5560.8878224354485;5561.416051314634;5639.928413601403;5649.858753531113;5656.038473459604;5667.971660141673;5679.602427830095;5695.743691533891;5713.600047996683;5366.436524164907;5428.112433770031;5500.73692887999;5519.503244707996;5545.694986775605;5441.183822426668;5463.726813659222;5465.207544906046;5481.342238931354;5492.512254718203;5596.944030559643;5615.354234262949;5651.858703532444;5668.2064510967675;5688.573356998324;3796.4684944107294;3990.6408423242046;4044.7775372354804;4056.756594604215;4063.309237429703;5607.663540187602;5628.324601047901;5671.829845104653;5674.205611214516;5675.943240567542;5524.447555244444;5526.364468086061;5539.750711217925;5545.0018996581;5545.611807173459;5282.9471705283995;5409.594280428905;5447.428020057995;5487.396386397413;5490.835274941758;5199.194124910645;5224.928889577552;5394.487523685244;5415.106507426231;5417.566594672496;5477.698726570077;5496.433516447793;5497.862553436036;5542.556595472433;5581.972090139523;5347.946520534745;5354.651947623392;5376.301080859464;5380.3274590676165;5422.8644283891645 17:48:18 INFO - PROCESS | 24221 | |5;yui.html;721.7618185998621;740.4409670698622;754.475639430596;815.2499700275746;861.4013260783754;13683.863161368383;14419.711605767878;14502.854971450282;14546.199959002264;14782.334794934226;14503;14539.273036348166;14543.563693089198;14560.708785824278;14642.707145857077;690.3924546399162;829.5727700234385;834.6995081770558;837.5728378526934;837.9706710265142;807.6325272001254;832.546262287052;833.7748807821885;834.4200780457554;834.5576844272546;862.8791969124328;863.1325517854578;863.7322430046705;864.5893200729666;865.0916537635458;706.0750416953807;841.5623875584662;861.0528418739368;861.2291998661194;864.9221570058694;639.9456046236076;640.4044238857861;641.1696852575878;641.1728869758007;641.5733537197758;13236.735265294736;13239.536616218385;13254.602361929157;13328.933355333258;13330;13202.471901123943;13673.931630341884;13814;13853.653658658613;14045.367958441793;12030.63908082759;12045.518179272818;12135.757284854342;12406.317652529107;12446.937765311206;4309.849155279581;4383.9342409863875;4419.933700994456;4446.466424029137;4446.9777651111535;59101.40898591002;59229.703851480896;59395.703021484616;62211.688941555454;64075.35924640787;11239.719007024727;11328.2070255083;11398.632164140356;11476;11595.884041159481;19815.10832012563;19822.405327840188;19823;19896.60206795885;19973.300934467225;7771.6891324347525;7855.6464959076975;7926.564038977796;8021;8126.471779334324;4353.1293741251875;4374.825006999748;4387.451568553931;4395.428594282723;4547.909041819145;3355.8489867955514;3456.3778519866164;3456.861725531001;3458.152752575635;3461.273132642123;619.7490016543308;628.3025841316136;628.3182746719768;632.424493710721;633.9112524246609;567.20307967306;577.8287885384137;616.1712496691943;662.4226594233821;682.6552590941543;8512.191341822518;9129.680461183827;9201.21789647874;9254.583543740548;9346.299027572959;575.122937520285;605.5307136968885;616.6762449713937;644.4416904201264;668.0647094068344;4016.3172260715746;4052.7163098583405;4219.346001369792;4298.699091063596;4333.609975102256;56432.153517696446;57869.710651446476;58999.41000590025;64888.675556621914;65146.34853651403;56198;56296;57102.143467848015;57250.42749572451;57675.71162144246;50719.49280507147;51421.22868156981;52382.47617523776;52402;53334.46665533372;9362.485063321583;9374.343795934492;9495.097965693249;9886.950565247127;9914.553845077133;35396.82301588476;35705.46441803427;35983.460248096824;36248.81875590605;37115.07212319713;43199.35200971925;45235.54764452313;46584;47161;49014.50985490099;12450.875491244971;12534.498620055461;12557.811632825333;12640.620781376574;12839.037072219808;13270;13348.332583370986;13802.585922422344;14046.1572305662;14293.499727509487;12459.688507787378;12470.750584988431;12545.12184147101;13887.375068121757;14330;12485.56300529477;12505.93747031259;12630.747385052431;12941.482340706267;13119.672008199872;11766.470508826953;12241.938790306347;12661.303628300164;12759.298238596595;13050.516050788157;10938.398388088413;10949.507272172612;11061.668149955514;11260.38067906273;11348.659540213477;11073.224874259047;11205.271657342246;11298.322100673986;11416.486258118239;11467.369294688871 17:48:18 INFO - PROCESS | 24221 | __end_tp_report 17:48:18 INFO - PROCESS | 24221 | __start_cc_report 17:48:18 INFO - PROCESS | 24221 | _x_x_mozilla_cycle_collect,923 17:48:18 INFO - PROCESS | 24221 | __end_cc_report 17:48:18 INFO - PROCESS | 24221 | __startTimestamp1464137298445__endTimestamp 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | ------- Summary: start ------- 17:48:18 INFO - PROCESS | 24221 | Number of tests: 6 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#0] dojo.html Cycles:165 Average:5389.93 Median:5574.67 stddev:621.16 (11.1%) stddev-sans-first:596.79 17:48:18 INFO - PROCESS | 24221 | Values: 3111.2 3137.0 3156.9 3180.3 3186.1 5324.5 5378.3 5413.8 5488.1 5497.3 5270.0 5278.2 5302.4 5359.9 5438.8 4758.9 4815.3 4901.0 5023.6 5052.6 4951.1 4960.2 4987.8 5011.6 5017.0 4784.3 4798.7 4860.6 4866.7 4882.2 4922.6 4946.1 4952.7 4962.2 4984.8 4771.7 4874.7 4910.2 4911.2 4964.8 5280.9 5347.9 5351.3 5413.5 5420.2 5834.5 5836.7 5841.6 5865.7 5874.4 5701.8 5728.0 5770.2 5845.9 5858.7 5453.9 5486.3 5496.1 5507.9 5508.9 6012.5 6014.2 6014.7 6018.7 6031.3 5533.3 5594.8 5647.7 5670.3 5752.8 5782.0 5818.6 5826.4 5832.7 5839.8 5771.2 5771.5 5773.7 5780.6 5781.6 5636.5 5652.9 5754.9 5778.9 5818.4 4419.0 4419.8 4420.0 4423.3 4463.9 3840.2 3943.7 3944.5 3966.1 3967.2 5418.3 5527.6 5543.0 5550.1 5567.7 5888.4 5891.2 5898.1 5900.3 5944.3 5396.6 5438.9 5558.5 5560.1 5574.7 4996.6 5005.7 5007.1 5010.3 5047.6 6016.2 6032.7 6033.2 6033.2 6033.6 5684.2 5780.7 5823.9 5866.5 5868.9 6056.1 6057.1 6059.5 6066.4 6105.4 5713.2 5736.5 5753.6 5754.4 5761.0 5638.4 5751.6 5787.5 5824.1 5870.9 5697.4 5704.3 5707.6 5712.3 5712.8 5644.7 5680.6 5700.2 5701.1 5701.2 5418.8 5517.8 5522.9 5578.1 5605.7 5699.6 5710.9 5752.5 5767.1 5781.6 5438.5 5502.4 5548.3 5570.0 5591.2 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#1] ext.html Cycles:180 Average:60605.70 Median:42278.18 stddev:119649.22 (283.0%) stddev-sans-first:119899.95 17:48:18 INFO - PROCESS | 24221 | Values: 567.3 614.9 636.2 650.7 650.9 31013.4 31559.0 34187.3 34319.8 42883.0 45136.8 45676.5 45811.0 45889.5 45957.5 8676.3 8829.2 8876.0 8878.3 8880.2 8580.8 8723.4 8724.3 8726.6 8735.8 8744.4 8769.9 8773.2 8780.4 8790.3 8677.3 8733.7 8746.8 8765.0 8765.3 8641.1 8717.6 8732.6 8736.8 8742.7 41650.0 42128.6 42177.0 42184.6 42200.4 3561.1 3613.6 3886.0 4056.2 4215.6 32127.0 32264.4 32464.4 32767.2 34378.0 4246.4 4292.3 4409.3 4421.8 4453.7 337984.0 338280.0 339630.0 340531.0 340864.0 57216.1 58464.0 58567.4 58576.7 58604.7 60742.4 60930.2 61080.4 61137.4 61174.1 14401.6 14607.1 14621.8 14630.9 14633.5 10575.7 10621.5 10650.7 10681.9 10696.7 14635.9 16809.7 16833.0 16868.0 16890.1 5828.2 5890.4 5981.0 6013.6 6116.0 1029.3 1167.6 1180.2 1184.2 1188.3 31778.0 31980.5 32054.0 32253.7 32529.5 954.8 1098.1 1136.6 1206.9 1250.1 16508.0 16580.0 16631.8 16657.5 16837.2 486749.0 488472.0 489423.0 491869.0 494664.0 57036.7 57146.1 57169.0 57218.7 57336.7 1262.6 1352.2 1369.9 1382.2 1399.1 29888.0 33736.0 33796.5 34126.5 34547.5 51333.9 52106.5 52149.0 52200.5 52221.2 447547.0 454096.0 455172.0 455728.0 671765.0 43552.0 44317.0 44841.3 47599.3 48667.5 48744.3 48753.5 48792.0 49124.5 50429.7 40772.0 41030.8 41225.0 42151.6 43056.6 40501.4 41041.8 41156.5 41612.8 42208.4 40645.2 41107.6 42168.2 42260.4 42296.0 36337.3 37154.8 37250.3 37953.2 38176.2 28032.4 28640.7 28681.7 28736.7 28967.7 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#2] jquery.html Cycles:180 Average:27484.44 Median:395.32 stddev:75896.69 (19198.7%) stddev-sans-first:76082.34 17:48:18 INFO - PROCESS | 24221 | Values: 394.3 396.4 397.7 399.5 419.5 17819.2 19031.4 19440.0 19505.1 20479.5 17545.9 18464.3 18502.7 19375.7 19775.0 5043.3 5127.6 5254.2 5275.8 5278.1 5111.5 5164.4 5164.5 5187.7 5202.9 4892.2 5062.3 5071.5 5190.8 5194.5 4997.0 5001.6 5034.1 5041.4 5052.5 4784.7 4922.4 4927.7 5079.4 5096.2 12861.5 12993.0 13178.7 13340.9 13410.5 2169.8 2255.4 2325.2 2329.7 2414.4 9130.4 9419.6 9492.0 9594.9 9854.7 1897.9 1916.0 1928.6 1935.3 1960.2 57555.7 62363.0 67676.7 74596.6 78631.6 10059.0 10916.2 10957.2 11072.3 11114.2 15030.0 15400.8 15425.3 15425.5 15466.1 6487.5 7133.8 7492.3 7565.0 7566.3 6153.5 6282.8 6645.5 6988.7 7027.4 4642.8 4678.7 4692.0 4759.7 4772.8 1964.9 1968.3 2000.8 2006.3 2057.2 864.7 971.7 976.9 1029.2 1075.5 17609.2 19006.5 19053.6 19364.7 19666.4 957.2 962.7 1017.1 1041.7 1056.5 10368.5 10936.7 10966.1 10977.3 11033.6 446883.0 449434.0 462169.0 462679.0 477144.0 80694.6 85575.0 99075.5 99606.5 101421.5 952.5 1016.4 1077.1 1081.1 1086.6 17514.6 17765.3 18151.6 18157.8 18342.4 42544.6 42843.0 42877.0 43015.0 43718.5 54437.0 57513.0 57947.0 58507.0 61169.4 8331.7 8529.9 8545.9 8665.4 8699.6 12612.7 13328.1 13394.4 13505.2 13727.9 11970.8 11973.4 12023.0 12435.8 12453.3 11712.6 11774.4 11849.8 12152.3 12242.8 12359.9 12377.9 12395.7 12509.3 12614.4 8677.0 8692.1 8734.2 8808.1 8932.9 11723.5 11797.4 11806.2 12063.6 12353.3 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#3] mootools.html Cycles:180 Average:5827.77 Median:2532.77 stddev:3351.12 (132.3%) stddev-sans-first:3343.92 17:48:18 INFO - PROCESS | 24221 | Values: 1389.2 1508.6 1540.2 1696.8 1828.1 8325.4 8680.4 8687.6 8929.5 8949.8 8509.6 8719.9 8728.6 8734.8 8736.0 2065.2 2275.7 2279.0 2311.9 2354.5 2249.9 2258.6 2263.9 2265.2 2265.5 2208.1 2276.5 2277.3 2280.2 2282.7 2003.6 2247.6 2318.7 2321.9 2337.7 2176.6 2182.2 2197.0 2197.6 2232.1 8669.7 8706.0 8716.6 8718.7 8720.0 5020.1 5144.9 5145.0 5160.7 5164.9 3297.8 3354.1 3359.3 3551.3 3561.4 1110.8 1129.2 1138.6 1143.2 1145.4 12094.5 12131.7 12148.3 12156.6 12156.7 4331.3 4399.4 4464.2 4487.7 4508.7 10194.1 10221.5 10226.8 10230.8 10235.8 4661.0 5084.5 5088.3 5089.5 5092.2 4652.7 4782.2 4783.2 4820.9 4821.4 3882.7 3982.5 4010.6 4038.8 4085.3 1230.6 1269.7 1291.0 1298.8 1311.1 823.8 851.0 887.2 944.3 1012.7 5935.5 6177.5 6202.5 6260.4 6294.4 454.3 463.2 466.4 482.3 483.3 4249.9 4289.7 4472.5 4574.0 4602.4 10943.7 11060.9 11162.7 11164.8 11165.8 10850.6 11086.3 11292.5 11358.7 11397.9 8213.6 8231.5 8267.2 8333.9 8412.9 6193.2 6243.6 6262.0 6287.6 6380.1 10314.9 10342.9 10446.8 10447.8 10457.7 9750.8 10184.9 10199.5 10465.3 10506.5 7089.8 7461.6 7737.9 7836.6 8063.3 8588.4 8656.0 8722.9 8725.5 8732.2 7730.2 7801.5 7888.2 8021.1 8087.5 7527.3 7571.6 7690.5 7786.3 7848.2 7077.2 7154.0 7155.2 7158.2 7168.7 5075.2 5240.0 5372.9 5419.2 5460.5 5332.9 5411.6 5496.9 5603.1 5636.9 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#4] prototype.html Cycles:180 Average:4564.00 Median:5254.21 stddev:1338.94 (25.5%) stddev-sans-first:1304.33 17:48:18 INFO - PROCESS | 24221 | Values: 324.5 331.4 333.2 339.4 340.1 5194.6 5211.9 5223.7 5248.4 5261.2 5066.8 5158.4 5162.1 5174.8 5182.8 3887.3 3929.7 4048.8 4071.8 4116.6 3999.3 4053.4 4054.5 4059.2 4065.1 4015.2 4021.8 4022.1 4035.7 4040.0 3847.4 3888.7 4004.9 4018.2 4041.5 3512.4 3546.2 3553.9 3556.8 3568.8 4981.8 5018.6 5021.5 5034.9 5047.6 4402.2 4570.0 4579.3 4597.5 4614.6 5215.3 5314.5 5339.3 5371.1 5392.7 3899.6 3904.5 3905.2 3906.4 3916.3 5326.2 5568.7 5590.2 5631.9 5660.5 3979.9 3986.9 3991.6 3998.6 4004.0 4044.4 4049.2 4053.0 4056.0 4060.4 4512.6 4629.9 4631.9 4647.3 4652.2 5336.5 5412.8 5440.3 5441.5 5460.5 1356.3 1388.5 1389.5 1395.0 1405.7 903.2 904.4 914.3 919.6 946.1 5190.5 5241.8 5260.5 5268.7 5278.9 5489.4 5535.1 5548.8 5549.0 5556.1 5105.5 5181.7 5260.0 5312.3 5320.2 2854.4 2901.0 2929.3 2932.8 2942.9 5472.5 5675.0 5702.5 5711.5 5713.9 5461.2 5560.9 5561.4 5639.9 5649.9 5656.0 5668.0 5679.6 5695.7 5713.6 5366.4 5428.1 5500.7 5519.5 5545.7 5441.2 5463.7 5465.2 5481.3 5492.5 5596.9 5615.4 5651.9 5668.2 5688.6 3796.5 3990.6 4044.8 4056.8 4063.3 5607.7 5628.3 5671.8 5674.2 5675.9 5524.4 5526.4 5539.8 5545.0 5545.6 5282.9 5409.6 5447.4 5487.4 5490.8 5199.2 5224.9 5394.5 5415.1 5417.6 5477.7 5496.4 5497.9 5542.6 5582.0 5347.9 5354.7 5376.3 5380.3 5422.9 17:48:18 INFO - PROCESS | 24221 | 17:48:18 INFO - PROCESS | 24221 | [#5] yui.html Cycles:180 Average:15250.06 Median:4391.44 stddev:17747.27 (404.1%) stddev-sans-first:17763.52 17:48:18 INFO - PROCESS | 24221 | Values: 721.8 740.4 754.5 815.2 861.4 13683.9 14419.7 14502.9 14546.2 14782.3 14503.0 14539.3 14543.6 14560.7 14642.7 690.4 829.6 834.7 837.6 838.0 807.6 832.5 833.8 834.4 834.6 862.9 863.1 863.7 864.6 865.1 706.1 841.6 861.1 861.2 864.9 639.9 640.4 641.2 641.2 641.6 13236.7 13239.5 13254.6 13328.9 13330.0 13202.5 13673.9 13814.0 13853.7 14045.4 12030.6 12045.5 12135.8 12406.3 12446.9 4309.8 4383.9 4419.9 4446.5 4447.0 59101.4 59229.7 59395.7 62211.7 64075.4 11239.7 11328.2 11398.6 11476.0 11595.9 19815.1 19822.4 19823.0 19896.6 19973.3 7771.7 7855.6 7926.6 8021.0 8126.5 4353.1 4374.8 4387.5 4395.4 4547.9 3355.8 3456.4 3456.9 3458.2 3461.3 619.7 628.3 628.3 632.4 633.9 567.2 577.8 616.2 662.4 682.7 8512.2 9129.7 9201.2 9254.6 9346.3 575.1 605.5 616.7 644.4 668.1 4016.3 4052.7 4219.3 4298.7 4333.6 56432.2 57869.7 58999.4 64888.7 65146.3 56198.0 56296.0 57102.1 57250.4 57675.7 50719.5 51421.2 52382.5 52402.0 53334.5 9362.5 9374.3 9495.1 9887.0 9914.6 35396.8 35705.5 35983.5 36248.8 37115.1 43199.4 45235.5 46584.0 47161.0 49014.5 12450.9 12534.5 12557.8 12640.6 12839.0 13270.0 13348.3 13802.6 14046.2 14293.5 12459.7 12470.8 12545.1 13887.4 14330.0 12485.6 12505.9 12630.7 12941.5 13119.7 11766.5 12241.9 12661.3 12759.3 13050.5 10938.4 10949.5 11061.7 11260.4 11348.7 11073.2 11205.3 11298.3 11416.5 11467.4 17:48:18 INFO - PROCESS | 24221 | -------- Summary: end -------- 17:48:18 INFO - PROCESS | 24221 | 17:48:19 INFO - TEST-INFO | 24221: exit 0 17:48:19 INFO - TEST-OK | dromaeo_css | took 1112068ms 17:48:19 INFO - TEST-START | kraken 17:48:19 INFO - operating with platform_type : linux_ 17:48:19 INFO - Initialising browser for kraken test... 17:48:19 INFO - TEST-INFO | started process 24410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajngkb/profile http://localhost:34927/getInfo.html) 17:48:23 INFO - PROCESS | 24410 | __metrics Screen width/height:1600/1200 17:48:23 INFO - PROCESS | 24410 | colorDepth:24 17:48:23 INFO - PROCESS | 24410 | Browser inner width/height: 1024/697 17:48:23 INFO - PROCESS | 24410 | __metrics 17:48:23 ERROR - PROCESS | 24410 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:48:24 INFO - TEST-INFO | 24410: exit 0 17:48:24 INFO - Browser initialized. 17:48:24 INFO - Running cycle 1/1 for kraken test... 17:48:24 INFO - TEST-INFO | started process 24490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajngkb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:36 INFO - PROCESS | 24490 | RSS: Main: 153022464 17:48:36 INFO - PROCESS | 24490 | 17:48:39 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34927/tests/kraken/driver.html?testName=audio-beat-detection) 17:48:39 INFO - PROCESS | 24490 | RSS: Main: 208961536 17:48:39 INFO - PROCESS | 24490 | 17:48:42 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34927/tests/kraken/driver.html?testName=audio-dft) 17:48:43 INFO - PROCESS | 24490 | RSS: Main: 198258688 17:48:43 INFO - PROCESS | 24490 | 17:48:46 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34927/tests/kraken/driver.html?testName=audio-fft) 17:48:46 INFO - PROCESS | 24490 | RSS: Main: 265412608 17:48:46 INFO - PROCESS | 24490 | 17:48:49 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34927/tests/kraken/driver.html?testName=audio-oscillator) 17:48:49 INFO - PROCESS | 24490 | RSS: Main: 175046656 17:48:49 INFO - PROCESS | 24490 | 17:48:51 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:52 INFO - PROCESS | 24490 | RSS: Main: 179281920 17:48:52 INFO - PROCESS | 24490 | 17:48:55 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34927/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:55 INFO - PROCESS | 24490 | RSS: Main: 215080960 17:48:55 INFO - PROCESS | 24490 | 17:48:59 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34927/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:59 INFO - PROCESS | 24490 | RSS: Main: 215732224 17:48:59 INFO - PROCESS | 24490 | 17:49:02 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34927/tests/kraken/driver.html?testName=json-parse-financial) 17:49:03 INFO - PROCESS | 24490 | RSS: Main: 216141824 17:49:03 INFO - PROCESS | 24490 | 17:49:04 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:49:05 INFO - PROCESS | 24490 | RSS: Main: 204324864 17:49:05 INFO - PROCESS | 24490 | 17:49:07 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:49:07 INFO - PROCESS | 24490 | RSS: Main: 207810560 17:49:07 INFO - PROCESS | 24490 | 17:49:09 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:49:10 INFO - PROCESS | 24490 | RSS: Main: 218054656 17:49:10 INFO - PROCESS | 24490 | 17:49:13 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:49:13 INFO - PROCESS | 24490 | RSS: Main: 224002048 17:49:13 INFO - PROCESS | 24490 | 17:49:16 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:49:17 INFO - PROCESS | 24490 | RSS: Main: 221188096 17:49:17 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | Cycle 1(1): loaded http://localhost:34927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34927/tests/kraken/driver.html?testName=ai-astar) 17:49:18 INFO - PROCESS | 24490 | RSS: Main: 267816960 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | __start_tp_report 17:49:18 INFO - PROCESS | 24490 | _x_x_mozilla_page_load 17:49:18 INFO - PROCESS | 24490 | _x_x_mozilla_page_load_details 17:49:18 INFO - PROCESS | 24490 | |i|pagename|runs| 17:49:18 INFO - PROCESS | 24490 | |0;ai-astar;110;104;110;109;109;111;109;109;109;109 17:49:18 INFO - PROCESS | 24490 | |1;audio-beat-detection;156;124;126;177;127;126;154;127;154;125 17:49:18 INFO - PROCESS | 24490 | |2;audio-dft;160;161;161;161;160;159;160;161;160;160 17:49:18 INFO - PROCESS | 24490 | |3;audio-fft;73;75;74;112;74;76;73;75;96;74 17:49:18 INFO - PROCESS | 24490 | |4;audio-oscillator;83;83;131;84;84;83;117;83;84;125 17:49:18 INFO - PROCESS | 24490 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;118;116 17:49:18 INFO - PROCESS | 24490 | |6;imaging-darkroom;145;146;146;152;146;147;146;145;146;146 17:49:18 INFO - PROCESS | 24490 | |7;imaging-desaturate;94;95;94;94;95;94;95;96;94;95 17:49:18 INFO - PROCESS | 24490 | |8;json-parse-financial;55;54;55;53;55;61;53;73;53;51 17:49:18 INFO - PROCESS | 24490 | |9;json-stringify-tinderbox;62;62;62;62;63;62;62;63;62;63 17:49:18 INFO - PROCESS | 24490 | |10;stanford-crypto-aes;79;78;79;79;79;80;79;85;81;86 17:49:18 INFO - PROCESS | 24490 | |11;stanford-crypto-ccm;128;130;121;119;126;117;132;123;164;137 17:49:18 INFO - PROCESS | 24490 | |12;stanford-crypto-pbkdf2;159;159;161;157;156;160;160;161;162;162 17:49:18 INFO - PROCESS | 24490 | |13;stanford-crypto-sha256-iterative;63;62;63;63;62;61;65;61;65;61 17:49:18 INFO - PROCESS | 24490 | __end_tp_report 17:49:18 INFO - PROCESS | 24490 | __start_cc_report 17:49:18 INFO - PROCESS | 24490 | _x_x_mozilla_cycle_collect,1618 17:49:18 INFO - PROCESS | 24490 | __end_cc_report 17:49:18 INFO - PROCESS | 24490 | __startTimestamp1464137358953__endTimestamp 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | ------- Summary: start ------- 17:49:18 INFO - PROCESS | 24490 | Number of tests: 14 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.85 (1.7%) stddev-sans-first:1.92 17:49:18 INFO - PROCESS | 24490 | Values: 110.0 104.0 110.0 109.0 109.0 111.0 109.0 109.0 109.0 109.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:140.50 stddev:18.93 (13.5%) stddev-sans-first:19.13 17:49:18 INFO - PROCESS | 24490 | Values: 156.0 124.0 126.0 177.0 127.0 126.0 154.0 127.0 154.0 125.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 17:49:18 INFO - PROCESS | 24490 | Values: 160.0 161.0 161.0 161.0 160.0 159.0 160.0 161.0 160.0 160.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.50 stddev:13.13 (17.6%) stddev-sans-first:13.67 17:49:18 INFO - PROCESS | 24490 | Values: 73.0 75.0 74.0 112.0 74.0 76.0 73.0 75.0 96.0 74.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:83.00 stddev:20.04 (24.1%) stddev-sans-first:20.72 17:49:18 INFO - PROCESS | 24490 | Values: 83.0 83.0 131.0 84.0 84.0 83.0 117.0 83.0 84.0 125.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 17:49:18 INFO - PROCESS | 24490 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 116.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.01 (1.4%) stddev-sans-first:2.06 17:49:18 INFO - PROCESS | 24490 | Values: 145.0 146.0 146.0 152.0 146.0 147.0 146.0 145.0 146.0 146.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:49:18 INFO - PROCESS | 24490 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 96.0 94.0 95.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:6.43 (11.7%) stddev-sans-first:6.80 17:49:18 INFO - PROCESS | 24490 | Values: 55.0 54.0 55.0 53.0 55.0 61.0 53.0 73.0 53.0 51.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:49:18 INFO - PROCESS | 24490 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:2.76 (3.5%) stddev-sans-first:2.87 17:49:18 INFO - PROCESS | 24490 | Values: 79.0 78.0 79.0 79.0 79.0 80.0 79.0 85.0 81.0 86.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:129.00 stddev:13.53 (10.5%) stddev-sans-first:14.34 17:49:18 INFO - PROCESS | 24490 | Values: 128.0 130.0 121.0 119.0 126.0 117.0 132.0 123.0 164.0 137.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 17:49:18 INFO - PROCESS | 24490 | Values: 159.0 159.0 161.0 157.0 156.0 160.0 160.0 161.0 162.0 162.0 17:49:18 INFO - PROCESS | 24490 | 17:49:18 INFO - PROCESS | 24490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 17:49:18 INFO - PROCESS | 24490 | Values: 63.0 62.0 63.0 63.0 62.0 61.0 65.0 61.0 65.0 61.0 17:49:18 INFO - PROCESS | 24490 | -------- Summary: end -------- 17:49:18 INFO - PROCESS | 24490 | 17:49:19 INFO - TEST-INFO | 24490: exit 0 17:49:19 INFO - TEST-OK | kraken | took 60739ms 17:49:19 INFO - SUITE-END | took 1172s 17:49:20 INFO - Completed test suite (00:19:33) 17:49:20 INFO - javascript benchmark 17:49:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.2221944513885, 3137.0432018234437, 3156.873725050998, 3180.2526406294533, 3186.060112266881, 5324.54741346986, 5378.273933019042, 5413.756380962856, 5488.1493368527845, 5497.312835895513, 5269.972355390701, 5278.181881808326, 5302.390225124112, 5359.892802143955, 5438.755256013479, 4758.881027974302, 4815.325854380372, 4900.9754951225195, 5023.623228257877, 5052.646314757969, 4951.084049450845, 4960.206366981283, 4987.750612469362, 5011.624128190382, 5017.0, 4784.258439941815, 4798.664093513456, 4860.611151107921, 4866.683665561727, 4882.218844984785, 4922.630802689777, 4946.060248552763, 4952.683119072901, 4962.206047032458, 4984.750762461898, 4771.6898401603785, 4874.707517548923, 4910.1898186799135, 4911.214205727067, 4964.776585053682, 5280.894382112375, 5347.866303342409, 5351.25082488452, 5413.485718856702, 5420.214068959979, 5834.5040671542965, 5836.6789826559525, 5841.561882858802, 5865.736041878083, 5874.383189765099, 5701.828945131652, 5727.971360143172, 5770.163326317703, 5845.88308233833, 5858.736356863908, 5453.945460545344, 5486.341639003345, 5496.0931446311315, 5507.917381239285, 5508.862278443031, 6012.518998480198, 6014.188084608521, 6014.729337179838, 6018.6990650467305, 6031.336552979169, 5533.335999679984, 5594.804181853697, 5647.745851436695, 5670.347909990404, 5752.7698892043845, 5782.0, 5818.592698511064, 5826.359100498942, 5832.679202643895, 5839.824805255849, 5771.249737534094, 5771.509421699118, 5773.653580785166, 5780.624259423208, 5781.624194427349, 5636.549076073904, 5652.85867853307, 5754.856128596819, 5778.855528611818, 5818.44724751148, 4419.0, 4419.845305414295, 4419.955800442019, 4423.336499525032, 4463.910721785546, 3840.2127563849344, 3943.664788492953, 3944.526656801202, 3966.1076257841755, 3967.1668949520345, 5418.268533747893, 5527.55779537636, 5542.97228513863, 5550.084236101079, 5567.721613919369, 5888.440598143169, 5891.204687367236, 5898.14476900847, 5900.321463031806, 5944.346121926585, 5396.64921780083, 5438.8912221755345, 5558.471945165203, 5560.054790685593, 5574.665520068809, 4996.625253106032, 5005.72468514228, 5007.098722229961, 5010.2735103409805, 5047.646664733434, 6016.217891674054, 6032.698365081728, 6033.155358249848, 6033.185519954838, 6033.637981721111, 5684.204211410323, 5780.653160810197, 5823.941760582509, 5866.501347385435, 5868.94131058684, 6056.0915862619195, 6057.121717351048, 6059.484943779652, 6066.423689749467, 6105.389461053859, 5713.22871412354, 5736.4550367715, 5753.568482363923, 5754.424557544212, 5761.049426844524, 5638.37977822431, 5751.568632352507, 5787.5369970401425, 5824.068149096293, 5870.9412905872105, 5697.401772813795, 5704.258446402107, 5707.6290041147195, 5712.314522257356, 5712.828615141552, 5644.689542075225, 5680.602357835077, 5700.173474846207, 5701.087825947829, 5701.173329867063, 5418.83743487696, 5517.751701173537, 5522.944770552243, 5578.107502799695, 5605.691686957257, 5699.5725320600295, 5710.914336284876, 5752.511036561939, 5767.106098554731, 5781.624194427349, 5438.483344082306, 5502.394736578893, 5548.306461692288, 5569.972150139223, 5591.217229587943], "value": 5347.6206759685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3248833887674, 614.9446549810517, 636.1793286660205, 650.6681592387881, 650.873079749449, 31013.379732405338, 31559.0, 34187.31625367497, 34319.82840085802, 42883.0, 45136.77431612845, 45676.543234567645, 45811.0, 45889.54110458894, 45957.54042459575, 8676.262517686004, 8829.161229683203, 8876.023637399881, 8878.334124940655, 8880.24517915978, 8580.785480363009, 8723.38936274461, 8724.258438032775, 8726.563671816384, 8735.781605459882, 8744.387892847502, 8769.868451973225, 8773.210411063003, 8780.385373023892, 8790.340724445692, 8677.349198810114, 8733.650653973833, 8746.781330466725, 8765.035846056928, 8765.298776097961, 8641.092685268082, 8717.607707653171, 8732.607032683482, 8736.825263494758, 8742.737717868475, 41650.0, 42128.578714212774, 42177.0, 42184.57815421837, 42200.36699449511, 3561.127523756696, 3613.6205698401554, 3885.9896426929204, 4056.2293164298985, 4215.620594146541, 32127.0, 32264.35471290561, 32464.350712985844, 32767.18082047944, 34378.0, 4246.426732391149, 4292.29177185764, 4409.338599210112, 4421.801018954155, 4453.732776033448, 337984.0, 338280.0, 339630.0, 340531.0, 340864.0, 57216.141757873665, 58464.0, 58567.414325856196, 58576.707116465, 58604.7069764657, 60742.392576074555, 60930.211629895086, 61080.38919610836, 61137.38862611406, 61174.082388764204, 14401.567952961428, 14607.123572585679, 14621.78067328991, 14630.926845365919, 14633.487827926185, 10575.682729518127, 10621.5220315086, 10650.680479585624, 10681.946590267155, 10696.732581685521, 14635.853641463662, 16809.6638067238, 16833.0, 16868.0, 16890.071046092336, 5828.184054232411, 5890.410958904075, 5981.0, 6013.579049466495, 6115.969420152871, 1029.264076185531, 1167.6146871532374, 1180.2387460088196, 1184.1829137894824, 1188.2751521571834, 31778.0, 31980.520292195637, 32054.0, 32253.677463225536, 32529.51205731916, 954.7517645412242, 1098.0995583621514, 1136.6078702847503, 1206.927584344942, 1250.0999280518013, 16508.0, 16580.0, 16631.750523742154, 16657.497856480688, 16837.242324095445, 486749.0, 488472.0, 489423.0, 491869.0, 494664.0, 57036.71481642648, 57146.14280785791, 57169.0, 57218.7139064302, 57336.71331643315, 1262.6275248801626, 1352.2089577597217, 1369.8835598974, 1382.2328607622867, 1399.0626280392162, 29888.0, 33736.0, 33796.49305260374, 34126.488102677984, 34547.481787772704, 51333.89328853608, 52106.478935210165, 52149.0, 52200.47799521956, 52221.21668174904, 447547.0, 454096.0, 455172.0, 455728.0, 671765.0, 43552.0, 44317.0, 44841.32738008998, 47599.28601071056, 48667.513324867716, 48744.2688359682, 48753.512464876316, 48792.0, 49124.508754913426, 50429.74785126051, 40772.0, 41030.79484602558, 41225.0, 42151.57848421476, 43056.56943430525, 40501.39247911225, 41041.79479102585, 41156.50169735606, 41612.79193604013, 42208.36687449752, 40645.187096257316, 41107.58892411038, 42168.15663686648, 42260.36609450799, 42296.0, 36337.27325453423, 37154.8142259287, 37250.254994899406, 37953.2409351817, 38176.23647526978, 28032.439351212455, 28640.713592863805, 28681.697745338366, 28736.712632873405, 28967.710322896502], "value": 20119.55515235262, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.2824060210415, 396.36185740957063, 397.70172370721957, 399.5305516018678, 419.45680343954575, 17819.198136083876, 19031.42905712831, 19440.02799860005, 19505.12226949787, 20479.488012799688, 17545.91227043866, 18464.261429542803, 18502.72245916309, 19375.70936435951, 19775.0, 5043.268726034741, 5127.564157046646, 5254.21186821976, 5275.788968441258, 5278.1291086970605, 5111.488851114896, 5164.354455693038, 5164.535191832734, 5187.740612969355, 5202.947970520303, 4892.168331383673, 5062.26597143414, 5071.492850714936, 5190.818321358754, 5194.480551944813, 4996.9500304996845, 5001.599872010267, 5034.119029169918, 5041.369828771403, 5052.545270925616, 4784.6889952153, 4922.433920099199, 4927.679700819471, 5079.415867175285, 5096.184610462308, 12861.485540578366, 12993.0, 13178.670533236746, 13340.933295333558, 13410.46358145673, 2169.8372622053253, 2255.379770563108, 2325.1513197682893, 2329.6854924585305, 2414.360194548446, 9130.358792539499, 9419.576119074658, 9491.952540237324, 9594.904050959542, 9854.704358869174, 1897.8576606754548, 1915.9712604310946, 1928.6364699384426, 1935.2742721479444, 1960.235508151822, 57555.71222143904, 62363.0, 67676.66161669209, 74596.62701686457, 78631.606841966, 10059.0, 10916.181286403551, 10957.232993690524, 11072.280301780358, 11114.166437517219, 15030.0, 15400.767938564888, 15425.305861236271, 15425.537233883002, 15466.144062712321, 6487.545871789024, 7133.821654458577, 7492.325690687864, 7565.0, 7566.31903128721, 6153.507719382439, 6282.780102696383, 6645.501587380869, 6988.6855091521, 7027.402670772939, 4642.814287428465, 4678.719276843401, 4691.976540117277, 4759.690620109682, 4772.832950846704, 1964.88210707358, 1968.2914150905663, 2000.7699114602008, 2006.3278801601334, 2057.1668474267944, 864.6930339729305, 971.6502059258661, 976.8681228034125, 1029.1869423155624, 1075.5106426576046, 17609.207585658674, 19006.524836879187, 19053.618927621646, 19364.70952935707, 19666.410007699793, 957.2246480350938, 962.6871266838166, 1017.1405162637559, 1041.7031146123318, 1056.5404049238605, 10368.481575921174, 10936.671899843017, 10966.122710183166, 10977.28647637901, 11033.558657653764, 446883.0, 449434.0, 462169.0, 462679.0, 477144.0, 80694.59652701698, 85575.0, 99075.50462247642, 99606.50196749115, 101421.49289253507, 952.5046975572664, 1016.4307987527009, 1077.1060020183386, 1081.1242893256488, 1086.6414083352474, 17514.562135946704, 17765.289388424317, 18151.636967260845, 18157.762033860945, 18342.449726508225, 42544.57455425406, 42843.0, 42877.0, 43015.0, 43718.469853554976, 54437.0, 57513.0, 57947.0, 58507.0, 61169.38830611637, 8331.708390206313, 8529.91470085316, 8545.871811922701, 8665.350098742494, 8699.56502174876, 12612.684682883002, 13328.067430222758, 13394.397252123872, 13505.189688618715, 13727.862721372658, 11970.76058478843, 11973.401329933295, 12023.0, 12435.813462797883, 12453.315067671365, 11712.648620541397, 11774.411279435823, 11849.822252666045, 12152.270863748203, 12242.75514489723, 12359.876401235873, 12377.876221238033, 12395.690107747378, 12509.311987840756, 12614.432350544064, 8676.956615216883, 8692.087330830173, 8734.213920747163, 8808.075152108937, 8932.910670893469, 11723.472443739882, 11797.35114568707, 11806.232594881305, 12063.638090857288, 12353.258804471761], "value": 8851.367542605136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.235920243867, 1508.5851390867513, 1540.214490609789, 1696.7624532565444, 1828.0676854804053, 8325.41722079454, 8680.392372533917, 8687.565621718912, 8929.464232146076, 8949.776255593613, 8509.574521273942, 8719.912800871989, 8728.563571821414, 8734.825303493926, 8735.995360533541, 2065.2461851424196, 2275.7382900966395, 2278.9544209115807, 2311.9422014449688, 2354.540864531417, 2249.898754556049, 2258.6499092640665, 2263.852849564773, 2265.229821860567, 2265.4676151104477, 2208.1167532986774, 2276.521930394611, 2277.2826559633745, 2280.1677387753434, 2282.691836602054, 2003.559216972271, 2247.5841969235744, 2318.675385446039, 2321.9071237150492, 2337.6844126043106, 2176.5646870625937, 2182.225310014938, 2196.9890150549145, 2197.637389830676, 2232.05137816429, 8669.69656062041, 8706.0, 8716.607752651145, 8718.694845680435, 8720.040795512488, 5020.0963826511215, 5144.948550514522, 5144.996725638502, 5160.7419629018395, 5164.92252616211, 3297.8186199759, 3354.077628652116, 3359.2945481448924, 3551.254236610315, 3561.3767590671528, 1110.783397237539, 1129.24904938216, 1138.5844166879112, 1143.2054721968236, 1145.4444594371723, 12094.455749491293, 12131.696707582292, 12148.3318417487, 12156.574519891761, 12156.696082597917, 4331.263685173528, 4399.36209249657, 4464.196444639996, 4487.685861989695, 4508.706934049276, 10194.082532572103, 10221.540030698636, 10226.795464090677, 10230.795384092276, 10235.846462303072, 4661.0, 5084.51697088776, 5088.262201980766, 5089.491050894955, 5092.236164575269, 4652.674312798072, 4782.163121453732, 4783.234682450791, 4820.855374338776, 4821.373221481185, 3882.7476214045996, 3982.482277303932, 4010.598940105966, 4038.8384464621085, 4085.305498065336, 1230.563150081726, 1269.7143142792797, 1291.0, 1298.7662220800157, 1311.0756916373934, 823.7569916874536, 850.9787255318543, 887.1572006593633, 944.3248077624531, 1012.7417508535276, 5935.52515798735, 6177.505799536027, 6202.503799696014, 6260.373962603703, 6294.402031806971, 454.3003774187714, 463.1547425947659, 466.40766226891657, 482.2645465664889, 483.28473858689335, 4249.87250382489, 4289.721168124124, 4472.463304403493, 4574.039451715177, 4602.378678878308, 10943.726406839893, 11060.944695276472, 11162.665120046411, 11164.832527512093, 11165.83251251232, 10850.565977360817, 11086.279391839505, 11292.548298067984, 11358.716032099099, 11397.943010285062, 8213.589320534069, 8231.46495477792, 8267.214614611603, 8333.916660833314, 8412.915870841336, 6193.163922870535, 6243.562950593415, 6261.96869015652, 6287.591306565058, 6380.074889140956, 10314.896851031393, 10342.896571034193, 10446.843297350393, 10447.84328235062, 10457.738556536147, 9750.75623109428, 10184.949075254577, 10199.490025498548, 10465.319754215952, 10506.474676266309, 7089.822754430974, 7461.552306861606, 7737.883931741141, 7836.608169591384, 8063.27430531255, 8588.355873309652, 8656.0, 8722.91277087221, 8725.476471411735, 8732.170443807829, 7730.188330225245, 7801.4929029612895, 7888.211178882296, 8021.077576078592, 8087.47431416956, 7527.322540971339, 7571.621418929141, 7690.538567685957, 7786.33816125613, 7848.215178482106, 7077.221505634273, 7154.034205382207, 7155.248698886542, 7158.212596614472, 7168.713251469882, 5075.187969924942, 5240.0, 5372.865678358073, 5419.184573168033, 5460.481254280837, 5332.893342133058, 5411.648242864201, 5496.917546236889, 5603.131514615078, 5636.887262254814], "value": 4563.117202469412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.539154400751, 331.43986662540306, 333.21860237742493, 339.3586122228986, 340.10891464363374, 5194.610404219679, 5211.921821172681, 5223.686578805275, 5248.448912864147, 5261.184516399954, 5066.797328106881, 5158.406783219922, 5162.122439185338, 5174.793008279674, 5182.792688292464, 3887.3197190491624, 3929.7052721045893, 4048.7570745755347, 4071.7760523171214, 4116.58834116589, 3999.300122478569, 4053.371727382246, 4054.4729185205883, 4059.2084543514025, 4065.125997910449, 4015.1969606078756, 4021.7989100544855, 4022.074922767765, 4035.737677050997, 4039.9596004039877, 3847.365184744514, 3888.747231429962, 4004.939925901114, 4018.2365350583295, 4041.4746083009313, 3512.4028915084496, 3546.219831637036, 3553.9111522211892, 3556.8399422025814, 3568.750187486877, 4981.775820088104, 5018.64869459138, 5021.49785021495, 5034.949650503521, 5047.596192304607, 4402.2296098183015, 4570.0, 4579.3131030345385, 4597.54024597541, 4614.630829533629, 5215.348081489814, 5314.4951229633125, 5339.332583427072, 5371.113766228567, 5392.73036348181, 3899.629535194152, 3904.492415985932, 3905.2189562087697, 3906.3945088511327, 3916.295066887959, 5326.227696983954, 5568.693721845297, 5590.161475778625, 5631.8592035199035, 5660.518855897212, 3979.880603581897, 3986.940195897064, 3991.6071339361893, 3998.580149084304, 4003.979980100081, 4044.4337792709043, 4049.190161967618, 4052.979735101306, 4055.9594404055583, 4060.3706425504092, 4512.571305725951, 4629.907401851944, 4631.861044168681, 4647.279671650899, 4652.1626107300335, 5336.519713225828, 5412.83761487156, 5440.319960004999, 5441.510264076173, 5460.535854452337, 1356.3353956561411, 1388.5348408283137, 1389.5136702154166, 1395.0165133580801, 1405.6626409661608, 903.1600611431431, 904.4482865452069, 914.2503147419053, 919.5678031325266, 946.1153821177221, 5190.506901844319, 5241.820590367213, 5260.526552610283, 5268.6575372600655, 5278.947210527922, 5489.3687225969525, 5535.142052981794, 5548.833534993957, 5549.0, 5556.138798486241, 5105.463926287686, 5181.740912954338, 5259.973700131475, 5312.256284120226, 5320.228566857784, 2854.4148449568206, 2900.9854950725535, 2929.29696872749, 2932.765378769693, 2942.8822847086303, 5472.495063857471, 5675.0, 5702.515286200636, 5711.543076553866, 5713.942860571424, 5461.225101841917, 5560.8878224354485, 5561.416051314634, 5639.928413601403, 5649.858753531113, 5656.038473459604, 5667.971660141673, 5679.602427830095, 5695.743691533891, 5713.600047996683, 5366.436524164907, 5428.112433770031, 5500.73692887999, 5519.503244707996, 5545.694986775605, 5441.183822426668, 5463.726813659222, 5465.207544906046, 5481.342238931354, 5492.512254718203, 5596.944030559643, 5615.354234262949, 5651.858703532444, 5668.2064510967675, 5688.573356998324, 3796.4684944107294, 3990.6408423242046, 4044.7775372354804, 4056.756594604215, 4063.309237429703, 5607.663540187602, 5628.324601047901, 5671.829845104653, 5674.205611214516, 5675.943240567542, 5524.447555244444, 5526.364468086061, 5539.750711217925, 5545.0018996581, 5545.611807173459, 5282.9471705283995, 5409.594280428905, 5447.428020057995, 5487.396386397413, 5490.835274941758, 5199.194124910645, 5224.928889577552, 5394.487523685244, 5415.106507426231, 5417.566594672496, 5477.698726570077, 5496.433516447793, 5497.862553436036, 5542.556595472433, 5581.972090139523, 5347.946520534745, 5354.651947623392, 5376.301080859464, 5380.3274590676165, 5422.8644283891645], "value": 4139.039537399765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7618185998621, 740.4409670698622, 754.475639430596, 815.2499700275746, 861.4013260783754, 13683.863161368383, 14419.711605767878, 14502.854971450282, 14546.199959002264, 14782.334794934226, 14503.0, 14539.273036348166, 14543.563693089198, 14560.708785824278, 14642.707145857077, 690.3924546399162, 829.5727700234385, 834.6995081770558, 837.5728378526934, 837.9706710265142, 807.6325272001254, 832.546262287052, 833.7748807821885, 834.4200780457554, 834.5576844272546, 862.8791969124328, 863.1325517854578, 863.7322430046705, 864.5893200729666, 865.0916537635458, 706.0750416953807, 841.5623875584662, 861.0528418739368, 861.2291998661194, 864.9221570058694, 639.9456046236076, 640.4044238857861, 641.1696852575878, 641.1728869758007, 641.5733537197758, 13236.735265294736, 13239.536616218385, 13254.602361929157, 13328.933355333258, 13330.0, 13202.471901123943, 13673.931630341884, 13814.0, 13853.653658658613, 14045.367958441793, 12030.63908082759, 12045.518179272818, 12135.757284854342, 12406.317652529107, 12446.937765311206, 4309.849155279581, 4383.9342409863875, 4419.933700994456, 4446.466424029137, 4446.9777651111535, 59101.40898591002, 59229.703851480896, 59395.703021484616, 62211.688941555454, 64075.35924640787, 11239.719007024727, 11328.2070255083, 11398.632164140356, 11476.0, 11595.884041159481, 19815.10832012563, 19822.405327840188, 19823.0, 19896.60206795885, 19973.300934467225, 7771.6891324347525, 7855.6464959076975, 7926.564038977796, 8021.0, 8126.471779334324, 4353.1293741251875, 4374.825006999748, 4387.451568553931, 4395.428594282723, 4547.909041819145, 3355.8489867955514, 3456.3778519866164, 3456.861725531001, 3458.152752575635, 3461.273132642123, 619.7490016543308, 628.3025841316136, 628.3182746719768, 632.424493710721, 633.9112524246609, 567.20307967306, 577.8287885384137, 616.1712496691943, 662.4226594233821, 682.6552590941543, 8512.191341822518, 9129.680461183827, 9201.21789647874, 9254.583543740548, 9346.299027572959, 575.122937520285, 605.5307136968885, 616.6762449713937, 644.4416904201264, 668.0647094068344, 4016.3172260715746, 4052.7163098583405, 4219.346001369792, 4298.699091063596, 4333.609975102256, 56432.153517696446, 57869.710651446476, 58999.41000590025, 64888.675556621914, 65146.34853651403, 56198.0, 56296.0, 57102.143467848015, 57250.42749572451, 57675.71162144246, 50719.49280507147, 51421.22868156981, 52382.47617523776, 52402.0, 53334.46665533372, 9362.485063321583, 9374.343795934492, 9495.097965693249, 9886.950565247127, 9914.553845077133, 35396.82301588476, 35705.46441803427, 35983.460248096824, 36248.81875590605, 37115.07212319713, 43199.35200971925, 45235.54764452313, 46584.0, 47161.0, 49014.50985490099, 12450.875491244971, 12534.498620055461, 12557.811632825333, 12640.620781376574, 12839.037072219808, 13270.0, 13348.332583370986, 13802.585922422344, 14046.1572305662, 14293.499727509487, 12459.688507787378, 12470.750584988431, 12545.12184147101, 13887.375068121757, 14330.0, 12485.56300529477, 12505.93747031259, 12630.747385052431, 12941.482340706267, 13119.672008199872, 11766.470508826953, 12241.938790306347, 12661.303628300164, 12759.298238596595, 13050.516050788157, 10938.398388088413, 10949.507272172612, 11061.668149955514, 11260.38067906273, 11348.659540213477, 11073.224874259047, 11205.271657342246, 11298.322100673986, 11416.486258118239, 11467.369294688871], "value": 6811.014367599228, "unit": "score"}], "name": "dromaeo_css", "value": 7047.494057062454, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 126.0, 177.0, 127.0, 126.0, 154.0, 127.0, 154.0, 125.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 112.0, 74.0, 76.0, 73.0, 75.0, 96.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 131.0, 84.0, 84.0, 83.0, 117.0, 83.0, 84.0, 125.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 152.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 55.0, 61.0, 53.0, 73.0, 53.0, 51.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 80.0, 79.0, 85.0, 81.0, 86.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 121.0, 119.0, 126.0, 117.0, 132.0, 123.0, 164.0, 137.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 157.0, 156.0, 160.0, 160.0, 161.0, 162.0, 162.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 65.0, 61.0, 65.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1493.7, "alertThreshold": 2.0}]} 17:49:20 INFO - Return code: 0 17:49:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:49:20 ERROR - # TBPL SUCCESS # 17:49:20 INFO - Running post-action listener: _resource_record_post_action 17:49:20 INFO - ##### 17:49:20 INFO - ##### Finished run-tests step (success) 17:49:20 INFO - ##### 17:49:20 INFO - Running post-run listener: _resource_record_post_run 17:49:20 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546492416; Read time: 16; Write time: 519852 17:49:20 INFO - TinderboxPrint: CPU usage
13.1% 17:49:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 17:49:20 INFO - TinderboxPrint: I/O write bytes / time
546,492,416 / 519,852 17:49:20 INFO - TinderboxPrint: CPU idle
8,259.5 (86.9%) 17:49:20 INFO - TinderboxPrint: CPU user
1,204.9 (12.7%) 17:49:20 INFO - TinderboxPrint: Swap in / out
0 / 0 17:49:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 236826624; Read time: 0; Write time: 287296 17:49:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292036608; Read time: 16; Write time: 229200 17:49:20 INFO - Running post-run listener: _upload_blobber_files 17:49:20 INFO - Blob upload gear active. 17:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:49:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:49:20 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'] 17:49:20 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 17:49:21 INFO - (blobuploader) - INFO - Open directory for files ... 17:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:49:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:22 INFO - (blobuploader) - INFO - Done attempting. 17:49:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:49:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:49:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:26 INFO - (blobuploader) - INFO - Done attempting. 17:49:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:49:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:49:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:27 INFO - (blobuploader) - INFO - Done attempting. 17:49:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:49:27 INFO - Return code: 0 17:49:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:49:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:49:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c0048d557055bd07a4a7d47d429ed5d46af7959cedf174b17881cf2441327f61ac2e82a2ac03624aca2b2175c88a6e911c48e902dff50d2b5da768ba1fd178d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0478ba8267d3b177113e8135dc8c895130bc8282f9bfbf0dfd06278e9ddc592aff4328c7ea9244e14dfdddb4c5a0e78e40d04ff08cd6983921a8bbcd9674a75e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04c62e58968c7c7e3e7aaefd834346a96d16f1fa1794a87f66573f9cd6fd11beb25615c3134fbe2a6a6197c77b73c851af7b94dd8769fef01110b15c77675339"} 17:49:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:49:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:49:27 INFO - Contents: 17:49:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c0048d557055bd07a4a7d47d429ed5d46af7959cedf174b17881cf2441327f61ac2e82a2ac03624aca2b2175c88a6e911c48e902dff50d2b5da768ba1fd178d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0478ba8267d3b177113e8135dc8c895130bc8282f9bfbf0dfd06278e9ddc592aff4328c7ea9244e14dfdddb4c5a0e78e40d04ff08cd6983921a8bbcd9674a75e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04c62e58968c7c7e3e7aaefd834346a96d16f1fa1794a87f66573f9cd6fd11beb25615c3134fbe2a6a6197c77b73c851af7b94dd8769fef01110b15c77675339"} 17:49:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:49:27 INFO - Copying logs to upload dir... 17:49:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:49:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.767082 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 17:49:27.577581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:49:27.581053) ========= 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=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c0048d557055bd07a4a7d47d429ed5d46af7959cedf174b17881cf2441327f61ac2e82a2ac03624aca2b2175c88a6e911c48e902dff50d2b5da768ba1fd178d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0478ba8267d3b177113e8135dc8c895130bc8282f9bfbf0dfd06278e9ddc592aff4328c7ea9244e14dfdddb4c5a0e78e40d04ff08cd6983921a8bbcd9674a75e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04c62e58968c7c7e3e7aaefd834346a96d16f1fa1794a87f66573f9cd6fd11beb25615c3134fbe2a6a6197c77b73c851af7b94dd8769fef01110b15c77675339"} build_url:https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/cF7cpE2aR_iR3l_8ny2eEw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c0048d557055bd07a4a7d47d429ed5d46af7959cedf174b17881cf2441327f61ac2e82a2ac03624aca2b2175c88a6e911c48e902dff50d2b5da768ba1fd178d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0478ba8267d3b177113e8135dc8c895130bc8282f9bfbf0dfd06278e9ddc592aff4328c7ea9244e14dfdddb4c5a0e78e40d04ff08cd6983921a8bbcd9674a75e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04c62e58968c7c7e3e7aaefd834346a96d16f1fa1794a87f66573f9cd6fd11beb25615c3134fbe2a6a6197c77b73c851af7b94dd8769fef01110b15c77675339"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:49:27.606653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:49:27.606976) ========= 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=ed14279e38b05397cf4aa391000001a4-1464136132.179726-310588043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:49:27.689730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:49:27.690127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:49:27.690477) ========= ========= Total master_lag: 0.17 =========