builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1464729327.09 results: success (0) buildid: 20160531113028 builduid: 670376437c9d4007a5517689cb82fe31 revision: 77fe72f30c9211b72235b099fb131bdbf98e7900 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.093217) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.093723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.094008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.108703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.108972) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 14:15:27-- 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% 224M=0s 2016-05-31 14:15:27 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.280450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.403952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.404267) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:27.453678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 14:15:27.454071) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77fe72f30c9211b72235b099fb131bdbf98e7900 --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 77fe72f30c9211b72235b099fb131bdbf98e7900 --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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 14:15:27,592 truncating revision to first 12 chars 2016-05-31 14:15:27,592 Setting DEBUG logging. 2016-05-31 14:15:27,592 attempt 1/10 2016-05-31 14:15:27,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77fe72f30c92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 14:15:28,421 unpacking tar archive at: fx-team-77fe72f30c92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.173641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 14:15:28.645278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:28.646067) ========= script_repo_revision: 77fe72f30c9211b72235b099fb131bdbf98e7900 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:28.646858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:28.647592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 14:15:28.658781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-31 14:15:28.659098) ========= /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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:28 INFO - MultiFileLogger online at 20160531 14:15:28 in /builds/slave/test 14:15:28 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 14:15:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:28 INFO - {'append_to_log': False, 14:15:28 INFO - 'base_work_dir': '/builds/slave/test', 14:15:28 INFO - 'blob_upload_branch': 'Fx-Team', 14:15:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:28 INFO - 'branch': 'Fx-Team', 14:15:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:28 INFO - 'config_files': ('talos/linux_config.py',), 14:15:28 INFO - 'default_actions': ('clobber', 14:15:28 INFO - 'read-buildbot-config', 14:15:28 INFO - 'download-and-extract', 14:15:28 INFO - 'populate-webroot', 14:15:28 INFO - 'create-virtualenv', 14:15:28 INFO - 'install', 14:15:28 INFO - 'run-tests'), 14:15:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:28 INFO - 'download_minidump_stackwalk': True, 14:15:28 INFO - 'download_symbols': 'ondemand', 14:15:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:28 INFO - 'installer_path': 'installer.exe', 14:15:28 INFO - 'log_level': 'info', 14:15:28 INFO - 'log_name': 'talos', 14:15:28 INFO - 'log_to_console': True, 14:15:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:28 INFO - 'opt_config_files': (), 14:15:28 INFO - 'pip_index': False, 14:15:28 INFO - 'sps_profile': False, 14:15:28 INFO - 'sps_profile_interval': 0, 14:15:28 INFO - 'suite': 'dromaeojs', 14:15:28 INFO - 'system_bits': '32', 14:15:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:28 INFO - 'title': 'talos-linux64-ix-059', 14:15:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:28 INFO - 'use_talos_json': True, 14:15:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:28 INFO - 'work_dir': 'build'} 14:15:28 INFO - ##### 14:15:28 INFO - ##### Running clobber step. 14:15:28 INFO - ##### 14:15:28 INFO - Running pre-action listener: _resource_record_pre_action 14:15:28 INFO - Running main action method: clobber 14:15:28 INFO - rmtree: /builds/slave/test/build 14:15:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:29 INFO - Running post-action listener: _resource_record_post_action 14:15:29 INFO - ##### 14:15:29 INFO - ##### Finished clobber step (success) 14:15:29 INFO - ##### 14:15:29 INFO - ##### 14:15:29 INFO - ##### Running read-buildbot-config step. 14:15:29 INFO - ##### 14:15:29 INFO - Running pre-action listener: _resource_record_pre_action 14:15:29 INFO - Running main action method: read_buildbot_config 14:15:29 INFO - Using buildbot properties: 14:15:29 INFO - { 14:15:29 INFO - "project": "", 14:15:29 INFO - "product": "firefox", 14:15:29 INFO - "script_repo_revision": "production", 14:15:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:15:29 INFO - "repository": "", 14:15:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:15:29 INFO - "buildid": "20160531113028", 14:15:29 INFO - "pgo_build": "True", 14:15:29 INFO - "basedir": "/builds/slave/test", 14:15:29 INFO - "buildnumber": 749, 14:15:29 INFO - "slavename": "talos-linux64-ix-059", 14:15:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:15:29 INFO - "platform": "ubuntu64_hw", 14:15:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:15:29 INFO - "branch": "fx-team", 14:15:29 INFO - "repo_path": "integration/fx-team", 14:15:29 INFO - "revision": "77fe72f30c9211b72235b099fb131bdbf98e7900", 14:15:29 INFO - "stage_platform": "linux64-pgo", 14:15:29 INFO - "builduid": "670376437c9d4007a5517689cb82fe31", 14:15:29 INFO - "slavebuilddir": "test" 14:15:29 INFO - } 14:15:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:15:29 INFO - Running post-action listener: _resource_record_post_action 14:15:29 INFO - ##### 14:15:29 INFO - ##### Finished read-buildbot-config step (success) 14:15:29 INFO - ##### 14:15:29 INFO - ##### 14:15:29 INFO - ##### Running download-and-extract step. 14:15:29 INFO - ##### 14:15:29 INFO - Running pre-action listener: _resource_record_pre_action 14:15:29 INFO - Running main action method: download_and_extract 14:15:29 INFO - mkdir: /builds/slave/test/build/tests 14:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:29 INFO - https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:30 INFO - Downloaded 1361 bytes. 14:15:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:30 INFO - Using the following test package requirements: 14:15:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:15:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'jsshell-linux-x86_64.zip'], 14:15:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:15:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:15:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:30 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')]} 14:15:30 INFO - https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:31 INFO - Downloaded 24413197 bytes. 14:15:31 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'] 14:15:31 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 14:15:32 INFO - Return code: 0 14:15:32 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 14:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:32 INFO - https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:33 INFO - Downloaded 24413197 bytes. 14:15:33 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'] 14:15:33 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 14:15:35 INFO - Return code: 0 14:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:35 INFO - https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:36 INFO - Downloaded 10834055 bytes. 14:15:36 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'] 14:15:36 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 14:15:36 INFO - Return code: 0 14:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:36 INFO - https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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 14:15:37 INFO - Downloaded 58974497 bytes. 14:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:37 INFO - mkdir: /builds/slave/test/properties 14:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:37 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:37 INFO - Contents: 14:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:38 INFO - Running post-action listener: _resource_record_post_action 14:15:38 INFO - Running post-action listener: set_extra_try_arguments 14:15:38 INFO - ##### 14:15:38 INFO - ##### Finished download-and-extract step (success) 14:15:38 INFO - ##### 14:15:38 INFO - ##### 14:15:38 INFO - ##### Running populate-webroot step. 14:15:38 INFO - ##### 14:15:38 INFO - Running pre-action listener: _resource_record_pre_action 14:15:38 INFO - Running main action method: populate_webroot 14:15:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:38 INFO - '--tppagecycles', 14:15:38 INFO - '7'], 14:15:38 INFO - 'tests': ['tsvgm']}}, 14:15:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['damp', 'tps']}, 14:15:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'tests': ['damp', 'tps']}, 14:15:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['dromaeo_dom']}, 14:15:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tsvgx', 14:15:38 INFO - 'tsvgr_opacity', 14:15:38 INFO - 'tart', 14:15:38 INFO - 'tscrollx', 14:15:38 INFO - 'cart']}, 14:15:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:38 INFO - 'tsvgr_opacity', 14:15:38 INFO - 'tart', 14:15:38 INFO - 'tscrollx', 14:15:38 INFO - 'cart']}, 14:15:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tp5o']}, 14:15:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'tests': ['tp5o']}, 14:15:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s', 14:15:38 INFO - '--xperf_path', 14:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:38 INFO - 'tests': ['tp5n']}, 14:15:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:38 INFO - 'talos_options': ['--xperf_path', 14:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:38 INFO - 'tests': ['tp5n']}}, 14:15:38 INFO - 'talos.zip': {'path': '', 14:15:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:38 INFO - Running post-action listener: _resource_record_post_action 14:15:38 INFO - ##### 14:15:38 INFO - ##### Finished populate-webroot step (success) 14:15:38 INFO - ##### 14:15:38 INFO - ##### 14:15:38 INFO - ##### Running create-virtualenv step. 14:15:38 INFO - ##### 14:15:38 INFO - Running pre-action listener: _resource_record_pre_action 14:15:38 INFO - Running main action method: create_virtualenv 14:15:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:38 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 14:15:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:38 INFO - Using real prefix '/usr' 14:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:41 INFO - Installing pip.................done. 14:15:41 INFO - Return code: 0 14:15:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:41 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')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'DISPLAY': ':0', 14:15:41 INFO - 'HOME': '/home/cltbld', 14:15:41 INFO - 'LANG': 'en_US.UTF-8', 14:15:41 INFO - 'LANGUAGE': 'en_US:en', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MAIL': '/var/mail/cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SHLVL': '1', 14:15:41 INFO - 'TERM': 'linux', 14:15:41 INFO - 'TMOUT': '86400', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - '_': '/tools/buildbot/bin/python'} 14:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:41 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 14:15:41 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15:41 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')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'DISPLAY': ':0', 14:15:41 INFO - 'HOME': '/home/cltbld', 14:15:41 INFO - 'LANG': 'en_US.UTF-8', 14:15:41 INFO - 'LANGUAGE': 'en_US:en', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MAIL': '/var/mail/cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SHLVL': '1', 14:15:41 INFO - 'TERM': 'linux', 14:15:41 INFO - 'TMOUT': '86400', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - '_': '/tools/buildbot/bin/python'} 14:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:41 INFO - Downloading/unpacking psutil>=3.1.1 14:15:41 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 14:15:41 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 14:15:41 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 14:15:41 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 14:15:41 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 14:15:41 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 14:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:43 INFO - Installing collected packages: psutil 14:15:43 INFO - Running setup.py install for psutil 14:15:43 INFO - building 'psutil._psutil_linux' extension 14:15:43 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 14:15:43 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 14:15:43 INFO - building 'psutil._psutil_posix' extension 14:15:43 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 14:15:43 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 14:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:44 INFO - Successfully installed psutil 14:15:44 INFO - Cleaning up... 14:15:44 INFO - Return code: 0 14:15:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:15:44 INFO - Using env: {'DISPLAY': ':0', 14:15:44 INFO - 'HOME': '/home/cltbld', 14:15:44 INFO - 'LANG': 'en_US.UTF-8', 14:15:44 INFO - 'LANGUAGE': 'en_US:en', 14:15:44 INFO - 'LOGNAME': 'cltbld', 14:15:44 INFO - 'MAIL': '/var/mail/cltbld', 14:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:44 INFO - 'MOZ_NO_REMOTE': '1', 14:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:44 INFO - 'NO_EM_RESTART': '1', 14:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:44 INFO - 'PWD': '/builds/slave/test', 14:15:44 INFO - 'SHELL': '/bin/bash', 14:15:44 INFO - 'SHLVL': '1', 14:15:44 INFO - 'TERM': 'linux', 14:15:44 INFO - 'TMOUT': '86400', 14:15:44 INFO - 'USER': 'cltbld', 14:15:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:44 INFO - '_': '/tools/buildbot/bin/python'} 14:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:46 INFO - Installing collected packages: mozsystemmonitor 14:15:46 INFO - Running setup.py install for mozsystemmonitor 14:15:46 INFO - Successfully installed mozsystemmonitor 14:15:46 INFO - Cleaning up... 14:15:46 INFO - Return code: 0 14:15:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:15:46 INFO - Using env: {'DISPLAY': ':0', 14:15:46 INFO - 'HOME': '/home/cltbld', 14:15:46 INFO - 'LANG': 'en_US.UTF-8', 14:15:46 INFO - 'LANGUAGE': 'en_US:en', 14:15:46 INFO - 'LOGNAME': 'cltbld', 14:15:46 INFO - 'MAIL': '/var/mail/cltbld', 14:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:46 INFO - 'MOZ_NO_REMOTE': '1', 14:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:46 INFO - 'NO_EM_RESTART': '1', 14:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:46 INFO - 'PWD': '/builds/slave/test', 14:15:46 INFO - 'SHELL': '/bin/bash', 14:15:46 INFO - 'SHLVL': '1', 14:15:46 INFO - 'TERM': 'linux', 14:15:46 INFO - 'TMOUT': '86400', 14:15:46 INFO - 'USER': 'cltbld', 14:15:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:46 INFO - '_': '/tools/buildbot/bin/python'} 14:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:48 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 14:15:48 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 14:15:48 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 14:15:48 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 14:15:48 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 14:15:48 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 14:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:49 INFO - Downloading docopt-0.6.1.tar.gz 14:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:49 INFO - Running setup.py install for blobuploader 14:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:49 INFO - Running setup.py install for requests 14:15:49 INFO - Running setup.py install for docopt 14:15:49 INFO - Successfully installed blobuploader requests docopt 14:15:49 INFO - Cleaning up... 14:15:49 INFO - Return code: 0 14:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:49 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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:49 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 14:15:49 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 14:15:49 INFO - Using env: {'DISPLAY': ':0', 14:15:49 INFO - 'HOME': '/home/cltbld', 14:15:49 INFO - 'LANG': 'en_US.UTF-8', 14:15:49 INFO - 'LANGUAGE': 'en_US:en', 14:15:49 INFO - 'LOGNAME': 'cltbld', 14:15:49 INFO - 'MAIL': '/var/mail/cltbld', 14:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:49 INFO - 'MOZ_NO_REMOTE': '1', 14:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:49 INFO - 'NO_EM_RESTART': '1', 14:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:49 INFO - 'PWD': '/builds/slave/test', 14:15:49 INFO - 'SHELL': '/bin/bash', 14:15:49 INFO - 'SHLVL': '1', 14:15:49 INFO - 'TERM': 'linux', 14:15:49 INFO - 'TMOUT': '86400', 14:15:49 INFO - 'USER': 'cltbld', 14:15:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:49 INFO - '_': '/tools/buildbot/bin/python'} 14:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:50 INFO - Running setup.py (path:/tmp/pip-g8qh3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:50 INFO - Running setup.py (path:/tmp/pip-iWnZQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:50 INFO - Running setup.py (path:/tmp/pip-fuOMqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:50 INFO - Running setup.py (path:/tmp/pip-9ZPtFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:50 INFO - Running setup.py (path:/tmp/pip-nD7caz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:50 INFO - Running setup.py (path:/tmp/pip-YpUuuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:50 INFO - Running setup.py (path:/tmp/pip-fe08cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:50 INFO - Running setup.py (path:/tmp/pip-ttiztZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:50 INFO - Running setup.py (path:/tmp/pip-_0IZjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:50 INFO - Running setup.py (path:/tmp/pip-6SwnxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:50 INFO - Running setup.py (path:/tmp/pip-znKWvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:50 INFO - Running setup.py (path:/tmp/pip-45nOl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:50 INFO - Running setup.py (path:/tmp/pip-YglbAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:51 INFO - Running setup.py (path:/tmp/pip-N7u01D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:51 INFO - Running setup.py (path:/tmp/pip-HWOOkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:51 INFO - Running setup.py (path:/tmp/pip-gTJDDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:51 INFO - Running setup.py (path:/tmp/pip-BcVJAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:51 INFO - Running setup.py install for manifestparser 14:15:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:51 INFO - Running setup.py install for mozcrash 14:15:51 INFO - Running setup.py install for mozdebug 14:15:51 INFO - Running setup.py install for mozdevice 14:15:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:51 INFO - Running setup.py install for mozfile 14:15:51 INFO - Running setup.py install for mozhttpd 14:15:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:51 INFO - Running setup.py install for mozinfo 14:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozInstall 14:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozleak 14:15:52 INFO - Running setup.py install for mozlog 14:15:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for moznetwork 14:15:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozprocess 14:15:52 INFO - Running setup.py install for mozprofile 14:15:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozrunner 14:15:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozscreenshot 14:15:52 INFO - Running setup.py install for moztest 14:15:53 INFO - Running setup.py install for mozversion 14:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:53 INFO - Cleaning up... 14:15:53 INFO - Return code: 0 14:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:53 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')]} 14:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:53 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')]} 14:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:53 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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:53 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 14:15:53 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 14:15:53 INFO - Using env: {'DISPLAY': ':0', 14:15:53 INFO - 'HOME': '/home/cltbld', 14:15:53 INFO - 'LANG': 'en_US.UTF-8', 14:15:53 INFO - 'LANGUAGE': 'en_US:en', 14:15:53 INFO - 'LOGNAME': 'cltbld', 14:15:53 INFO - 'MAIL': '/var/mail/cltbld', 14:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:53 INFO - 'MOZ_NO_REMOTE': '1', 14:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:53 INFO - 'NO_EM_RESTART': '1', 14:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:53 INFO - 'PWD': '/builds/slave/test', 14:15:53 INFO - 'SHELL': '/bin/bash', 14:15:53 INFO - 'SHLVL': '1', 14:15:53 INFO - 'TERM': 'linux', 14:15:53 INFO - 'TMOUT': '86400', 14:15:53 INFO - 'USER': 'cltbld', 14:15:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:53 INFO - '_': '/tools/buildbot/bin/python'} 14:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:53 INFO - Running setup.py (path:/tmp/pip-I41xR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:53 INFO - Running setup.py (path:/tmp/pip-YmJ6je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:53 INFO - Running setup.py (path:/tmp/pip-MyewzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:53 INFO - Running setup.py (path:/tmp/pip-Ikr07A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:53 INFO - Running setup.py (path:/tmp/pip-TG6XZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:53 INFO - Running setup.py (path:/tmp/pip-7VP1v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:53 INFO - Running setup.py (path:/tmp/pip-0lcm4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:53 INFO - Running setup.py (path:/tmp/pip-DQYtgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:53 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)) 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:53 INFO - Running setup.py (path:/tmp/pip-roG2XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:54 INFO - Running setup.py (path:/tmp/pip-rgqy1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:54 INFO - Running setup.py (path:/tmp/pip-wpdJwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:54 INFO - Running setup.py (path:/tmp/pip-0ebvQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:54 INFO - Running setup.py (path:/tmp/pip-5mxonf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:54 INFO - Running setup.py (path:/tmp/pip-v2_iH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:54 INFO - Running setup.py (path:/tmp/pip-P2G3Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:54 INFO - Running setup.py (path:/tmp/pip-8C0EgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:54 INFO - Running setup.py (path:/tmp/pip-j6lKnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:54 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 14:15:54 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 14:15:54 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 14:15:54 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 14:15:54 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 14:15:54 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 14:15:56 INFO - Downloading blessings-1.6.tar.gz 14:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:56 INFO - Installing collected packages: blessings 14:15:56 INFO - Running setup.py install for blessings 14:15:56 INFO - Successfully installed blessings 14:15:56 INFO - Cleaning up... 14:15:56 INFO - Return code: 0 14:15:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:56 INFO - Reading from file tmpfile_stdout 14:15:56 INFO - Current package versions: 14:15:56 INFO - argparse == 1.2.1 14:15:56 INFO - blessings == 1.6 14:15:56 INFO - blobuploader == 1.2.4 14:15:56 INFO - docopt == 0.6.1 14:15:56 INFO - manifestparser == 1.1 14:15:56 INFO - mozInstall == 1.12 14:15:56 INFO - mozcrash == 0.17 14:15:56 INFO - mozdebug == 0.1 14:15:56 INFO - mozdevice == 0.48 14:15:56 INFO - mozfile == 1.2 14:15:56 INFO - mozhttpd == 0.7 14:15:56 INFO - mozinfo == 0.9 14:15:56 INFO - mozleak == 0.1 14:15:56 INFO - mozlog == 3.2 14:15:56 INFO - moznetwork == 0.27 14:15:56 INFO - mozprocess == 0.22 14:15:56 INFO - mozprofile == 0.28 14:15:56 INFO - mozrunner == 6.11 14:15:56 INFO - mozscreenshot == 0.1 14:15:56 INFO - mozsystemmonitor == 0.3 14:15:56 INFO - moztest == 0.7 14:15:56 INFO - mozversion == 1.4 14:15:56 INFO - psutil == 3.1.1 14:15:56 INFO - requests == 1.2.3 14:15:56 INFO - wsgiref == 0.1.2 14:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:56 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')]} 14:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:56 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')]} 14:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:56 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 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:56 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 14:15:56 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 14:15:56 INFO - Using env: {'DISPLAY': ':0', 14:15:56 INFO - 'HOME': '/home/cltbld', 14:15:56 INFO - 'LANG': 'en_US.UTF-8', 14:15:56 INFO - 'LANGUAGE': 'en_US:en', 14:15:56 INFO - 'LOGNAME': 'cltbld', 14:15:56 INFO - 'MAIL': '/var/mail/cltbld', 14:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:56 INFO - 'MOZ_NO_REMOTE': '1', 14:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:56 INFO - 'NO_EM_RESTART': '1', 14:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:56 INFO - 'PWD': '/builds/slave/test', 14:15:56 INFO - 'SHELL': '/bin/bash', 14:15:56 INFO - 'SHLVL': '1', 14:15:56 INFO - 'TERM': 'linux', 14:15:56 INFO - 'TMOUT': '86400', 14:15:56 INFO - 'USER': 'cltbld', 14:15:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:56 INFO - '_': '/tools/buildbot/bin/python'} 14:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 INFO - Cleaning up... 14:15:57 INFO - Return code: 0 14:15:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:15:57 INFO - Using env: {'DISPLAY': ':0', 14:15:57 INFO - 'HOME': '/home/cltbld', 14:15:57 INFO - 'LANG': 'en_US.UTF-8', 14:15:57 INFO - 'LANGUAGE': 'en_US:en', 14:15:57 INFO - 'LOGNAME': 'cltbld', 14:15:57 INFO - 'MAIL': '/var/mail/cltbld', 14:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:57 INFO - 'MOZ_NO_REMOTE': '1', 14:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:57 INFO - 'NO_EM_RESTART': '1', 14:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:57 INFO - 'PWD': '/builds/slave/test', 14:15:57 INFO - 'SHELL': '/bin/bash', 14:15:57 INFO - 'SHLVL': '1', 14:15:57 INFO - 'TERM': 'linux', 14:15:57 INFO - 'TMOUT': '86400', 14:15:57 INFO - 'USER': 'cltbld', 14:15:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:57 INFO - '_': '/tools/buildbot/bin/python'} 14:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:57 INFO - Downloading/unpacking jsonschema 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:59 INFO - Downloading/unpacking functools32 (from jsonschema) 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:59 INFO - warning: no files found matching '*.txt' 14:15:59 INFO - no previously-included directories found matching 'build' 14:15:59 INFO - no previously-included directories found matching 'dist' 14:15:59 INFO - no previously-included directories found matching '.git*' 14:15:59 INFO - Installing collected packages: jsonschema, functools32 14:15:59 INFO - Running setup.py install for functools32 14:15:59 INFO - warning: no files found matching '*.txt' 14:15:59 INFO - no previously-included directories found matching 'build' 14:15:59 INFO - no previously-included directories found matching 'dist' 14:15:59 INFO - no previously-included directories found matching '.git*' 14:15:59 INFO - Successfully installed jsonschema functools32 14:15:59 INFO - Cleaning up... 14:15:59 INFO - Return code: 0 14:15:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86340df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', '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 14:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:15:59 INFO - Using env: {'DISPLAY': ':0', 14:15:59 INFO - 'HOME': '/home/cltbld', 14:15:59 INFO - 'LANG': 'en_US.UTF-8', 14:15:59 INFO - 'LANGUAGE': 'en_US:en', 14:15:59 INFO - 'LOGNAME': 'cltbld', 14:15:59 INFO - 'MAIL': '/var/mail/cltbld', 14:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:59 INFO - 'MOZ_NO_REMOTE': '1', 14:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:59 INFO - 'NO_EM_RESTART': '1', 14:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:59 INFO - 'PWD': '/builds/slave/test', 14:15:59 INFO - 'SHELL': '/bin/bash', 14:15:59 INFO - 'SHLVL': '1', 14:15:59 INFO - 'TERM': 'linux', 14:15:59 INFO - 'TMOUT': '86400', 14:15:59 INFO - 'USER': 'cltbld', 14:15:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:00 INFO - Downloading/unpacking flake8 14:16:00 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 14:16:00 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 14:16:00 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 14:16:00 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 14:16:00 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 14:16:00 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 14:16:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:16:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:16:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:16:02 INFO - no previously-included directories found matching 'docs/_build' 14:16:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:16:02 INFO - Running setup.py install for pep8 14:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:16:02 INFO - no previously-included directories found matching 'docs/_build' 14:16:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:16:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:16:02 INFO - Cleaning up... 14:16:02 INFO - Return code: 0 14:16:02 INFO - Running post-action listener: _resource_record_post_action 14:16:02 INFO - Running post-action listener: _start_resource_monitoring 14:16:02 INFO - Starting resource monitoring. 14:16:02 INFO - ##### 14:16:02 INFO - ##### Finished create-virtualenv step (success) 14:16:02 INFO - ##### 14:16:02 INFO - ##### 14:16:02 INFO - ##### Running install step. 14:16:02 INFO - ##### 14:16:02 INFO - Running pre-action listener: _resource_record_pre_action 14:16:02 INFO - Running main action method: install 14:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:03 INFO - Reading from file tmpfile_stdout 14:16:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:03 INFO - Reading from file tmpfile_stdout 14:16:03 INFO - Output received: 14:16:03 INFO - Usage: mozinstall [options] installer 14:16:03 INFO - Options: 14:16:03 INFO - -h, --help show this help message and exit 14:16:03 INFO - -d DEST, --destination=DEST 14:16:03 INFO - Directory to install application into. [default: 14:16:03 INFO - "/builds/slave/test"] 14:16:03 INFO - --app=APP Application being installed. [default: firefox] 14:16:03 INFO - mkdir: /builds/slave/test/build/application 14:16:03 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'] 14:16:03 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 14:16:19 INFO - Reading from file tmpfile_stdout 14:16:19 INFO - Output received: 14:16:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:16:19 INFO - Running post-action listener: _resource_record_post_action 14:16:19 INFO - ##### 14:16:19 INFO - ##### Finished install step (success) 14:16:19 INFO - ##### 14:16:19 INFO - ##### 14:16:19 INFO - ##### Running run-tests step. 14:16:19 INFO - ##### 14:16:19 INFO - Running pre-action listener: _resource_record_pre_action 14:16:19 INFO - Running main action method: run_tests 14:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:19 INFO - Python 2.7.3 14:16:19 INFO - Return code: 0 14:16:19 INFO - grabbing minidump binary from tooltool 14:16: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')]} 14:16:19 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 0xf159c0>, '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 0xf168c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:19 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 14:16:19 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 14:16:19 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 14:16:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:20 INFO - Return code: 0 14:16:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:16:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:16:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:16:20 INFO - Return code: 0 14:16:20 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/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 14:16:20 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/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 14:16:20 INFO - Using env: {'DISPLAY': ':0', 14:16:20 INFO - 'HOME': '/home/cltbld', 14:16:20 INFO - 'LANG': 'en_US.UTF-8', 14:16:20 INFO - 'LANGUAGE': 'en_US:en', 14:16:20 INFO - 'LOGNAME': 'cltbld', 14:16:20 INFO - 'MAIL': '/var/mail/cltbld', 14:16:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:20 INFO - 'MOZ_NO_REMOTE': '1', 14:16:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:20 INFO - 'NO_EM_RESTART': '1', 14:16:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:20 INFO - 'PWD': '/builds/slave/test', 14:16:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:20 INFO - 'SHELL': '/bin/bash', 14:16:20 INFO - 'SHLVL': '1', 14:16:20 INFO - 'TERM': 'linux', 14:16:20 INFO - 'TMOUT': '86400', 14:16:20 INFO - 'USER': 'cltbld', 14:16:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203', 14:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:20 INFO - '_': '/tools/buildbot/bin/python'} 14:16:20 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/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 14:16:21 INFO - mozversion application_buildid: 20160531113028 14:16:21 INFO - mozversion application_changeset: 77fe72f30c9211b72235b099fb131bdbf98e7900 14:16:21 INFO - mozversion application_display_name: Nightly 14:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:21 INFO - mozversion application_name: Firefox 14:16:21 INFO - mozversion application_remotingname: firefox 14:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:16:21 INFO - mozversion application_vendor: Mozilla 14:16:21 INFO - mozversion application_version: 49.0a1 14:16:21 INFO - mozversion platform_buildid: 20160531113028 14:16:21 INFO - mozversion platform_changeset: 77fe72f30c9211b72235b099fb131bdbf98e7900 14:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:16:21 INFO - mozversion platform_version: 49.0a1 14:16:21 INFO - using testdate: 1464729381 14:16:21 INFO - actual date: 1464729381 14:16:21 INFO - starting webserver on 'localhost:52678' 14:16:21 INFO - SUITE-START | Running 2 tests 14:16:21 INFO - TEST-START | dromaeo_css 14:16:21 INFO - operating with platform_type : linux_ 14:16:21 INFO - Initialising browser for dromaeo_css test... 14:16:21 INFO - TEST-INFO | started process 11524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3W_70/profile http://localhost:52678/getInfo.html) 14:16:25 INFO - PROCESS | 11524 | __metrics Screen width/height:1600/1200 14:16:25 INFO - PROCESS | 11524 | colorDepth:24 14:16:25 INFO - PROCESS | 11524 | Browser inner width/height: 1024/697 14:16:25 INFO - PROCESS | 11524 | __metrics 14:16:26 ERROR - PROCESS | 11524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:16:26 INFO - TEST-INFO | 11524: exit 0 14:16:26 INFO - Browser initialized. 14:16:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:26 INFO - TEST-INFO | started process 11606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3W_70/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:38 INFO - PROCESS | 11606 | RSS: Main: 155566080 14:16:38 INFO - PROCESS | 11606 | 14:17:30 INFO - PROCESS | 11606 | 1464729450088 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] 14:19:37 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52678/tests/dromaeo/cssquery-ext.html) 14:19:39 INFO - PROCESS | 11606 | RSS: Main: 290312192 14:19:39 INFO - PROCESS | 11606 | 14:22:41 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-ext.html (next: http://localhost:52678/tests/dromaeo/cssquery-jquery.html) 14:22:42 INFO - PROCESS | 11606 | RSS: Main: 238587904 14:22:42 INFO - PROCESS | 11606 | 14:25:44 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52678/tests/dromaeo/cssquery-mootools.html) 14:25:44 INFO - PROCESS | 11606 | RSS: Main: 249053184 14:25:44 INFO - PROCESS | 11606 | 14:28:47 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52678/tests/dromaeo/cssquery-prototype.html) 14:28:47 INFO - PROCESS | 11606 | RSS: Main: 240304128 14:28:47 INFO - PROCESS | 11606 | 14:31:50 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52678/tests/dromaeo/cssquery-yui.html) 14:31:50 INFO - PROCESS | 11606 | RSS: Main: 227532800 14:31:50 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-yui.html (next: http://localhost:52678/tests/dromaeo/cssquery-dojo.html) 14:34:53 INFO - PROCESS | 11606 | RSS: Main: 273899520 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | __start_tp_report 14:34:53 INFO - PROCESS | 11606 | _x_x_mozilla_page_load 14:34:53 INFO - PROCESS | 11606 | _x_x_mozilla_page_load_details 14:34:53 INFO - PROCESS | 11606 | |i|pagename|runs| 14:34:53 INFO - PROCESS | 11606 | |0;dojo.html;3121.5317702344646;3146.5909431773853;3157.842107894605;3188.665190155032;3211.3095684427844;5326.760295786689;5383.488568585988;5390.353157621091;5485.6434331768405;5509.972450137749;5410.161424979125;5437.966786310598;5484.808031718891;5546.140348246018;5551.750171242294;4853.805847766085;4878.926816097762;4894.1679914414635;4917.336159618441;4938.876528086791;5005.324281222043;5031.496850314976;5037.546620804127;5054.064997975368;5060.139776238048;4807.711537307738;4958.281049247875;5000.124978128831;5007.649464537502;5028.899422011557;4782.880427989293;4789.928151077736;4819.7108173509705;4831.4685384607665;4834.879128021792;4791.448983366922;4847.903041939177;4871.342368780205;4888.902221955576;4924.064427758714;5159.22611608258;5200.557952574036;5321.388040375329;5363.919541206885;5367.704776237305;5760.510356619692;5831.970840145815;5876.353601103875;5881.117832325142;5883.8529036774;5783.306003279633;5831.183634291203;5832.329282132524;5833.474987251126;5840.532757379442;5224.138017227153;5299.5230429261555;5397.163439666858;5422.6475279106735;5435.347758268994;5983.551233657406;5987.5808693391045;5990.430909063632;5997.460228579449;6000.789972350947;5711.600187986801;5714.200011998323;5716.456936591017;5716.542676585863;5721.113227449752;5681.545476361881;5692.459216374438;5782.884342313214;5818.854528636818;5838.8540286492325;5751.798687045934;5815.360310365856;5816.47651711348;5827.5920685552455;5830.854228644318;5633.57748168889;5676.233708449389;5710.828675139753;5721.456461636138;5785.566082543826;4273.594008569181;4303.978480107579;4316.330968699856;4347.608715215646;4383.925938145111;3865.362215234511;3873.3028054949814;3882.378819388884;3914.725969182187;3915.6280153385383;5276.604254680914;5348.866278343073;5363.302770639792;5364.114921038063;5364.704941228192;5766;5856.209411729447;5860.853478663067;5887.499562537147;5888.587798854039;5407.729613519308;5414.214938833847;5426.8914621707345;5453.563714902878;5474.09677403224;4873.829415970424;4956.5786908112495;4962.776675049631;4977.701337919736;5029.622778291643;5930.762769489172;5932.347441781487;5944.554158438134;5945.554083443672;6081.087836824512;5787.710614469175;5825.883482330414;5828.6502809831545;5831.825045248649;5832.737526811219;5835.153902684172;5970.671613061323;6009.06859436788;6020.277566692025;6030.427109424598;5744.798932037359;5765.250517432707;5767.5674324425;5772.94227057724;5814.883702325845;5822.272215973004;5866.67733274674;5874.823755287348;5880.50015748649;5889.587728858939;5564.554835613222;5663.122216056518;5732.111522713819;5733.483986441241;5751.079827227623;5658.915116273177;5660.801871934463;5666.518345940642;5666.744996475086;5673.602847800615;5494.313210848644;5539.058360078877;5545;5547.61166718342;5548.195511650869;5558.861028474321;5586.664800112007;5607.915881261702;5682.857928551819;5700.173474846207;5527.115661494142;5591.245181900392;5612.186232996274;5629.8592535186945;5630.2680651516675 14:34:53 INFO - PROCESS | 11606 | |1;ext.html;571.4942276085663;617.7590739611552;621.415869083062;622.7011034703343;624.896892012818;43105.13789724208;44761.77619111908;44765;44812.999999999956;47786.28320575194;45748.542514574925;46423.76788116063;46428.53571464284;46445.30332045022;46469.76765116178;8076.353891688651;8833.42582732122;9019.729408117766;10493.737656558571;10738.463076846165;10582;10726.517306721178;10742.248042637018;10743.677689669323;10744.838827417596;10779.407132607703;10831.83752243717;10837.67486975388;10842.403667798268;10849.294795838245;8162.265396114349;10753.301035432673;10987.340759554452;11008.669739907815;11010.119190464824;10402;10481.266311358208;10512.369257844553;10755.569777208902;10758.300710453874;42997.78501107506;43522.347164792554;43547.56452435467;43569.34645980313;43638.78180609109;3519.771214871025;3532.381833179209;3926.312895243321;4296.076343586144;4390;30549.847250763603;33512;34098.31803363919;34215.4867676985;34272.48591271133;4261.403403523509;4294.119705460374;4301.698881078326;4475.328700694889;4478.350639157304;369042;373020;373110.99999999726;373225;374059;35757.46363804545;36707.4493882592;65180.67409662921;65763.34236657667;66073;36273.45589816155;36358;36379.636203638154;36444.45333320002;36503.634963650555;14348.49780257686;15569.766453503207;15686.137262450675;15691.764623530657;15696;11870;11954.462049207807;11999.520019199133;12329.321887296284;12330.136890417763;8527.872081918777;8563.785905352292;8592.5703714814;8607.61265743043;8654.177853103945;3326.2183386904057;3326.850291736878;3354.3962086824117;3363.7645364824716;3385.579310792795;972.3533849989677;974.5955428497094;1054.4253381906879;1097.0801098078364;1141.7316930521322;29880.662554329207;32466.83766581152;32562;32562.67437325644;32610.67389326124;1143.1312202725987;1184.5676328140166;1203.5546847666244;1241.76406482768;1286.4789760147155;17104.0592767399;17403.73894391585;17468.301267949395;17494.737578936325;17542.473725788248;543137;547064;548416;548511;550268;60917;61150;61480.69259653673;61637.69181154066;61684;1264.6016504801141;1335.732853429318;1341.0478560222157;1361.5574938145141;1399.3143359753851;32874.67125328716;33759.83120084384;34175.82912085523;34329.65670343365;34462.48306275358;52909.735451324035;53569.46430535645;53718;53771.19343209933;53783.462165377845;457416;457958;461600;464430;466124;37607.62392376041;42754.144917100864;43031.569684302754;44140.33789493224;44321.778391109125;48895.266571002176;48976.2653560204;49493;49755.75122124511;50515.49484505108;39475.80262098671;41432;42626;43547.34678979881;44224.33663495114;41942;42516;42712;43424.56575434205;43547.34678979754;41433.37849932193;41983.790081049396;42097.158056839304;42392.788036059625;44514;33771.324573508886;36909.81545092257;38017.2396552073;39041.414378783775;39505.407418889314;28286.10984770837;28493.430131397672;28659.283517911386;28722.856385718773;28930.855345723136 14:34:53 INFO - PROCESS | 11606 | |2;jquery.html;378.89580365399513;383.7869982159902;398.4600865826806;400.0518770513882;411.717973188366;17958;18370.44888653339;20295.782253064826;20299.955006748994;20302.796972030275;11851.051915846732;12115.27308361499;12144.878551214486;12148.149629525937;16712.83287167128;5133.486651334864;5256.526912577867;5271.28837606922;5289.735513224343;5295.179247216668;3900.9219815603815;5192.506711862367;5470.070088085015;5493.945060549403;5616.466435688603;5484.875600501908;5541.501264886159;5555.30558680165;5564.638298510604;5599.384067752544;5405.405405405402;5525.696086715229;5541.085720856054;5554.666719996813;5560.833175004756;3817.10298079951;4007.7996100195164;4011.7191796574252;5312.256284120188;5642.858928526779;12694.365281735876;13347.532836350681;13649.863501364958;13656.590302290848;13697.246651434167;2270.1260014894383;2286.7255929288426;2365.3258821236036;3131.170239886432;3267.18320419895;15015.624609384744;15567.45513907019;15786.131762753044;16151.515454536382;16217.837821621752;1910.1881700277327;2044.4377796106041;2056.4139220322136;2068.162394230339;2079.5944790765807;93735;94290.99999999932;96682.51658741661;96931.51534242355;98073.5096324521;16944;17464.5633859152;17489.7376539352;17501.562460938578;18084.27662893496;31788.364232715216;31872.362552748815;32415.351692966007;32444.675553244637;32483.18792030218;9786.1192492676;9897.703068907944;10003.599856005823;10286.228532860065;10464.476776161313;8434.957825210835;8573.442726222776;8602.268807151337;8666.6100025499;8753.037165911745;8939.374243802871;9034.412763170372;9044.547772611342;9093.590788414538;9202.309826762885;2718.660167479065;3284.6058472983395;3476.443768996948;3518.876839310663;3532.593751718534;868.3877866104508;1001.3641337750581;1018.765683892694;1026.6868605075374;1062.718379629399;18620.16209270586;18657.90671046636;18883.716744248846;18933.52666183329;19326.32357867496;973.9464329461806;1018.1701912940929;1034.5551412892378;1045.1220974381404;1062.9362238265728;10218.824835143905;10670.093042091354;10744.462776861126;10757.683526737523;10761.784764304826;462531;469809;481365;481566;487715;90534;92205.53897230471;92471.53764231136;92496.53751731198;92790.53604731933;997.5959736306952;1002.4436437776958;1012.8581998520214;1017.1252722658508;1049.8897615750388;16453.753193701865;16538.09040502784;16752;16868.831311686725;17096.145192740063;38341.616583833806;38394.616053839105;39257.2148557033;40615.18769624532;42378.15243695047;54394.72802635962;56677;57732;57821;58100;8349.37187248505;8431.15688431152;8652.697155599524;8948.015718271115;8968.910310896808;12463.688407789878;13006.80489792635;13275.86724132785;13590.59228223155;13633.454661813814;11038.889611103787;11144.498497567467;11268.661940141808;11405.942970285096;11552.364619945984;11508.36703981289;11580.826287605862;11699.941500292443;11882.168248222888;11928.582499612472;11687.532498700297;11860.762784744084;11967.461464233957;12355.876441235472;12370.13409061393;8428.704995325133;8521.488710677379;8625.741227763177;8892.68875589377;8901.154390332907;8960.238379737795;11111.666650000512;12015.579454719043;12130.636080917586;12132 14:34:53 INFO - PROCESS | 11606 | |3;mootools.html;1331.0483004651671;1395.2535393564444;1413.936372863221;1421.495369143954;1469.5003698742428;8549.57252137393;8848.690295839648;8888.06675299094;9054.637814487429;9070.546472676357;8789.956050219756;8989.280857531397;9006.549672516381;9012.54937253138;9014.188723014928;2073.3779866040204;2344.2264052862515;2356.57581635306;2392.5334559760768;2421.1041914491575;2407.121400688745;2419.927402177929;2423.248792874215;2423.273018094573;2425.0784701813286;2388.904443822245;2401.1235898896953;2423.7091549014053;2424.696912885889;2429.441228517442;1982.8413726901813;2192.090282532747;2248.4940888300166;2251.0658076898067;2261.5137745384823;2264.909403623853;2270.852394594346;2284.246198754407;2285.691431656738;2287.565362581121;8683.348748843862;8800.559972001374;8802.38383313162;8815.118488151198;8820.073892241351;5253.238280449314;5447.836564903059;5458.372287186985;5459.563234941195;5460.945390546083;3334.699877011081;3350.2461946062185;3378.1385746634696;3388.40702876998;3437.346904088215;1075.9408232547207;1097.5554900265406;1105.6793529876327;1122.6183097746723;1128.2046157459054;12924.289164095972;12933;12939.288339141438;12949.805752913713;12961.675958101123;4734.405434240027;4778.1399348117675;4783.306420568998;4794;4861.270809378621;10538.262321637412;10596.205284603531;10632.840507392395;10660.09389201911;10681.893181068246;5377.354717433855;5414.945850541523;5463.754131064112;5464;5465.453454654503;4489.057297967398;4820.734859582686;4960.603151747924;4979.775910084055;5020.723860187652;4109.239790638741;4169.708120431601;4199.958000420018;4234.449521562239;4251.107267473803;1274.3628185907046;1286.9935650321688;1296.8508621508458;1305.8237137986441;1307.1895424836473;964.1467301438138;1000.8348622477209;1005.2812239248972;1011.4790882695418;1019.9796004079877;6035.185249991195;6059.787907423219;6116.204893363834;6117.265928088569;6122.479589234965;433.63574597338385;441.66433510532227;444.5310197741349;446.4174252600323;447.6485958522544;4149.605787450188;4173.123644034726;4250.681198910094;4283.935740963888;4335.154644844288;10991;11379;11394.94302528482;11405.543778248943;11449.313041217554;10599.099076578577;10985;11007.669769906915;11328.830067548994;11345.319280843176;8226.465279756796;8339.166083391612;8363.247307742333;8370.246677799027;8382.245597896219;6101.450869421773;6220.564560480723;6287.874242515216;6322.399372059647;6327.557071004985;10292.588296468057;10510.421926794099;10563.471826408495;10643.414612196404;10662.680119596425;10794.16499195123;10830;10892.564297428331;10942.398168100512;10953.726156846142;7322.743703970335;7875;8010.919890801018;8099;8147.1038185798325;8811.867821982547;8867.91132088671;8918.554072296229;8937.28501719848;8937.374383793072;7762.146163922077;7819.218078192135;7869.0950540688555;7885.6451459685595;8061;7436.405087593088;7500.587467689111;7519.586422746583;7609.429292802951;7652.846943061219;6921.169459664872;6949.930500695131;6976.372126508639;6988.301169882971;6999.615021173884;4842.854714358575;4989.501049894981;5121.052605268037;5175.353080864892;5192.402873669425;5331.200319952039;5339.172428273624;5341.65279256847;5392.272043274264;5466 14:34:53 INFO - PROCESS | 11606 | |4;prototype.html;320.94543927532317;329.9620543637481;332.54939556900416;334.55170072103374;338.09896625493064;5339.8398048058525;5404.486573775485;5408.486193811592;5432.402435732071;5441;5230.686158830473;5309.230161626562;5331.653442526233;5343.492368225013;5365.873166635011;3954.307996100685;4037.0916543777707;4141.171765646867;4141.979290103545;4143.0885205254945;4095.651869591088;4104.40486129511;4137.27597670408;4139.950724391415;4144.8756537303925;3980.5024371953505;4080.6939479539005;4109.363048727437;4117.382392641098;4139.882231797413;4040.393940908858;4083.673306135502;4093.9385909211387;4101.753894766323;4105.096878686684;3586.5158203642695;3603.297357015383;3603.819809009539;3612.3858943979585;3626.2384899171207;5152.995165942642;5154.860732795885;5157.664751791159;5178.818741344035;5198.6880787152895;4554.157480866051;4703.341532185463;4720.244760838249;4730.2431610942085;4763.261694437368;5499.7250137492965;5518.46150770646;5524.917126243109;5535.474129957647;5619.494245517923;3988.4615576897036;4006.419069234945;4009.278329900617;4011.618896204856;4012.618801213909;5707.77168913243;5715.942840571624;5731.770729170787;5749.712514374306;5769.221155144044;4039.171969746195;4041.4341992121126;4057.6753859691153;4059.89850253746;4067.678004648501;4107.404426358161;4141.7100802943505;4143.482064741907;4150.688698347576;4175.853845115406;4583.610393116555;4670.719756814602;4676.976615116902;4757.16749568831;4790.616750660009;5535.58483113768;5535.861603459945;5614.157876318585;5645.774169033275;5681.375048744635;1436.3464623596446;1448.7323591857125;1451.4557041109583;1458.4030486617137;1459.6204986703533;921.1071248584224;949.5964215208509;956.2541217850088;968.8207681578931;977.8044391121804;5300.337457817773;5314.335708036496;5340.25236466895;5364.436734142937;5397.298351214396;5694.4590263924865;5732.455416735404;5765.9621268171295;5774.595778295563;5783.624064435882;5241.68549887008;5317.202419637086;5320.228566857784;5361.544268737123;5374.328208973879;3010.668826429091;3031.060371284909;3044.4824379855036;3047.2229581456586;3075.7078077582596;5627.746751396197;5880.705964701748;5919.970400148058;5956.672383018976;5988.3113441953865;5774.39368866263;5779.711014449261;5789.6683762733965;5804.245448091806;5821.79623713168;5878.676672782953;5883.735231914574;5899.610657683645;5919.437653422918;5946.643201407929;5507.228987941611;5624.184493248538;5628.887422251614;5686.317641883001;5724.3703192647945;5587.916181257203;5591.692456914909;5617.382087970238;5644.463775941279;5664.207011018379;5652.208690783212;5918.852028699144;5936.703164841827;5956.463918247378;5962.403759624003;4077.143799801956;4091.140860419226;4093.324601440729;4096.2831504486;4101.5488296286785;5615.5507559395965;5626.381098079126;5728.541716662574;5756.56825738063;5769.509591684754;5570.777168913361;5589.217509548585;5617.034038086637;5630.380658127685;5647.887042259214;5596.468335508121;5601.387105317129;5626.915596265977;5629.971850140723;5634.858753673578;5199.324087868704;5491.917621235605;5516.255305533862;5545.279113715191;5562.527185189142;5668.489835914787;5692.320765374142;5694.572907031907;5703.429657034263;5719.399463056319;5452.282531002721;5526.171074338881;5600.523955463668;5606.159076138611;5625.09998400254 14:34:53 INFO - PROCESS | 11606 | |5;yui.html;704.7145905908109;751.8759404698225;770.7726220764874;797.8444203380343;847.5804476783991;14101.435942562299;14517.274136293196;15130;15545.92227038866;15624.453144139958;15367.769483457758;15439.305231264592;15468.767968480483;15476.148811815374;15484.070955742664;665.3479590001801;792.6195426195429;813.2802469814227;814.6863457568849;821.1008945204991;801.0107517216234;802.181774589918;804.2882049386277;804.4007214625083;806.2743530822248;859.6303589456531;860.0668274921718;860.6815478273016;860.9182127697859;861.5778268648348;699.9440044796429;832.3382910586068;850.9787255318605;851.6635928808087;857.2970164465141;621.7979156774066;621.8414304352361;622.1538707357989;622.17561730707;623.0156352962308;13229.867701323055;13261.27063011534;13275;13291.734165316639;13301.068925175241;12443.875561244453;12533.24800511963;12758.234505929673;12788.808167877489;13064.86935130646;12142.575009874701;12148.45331960064;12549.498020079185;12622.305773182472;12837.422315995802;4389.802458889326;4461.7992190351515;4464.910701785946;4495.527969563182;4519.887002824956;52214.47785522134;54584.454155458734;58770;59143.70428147875;59146;11286.66140015801;11318.603848865416;11370.374629395297;11389.259698119597;11684.415779211005;18351.632967340578;18454.815451845578;18514.907425462785;18704.438866834018;18727.157277922524;8498.617562209716;8562.400631955828;8588.484690918565;8665.783355416039;8760.211580957617;4602.240630296031;4709.95290047102;4764.547368000034;4795.352627395327;4924.532169443897;3451.8964431067106;3567.108222944264;3567.9643203568153;3568.839402226906;3570.107473131717;685.2359619024752;688.7072993977539;691.3432239372617;694.1115372323434;698.8532408194235;619.4146531527663;685.4858855858106;712.6935417770409;742.4246209187922;755.1768572256267;8885.955570222108;8957.596908139149;9184.357095003286;9221.953890230507;9423.670171543963;624.7719582352408;673.6833688166554;674.7739507265023;733.4132693844903;754.2532892436558;4555.382839092074;4717.693349932312;4745.715257084586;4783.569478746929;4833.854984350475;68241;68731.3126868725;68739;69066;69616.30383696099;60077;60249.69875150596;60791.696041519506;61232;61737.38262617406;54683.179752303746;55909.44090559124;55972;56647.433525664215;57020.429795702345;8901.866472003054;8947.239484643618;8947.418417802823;9049.366544342096;9139.817203656023;37590.248195036496;37924.43113353357;38038.429423559224;38054.23891522209;38170.0457488565;46151;47530.52469475261;49094.509054908995;49238;49576.50423495719;10952.123830093733;11076.778464430505;11178.552857885594;11194.272372295774;11263.943680281545;11770.470328835394;11805.704857378634;12015.279083255033;12577.245365278113;12790.808137878126;11486.19596628228;11821.527138914347;11877.109216808602;12089.15375923677;12195.75608487843;11296.152788540729;11330.60342887995;11677.357745324089;11956.46195921203;12856.42146103409;11394.08847292198;11658.6502404928;11851.881481185077;12031.45858436355;12094.153409261618;9427.952860235655;9900.801983960424;9936.801263974536;10025.147862431775;10249.74375640615;9894.75263118399;9989.500524973577;10004.349717268355;10006.499675016366;10105.595776169164 14:34:53 INFO - PROCESS | 11606 | __end_tp_report 14:34:53 INFO - PROCESS | 11606 | __start_cc_report 14:34:53 INFO - PROCESS | 11606 | _x_x_mozilla_cycle_collect,1148 14:34:53 INFO - PROCESS | 11606 | __end_cc_report 14:34:53 INFO - PROCESS | 11606 | __startTimestamp1464730493620__endTimestamp 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | ------- Summary: start ------- 14:34:53 INFO - PROCESS | 11606 | Number of tests: 6 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#0] dojo.html Cycles:165 Average:5371.45 Median:5564.55 stddev:624.16 (11.2%) stddev-sans-first:600.60 14:34:53 INFO - PROCESS | 11606 | Values: 3121.5 3146.6 3157.8 3188.7 3211.3 5326.8 5383.5 5390.4 5485.6 5510.0 5410.2 5438.0 5484.8 5546.1 5551.8 4853.8 4878.9 4894.2 4917.3 4938.9 5005.3 5031.5 5037.5 5054.1 5060.1 4807.7 4958.3 5000.1 5007.6 5028.9 4782.9 4789.9 4819.7 4831.5 4834.9 4791.4 4847.9 4871.3 4888.9 4924.1 5159.2 5200.6 5321.4 5363.9 5367.7 5760.5 5832.0 5876.4 5881.1 5883.9 5783.3 5831.2 5832.3 5833.5 5840.5 5224.1 5299.5 5397.2 5422.6 5435.3 5983.6 5987.6 5990.4 5997.5 6000.8 5711.6 5714.2 5716.5 5716.5 5721.1 5681.5 5692.5 5782.9 5818.9 5838.9 5751.8 5815.4 5816.5 5827.6 5830.9 5633.6 5676.2 5710.8 5721.5 5785.6 4273.6 4304.0 4316.3 4347.6 4383.9 3865.4 3873.3 3882.4 3914.7 3915.6 5276.6 5348.9 5363.3 5364.1 5364.7 5766.0 5856.2 5860.9 5887.5 5888.6 5407.7 5414.2 5426.9 5453.6 5474.1 4873.8 4956.6 4962.8 4977.7 5029.6 5930.8 5932.3 5944.6 5945.6 6081.1 5787.7 5825.9 5828.7 5831.8 5832.7 5835.2 5970.7 6009.1 6020.3 6030.4 5744.8 5765.3 5767.6 5772.9 5814.9 5822.3 5866.7 5874.8 5880.5 5889.6 5564.6 5663.1 5732.1 5733.5 5751.1 5658.9 5660.8 5666.5 5666.7 5673.6 5494.3 5539.1 5545.0 5547.6 5548.2 5558.9 5586.7 5607.9 5682.9 5700.2 5527.1 5591.2 5612.2 5629.9 5630.3 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#1] ext.html Cycles:180 Average:61877.21 Median:37812.43 stddev:123648.53 (327.0%) stddev-sans-first:123909.73 14:34:53 INFO - PROCESS | 11606 | Values: 571.5 617.8 621.4 622.7 624.9 43105.1 44761.8 44765.0 44813.0 47786.3 45748.5 46423.8 46428.5 46445.3 46469.8 8076.4 8833.4 9019.7 10493.7 10738.5 10582.0 10726.5 10742.2 10743.7 10744.8 10779.4 10831.8 10837.7 10842.4 10849.3 8162.3 10753.3 10987.3 11008.7 11010.1 10402.0 10481.3 10512.4 10755.6 10758.3 42997.8 43522.3 43547.6 43569.3 43638.8 3519.8 3532.4 3926.3 4296.1 4390.0 30549.8 33512.0 34098.3 34215.5 34272.5 4261.4 4294.1 4301.7 4475.3 4478.4 369042.0 373020.0 373111.0 373225.0 374059.0 35757.5 36707.4 65180.7 65763.3 66073.0 36273.5 36358.0 36379.6 36444.5 36503.6 14348.5 15569.8 15686.1 15691.8 15696.0 11870.0 11954.5 11999.5 12329.3 12330.1 8527.9 8563.8 8592.6 8607.6 8654.2 3326.2 3326.9 3354.4 3363.8 3385.6 972.4 974.6 1054.4 1097.1 1141.7 29880.7 32466.8 32562.0 32562.7 32610.7 1143.1 1184.6 1203.6 1241.8 1286.5 17104.1 17403.7 17468.3 17494.7 17542.5 543137.0 547064.0 548416.0 548511.0 550268.0 60917.0 61150.0 61480.7 61637.7 61684.0 1264.6 1335.7 1341.0 1361.6 1399.3 32874.7 33759.8 34175.8 34329.7 34462.5 52909.7 53569.5 53718.0 53771.2 53783.5 457416.0 457958.0 461600.0 464430.0 466124.0 37607.6 42754.1 43031.6 44140.3 44321.8 48895.3 48976.3 49493.0 49755.8 50515.5 39475.8 41432.0 42626.0 43547.3 44224.3 41942.0 42516.0 42712.0 43424.6 43547.3 41433.4 41983.8 42097.2 42392.8 44514.0 33771.3 36909.8 38017.2 39041.4 39505.4 28286.1 28493.4 28659.3 28722.9 28930.9 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#2] jquery.html Cycles:180 Average:29472.00 Median:32143.86 stddev:78895.43 (245.4%) stddev-sans-first:79086.51 14:34:53 INFO - PROCESS | 11606 | Values: 378.9 383.8 398.5 400.1 411.7 17958.0 18370.4 20295.8 20300.0 20302.8 11851.1 12115.3 12144.9 12148.1 16712.8 5133.5 5256.5 5271.3 5289.7 5295.2 3900.9 5192.5 5470.1 5493.9 5616.5 5484.9 5541.5 5555.3 5564.6 5599.4 5405.4 5525.7 5541.1 5554.7 5560.8 3817.1 4007.8 4011.7 5312.3 5642.9 12694.4 13347.5 13649.9 13656.6 13697.2 2270.1 2286.7 2365.3 3131.2 3267.2 15015.6 15567.5 15786.1 16151.5 16217.8 1910.2 2044.4 2056.4 2068.2 2079.6 93735.0 94291.0 96682.5 96931.5 98073.5 16944.0 17464.6 17489.7 17501.6 18084.3 31788.4 31872.4 32415.4 32444.7 32483.2 9786.1 9897.7 10003.6 10286.2 10464.5 8435.0 8573.4 8602.3 8666.6 8753.0 8939.4 9034.4 9044.5 9093.6 9202.3 2718.7 3284.6 3476.4 3518.9 3532.6 868.4 1001.4 1018.8 1026.7 1062.7 18620.2 18657.9 18883.7 18933.5 19326.3 973.9 1018.2 1034.6 1045.1 1062.9 10218.8 10670.1 10744.5 10757.7 10761.8 462531.0 469809.0 481365.0 481566.0 487715.0 90534.0 92205.5 92471.5 92496.5 92790.5 997.6 1002.4 1012.9 1017.1 1049.9 16453.8 16538.1 16752.0 16868.8 17096.1 38341.6 38394.6 39257.2 40615.2 42378.2 54394.7 56677.0 57732.0 57821.0 58100.0 8349.4 8431.2 8652.7 8948.0 8968.9 12463.7 13006.8 13275.9 13590.6 13633.5 11038.9 11144.5 11268.7 11405.9 11552.4 11508.4 11580.8 11699.9 11882.2 11928.6 11687.5 11860.8 11967.5 12355.9 12370.1 8428.7 8521.5 8625.7 8892.7 8901.2 8960.2 11111.7 12015.6 12130.6 12132.0 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#3] mootools.html Cycles:180 Average:5929.23 Median:443.10 stddev:3449.02 (778.4%) stddev-sans-first:3441.39 14:34:53 INFO - PROCESS | 11606 | Values: 1331.0 1395.3 1413.9 1421.5 1469.5 8549.6 8848.7 8888.1 9054.6 9070.5 8790.0 8989.3 9006.5 9012.5 9014.2 2073.4 2344.2 2356.6 2392.5 2421.1 2407.1 2419.9 2423.2 2423.3 2425.1 2388.9 2401.1 2423.7 2424.7 2429.4 1982.8 2192.1 2248.5 2251.1 2261.5 2264.9 2270.9 2284.2 2285.7 2287.6 8683.3 8800.6 8802.4 8815.1 8820.1 5253.2 5447.8 5458.4 5459.6 5460.9 3334.7 3350.2 3378.1 3388.4 3437.3 1075.9 1097.6 1105.7 1122.6 1128.2 12924.3 12933.0 12939.3 12949.8 12961.7 4734.4 4778.1 4783.3 4794.0 4861.3 10538.3 10596.2 10632.8 10660.1 10681.9 5377.4 5414.9 5463.8 5464.0 5465.5 4489.1 4820.7 4960.6 4979.8 5020.7 4109.2 4169.7 4200.0 4234.4 4251.1 1274.4 1287.0 1296.9 1305.8 1307.2 964.1 1000.8 1005.3 1011.5 1020.0 6035.2 6059.8 6116.2 6117.3 6122.5 433.6 441.7 444.5 446.4 447.6 4149.6 4173.1 4250.7 4283.9 4335.2 10991.0 11379.0 11394.9 11405.5 11449.3 10599.1 10985.0 11007.7 11328.8 11345.3 8226.5 8339.2 8363.2 8370.2 8382.2 6101.5 6220.6 6287.9 6322.4 6327.6 10292.6 10510.4 10563.5 10643.4 10662.7 10794.2 10830.0 10892.6 10942.4 10953.7 7322.7 7875.0 8010.9 8099.0 8147.1 8811.9 8867.9 8918.6 8937.3 8937.4 7762.1 7819.2 7869.1 7885.6 8061.0 7436.4 7500.6 7519.6 7609.4 7652.8 6921.2 6949.9 6976.4 6988.3 6999.6 4842.9 4989.5 5121.1 5175.4 5192.4 5331.2 5339.2 5341.7 5392.3 5466.0 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#4] prototype.html Cycles:180 Average:4694.33 Median:5385.81 stddev:1383.25 (25.7%) stddev-sans-first:1347.62 14:34:53 INFO - PROCESS | 11606 | Values: 320.9 330.0 332.5 334.6 338.1 5339.8 5404.5 5408.5 5432.4 5441.0 5230.7 5309.2 5331.7 5343.5 5365.9 3954.3 4037.1 4141.2 4142.0 4143.1 4095.7 4104.4 4137.3 4140.0 4144.9 3980.5 4080.7 4109.4 4117.4 4139.9 4040.4 4083.7 4093.9 4101.8 4105.1 3586.5 3603.3 3603.8 3612.4 3626.2 5153.0 5154.9 5157.7 5178.8 5198.7 4554.2 4703.3 4720.2 4730.2 4763.3 5499.7 5518.5 5524.9 5535.5 5619.5 3988.5 4006.4 4009.3 4011.6 4012.6 5707.8 5715.9 5731.8 5749.7 5769.2 4039.2 4041.4 4057.7 4059.9 4067.7 4107.4 4141.7 4143.5 4150.7 4175.9 4583.6 4670.7 4677.0 4757.2 4790.6 5535.6 5535.9 5614.2 5645.8 5681.4 1436.3 1448.7 1451.5 1458.4 1459.6 921.1 949.6 956.3 968.8 977.8 5300.3 5314.3 5340.3 5364.4 5397.3 5694.5 5732.5 5766.0 5774.6 5783.6 5241.7 5317.2 5320.2 5361.5 5374.3 3010.7 3031.1 3044.5 3047.2 3075.7 5627.7 5880.7 5920.0 5956.7 5988.3 5774.4 5779.7 5789.7 5804.2 5821.8 5878.7 5883.7 5899.6 5919.4 5946.6 5507.2 5624.2 5628.9 5686.3 5724.4 5587.9 5591.7 5617.4 5644.5 5664.2 5652.2 5918.9 5936.7 5956.5 5962.4 4077.1 4091.1 4093.3 4096.3 4101.5 5615.6 5626.4 5728.5 5756.6 5769.5 5570.8 5589.2 5617.0 5630.4 5647.9 5596.5 5601.4 5626.9 5630.0 5634.9 5199.3 5491.9 5516.3 5545.3 5562.5 5668.5 5692.3 5694.6 5703.4 5719.4 5452.3 5526.2 5600.5 5606.2 5625.1 14:34:53 INFO - PROCESS | 11606 | 14:34:53 INFO - PROCESS | 11606 | [#5] yui.html Cycles:180 Average:15482.74 Median:26964.18 stddev:18766.74 (69.6%) stddev-sans-first:18786.58 14:34:53 INFO - PROCESS | 11606 | Values: 704.7 751.9 770.8 797.8 847.6 14101.4 14517.3 15130.0 15545.9 15624.5 15367.8 15439.3 15468.8 15476.1 15484.1 665.3 792.6 813.3 814.7 821.1 801.0 802.2 804.3 804.4 806.3 859.6 860.1 860.7 860.9 861.6 699.9 832.3 851.0 851.7 857.3 621.8 621.8 622.2 622.2 623.0 13229.9 13261.3 13275.0 13291.7 13301.1 12443.9 12533.2 12758.2 12788.8 13064.9 12142.6 12148.5 12549.5 12622.3 12837.4 4389.8 4461.8 4464.9 4495.5 4519.9 52214.5 54584.5 58770.0 59143.7 59146.0 11286.7 11318.6 11370.4 11389.3 11684.4 18351.6 18454.8 18514.9 18704.4 18727.2 8498.6 8562.4 8588.5 8665.8 8760.2 4602.2 4710.0 4764.5 4795.4 4924.5 3451.9 3567.1 3568.0 3568.8 3570.1 685.2 688.7 691.3 694.1 698.9 619.4 685.5 712.7 742.4 755.2 8886.0 8957.6 9184.4 9222.0 9423.7 624.8 673.7 674.8 733.4 754.3 4555.4 4717.7 4745.7 4783.6 4833.9 68241.0 68731.3 68739.0 69066.0 69616.3 60077.0 60249.7 60791.7 61232.0 61737.4 54683.2 55909.4 55972.0 56647.4 57020.4 8901.9 8947.2 8947.4 9049.4 9139.8 37590.2 37924.4 38038.4 38054.2 38170.0 46151.0 47530.5 49094.5 49238.0 49576.5 10952.1 11076.8 11178.6 11194.3 11263.9 11770.5 11805.7 12015.3 12577.2 12790.8 11486.2 11821.5 11877.1 12089.2 12195.8 11296.2 11330.6 11677.4 11956.5 12856.4 11394.1 11658.7 11851.9 12031.5 12094.2 9428.0 9900.8 9936.8 10025.1 10249.7 9894.8 9989.5 10004.3 10006.5 10105.6 14:34:53 INFO - PROCESS | 11606 | -------- Summary: end -------- 14:34:53 INFO - PROCESS | 11606 | 14:34:54 INFO - TEST-INFO | 11606: exit 0 14:34:54 INFO - TEST-OK | dromaeo_css | took 1113212ms 14:34:54 INFO - TEST-START | kraken 14:34:54 INFO - operating with platform_type : linux_ 14:34:54 INFO - Initialising browser for kraken test... 14:34:54 INFO - TEST-INFO | started process 11787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOYko1/profile http://localhost:52678/getInfo.html) 14:34:58 INFO - PROCESS | 11787 | __metrics Screen width/height:1600/1200 14:34:58 INFO - PROCESS | 11787 | colorDepth:24 14:34:58 INFO - PROCESS | 11787 | Browser inner width/height: 1024/697 14:34:58 INFO - PROCESS | 11787 | __metrics 14:34:59 ERROR - PROCESS | 11787 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:35:00 INFO - TEST-INFO | 11787: exit 0 14:35:00 INFO - Browser initialized. 14:35:00 INFO - Running cycle 1/1 for kraken test... 14:35:00 INFO - TEST-INFO | started process 11869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOYko1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:11 INFO - PROCESS | 11869 | RSS: Main: 155582464 14:35:11 INFO - PROCESS | 11869 | 14:35:14 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:15 INFO - PROCESS | 11869 | RSS: Main: 214573056 14:35:15 INFO - PROCESS | 11869 | 14:35:17 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-dft) 14:35:18 INFO - PROCESS | 11869 | RSS: Main: 201859072 14:35:18 INFO - PROCESS | 11869 | 14:35:21 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-fft) 14:35:22 INFO - PROCESS | 11869 | RSS: Main: 268963840 14:35:22 INFO - PROCESS | 11869 | 14:35:24 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-oscillator) 14:35:25 INFO - PROCESS | 11869 | RSS: Main: 179449856 14:35:25 INFO - PROCESS | 11869 | 14:35:27 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:27 INFO - PROCESS | 11869 | RSS: Main: 184176640 14:35:27 INFO - PROCESS | 11869 | 14:35:30 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:31 INFO - PROCESS | 11869 | RSS: Main: 218628096 14:35:31 INFO - PROCESS | 11869 | 14:35:34 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:35 INFO - PROCESS | 11869 | RSS: Main: 220385280 14:35:35 INFO - PROCESS | 11869 | 14:35:38 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52678/tests/kraken/driver.html?testName=json-parse-financial) 14:35:38 INFO - PROCESS | 11869 | RSS: Main: 220815360 14:35:38 INFO - PROCESS | 11869 | 14:35:40 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:40 INFO - PROCESS | 11869 | RSS: Main: 209158144 14:35:40 INFO - PROCESS | 11869 | 14:35:42 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:43 INFO - PROCESS | 11869 | RSS: Main: 209768448 14:35:43 INFO - PROCESS | 11869 | 14:35:45 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:46 INFO - PROCESS | 11869 | RSS: Main: 216465408 14:35:46 INFO - PROCESS | 11869 | 14:35:48 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:49 INFO - PROCESS | 11869 | RSS: Main: 222232576 14:35:49 INFO - PROCESS | 11869 | 14:35:51 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:52 INFO - PROCESS | 11869 | RSS: Main: 221876224 14:35:52 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52678/tests/kraken/driver.html?testName=ai-astar) 14:35:54 INFO - PROCESS | 11869 | RSS: Main: 264069120 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | __start_tp_report 14:35:54 INFO - PROCESS | 11869 | _x_x_mozilla_page_load 14:35:54 INFO - PROCESS | 11869 | _x_x_mozilla_page_load_details 14:35:54 INFO - PROCESS | 11869 | |i|pagename|runs| 14:35:54 INFO - PROCESS | 11869 | |0;ai-astar;110;106;109;109;111;109;108;109;109;108 14:35:54 INFO - PROCESS | 11869 | |1;audio-beat-detection;154;127;125;192;126;126;153;124;191;125 14:35:54 INFO - PROCESS | 11869 | |2;audio-dft;161;162;160;162;159;160;160;160;161;160 14:35:54 INFO - PROCESS | 11869 | |3;audio-fft;73;74;75;126;77;76;74;75;104;75 14:35:54 INFO - PROCESS | 11869 | |4;audio-oscillator;84;84;109;83;83;84;117;85;83;120 14:35:54 INFO - PROCESS | 11869 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;117;117;117 14:35:54 INFO - PROCESS | 11869 | |6;imaging-darkroom;146;146;146;146;146;145;146;145;146;145 14:35:54 INFO - PROCESS | 11869 | |7;imaging-desaturate;95;95;94;95;94;94;94;94;95;95 14:35:54 INFO - PROCESS | 11869 | |8;json-parse-financial;55;55;53;54;54;53;54;56;54;54 14:35:54 INFO - PROCESS | 11869 | |9;json-stringify-tinderbox;63;62;61;62;63;62;62;62;65;63 14:35:54 INFO - PROCESS | 11869 | |10;stanford-crypto-aes;81;80;79;80;87;81;81;82;112;80 14:35:54 INFO - PROCESS | 11869 | |11;stanford-crypto-ccm;124;130;133;136;122;130;119;129;127;121 14:35:54 INFO - PROCESS | 11869 | |12;stanford-crypto-pbkdf2;165;161;165;168;170;161;162;169;166;161 14:35:54 INFO - PROCESS | 11869 | |13;stanford-crypto-sha256-iterative;63;65;63;63;64;66;64;63;63;63 14:35:54 INFO - PROCESS | 11869 | __end_tp_report 14:35:54 INFO - PROCESS | 11869 | __start_cc_report 14:35:54 INFO - PROCESS | 11869 | _x_x_mozilla_cycle_collect,1606 14:35:54 INFO - PROCESS | 11869 | __end_cc_report 14:35:54 INFO - PROCESS | 11869 | __startTimestamp1464730554419__endTimestamp 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | ------- Summary: start ------- 14:35:54 INFO - PROCESS | 11869 | Number of tests: 14 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.32 (1.2%) stddev-sans-first:1.32 14:35:54 INFO - PROCESS | 11869 | Values: 110.0 106.0 109.0 109.0 111.0 109.0 108.0 109.0 109.0 108.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:140.00 stddev:27.39 (19.6%) stddev-sans-first:28.83 14:35:54 INFO - PROCESS | 11869 | Values: 154.0 127.0 125.0 192.0 126.0 126.0 153.0 124.0 191.0 125.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 14:35:54 INFO - PROCESS | 11869 | Values: 161.0 162.0 160.0 162.0 159.0 160.0 160.0 160.0 161.0 160.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.73 (23.6%) stddev-sans-first:18.44 14:35:54 INFO - PROCESS | 11869 | Values: 73.0 74.0 75.0 126.0 77.0 76.0 74.0 75.0 104.0 75.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.50 stddev:15.52 (18.6%) stddev-sans-first:16.10 14:35:54 INFO - PROCESS | 11869 | Values: 84.0 84.0 109.0 83.0 83.0 84.0 117.0 85.0 83.0 120.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:35:54 INFO - PROCESS | 11869 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:35:54 INFO - PROCESS | 11869 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:35:54 INFO - PROCESS | 11869 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 14:35:54 INFO - PROCESS | 11869 | Values: 55.0 55.0 53.0 54.0 54.0 53.0 54.0 56.0 54.0 54.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 14:35:54 INFO - PROCESS | 11869 | Values: 63.0 62.0 61.0 62.0 63.0 62.0 62.0 62.0 65.0 63.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:9.98 (12.3%) stddev-sans-first:10.51 14:35:54 INFO - PROCESS | 11869 | Values: 81.0 80.0 79.0 80.0 87.0 81.0 81.0 82.0 112.0 80.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:129.50 stddev:5.51 (4.3%) stddev-sans-first:5.73 14:35:54 INFO - PROCESS | 11869 | Values: 124.0 130.0 133.0 136.0 122.0 130.0 119.0 129.0 127.0 121.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:3.46 (2.1%) stddev-sans-first:3.67 14:35:54 INFO - PROCESS | 11869 | Values: 165.0 161.0 165.0 168.0 170.0 161.0 162.0 169.0 166.0 161.0 14:35:54 INFO - PROCESS | 11869 | 14:35:54 INFO - PROCESS | 11869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.06 (1.7%) stddev-sans-first:1.09 14:35:54 INFO - PROCESS | 11869 | Values: 63.0 65.0 63.0 63.0 64.0 66.0 64.0 63.0 63.0 63.0 14:35:54 INFO - PROCESS | 11869 | -------- Summary: end -------- 14:35:54 INFO - PROCESS | 11869 | 14:35:55 INFO - TEST-INFO | 11869: exit 0 14:35:55 INFO - TEST-OK | kraken | took 61053ms 14:35:55 INFO - SUITE-END | took 1174s 14:35:55 INFO - Completed test suite (00:19:34) 14:35:55 INFO - javascript benchmark 14:35:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.5317702344646, 3146.5909431773853, 3157.842107894605, 3188.665190155032, 3211.3095684427844, 5326.760295786689, 5383.488568585988, 5390.353157621091, 5485.6434331768405, 5509.972450137749, 5410.161424979125, 5437.966786310598, 5484.808031718891, 5546.140348246018, 5551.750171242294, 4853.805847766085, 4878.926816097762, 4894.1679914414635, 4917.336159618441, 4938.876528086791, 5005.324281222043, 5031.496850314976, 5037.546620804127, 5054.064997975368, 5060.139776238048, 4807.711537307738, 4958.281049247875, 5000.124978128831, 5007.649464537502, 5028.899422011557, 4782.880427989293, 4789.928151077736, 4819.7108173509705, 4831.4685384607665, 4834.879128021792, 4791.448983366922, 4847.903041939177, 4871.342368780205, 4888.902221955576, 4924.064427758714, 5159.22611608258, 5200.557952574036, 5321.388040375329, 5363.919541206885, 5367.704776237305, 5760.510356619692, 5831.970840145815, 5876.353601103875, 5881.117832325142, 5883.8529036774, 5783.306003279633, 5831.183634291203, 5832.329282132524, 5833.474987251126, 5840.532757379442, 5224.138017227153, 5299.5230429261555, 5397.163439666858, 5422.6475279106735, 5435.347758268994, 5983.551233657406, 5987.5808693391045, 5990.430909063632, 5997.460228579449, 6000.789972350947, 5711.600187986801, 5714.200011998323, 5716.456936591017, 5716.542676585863, 5721.113227449752, 5681.545476361881, 5692.459216374438, 5782.884342313214, 5818.854528636818, 5838.8540286492325, 5751.798687045934, 5815.360310365856, 5816.47651711348, 5827.5920685552455, 5830.854228644318, 5633.57748168889, 5676.233708449389, 5710.828675139753, 5721.456461636138, 5785.566082543826, 4273.594008569181, 4303.978480107579, 4316.330968699856, 4347.608715215646, 4383.925938145111, 3865.362215234511, 3873.3028054949814, 3882.378819388884, 3914.725969182187, 3915.6280153385383, 5276.604254680914, 5348.866278343073, 5363.302770639792, 5364.114921038063, 5364.704941228192, 5766.0, 5856.209411729447, 5860.853478663067, 5887.499562537147, 5888.587798854039, 5407.729613519308, 5414.214938833847, 5426.8914621707345, 5453.563714902878, 5474.09677403224, 4873.829415970424, 4956.5786908112495, 4962.776675049631, 4977.701337919736, 5029.622778291643, 5930.762769489172, 5932.347441781487, 5944.554158438134, 5945.554083443672, 6081.087836824512, 5787.710614469175, 5825.883482330414, 5828.6502809831545, 5831.825045248649, 5832.737526811219, 5835.153902684172, 5970.671613061323, 6009.06859436788, 6020.277566692025, 6030.427109424598, 5744.798932037359, 5765.250517432707, 5767.5674324425, 5772.94227057724, 5814.883702325845, 5822.272215973004, 5866.67733274674, 5874.823755287348, 5880.50015748649, 5889.587728858939, 5564.554835613222, 5663.122216056518, 5732.111522713819, 5733.483986441241, 5751.079827227623, 5658.915116273177, 5660.801871934463, 5666.518345940642, 5666.744996475086, 5673.602847800615, 5494.313210848644, 5539.058360078877, 5545.0, 5547.61166718342, 5548.195511650869, 5558.861028474321, 5586.664800112007, 5607.915881261702, 5682.857928551819, 5700.173474846207, 5527.115661494142, 5591.245181900392, 5612.186232996274, 5629.8592535186945, 5630.2680651516675], "value": 5328.667073029341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4942276085663, 617.7590739611552, 621.415869083062, 622.7011034703343, 624.896892012818, 43105.13789724208, 44761.77619111908, 44765.0, 44812.999999999956, 47786.28320575194, 45748.542514574925, 46423.76788116063, 46428.53571464284, 46445.30332045022, 46469.76765116178, 8076.353891688651, 8833.42582732122, 9019.729408117766, 10493.737656558571, 10738.463076846165, 10582.0, 10726.517306721178, 10742.248042637018, 10743.677689669323, 10744.838827417596, 10779.407132607703, 10831.83752243717, 10837.67486975388, 10842.403667798268, 10849.294795838245, 8162.265396114349, 10753.301035432673, 10987.340759554452, 11008.669739907815, 11010.119190464824, 10402.0, 10481.266311358208, 10512.369257844553, 10755.569777208902, 10758.300710453874, 42997.78501107506, 43522.347164792554, 43547.56452435467, 43569.34645980313, 43638.78180609109, 3519.771214871025, 3532.381833179209, 3926.312895243321, 4296.076343586144, 4390.0, 30549.847250763603, 33512.0, 34098.31803363919, 34215.4867676985, 34272.48591271133, 4261.403403523509, 4294.119705460374, 4301.698881078326, 4475.328700694889, 4478.350639157304, 369042.0, 373020.0, 373110.99999999726, 373225.0, 374059.0, 35757.46363804545, 36707.4493882592, 65180.67409662921, 65763.34236657667, 66073.0, 36273.45589816155, 36358.0, 36379.636203638154, 36444.45333320002, 36503.634963650555, 14348.49780257686, 15569.766453503207, 15686.137262450675, 15691.764623530657, 15696.0, 11870.0, 11954.462049207807, 11999.520019199133, 12329.321887296284, 12330.136890417763, 8527.872081918777, 8563.785905352292, 8592.5703714814, 8607.61265743043, 8654.177853103945, 3326.2183386904057, 3326.850291736878, 3354.3962086824117, 3363.7645364824716, 3385.579310792795, 972.3533849989677, 974.5955428497094, 1054.4253381906879, 1097.0801098078364, 1141.7316930521322, 29880.662554329207, 32466.83766581152, 32562.0, 32562.67437325644, 32610.67389326124, 1143.1312202725987, 1184.5676328140166, 1203.5546847666244, 1241.76406482768, 1286.4789760147155, 17104.0592767399, 17403.73894391585, 17468.301267949395, 17494.737578936325, 17542.473725788248, 543137.0, 547064.0, 548416.0, 548511.0, 550268.0, 60917.0, 61150.0, 61480.69259653673, 61637.69181154066, 61684.0, 1264.6016504801141, 1335.732853429318, 1341.0478560222157, 1361.5574938145141, 1399.3143359753851, 32874.67125328716, 33759.83120084384, 34175.82912085523, 34329.65670343365, 34462.48306275358, 52909.735451324035, 53569.46430535645, 53718.0, 53771.19343209933, 53783.462165377845, 457416.0, 457958.0, 461600.0, 464430.0, 466124.0, 37607.62392376041, 42754.144917100864, 43031.569684302754, 44140.33789493224, 44321.778391109125, 48895.266571002176, 48976.2653560204, 49493.0, 49755.75122124511, 50515.49484505108, 39475.80262098671, 41432.0, 42626.0, 43547.34678979881, 44224.33663495114, 41942.0, 42516.0, 42712.0, 43424.56575434205, 43547.34678979754, 41433.37849932193, 41983.790081049396, 42097.158056839304, 42392.788036059625, 44514.0, 33771.324573508886, 36909.81545092257, 38017.2396552073, 39041.414378783775, 39505.407418889314, 28286.10984770837, 28493.430131397672, 28659.283517911386, 28722.856385718773, 28930.855345723136], "value": 20004.39239559827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.89580365399513, 383.7869982159902, 398.4600865826806, 400.0518770513882, 411.717973188366, 17958.0, 18370.44888653339, 20295.782253064826, 20299.955006748994, 20302.796972030275, 11851.051915846732, 12115.27308361499, 12144.878551214486, 12148.149629525937, 16712.83287167128, 5133.486651334864, 5256.526912577867, 5271.28837606922, 5289.735513224343, 5295.179247216668, 3900.9219815603815, 5192.506711862367, 5470.070088085015, 5493.945060549403, 5616.466435688603, 5484.875600501908, 5541.501264886159, 5555.30558680165, 5564.638298510604, 5599.384067752544, 5405.405405405402, 5525.696086715229, 5541.085720856054, 5554.666719996813, 5560.833175004756, 3817.10298079951, 4007.7996100195164, 4011.7191796574252, 5312.256284120188, 5642.858928526779, 12694.365281735876, 13347.532836350681, 13649.863501364958, 13656.590302290848, 13697.246651434167, 2270.1260014894383, 2286.7255929288426, 2365.3258821236036, 3131.170239886432, 3267.18320419895, 15015.624609384744, 15567.45513907019, 15786.131762753044, 16151.515454536382, 16217.837821621752, 1910.1881700277327, 2044.4377796106041, 2056.4139220322136, 2068.162394230339, 2079.5944790765807, 93735.0, 94290.99999999932, 96682.51658741661, 96931.51534242355, 98073.5096324521, 16944.0, 17464.5633859152, 17489.7376539352, 17501.562460938578, 18084.27662893496, 31788.364232715216, 31872.362552748815, 32415.351692966007, 32444.675553244637, 32483.18792030218, 9786.1192492676, 9897.703068907944, 10003.599856005823, 10286.228532860065, 10464.476776161313, 8434.957825210835, 8573.442726222776, 8602.268807151337, 8666.6100025499, 8753.037165911745, 8939.374243802871, 9034.412763170372, 9044.547772611342, 9093.590788414538, 9202.309826762885, 2718.660167479065, 3284.6058472983395, 3476.443768996948, 3518.876839310663, 3532.593751718534, 868.3877866104508, 1001.3641337750581, 1018.765683892694, 1026.6868605075374, 1062.718379629399, 18620.16209270586, 18657.90671046636, 18883.716744248846, 18933.52666183329, 19326.32357867496, 973.9464329461806, 1018.1701912940929, 1034.5551412892378, 1045.1220974381404, 1062.9362238265728, 10218.824835143905, 10670.093042091354, 10744.462776861126, 10757.683526737523, 10761.784764304826, 462531.0, 469809.0, 481365.0, 481566.0, 487715.0, 90534.0, 92205.53897230471, 92471.53764231136, 92496.53751731198, 92790.53604731933, 997.5959736306952, 1002.4436437776958, 1012.8581998520214, 1017.1252722658508, 1049.8897615750388, 16453.753193701865, 16538.09040502784, 16752.0, 16868.831311686725, 17096.145192740063, 38341.616583833806, 38394.616053839105, 39257.2148557033, 40615.18769624532, 42378.15243695047, 54394.72802635962, 56677.0, 57732.0, 57821.0, 58100.0, 8349.37187248505, 8431.15688431152, 8652.697155599524, 8948.015718271115, 8968.910310896808, 12463.688407789878, 13006.80489792635, 13275.86724132785, 13590.59228223155, 13633.454661813814, 11038.889611103787, 11144.498497567467, 11268.661940141808, 11405.942970285096, 11552.364619945984, 11508.36703981289, 11580.826287605862, 11699.941500292443, 11882.168248222888, 11928.582499612472, 11687.532498700297, 11860.762784744084, 11967.461464233957, 12355.876441235472, 12370.13409061393, 8428.704995325133, 8521.488710677379, 8625.741227763177, 8892.68875589377, 8901.154390332907, 8960.238379737795, 11111.666650000512, 12015.579454719043, 12130.636080917586, 12132.0], "value": 9731.242881883807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.0483004651671, 1395.2535393564444, 1413.936372863221, 1421.495369143954, 1469.5003698742428, 8549.57252137393, 8848.690295839648, 8888.06675299094, 9054.637814487429, 9070.546472676357, 8789.956050219756, 8989.280857531397, 9006.549672516381, 9012.54937253138, 9014.188723014928, 2073.3779866040204, 2344.2264052862515, 2356.57581635306, 2392.5334559760768, 2421.1041914491575, 2407.121400688745, 2419.927402177929, 2423.248792874215, 2423.273018094573, 2425.0784701813286, 2388.904443822245, 2401.1235898896953, 2423.7091549014053, 2424.696912885889, 2429.441228517442, 1982.8413726901813, 2192.090282532747, 2248.4940888300166, 2251.0658076898067, 2261.5137745384823, 2264.909403623853, 2270.852394594346, 2284.246198754407, 2285.691431656738, 2287.565362581121, 8683.348748843862, 8800.559972001374, 8802.38383313162, 8815.118488151198, 8820.073892241351, 5253.238280449314, 5447.836564903059, 5458.372287186985, 5459.563234941195, 5460.945390546083, 3334.699877011081, 3350.2461946062185, 3378.1385746634696, 3388.40702876998, 3437.346904088215, 1075.9408232547207, 1097.5554900265406, 1105.6793529876327, 1122.6183097746723, 1128.2046157459054, 12924.289164095972, 12933.0, 12939.288339141438, 12949.805752913713, 12961.675958101123, 4734.405434240027, 4778.1399348117675, 4783.306420568998, 4794.0, 4861.270809378621, 10538.262321637412, 10596.205284603531, 10632.840507392395, 10660.09389201911, 10681.893181068246, 5377.354717433855, 5414.945850541523, 5463.754131064112, 5464.0, 5465.453454654503, 4489.057297967398, 4820.734859582686, 4960.603151747924, 4979.775910084055, 5020.723860187652, 4109.239790638741, 4169.708120431601, 4199.958000420018, 4234.449521562239, 4251.107267473803, 1274.3628185907046, 1286.9935650321688, 1296.8508621508458, 1305.8237137986441, 1307.1895424836473, 964.1467301438138, 1000.8348622477209, 1005.2812239248972, 1011.4790882695418, 1019.9796004079877, 6035.185249991195, 6059.787907423219, 6116.204893363834, 6117.265928088569, 6122.479589234965, 433.63574597338385, 441.66433510532227, 444.5310197741349, 446.4174252600323, 447.6485958522544, 4149.605787450188, 4173.123644034726, 4250.681198910094, 4283.935740963888, 4335.154644844288, 10991.0, 11379.0, 11394.94302528482, 11405.543778248943, 11449.313041217554, 10599.099076578577, 10985.0, 11007.669769906915, 11328.830067548994, 11345.319280843176, 8226.465279756796, 8339.166083391612, 8363.247307742333, 8370.246677799027, 8382.245597896219, 6101.450869421773, 6220.564560480723, 6287.874242515216, 6322.399372059647, 6327.557071004985, 10292.588296468057, 10510.421926794099, 10563.471826408495, 10643.414612196404, 10662.680119596425, 10794.16499195123, 10830.0, 10892.564297428331, 10942.398168100512, 10953.726156846142, 7322.743703970335, 7875.0, 8010.919890801018, 8099.0, 8147.1038185798325, 8811.867821982547, 8867.91132088671, 8918.554072296229, 8937.28501719848, 8937.374383793072, 7762.146163922077, 7819.218078192135, 7869.0950540688555, 7885.6451459685595, 8061.0, 7436.405087593088, 7500.587467689111, 7519.586422746583, 7609.429292802951, 7652.846943061219, 6921.169459664872, 6949.930500695131, 6976.372126508639, 6988.301169882971, 6999.615021173884, 4842.854714358575, 4989.501049894981, 5121.052605268037, 5175.353080864892, 5192.402873669425, 5331.200319952039, 5339.172428273624, 5341.65279256847, 5392.272043274264, 5466.0], "value": 4622.116795983862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.94543927532317, 329.9620543637481, 332.54939556900416, 334.55170072103374, 338.09896625493064, 5339.8398048058525, 5404.486573775485, 5408.486193811592, 5432.402435732071, 5441.0, 5230.686158830473, 5309.230161626562, 5331.653442526233, 5343.492368225013, 5365.873166635011, 3954.307996100685, 4037.0916543777707, 4141.171765646867, 4141.979290103545, 4143.0885205254945, 4095.651869591088, 4104.40486129511, 4137.27597670408, 4139.950724391415, 4144.8756537303925, 3980.5024371953505, 4080.6939479539005, 4109.363048727437, 4117.382392641098, 4139.882231797413, 4040.393940908858, 4083.673306135502, 4093.9385909211387, 4101.753894766323, 4105.096878686684, 3586.5158203642695, 3603.297357015383, 3603.819809009539, 3612.3858943979585, 3626.2384899171207, 5152.995165942642, 5154.860732795885, 5157.664751791159, 5178.818741344035, 5198.6880787152895, 4554.157480866051, 4703.341532185463, 4720.244760838249, 4730.2431610942085, 4763.261694437368, 5499.7250137492965, 5518.46150770646, 5524.917126243109, 5535.474129957647, 5619.494245517923, 3988.4615576897036, 4006.419069234945, 4009.278329900617, 4011.618896204856, 4012.618801213909, 5707.77168913243, 5715.942840571624, 5731.770729170787, 5749.712514374306, 5769.221155144044, 4039.171969746195, 4041.4341992121126, 4057.6753859691153, 4059.89850253746, 4067.678004648501, 4107.404426358161, 4141.7100802943505, 4143.482064741907, 4150.688698347576, 4175.853845115406, 4583.610393116555, 4670.719756814602, 4676.976615116902, 4757.16749568831, 4790.616750660009, 5535.58483113768, 5535.861603459945, 5614.157876318585, 5645.774169033275, 5681.375048744635, 1436.3464623596446, 1448.7323591857125, 1451.4557041109583, 1458.4030486617137, 1459.6204986703533, 921.1071248584224, 949.5964215208509, 956.2541217850088, 968.8207681578931, 977.8044391121804, 5300.337457817773, 5314.335708036496, 5340.25236466895, 5364.436734142937, 5397.298351214396, 5694.4590263924865, 5732.455416735404, 5765.9621268171295, 5774.595778295563, 5783.624064435882, 5241.68549887008, 5317.202419637086, 5320.228566857784, 5361.544268737123, 5374.328208973879, 3010.668826429091, 3031.060371284909, 3044.4824379855036, 3047.2229581456586, 3075.7078077582596, 5627.746751396197, 5880.705964701748, 5919.970400148058, 5956.672383018976, 5988.3113441953865, 5774.39368866263, 5779.711014449261, 5789.6683762733965, 5804.245448091806, 5821.79623713168, 5878.676672782953, 5883.735231914574, 5899.610657683645, 5919.437653422918, 5946.643201407929, 5507.228987941611, 5624.184493248538, 5628.887422251614, 5686.317641883001, 5724.3703192647945, 5587.916181257203, 5591.692456914909, 5617.382087970238, 5644.463775941279, 5664.207011018379, 5652.208690783212, 5918.852028699144, 5936.703164841827, 5956.463918247378, 5962.403759624003, 4077.143799801956, 4091.140860419226, 4093.324601440729, 4096.2831504486, 4101.5488296286785, 5615.5507559395965, 5626.381098079126, 5728.541716662574, 5756.56825738063, 5769.509591684754, 5570.777168913361, 5589.217509548585, 5617.034038086637, 5630.380658127685, 5647.887042259214, 5596.468335508121, 5601.387105317129, 5626.915596265977, 5629.971850140723, 5634.858753673578, 5199.324087868704, 5491.917621235605, 5516.255305533862, 5545.279113715191, 5562.527185189142, 5668.489835914787, 5692.320765374142, 5694.572907031907, 5703.429657034263, 5719.399463056319, 5452.282531002721, 5526.171074338881, 5600.523955463668, 5606.159076138611, 5625.09998400254], "value": 4254.139433905242, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7145905908109, 751.8759404698225, 770.7726220764874, 797.8444203380343, 847.5804476783991, 14101.435942562299, 14517.274136293196, 15130.0, 15545.92227038866, 15624.453144139958, 15367.769483457758, 15439.305231264592, 15468.767968480483, 15476.148811815374, 15484.070955742664, 665.3479590001801, 792.6195426195429, 813.2802469814227, 814.6863457568849, 821.1008945204991, 801.0107517216234, 802.181774589918, 804.2882049386277, 804.4007214625083, 806.2743530822248, 859.6303589456531, 860.0668274921718, 860.6815478273016, 860.9182127697859, 861.5778268648348, 699.9440044796429, 832.3382910586068, 850.9787255318605, 851.6635928808087, 857.2970164465141, 621.7979156774066, 621.8414304352361, 622.1538707357989, 622.17561730707, 623.0156352962308, 13229.867701323055, 13261.27063011534, 13275.0, 13291.734165316639, 13301.068925175241, 12443.875561244453, 12533.24800511963, 12758.234505929673, 12788.808167877489, 13064.86935130646, 12142.575009874701, 12148.45331960064, 12549.498020079185, 12622.305773182472, 12837.422315995802, 4389.802458889326, 4461.7992190351515, 4464.910701785946, 4495.527969563182, 4519.887002824956, 52214.47785522134, 54584.454155458734, 58770.0, 59143.70428147875, 59146.0, 11286.66140015801, 11318.603848865416, 11370.374629395297, 11389.259698119597, 11684.415779211005, 18351.632967340578, 18454.815451845578, 18514.907425462785, 18704.438866834018, 18727.157277922524, 8498.617562209716, 8562.400631955828, 8588.484690918565, 8665.783355416039, 8760.211580957617, 4602.240630296031, 4709.95290047102, 4764.547368000034, 4795.352627395327, 4924.532169443897, 3451.8964431067106, 3567.108222944264, 3567.9643203568153, 3568.839402226906, 3570.107473131717, 685.2359619024752, 688.7072993977539, 691.3432239372617, 694.1115372323434, 698.8532408194235, 619.4146531527663, 685.4858855858106, 712.6935417770409, 742.4246209187922, 755.1768572256267, 8885.955570222108, 8957.596908139149, 9184.357095003286, 9221.953890230507, 9423.670171543963, 624.7719582352408, 673.6833688166554, 674.7739507265023, 733.4132693844903, 754.2532892436558, 4555.382839092074, 4717.693349932312, 4745.715257084586, 4783.569478746929, 4833.854984350475, 68241.0, 68731.3126868725, 68739.0, 69066.0, 69616.30383696099, 60077.0, 60249.69875150596, 60791.696041519506, 61232.0, 61737.38262617406, 54683.179752303746, 55909.44090559124, 55972.0, 56647.433525664215, 57020.429795702345, 8901.866472003054, 8947.239484643618, 8947.418417802823, 9049.366544342096, 9139.817203656023, 37590.248195036496, 37924.43113353357, 38038.429423559224, 38054.23891522209, 38170.0457488565, 46151.0, 47530.52469475261, 49094.509054908995, 49238.0, 49576.50423495719, 10952.123830093733, 11076.778464430505, 11178.552857885594, 11194.272372295774, 11263.943680281545, 11770.470328835394, 11805.704857378634, 12015.279083255033, 12577.245365278113, 12790.808137878126, 11486.19596628228, 11821.527138914347, 11877.109216808602, 12089.15375923677, 12195.75608487843, 11296.152788540729, 11330.60342887995, 11677.357745324089, 11956.46195921203, 12856.42146103409, 11394.08847292198, 11658.6502404928, 11851.881481185077, 12031.45858436355, 12094.153409261618, 9427.952860235655, 9900.801983960424, 9936.801263974536, 10025.147862431775, 10249.74375640615, 9894.75263118399, 9989.500524973577, 10004.349717268355, 10006.499675016366, 10105.595776169164], "value": 6818.000037072439, "unit": "score"}], "name": "dromaeo_css", "value": 7197.990072326864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 109.0, 109.0, 111.0, 109.0, 108.0, 109.0, 109.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 125.0, 192.0, 126.0, 126.0, 153.0, 124.0, 191.0, 125.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 162.0, 159.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 126.0, 77.0, 76.0, 74.0, 75.0, 104.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 83.0, 83.0, 84.0, 117.0, 85.0, 83.0, 120.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 56.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 65.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 87.0, 81.0, 81.0, 82.0, 112.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 133.0, 136.0, 122.0, 130.0, 119.0, 129.0, 127.0, 121.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 165.0, 168.0, 170.0, 161.0, 162.0, 169.0, 166.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 63.0, 64.0, 66.0, 64.0, 63.0, 63.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1503.3999999999999, "alertThreshold": 2.0}]} 14:35:55 INFO - Return code: 0 14:35:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:55 ERROR - # TBPL SUCCESS # 14:35:55 INFO - Running post-action listener: _resource_record_post_action 14:35:55 INFO - ##### 14:35:55 INFO - ##### Finished run-tests step (success) 14:35:55 INFO - ##### 14:35:55 INFO - Running post-run listener: _resource_record_post_run 14:35:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 36864; Write bytes: 545832960; Read time: 36; Write time: 462216 14:35:55 INFO - TinderboxPrint: CPU usage
13.1% 14:35:55 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 36 14:35:55 INFO - TinderboxPrint: I/O write bytes / time
545,832,960 / 462,216 14:35:55 INFO - TinderboxPrint: CPU idle
8,265.2 (86.9%) 14:35:55 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 14:35:55 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254013440; Read time: 0; Write time: 276344 14:35:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 36864; Write bytes: 287916032; Read time: 36; Write time: 185508 14:35:56 INFO - Running post-run listener: _upload_blobber_files 14:35:56 INFO - Blob upload gear active. 14:35:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:56 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 14:35:56 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'] 14:35:56 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 14:35:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:00 INFO - (blobuploader) - INFO - Done attempting. 14:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:03 INFO - (blobuploader) - INFO - Done attempting. 14:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:04 INFO - (blobuploader) - INFO - Done attempting. 14:36:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:04 INFO - Return code: 0 14:36:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652d3e9aec31d3c62cdcf0f56a58cd448e103ad10b48fce2d9d25ef5fbcc409b5cb1d496d41b2f9a9571bc35d5960855fa8df3d7ce1d8b65c7386ee1f198bff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b14ce7b873a5d4ef181ea07b29ee217a79b99c6f55e9d5879bdedd74404ab87a67de24a383e9b9f962ad782cf6f026183091918d2109a86af0ea1add4449bf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18261787f7e435b726bca0dff9e05d547fe9bb0c7980fa19d1e62075d7085f3e955ed65ccb1625692f98b87999aaae6ebf799a0578a05b0f81dc192fc61a3259"} 14:36:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:04 INFO - Contents: 14:36:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652d3e9aec31d3c62cdcf0f56a58cd448e103ad10b48fce2d9d25ef5fbcc409b5cb1d496d41b2f9a9571bc35d5960855fa8df3d7ce1d8b65c7386ee1f198bff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b14ce7b873a5d4ef181ea07b29ee217a79b99c6f55e9d5879bdedd74404ab87a67de24a383e9b9f962ad782cf6f026183091918d2109a86af0ea1add4449bf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18261787f7e435b726bca0dff9e05d547fe9bb0c7980fa19d1e62075d7085f3e955ed65ccb1625692f98b87999aaae6ebf799a0578a05b0f81dc192fc61a3259"} 14:36:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:04 INFO - Copying logs to upload dir... 14:36:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.030065 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-31 14:36:04.695083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 14:36:04.698893) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 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/652d3e9aec31d3c62cdcf0f56a58cd448e103ad10b48fce2d9d25ef5fbcc409b5cb1d496d41b2f9a9571bc35d5960855fa8df3d7ce1d8b65c7386ee1f198bff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b14ce7b873a5d4ef181ea07b29ee217a79b99c6f55e9d5879bdedd74404ab87a67de24a383e9b9f962ad782cf6f026183091918d2109a86af0ea1add4449bf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18261787f7e435b726bca0dff9e05d547fe9bb0c7980fa19d1e62075d7085f3e955ed65ccb1625692f98b87999aaae6ebf799a0578a05b0f81dc192fc61a3259"} build_url:https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/ClJ8sc0MT3SkXrPtJJDUvw/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/652d3e9aec31d3c62cdcf0f56a58cd448e103ad10b48fce2d9d25ef5fbcc409b5cb1d496d41b2f9a9571bc35d5960855fa8df3d7ce1d8b65c7386ee1f198bff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b14ce7b873a5d4ef181ea07b29ee217a79b99c6f55e9d5879bdedd74404ab87a67de24a383e9b9f962ad782cf6f026183091918d2109a86af0ea1add4449bf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18261787f7e435b726bca0dff9e05d547fe9bb0c7980fa19d1e62075d7085f3e955ed65ccb1625692f98b87999aaae6ebf799a0578a05b0f81dc192fc61a3259"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 14:36:04.724554) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:36:04.724887) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464729326.502612-744351203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:36:04.810338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 14:36:04.810998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 14:36:04.811621) ========= ========= Total master_lag: 0.17 =========