builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1464079502.27 results: success (0) buildid: 20160523193033 builduid: 06a868e8689c40f29754689df9b8e090 revision: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.272077) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.272538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.272825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.289166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.289527) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 01:45:02-- 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% 38.1M=0s 2016-05-24 01:45:02 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.372908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.373226) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.422503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:02.422855) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 46fe2115d46a5bb40523b8466341d8f9a26e1bdf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 46fe2115d46a5bb40523b8466341d8f9a26e1bdf --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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 01:45:02,778 truncating revision to first 12 chars 2016-05-24 01:45:02,778 Setting DEBUG logging. 2016-05-24 01:45:02,778 attempt 1/10 2016-05-24 01:45:02,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/46fe2115d46a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 01:45:03,199 unpacking tar archive at: mozilla-central-46fe2115d46a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:03.122112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:03.122435) ========= script_repo_revision: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:03.122844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:03.123112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:03.130555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 01:45:03.130823) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:45:03 INFO - MultiFileLogger online at 20160524 01:45:03 in /builds/slave/test 01:45:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:45:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:45:03 INFO - {'append_to_log': False, 01:45:03 INFO - 'base_work_dir': '/builds/slave/test', 01:45:03 INFO - 'blob_upload_branch': 'Firefox', 01:45:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:45:03 INFO - 'branch': 'Firefox', 01:45:03 INFO - 'buildbot_json_path': 'buildprops.json', 01:45:03 INFO - 'config_files': ('talos/linux_config.py',), 01:45:03 INFO - 'default_actions': ('clobber', 01:45:03 INFO - 'read-buildbot-config', 01:45:03 INFO - 'download-and-extract', 01:45:03 INFO - 'populate-webroot', 01:45:03 INFO - 'create-virtualenv', 01:45:03 INFO - 'install', 01:45:03 INFO - 'run-tests'), 01:45:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:45:03 INFO - 'download_minidump_stackwalk': True, 01:45:03 INFO - 'download_symbols': 'ondemand', 01:45:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:45:03 INFO - 'tooltool.py': '/tools/tooltool.py', 01:45:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:45:03 INFO - '/tools/misc-python/virtualenv.py')}, 01:45:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:45:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:45:03 INFO - 'installer_path': 'installer.exe', 01:45:03 INFO - 'log_level': 'info', 01:45:03 INFO - 'log_name': 'talos', 01:45:03 INFO - 'log_to_console': True, 01:45:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:45:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:45:03 INFO - 'opt_config_files': (), 01:45:03 INFO - 'pip_index': False, 01:45:03 INFO - 'sps_profile': False, 01:45:03 INFO - 'sps_profile_interval': 0, 01:45:03 INFO - 'suite': 'dromaeojs', 01:45:03 INFO - 'system_bits': '32', 01:45:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:45:03 INFO - 'title': 'talos-linux64-ix-061', 01:45:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:45:03 INFO - 'use_talos_json': True, 01:45:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:45:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:45:03 INFO - 'work_dir': 'build'} 01:45:03 INFO - ##### 01:45:03 INFO - ##### Running clobber step. 01:45:03 INFO - ##### 01:45:03 INFO - Running pre-action listener: _resource_record_pre_action 01:45:03 INFO - Running main action method: clobber 01:45:03 INFO - rmtree: /builds/slave/test/build 01:45:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:45:04 INFO - Running post-action listener: _resource_record_post_action 01:45:04 INFO - ##### 01:45:04 INFO - ##### Finished clobber step (success) 01:45:04 INFO - ##### 01:45:04 INFO - ##### 01:45:04 INFO - ##### Running read-buildbot-config step. 01:45:04 INFO - ##### 01:45:04 INFO - Running pre-action listener: _resource_record_pre_action 01:45:04 INFO - Running main action method: read_buildbot_config 01:45:04 INFO - Using buildbot properties: 01:45:04 INFO - { 01:45:04 INFO - "project": "", 01:45:04 INFO - "product": "firefox", 01:45:04 INFO - "script_repo_revision": "production", 01:45:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:45:04 INFO - "repository": "", 01:45:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:45:04 INFO - "buildid": "20160523193033", 01:45:04 INFO - "pgo_build": "True", 01:45:04 INFO - "basedir": "/builds/slave/test", 01:45:04 INFO - "buildnumber": 300, 01:45:04 INFO - "slavename": "talos-linux64-ix-061", 01:45:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:45:04 INFO - "platform": "ubuntu64_hw", 01:45:04 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:45:04 INFO - "branch": "mozilla-central", 01:45:04 INFO - "repo_path": "mozilla-central", 01:45:04 INFO - "revision": "46fe2115d46a5bb40523b8466341d8f9a26e1bdf", 01:45:04 INFO - "stage_platform": "linux64-pgo", 01:45:04 INFO - "builduid": "06a868e8689c40f29754689df9b8e090", 01:45:04 INFO - "slavebuilddir": "test" 01:45:04 INFO - } 01:45:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:45:04 INFO - Running post-action listener: _resource_record_post_action 01:45:04 INFO - ##### 01:45:04 INFO - ##### Finished read-buildbot-config step (success) 01:45:04 INFO - ##### 01:45:04 INFO - ##### 01:45:04 INFO - ##### Running download-and-extract step. 01:45:04 INFO - ##### 01:45:04 INFO - Running pre-action listener: _resource_record_pre_action 01:45:04 INFO - Running main action method: download_and_extract 01:45:04 INFO - mkdir: /builds/slave/test/build/tests 01:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:04 INFO - https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:04 INFO - Downloaded 1361 bytes. 01:45:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:45:04 INFO - Using the following test package requirements: 01:45:04 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:04 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:45:04 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:45:04 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'jsshell-linux-x86_64.zip'], 01:45:04 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:45:04 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:04 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:45:04 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:45:04 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:45:04 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:45:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:04 INFO - https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:05 INFO - Downloaded 24389070 bytes. 01:45:05 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'] 01:45:05 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 01:45:06 INFO - Return code: 0 01:45:06 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 01:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:06 INFO - https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:45:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:45:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:08 INFO - Downloaded 24389070 bytes. 01:45:08 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'] 01:45:08 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 01:45:09 INFO - Return code: 0 01:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:09 INFO - https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:45:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:10 INFO - Downloaded 10840359 bytes. 01:45:10 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'] 01:45:10 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 01:45:10 INFO - Return code: 0 01:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:10 INFO - https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxDfRuLmQiCtEQVsg9s41A/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 01:45:12 INFO - Downloaded 58598567 bytes. 01:45:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:45:12 INFO - mkdir: /builds/slave/test/properties 01:45:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:45:12 INFO - Writing to file /builds/slave/test/properties/build_url 01:45:12 INFO - Contents: 01:45:12 INFO - build_url:https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:45:12 INFO - Running post-action listener: _resource_record_post_action 01:45:12 INFO - Running post-action listener: set_extra_try_arguments 01:45:12 INFO - ##### 01:45:12 INFO - ##### Finished download-and-extract step (success) 01:45:12 INFO - ##### 01:45:12 INFO - ##### 01:45:12 INFO - ##### Running populate-webroot step. 01:45:12 INFO - ##### 01:45:12 INFO - Running pre-action listener: _resource_record_pre_action 01:45:12 INFO - Running main action method: populate_webroot 01:45:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:12 INFO - '--tppagecycles', 01:45:12 INFO - '7'], 01:45:12 INFO - 'tests': ['tsvgm']}}, 01:45:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:45:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:45:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:45:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['damp', 'tps']}, 01:45:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'tests': ['damp', 'tps']}, 01:45:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['dromaeo_dom']}, 01:45:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'other-e10s': {'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['a11yr', 01:45:12 INFO - 'ts_paint', 01:45:12 INFO - 'tpaint', 01:45:12 INFO - 'sessionrestore', 01:45:12 INFO - 'sessionrestore_no_auto_restore', 01:45:12 INFO - 'tabpaint']}, 01:45:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['tsvgx', 01:45:12 INFO - 'tsvgr_opacity', 01:45:12 INFO - 'tart', 01:45:12 INFO - 'tscrollx', 01:45:12 INFO - 'cart']}, 01:45:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:45:12 INFO - 'tsvgr_opacity', 01:45:12 INFO - 'tart', 01:45:12 INFO - 'tscrollx', 01:45:12 INFO - 'cart']}, 01:45:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'talos_options': ['--disable-e10s'], 01:45:12 INFO - 'tests': ['tp5o']}, 01:45:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'tests': ['tp5o']}, 01:45:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'talos_options': ['--disable-e10s', 01:45:12 INFO - '--xperf_path', 01:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:12 INFO - 'tests': ['tp5n']}, 01:45:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:12 INFO - 'talos_options': ['--xperf_path', 01:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:12 INFO - 'tests': ['tp5n']}}, 01:45:12 INFO - 'talos.zip': {'path': '', 01:45:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:12 INFO - Running post-action listener: _resource_record_post_action 01:45:12 INFO - ##### 01:45:12 INFO - ##### Finished populate-webroot step (success) 01:45:12 INFO - ##### 01:45:12 INFO - ##### 01:45:12 INFO - ##### Running create-virtualenv step. 01:45:12 INFO - ##### 01:45:12 INFO - Running pre-action listener: _resource_record_pre_action 01:45:12 INFO - Running main action method: create_virtualenv 01:45:12 INFO - Creating virtualenv /builds/slave/test/build/venv 01:45:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:45:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:45:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:12 INFO - Using real prefix '/usr' 01:45:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:45:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:15 INFO - Installing pip.................done. 01:45:15 INFO - Return code: 0 01:45:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:15 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:45:15 INFO - Using env: {'DISPLAY': ':0', 01:45:15 INFO - 'HOME': '/home/cltbld', 01:45:15 INFO - 'LANG': 'en_US.UTF-8', 01:45:15 INFO - 'LANGUAGE': 'en_US:en', 01:45:15 INFO - 'LOGNAME': 'cltbld', 01:45:15 INFO - 'MAIL': '/var/mail/cltbld', 01:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:15 INFO - 'MOZ_NO_REMOTE': '1', 01:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:15 INFO - 'NO_EM_RESTART': '1', 01:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:15 INFO - 'PWD': '/builds/slave/test', 01:45:15 INFO - 'SHELL': '/bin/bash', 01:45:15 INFO - 'SHLVL': '1', 01:45:15 INFO - 'TERM': 'linux', 01:45:15 INFO - 'TMOUT': '86400', 01:45:15 INFO - 'USER': 'cltbld', 01:45:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:15 INFO - '_': '/tools/buildbot/bin/python'} 01:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:45:15 INFO - Cleaning up... 01:45:15 INFO - Return code: 0 01:45:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:15 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:15 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 01:45:15 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 01:45:15 INFO - Using env: {'DISPLAY': ':0', 01:45:15 INFO - 'HOME': '/home/cltbld', 01:45:15 INFO - 'LANG': 'en_US.UTF-8', 01:45:15 INFO - 'LANGUAGE': 'en_US:en', 01:45:15 INFO - 'LOGNAME': 'cltbld', 01:45:15 INFO - 'MAIL': '/var/mail/cltbld', 01:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:15 INFO - 'MOZ_NO_REMOTE': '1', 01:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:15 INFO - 'NO_EM_RESTART': '1', 01:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:15 INFO - 'PWD': '/builds/slave/test', 01:45:15 INFO - 'SHELL': '/bin/bash', 01:45:15 INFO - 'SHLVL': '1', 01:45:15 INFO - 'TERM': 'linux', 01:45:15 INFO - 'TMOUT': '86400', 01:45:15 INFO - 'USER': 'cltbld', 01:45:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:15 INFO - '_': '/tools/buildbot/bin/python'} 01:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:15 INFO - Downloading/unpacking psutil>=3.1.1 01:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:17 INFO - Installing collected packages: psutil 01:45:17 INFO - Running setup.py install for psutil 01:45:18 INFO - building 'psutil._psutil_linux' extension 01:45:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:45:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:45:18 INFO - building 'psutil._psutil_posix' extension 01:45:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:45:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:45:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:18 INFO - Successfully installed psutil 01:45:18 INFO - Cleaning up... 01:45:18 INFO - Return code: 0 01:45:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:45:18 INFO - Using env: {'DISPLAY': ':0', 01:45:18 INFO - 'HOME': '/home/cltbld', 01:45:18 INFO - 'LANG': 'en_US.UTF-8', 01:45:18 INFO - 'LANGUAGE': 'en_US:en', 01:45:18 INFO - 'LOGNAME': 'cltbld', 01:45:18 INFO - 'MAIL': '/var/mail/cltbld', 01:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:18 INFO - 'MOZ_NO_REMOTE': '1', 01:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:18 INFO - 'NO_EM_RESTART': '1', 01:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:18 INFO - 'PWD': '/builds/slave/test', 01:45:18 INFO - 'SHELL': '/bin/bash', 01:45:18 INFO - 'SHLVL': '1', 01:45:18 INFO - 'TERM': 'linux', 01:45:18 INFO - 'TMOUT': '86400', 01:45:18 INFO - 'USER': 'cltbld', 01:45:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:18 INFO - '_': '/tools/buildbot/bin/python'} 01:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:45:20 INFO - Installing collected packages: mozsystemmonitor 01:45:20 INFO - Running setup.py install for mozsystemmonitor 01:45:20 INFO - Successfully installed mozsystemmonitor 01:45:20 INFO - Cleaning up... 01:45:20 INFO - Return code: 0 01:45:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:45:20 INFO - Using env: {'DISPLAY': ':0', 01:45:20 INFO - 'HOME': '/home/cltbld', 01:45:20 INFO - 'LANG': 'en_US.UTF-8', 01:45:20 INFO - 'LANGUAGE': 'en_US:en', 01:45:20 INFO - 'LOGNAME': 'cltbld', 01:45:20 INFO - 'MAIL': '/var/mail/cltbld', 01:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:20 INFO - 'MOZ_NO_REMOTE': '1', 01:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:20 INFO - 'NO_EM_RESTART': '1', 01:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:20 INFO - 'PWD': '/builds/slave/test', 01:45:20 INFO - 'SHELL': '/bin/bash', 01:45:20 INFO - 'SHLVL': '1', 01:45:20 INFO - 'TERM': 'linux', 01:45:20 INFO - 'TMOUT': '86400', 01:45:20 INFO - 'USER': 'cltbld', 01:45:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:20 INFO - '_': '/tools/buildbot/bin/python'} 01:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:22 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:45:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:23 INFO - Downloading docopt-0.6.1.tar.gz 01:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:23 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:23 INFO - Running setup.py install for blobuploader 01:45:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:45:23 INFO - Running setup.py install for requests 01:45:24 INFO - Running setup.py install for docopt 01:45:24 INFO - Successfully installed blobuploader requests docopt 01:45:24 INFO - Cleaning up... 01:45:24 INFO - Return code: 0 01:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:24 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:45:24 INFO - Using env: {'DISPLAY': ':0', 01:45:24 INFO - 'HOME': '/home/cltbld', 01:45:24 INFO - 'LANG': 'en_US.UTF-8', 01:45:24 INFO - 'LANGUAGE': 'en_US:en', 01:45:24 INFO - 'LOGNAME': 'cltbld', 01:45:24 INFO - 'MAIL': '/var/mail/cltbld', 01:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:24 INFO - 'MOZ_NO_REMOTE': '1', 01:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:24 INFO - 'NO_EM_RESTART': '1', 01:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:24 INFO - 'PWD': '/builds/slave/test', 01:45:24 INFO - 'SHELL': '/bin/bash', 01:45:24 INFO - 'SHLVL': '1', 01:45:24 INFO - 'TERM': 'linux', 01:45:24 INFO - 'TMOUT': '86400', 01:45:24 INFO - 'USER': 'cltbld', 01:45:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:24 INFO - '_': '/tools/buildbot/bin/python'} 01:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:24 INFO - Running setup.py (path:/tmp/pip-Hsuq_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:24 INFO - Running setup.py (path:/tmp/pip-O3mEVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:24 INFO - Running setup.py (path:/tmp/pip-PhATI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:24 INFO - Running setup.py (path:/tmp/pip-Rn6RxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:24 INFO - Running setup.py (path:/tmp/pip-r3_XEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:24 INFO - Running setup.py (path:/tmp/pip-acWy5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:24 INFO - Running setup.py (path:/tmp/pip-s3EqrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:24 INFO - Running setup.py (path:/tmp/pip-EQ1ZCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:25 INFO - Running setup.py (path:/tmp/pip-NpI977-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:25 INFO - Running setup.py (path:/tmp/pip-cko10u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:25 INFO - Running setup.py (path:/tmp/pip-NyyjJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:25 INFO - Running setup.py (path:/tmp/pip-aEPqnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:25 INFO - Running setup.py (path:/tmp/pip-03fVLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:25 INFO - Running setup.py (path:/tmp/pip-V4djZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:25 INFO - Running setup.py (path:/tmp/pip-vzRQVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:25 INFO - Running setup.py (path:/tmp/pip-IQiGBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:25 INFO - Running setup.py (path:/tmp/pip-sRoOeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:25 INFO - Running setup.py install for manifestparser 01:45:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:45:25 INFO - Running setup.py install for mozcrash 01:45:25 INFO - Running setup.py install for mozdebug 01:45:25 INFO - Running setup.py install for mozdevice 01:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozfile 01:45:26 INFO - Running setup.py install for mozhttpd 01:45:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozinfo 01:45:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozInstall 01:45:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozleak 01:45:26 INFO - Running setup.py install for mozlog 01:45:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for moznetwork 01:45:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozprocess 01:45:26 INFO - Running setup.py install for mozprofile 01:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozrunner 01:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozscreenshot 01:45:27 INFO - Running setup.py install for moztest 01:45:27 INFO - Running setup.py install for mozversion 01:45:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:27 INFO - Cleaning up... 01:45:27 INFO - Return code: 0 01:45:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:27 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:45:27 INFO - Using env: {'DISPLAY': ':0', 01:45:27 INFO - 'HOME': '/home/cltbld', 01:45:27 INFO - 'LANG': 'en_US.UTF-8', 01:45:27 INFO - 'LANGUAGE': 'en_US:en', 01:45:27 INFO - 'LOGNAME': 'cltbld', 01:45:27 INFO - 'MAIL': '/var/mail/cltbld', 01:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:27 INFO - 'MOZ_NO_REMOTE': '1', 01:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:27 INFO - 'NO_EM_RESTART': '1', 01:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:27 INFO - 'PWD': '/builds/slave/test', 01:45:27 INFO - 'SHELL': '/bin/bash', 01:45:27 INFO - 'SHLVL': '1', 01:45:27 INFO - 'TERM': 'linux', 01:45:27 INFO - 'TMOUT': '86400', 01:45:27 INFO - 'USER': 'cltbld', 01:45:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:27 INFO - '_': '/tools/buildbot/bin/python'} 01:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:27 INFO - Running setup.py (path:/tmp/pip-0ZTEgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:27 INFO - Running setup.py (path:/tmp/pip-aADOHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:27 INFO - Running setup.py (path:/tmp/pip-PUHA_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:27 INFO - Running setup.py (path:/tmp/pip-kBZgwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:27 INFO - Running setup.py (path:/tmp/pip-GkVPix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:28 INFO - Running setup.py (path:/tmp/pip-B0fIj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:28 INFO - Running setup.py (path:/tmp/pip-YrmtS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:28 INFO - Running setup.py (path:/tmp/pip-Wqbns7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:28 INFO - Running setup.py (path:/tmp/pip-hxCS7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:28 INFO - Running setup.py (path:/tmp/pip-KQmiVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:28 INFO - Running setup.py (path:/tmp/pip-pTLmIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:28 INFO - Running setup.py (path:/tmp/pip-1nLoqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:28 INFO - Running setup.py (path:/tmp/pip-mtAn2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:28 INFO - Running setup.py (path:/tmp/pip-GFpTdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:28 INFO - Running setup.py (path:/tmp/pip-HghPHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:28 INFO - Running setup.py (path:/tmp/pip-dHBpUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:28 INFO - Running setup.py (path:/tmp/pip-JWfVkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:45:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:30 INFO - Downloading blessings-1.6.tar.gz 01:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:45:30 INFO - Installing collected packages: blessings 01:45:30 INFO - Running setup.py install for blessings 01:45:30 INFO - Successfully installed blessings 01:45:30 INFO - Cleaning up... 01:45:31 INFO - Return code: 0 01:45:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:45:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:31 INFO - Reading from file tmpfile_stdout 01:45:31 INFO - Current package versions: 01:45:31 INFO - argparse == 1.2.1 01:45:31 INFO - blessings == 1.6 01:45:31 INFO - blobuploader == 1.2.4 01:45:31 INFO - docopt == 0.6.1 01:45:31 INFO - manifestparser == 1.1 01:45:31 INFO - mozInstall == 1.12 01:45:31 INFO - mozcrash == 0.17 01:45:31 INFO - mozdebug == 0.1 01:45:31 INFO - mozdevice == 0.48 01:45:31 INFO - mozfile == 1.2 01:45:31 INFO - mozhttpd == 0.7 01:45:31 INFO - mozinfo == 0.9 01:45:31 INFO - mozleak == 0.1 01:45:31 INFO - mozlog == 3.2 01:45:31 INFO - moznetwork == 0.27 01:45:31 INFO - mozprocess == 0.22 01:45:31 INFO - mozprofile == 0.28 01:45:31 INFO - mozrunner == 6.11 01:45:31 INFO - mozscreenshot == 0.1 01:45:31 INFO - mozsystemmonitor == 0.3 01:45:31 INFO - moztest == 0.7 01:45:31 INFO - mozversion == 1.4 01:45:31 INFO - psutil == 3.1.1 01:45:31 INFO - requests == 1.2.3 01:45:31 INFO - wsgiref == 0.1.2 01:45:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:31 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:45:31 INFO - Using env: {'DISPLAY': ':0', 01:45:31 INFO - 'HOME': '/home/cltbld', 01:45:31 INFO - 'LANG': 'en_US.UTF-8', 01:45:31 INFO - 'LANGUAGE': 'en_US:en', 01:45:31 INFO - 'LOGNAME': 'cltbld', 01:45:31 INFO - 'MAIL': '/var/mail/cltbld', 01:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:31 INFO - 'MOZ_NO_REMOTE': '1', 01:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:31 INFO - 'NO_EM_RESTART': '1', 01:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:31 INFO - 'PWD': '/builds/slave/test', 01:45:31 INFO - 'SHELL': '/bin/bash', 01:45:31 INFO - 'SHLVL': '1', 01:45:31 INFO - 'TERM': 'linux', 01:45:31 INFO - 'TMOUT': '86400', 01:45:31 INFO - 'USER': 'cltbld', 01:45:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:31 INFO - '_': '/tools/buildbot/bin/python'} 01:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:45:31 INFO - Cleaning up... 01:45:31 INFO - Return code: 0 01:45:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:31 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:45:31 INFO - Using env: {'DISPLAY': ':0', 01:45:31 INFO - 'HOME': '/home/cltbld', 01:45:31 INFO - 'LANG': 'en_US.UTF-8', 01:45:31 INFO - 'LANGUAGE': 'en_US:en', 01:45:31 INFO - 'LOGNAME': 'cltbld', 01:45:31 INFO - 'MAIL': '/var/mail/cltbld', 01:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:31 INFO - 'MOZ_NO_REMOTE': '1', 01:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:31 INFO - 'NO_EM_RESTART': '1', 01:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:31 INFO - 'PWD': '/builds/slave/test', 01:45:31 INFO - 'SHELL': '/bin/bash', 01:45:31 INFO - 'SHLVL': '1', 01:45:31 INFO - 'TERM': 'linux', 01:45:31 INFO - 'TMOUT': '86400', 01:45:31 INFO - 'USER': 'cltbld', 01:45:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:31 INFO - '_': '/tools/buildbot/bin/python'} 01:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:31 INFO - Downloading/unpacking jsonschema 01:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:45:33 INFO - Downloading/unpacking functools32 (from jsonschema) 01:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:33 INFO - Downloading functools32-3.2.3-2.tar.gz 01:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:45:33 INFO - warning: no files found matching '*.txt' 01:45:33 INFO - no previously-included directories found matching 'build' 01:45:33 INFO - no previously-included directories found matching 'dist' 01:45:33 INFO - no previously-included directories found matching '.git*' 01:45:33 INFO - Installing collected packages: jsonschema, functools32 01:45:33 INFO - Running setup.py install for functools32 01:45:33 INFO - warning: no files found matching '*.txt' 01:45:33 INFO - no previously-included directories found matching 'build' 01:45:33 INFO - no previously-included directories found matching 'dist' 01:45:33 INFO - no previously-included directories found matching '.git*' 01:45:34 INFO - Successfully installed jsonschema functools32 01:45:34 INFO - Cleaning up... 01:45:34 INFO - Return code: 0 01:45:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:34 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 0x7f2d08fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:45:34 INFO - Using env: {'DISPLAY': ':0', 01:45:34 INFO - 'HOME': '/home/cltbld', 01:45:34 INFO - 'LANG': 'en_US.UTF-8', 01:45:34 INFO - 'LANGUAGE': 'en_US:en', 01:45:34 INFO - 'LOGNAME': 'cltbld', 01:45:34 INFO - 'MAIL': '/var/mail/cltbld', 01:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:34 INFO - 'MOZ_NO_REMOTE': '1', 01:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:34 INFO - 'NO_EM_RESTART': '1', 01:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:34 INFO - 'PWD': '/builds/slave/test', 01:45:34 INFO - 'SHELL': '/bin/bash', 01:45:34 INFO - 'SHLVL': '1', 01:45:34 INFO - 'TERM': 'linux', 01:45:34 INFO - 'TMOUT': '86400', 01:45:34 INFO - 'USER': 'cltbld', 01:45:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:34 INFO - '_': '/tools/buildbot/bin/python'} 01:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:34 INFO - Downloading/unpacking flake8 01:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:45:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:45:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:45:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:36 INFO - no previously-included directories found matching 'docs/_build' 01:45:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:45:36 INFO - Running setup.py install for pep8 01:45:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:36 INFO - no previously-included directories found matching 'docs/_build' 01:45:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:45:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:45:37 INFO - Cleaning up... 01:45:37 INFO - Return code: 0 01:45:37 INFO - Running post-action listener: _resource_record_post_action 01:45:37 INFO - Running post-action listener: _start_resource_monitoring 01:45:37 INFO - Starting resource monitoring. 01:45:37 INFO - ##### 01:45:37 INFO - ##### Finished create-virtualenv step (success) 01:45:37 INFO - ##### 01:45:37 INFO - ##### 01:45:37 INFO - ##### Running install step. 01:45:37 INFO - ##### 01:45:37 INFO - Running pre-action listener: _resource_record_pre_action 01:45:37 INFO - Running main action method: install 01:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:37 INFO - Reading from file tmpfile_stdout 01:45:37 INFO - Detecting whether we're running mozinstall >=1.0... 01:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:45:37 INFO - Reading from file tmpfile_stdout 01:45:37 INFO - Output received: 01:45:37 INFO - Usage: mozinstall [options] installer 01:45:37 INFO - Options: 01:45:37 INFO - -h, --help show this help message and exit 01:45:37 INFO - -d DEST, --destination=DEST 01:45:37 INFO - Directory to install application into. [default: 01:45:37 INFO - "/builds/slave/test"] 01:45:37 INFO - --app=APP Application being installed. [default: firefox] 01:45:37 INFO - mkdir: /builds/slave/test/build/application 01:45:37 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'] 01:45:37 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 01:45:54 INFO - Reading from file tmpfile_stdout 01:45:54 INFO - Output received: 01:45:54 INFO - /builds/slave/test/build/application/firefox/firefox 01:45:54 INFO - Running post-action listener: _resource_record_post_action 01:45:54 INFO - ##### 01:45:54 INFO - ##### Finished install step (success) 01:45:54 INFO - ##### 01:45:54 INFO - ##### 01:45:54 INFO - ##### Running run-tests step. 01:45:54 INFO - ##### 01:45:54 INFO - Running pre-action listener: _resource_record_pre_action 01:45:54 INFO - Running main action method: run_tests 01:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:45:54 INFO - Python 2.7.3 01:45:54 INFO - Return code: 0 01:45:54 INFO - grabbing minidump binary from tooltool 01:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:54 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 0x2a649c0>, '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 0x2a658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a65d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:45:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:45:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:45:54 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 01:45:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:45:54 INFO - Return code: 0 01:45:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:45:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:45:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:45:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:45:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:45:55 INFO - Return code: 0 01:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 01:45:55 INFO - Using env: {'DISPLAY': ':0', 01:45:55 INFO - 'HOME': '/home/cltbld', 01:45:55 INFO - 'LANG': 'en_US.UTF-8', 01:45:55 INFO - 'LANGUAGE': 'en_US:en', 01:45:55 INFO - 'LOGNAME': 'cltbld', 01:45:55 INFO - 'MAIL': '/var/mail/cltbld', 01:45:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:45:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:55 INFO - 'MOZ_NO_REMOTE': '1', 01:45:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:55 INFO - 'NO_EM_RESTART': '1', 01:45:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:55 INFO - 'PWD': '/builds/slave/test', 01:45:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:45:55 INFO - 'SHELL': '/bin/bash', 01:45:55 INFO - 'SHLVL': '1', 01:45:55 INFO - 'TERM': 'linux', 01:45:55 INFO - 'TMOUT': '86400', 01:45:55 INFO - 'USER': 'cltbld', 01:45:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871', 01:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:55 INFO - '_': '/tools/buildbot/bin/python'} 01:45:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:45:55 INFO - mozversion application_buildid: 20160523193033 01:45:55 INFO - mozversion application_changeset: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf 01:45:55 INFO - mozversion application_display_name: Nightly 01:45:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:45:55 INFO - mozversion application_name: Firefox 01:45:55 INFO - mozversion application_remotingname: firefox 01:45:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:45:55 INFO - mozversion application_vendor: Mozilla 01:45:55 INFO - mozversion application_version: 49.0a1 01:45:55 INFO - mozversion platform_buildid: 20160523193033 01:45:55 INFO - mozversion platform_changeset: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf 01:45:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:45:55 INFO - mozversion platform_version: 49.0a1 01:45:55 INFO - using testdate: 1464079555 01:45:55 INFO - actual date: 1464079555 01:45:55 INFO - starting webserver on 'localhost:43202' 01:45:55 INFO - SUITE-START | Running 2 tests 01:45:55 INFO - TEST-START | dromaeo_css 01:45:55 INFO - operating with platform_type : linux_ 01:45:55 INFO - Initialising browser for dromaeo_css test... 01:45:55 INFO - TEST-INFO | started process 28987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZcwFT/profile http://localhost:43202/getInfo.html) 01:45:59 INFO - PROCESS | 28987 | __metrics Screen width/height:1600/1200 01:45:59 INFO - PROCESS | 28987 | colorDepth:24 01:45:59 INFO - PROCESS | 28987 | Browser inner width/height: 1024/697 01:45:59 INFO - PROCESS | 28987 | __metrics 01:46:00 ERROR - PROCESS | 28987 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:46:01 INFO - TEST-INFO | 28987: exit 0 01:46:01 INFO - Browser initialized. 01:46:01 INFO - Running cycle 1/1 for dromaeo_css test... 01:46:01 INFO - TEST-INFO | started process 29073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZcwFT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:13 INFO - PROCESS | 29073 | RSS: Main: 153141248 01:46:13 INFO - PROCESS | 29073 | 01:47:04 INFO - PROCESS | 29073 | 1464079624436 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:49:12 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43202/tests/dromaeo/cssquery-ext.html) 01:49:13 INFO - PROCESS | 29073 | RSS: Main: 250241024 01:49:13 INFO - PROCESS | 29073 | 01:52:15 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-ext.html (next: http://localhost:43202/tests/dromaeo/cssquery-jquery.html) 01:52:16 INFO - PROCESS | 29073 | RSS: Main: 235880448 01:52:16 INFO - PROCESS | 29073 | 01:55:18 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43202/tests/dromaeo/cssquery-mootools.html) 01:55:18 INFO - PROCESS | 29073 | RSS: Main: 235036672 01:55:18 INFO - PROCESS | 29073 | 01:58:20 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43202/tests/dromaeo/cssquery-prototype.html) 01:58:21 INFO - PROCESS | 29073 | RSS: Main: 232181760 01:58:21 INFO - PROCESS | 29073 | 02:01:23 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43202/tests/dromaeo/cssquery-yui.html) 02:01:24 INFO - PROCESS | 29073 | RSS: Main: 221351936 02:01:24 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | Cycle 1(1): loaded http://localhost:43202/tests/dromaeo/cssquery-yui.html (next: http://localhost:43202/tests/dromaeo/cssquery-dojo.html) 02:04:27 INFO - PROCESS | 29073 | RSS: Main: 253157376 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | __start_tp_report 02:04:27 INFO - PROCESS | 29073 | _x_x_mozilla_page_load 02:04:27 INFO - PROCESS | 29073 | _x_x_mozilla_page_load_details 02:04:27 INFO - PROCESS | 29073 | |i|pagename|runs| 02:04:27 INFO - PROCESS | 29073 | |0;dojo.html;3056.6484854241767;3099.411111888741;3131.5928929239203;3151.353972435651;3155.0850253426506;5216.6087543434205;5258.7633556489955;5338.25264462975;5481.177823326503;5483.396826349099;5277.736113194344;5284.603654725892;5292.947070529303;5308.389535203452;5330.413654498012;4758.4765675775725;4771.522847715218;4805.351277577517;4931.5315045070665;4932.53140951609;4910.042541704369;4930.359053323081;4965.627577931651;4976.800927962895;5002.74986250686;4679.110968915912;4755.809767609308;4823.252395878644;4832.661713680044;4846.127697014536;4845.248986407112;4862.051899879525;4925.852224433273;4929.65492415531;4971.975140124312;4605.608523275526;4874.902501949977;4877.853664390074;4902.558769710708;4941.629377796679;5112.335396398445;5160.277561141444;5172.32759741235;5227.398849132361;5232.162853943389;5616.045272303718;5622.522085622686;5655.943440565583;5664.235328230678;5667.603267771257;5548.223248745179;5673.149027645845;5713.74288157034;5716.085426331767;5726.083826587767;5327.254184414146;5364.356277246717;5399.352077750695;5422.53908417781;5427.050266203438;5906.350301466835;5918.23063001807;5927.022041363127;5927.555433342516;5936.495397891142;5322.28149199853;5619.072852979294;5624.0439125348785;5696.743646535916;5756.971215143897;5768.711564421762;5769.423057694281;5779.133130030529;5810.360860305363;5838.795642152504;5745.942540574624;5764.855878603068;5765.019946609086;5765.769369225268;5768.423157684198;5544;5572.832815015556;5605.887882242332;5649.548036157097;5824.0390335595;4335.3063509838275;4338.436003319612;4342.5874541918465;4345.196138714348;4376.321670141133;3854.3640299350295;3863.9034024149623;3899;3917.804109794556;3922.1763429679518;5121.539061484485;5128.076946149654;5183.092958732283;5196.220566914993;5236.869078272997;5511.972440137773;5518.53092487135;5527.640703354269;5529.723513824292;5559.610827242135;5220.190870415092;5289.3917199521775;5293.973530132324;5299.5760339172775;5334.653247538898;4740.004599034172;4886.413630364379;4893.412790465167;4928.753562321869;4991.67554108989;5943.64338139713;5948.821535353946;5952.642841429528;5966.373530779206;5972.880542389128;5764.4523770242595;5773.711314434177;5779.393163717918;5785.971070144622;5787.594868359174;5668.461496157858;5851.61964472308;5917.260342457193;5930.28836539618;5979.162917191684;5591.720413979204;5634.380218175916;5634.577406694596;5636.351819540805;5637.915431268616;5419.83740487786;5759;5768.884622307614;5777.3356064051495;5778.768849246151;5504.256925315031;5597.496225339739;5601.075822489243;5609.467100625598;5614.101743720985;5568.749406276808;5617.550595952396;5618.073017951992;5623.662580245198;5631.183478395692;5304.761285742074;5436.592255580927;5518.751656175402;5519.475649813261;5523.990214189522;5587;5693.5445164387575;5702.37273899879;5707.828765137053;5712.057510510719;5536.031194541019;5554.305711786027;5554.444555544414;5561.443855614406;5618.6628802272 02:04:27 INFO - PROCESS | 29073 | |1;ext.html;604.6281536854835;627.8210709947666;631.9052142178673;649.3376755709177;651.7718798420552;32544.67455325446;43607.563924360744;44401.77799111;44525;44557;46597.30104048442;47059;47068.529314706844;47142.52857471433;47218.29172562414;8127.106018338008;8771.342149338809;8977.820443591125;8979.910200898006;10408.63569775058;10249;10669.093127084207;10678.092362149187;10680.145588352952;10682.519286632081;10661.520231589559;10765.892341076567;10770.138388928906;10773.892261077406;10776.299540529879;8162.632681529316;10587.047165755042;10675.612170417835;10857.83713244294;10861.891381086247;10469.424181670005;10554.155667546578;10559.524821383056;10566.101881340095;10576.153907687367;41855;42229.366559501635;42343.576564234274;42372;42401.75982401766;3711.4247291669835;3873.2447172801317;4072.5520192779068;4120.958790412087;4180.958190418088;32496.187595310308;32537.83731081353;32877;33177.834110829535;34624;4432.335149727567;4584.7936842842155;4620.792064357112;4626.768661566942;4649.604783593365;234325;322224.9999999977;323402;323694;325193;60616;60810.39189608136;60985.390146098856;61061.69469152626;61108.38891611027;57660.711696442086;57669;57827;57963;58026;16777.328906843835;16987.235574399183;17033.7444938326;17037.7444338335;17046;12901.870981290067;13019.869801301866;13031.674208144683;13049.412776424893;13049.739005219843;16115.004461230616;18619.906900465412;18673.906630467034;18817.623647526972;19114.71327930082;5526.253955716007;6606.636634985122;6656.733730650816;6744.5278830482375;6954.269801670853;1086.6359769477315;1129.6498085593491;1155.3645494977898;1160.4313886195703;1225.6813228560638;31585.210369740482;32414;32699;33004.3399132016;33274.500882486784;1097.6322931817772;1178.640514643042;1182.467889449751;1190.6666133482638;1210.2133613151345;17166.39917602903;17252;17360.826391736173;17493.65012699739;17519.73720394195;450648;454989;455709.93595351913;455795;458433;58652.4134758647;59625.70187149037;59658.40341596615;59820.40179598148;59951.70024149851;1374.6219789557952;1410.703752212047;1422.49501426994;1431.935562899672;1439.0574173916102;30145.604889448245;31858.362832743678;32146.839265803523;32334;32584.34831303408;52819.20771188358;53006.20490692565;53136.468635313155;53294.20058699045;53334.73332633312;391969;392218;392281;393107;396367;28031.859840700665;28837.134885953456;28968.13095607051;30569.23576910595;42218.57781422146;48671;49294.7216268742;49698.75150624224;50137.498625013286;50321;41145.58854411537;41485.58514414817;42126.78936605297;42654;43077.78461107674;40878.59121408748;40910;41446.12944791381;41738.165236695706;41975;41289;42290.154196916505;42687.3596896053;42917.356239657056;43082.78458607687;34674.82662586772;36394.63605363912;36674;36896.63103369039;36994.44508332431;27755.167344979684;28065.158045258675;28198.15405537837;28291.897674837444;28347.291317716397 02:04:27 INFO - PROCESS | 29073 | |2;jquery.html;377.32647224703874;392.842862854858;404.5186228388218;404.7793952296;425.0775816478242;14474;18414.171362288696;19155;19485.707714384294;19493.3177338793;11511.251768635053;11963.58127465539;12094.274343539371;12109.394530273474;12139.999999999978;3902.317094508464;5146.691198528081;5307.761150748206;5315.468453154673;5321.494458026481;5631.267935168423;5911.261092363455;5922.170896074553;6005.669688167149;6011.188489553898;5911.261092363455;5916.674582897939;5920.052791553352;5937.940620593804;5976.073708575178;5864.179014937933;5901.557383196256;5909.290885093795;5955.136505206764;5959.702014899238;5468.535174510172;5708.257926469574;5735.913961290584;5740.282464691913;5797.594168408213;13279.269640169787;13570.59288221345;13644.181349119084;13661.248631325274;13762.036657433984;2082.1775398717573;2200.7249093863265;2280.270313499681;2361.3624321433117;2736.466389054135;9821.656242031566;9872.851907221397;9879.703608891745;10218.080372766412;10279.280450368477;1864.0679660169915;1969.9803001970083;1988.6321030609383;1994.8204661580382;2005.1678553400468;84147.57926210391;86257.56871215603;86320.5683971576;86999;87689.56155219246;11034.613788517363;11123.72190695239;11162.330260184253;11218.831717524243;11333.43332833355;15574.454894078879;15618.68762624741;15710.293036813371;15725.135117568643;15725.606859828367;7939.801504962306;8271.793205169919;8314;8366.37252206087;8444.57777111142;7897.1707970662255;7953.761387158394;7958.283754462011;8053.1946805319;8136.349092072738;4593.655475839326;4742.842006886858;4772.26029965349;4800.759962001886;4868.932572479315;1967.7737060238255;1970.1232951336517;2000.21991423345;2001.2495314257153;2014.3856123882063;447.7873010320137;448.1373356289196;1034.2139973619953;1087.6410784441273;1088.0588291128274;11547.711307217218;11810.468528916219;11910.702232444084;18381.724274135897;20021;995.3430735714538;1004.1866088468364;1004.3873237325225;1012.2357619997002;1034.4414016431194;10814.756303025095;11177.72055698614;11219.30736623221;11253.549858005752;11262.943685281685;477938;485715;486111;489349;501160;60241.69879150576;64011;81706.18293816986;89639.55180224057;93084;1027.3887037212846;1053.6312290698195;1063.6596289187385;1074.258761454594;1075.6074032977906;17390.131168019987;17403.21685524129;17685;17739.37912173068;17996.460106196835;30210;30537;31053.689463105078;38296.808515957244;39624;58127.93104482646;59059.70470147622;59439;60033.099503508354;60149.699251503465;7400.444966627632;7878.172791856772;8019.278264956182;8027.157148499324;8132.75601731949;9617.951910240405;13133.212007279593;13179.802302965654;13624.960178400623;13844.792328114885;11650.242734222249;11684.824727629262;11690.941545292559;12105.515779368727;12153.635390938285;8100.675972961016;11310.94344528272;11470.139739519736;11830.231034982698;12010.39948002579;11416.885831141915;11839.28964262147;12064.819027714766;12405.069619778373;12432.254064756144;7527.473076884566;7759.262870027338;7950.64222110018;8034.919650803417;8095.109537950939;10920.508577114208;11714.121440891797;11869.881301186877;11946.9690152676;11988.76022479528 02:04:27 INFO - PROCESS | 29073 | |3;mootools.html;1379.6619828142107;1535.5393381985402;1553.5494706535105;1731.696953033219;1858.2845604442293;8557.529335886524;8969.686060987866;8982.461052336865;9175.816483670322;9246.768830779218;8949.86575201371;9128.589213485393;9129.863052054225;9130.90869091309;9140.81718365634;2029.786872378401;2318.860868347896;2386.212549858551;2398.59223931932;2407.325948734357;2436.89474519765;2457.4716435966266;2459.6187590923437;2467.494163696438;2469.4320306329464;2356.646503024543;2372.96440553391;2375.156819329139;2378.7383387827413;2379.131616959806;1996.1416590865922;2337.532493501298;2392.8564286142887;2400.411899084718;2430.6718592989896;2286.748457669655;2290.118304452781;2297.7012988311412;2305.965410518844;2328.569214695287;8972.237359824423;9156.359054866161;9180.081991800833;9180.8622870657;9188.8621670675;5264.263003179558;5384.40771515133;5399.19012148177;5401.78392864285;5401.972990135024;3533.469979503095;3559.94660080099;3560.6439356064448;3639.253952939641;3661.4324779659196;1164.0687450039934;1166.9170530602833;1169.216624861345;1185.0282768130137;2018.3339497965635;12583.433745481476;13126.803097953538;13147.60557183286;13159.144655597356;13160.60518184456;4691.437027556715;4729.361536192639;4794.328793968847;4810.7835147418455;4815.446223684251;10059.497025148714;10111.949440252898;10142.695719128438;10228.64199753005;10232.897671023344;4719.976400117977;5257.027449921777;5280.313559237351;5291.576673866081;5312.5218730314455;4799.28010798383;4955.2567114933045;4969.478204788517;5028.572571331405;5032.169692000779;3978.536326726943;3995.640392364643;4013.3177359848896;4045.8381664733083;4062.106336605942;1169.8888605582456;1175.4710380328886;1184.0586733546852;1185.9407029648482;1193.7791508570942;947.2564037230741;961.3030552849128;961.8941916389192;963.7349728824629;986.9161121304626;5985.970070149621;6033.939660603338;6051.062085376773;6070.2412198475195;6173;451.6296636757827;455.3329372469282;459.4601343421533;461.1353711790393;464.42643335480653;4024.195160967818;4024.3158663027357;4097;4216.0292597598645;4265.872023839228;11346.31922084661;11595.768084638428;11700;11727.472263748152;11731.413429328499;11372.14708896836;11483.13876459269;11494.770104598028;11548.826767598493;11573.305601663928;8562.100979397199;8718.738437846874;8724.956375218084;8726.912730872737;8729.25801306896;5689.431056894277;5782.10377391505;5830.5627077968475;5854.297484301911;5904.822855314347;10420.531076101744;10758.085562726943;10933.726656833644;10954;10980.615678451215;10283.897161028293;10627.521761520904;10958.452077396258;10963;10992.725181870517;7811.609419529114;8438.324934005388;8667.219950204511;8685.261752750834;8901.465912045298;8876.911230887608;8882.022977472601;8945.507997060224;8948.642054318016;8968.461892286483;7271.236520165518;7795.532268063935;7915.802104947423;8121.634526446206;8283.668653253802;7928.603569821371;8043.436959412785;8059.073206581318;8117.837643246984;8198.549079800669;7250.528715633467;7606.505577137468;7671.002769639911;7679.308862202429;7679.616019199129;5204.479552044765;5208.192730126836;5277.366715994105;5322.946770532245;5366.5170134686505;5191.299174611379;5389.083855744611;5438.972805135949;5558.055130627884;5559.082751345983 02:04:27 INFO - PROCESS | 29073 | |4;prototype.html;326.6015461137413;326.7386091127099;333.57968959111514;336.7861408005916;336.8837750975914;5389.757460914258;5399.460053994599;5410.702411367378;5436.728163591824;5476.576090216542;5343.866403339918;5353.277307563478;5379.193121031847;5379.677219366831;5381.973090134544;3985.6811455083525;4050.8784736457956;4184;4202.432671589327;4257.297545904922;4137.9172416551655;4157.708960372775;4157.958420415787;4164.521080075785;4182.811773470186;4114.259433302004;4127.236461254663;4134.607212314841;4175.665946724254;4184.184084103601;3948.9802550987206;4005.4192142139373;4111.465509483778;4119.402686610425;4133.627973482401;3623.855045798165;3627.111357717376;3637.781733096023;3640.0899775056237;3655.6161603031564;5136.306598609177;5157.226416037587;5159.458256883048;5167.328247327823;5178.585713142939;4484.5291244419195;4735.905281894377;4751.311059896296;4757.167495688275;4762.714237145782;5570.777168913239;5590.91613625796;5596.412376700469;5603.831885043455;5649.12438572022;4008.599140085997;4020.638142567154;4030.1536677297804;4034.23349563582;4043.8786836394956;5636.830895073113;5831.300243970751;5865.56008299375;5901.616394934315;5964.403559644001;4015.6988225883174;4022.6379625833815;4024.657904078186;4033.757974521538;4037.6971727120585;4092.4475195848777;4092.7748973806133;4093.2836753568604;4110;4113.341865301538;4494.5730155635165;4657;4675.696079754873;4728.692634978715;4733.479317275097;5516;5558.861028474321;5578.721063946787;5603.80386686464;5649.604527683105;1385.7990591364196;1412.3785534364847;1416.8087308213464;1419.673475100712;1420.5596265157835;869.1301831451497;902.9232515236279;910.2081189365163;920.6409500294891;942.0861764088822;5424.891502169935;5439.3200849893765;5460.836174914759;5470.671759694431;5482.780688772485;5719.055521122838;5758.90580789657;5761.366249712528;5762.538996880239;5779.248697669276;5190.92213616796;5459.29029226206;5471.644343117685;5495.945040549544;5508.779648814003;3008.503596906486;3032.9241768955953;3044.6955304469375;3059.709327613873;3092.098359508886;5664.858378540487;5891.587588868738;5958.582899197015;5977.432143946318;6007.279126504847;5813;5821.708914554255;5844.12338149281;5853.122031695195;5874.50066744323;5896.6756828374855;5901.698337648407;5927.103326935339;5944.762209511658;5956.76172953077;5473.534749546333;5726.885462290647;5763.193152958673;5763.9135412968;5782.363939966516;5620.718964051863;5680.318361796611;5699.601027928005;5714.79998200061;5770.451807078321;5796.8550786229;5984.760609575743;6003.489703375262;6011.849703757441;6021.789237376671;4071.226466971266;4087.1417002428634;4093.6725061995567;4103.651189648914;4113.691473139466;5848.982101175087;5864.44287792659;5876.6180198286975;5889.440503152194;5893.882122357614;5544.500994910478;5685.346185188756;5688.260526131577;5701.4298570142655;5731.420860612824;5620.325560932714;5648.689322087324;5652.7173641318595;5655.7172141393585;5659.547236221175;5315.3090098286975;5397.865053373697;5535.114381698909;5565;5580.832575022756;5645.971770141123;5652.519535839499;5658.745356458887;5683.9715801420725;5685.346185188756;5507.972460137674;5540.141278101901;5554.666719996813;5555.194496797861;5558.388577256418 02:04:27 INFO - PROCESS | 29073 | |5;yui.html;829.3903980574278;848.1518481518482;855.5166331022972;864.9740507784767;871.0244526130739;13855.168689878601;14623.63440913975;14636.4877229297;14734.263286835669;14747.410103595857;13613.863861361384;13666;13667.794983075262;13716.177029378245;13717.862821371784;660.4320284555279;788.6687591211676;812.760235730461;815.1115284340068;816.5264146794844;803.6945960534988;808.4744915804745;808.7937575918162;810.623060276971;811.0429692962302;697.591908733389;852.1606217875387;857.618359829876;859.7377799771067;860.0195776814437;844.1010324004945;862.2067697718084;863.404251066765;866.1035827918138;866.2204016385241;617.7528988404629;618.9535784816112;619.2074145094286;621.673621348791;622.2999125983268;13983.79024314636;14016;14033;14038.789418158736;14083;13391.464341426332;13420.396082176325;13594;13715.794263086062;13761.105528140739;10975.83536246957;10999.505022274017;11039.724006899893;11072.944635276852;11280.435978201058;3715.349813782604;3732.5147730794824;3786.7917264550438;3791.8104094795426;3792.5069740933777;51126;53119.73440132775;53529;58245.708771456295;58744.41255587432;11077;11124.61063862761;11173.441327933571;11336.6032188873;11593.6521904343;21328.893355533433;21365.89317053436;21389.25137620176;21411.250606228707;21418.57162856734;8201.097879233279;8309.210624990616;8326.583670816435;8394.202550757791;8562.357823163287;4726.503717109723;4768.928466073012;4772.737499437495;4774.40319960005;4865.70805751656;3557.0573797943566;3615.222727113683;3698.7424275746375;3703.333399987974;3706.09200745819;688.3804575881646;701.0885848397165;702.4345401951479;708.0335342257781;716.4232792601902;690.6581242285;750.4933522036424;765.9004329437138;776.5069181070061;783.475071701961;9191.68499298465;9352.859707104399;9532.714018579454;9641.951790241144;9775;695.4575431163701;703.5778532880333;727.5998200989435;734.9595772232578;736.3446532586003;4331.5884990925815;4561.977190114095;4651.440454099973;4664.183767840615;4740.644451666139;64755.676221619535;65547.67226163839;66004.6699766498;66146.33853661497;71056;54189.729051354494;54405.727971360684;56358;59624.701876491206;62664.68667656633;49292.753536232805;49314;49839.25241121386;55124;55280.44719552834;9771.560279787569;9868.654597089067;9884.25868059884;10131.64539241123;10149.441780702133;36363.27273454463;36776.81611592032;37114.814425927696;37509.43735844019;37812.62187378091;48383.51616483931;49123.26315105205;49458.25812612742;49628.50371496239;49635.751821240665;12404.503819847105;12462.68843278889;12778.361081945679;13041.543545975845;13292.601221963356;13397.866021339662;14115.576532704035;14220.989824465518;14434.566962991126;14483.855161448251;12256.877431225574;12514.874851251736;13413.798793018308;13516.12145210558;13617.455301787817;12100.273983561014;13046.869531304565;13410.128341658152;13420.597382078553;13750.18698578908;12695.238285702519;12996.350182491027;13004.798080767769;13039.608811735663;13141.342932853127;11162.441877906234;11258.09935205198;11616.825747613624;11617.767644647229;11797.823032654689;11192.944035279772;11293.462592077027;11381.601643942422;11501.699660068187;11670.183087183816 02:04:27 INFO - PROCESS | 29073 | __end_tp_report 02:04:27 INFO - PROCESS | 29073 | __start_cc_report 02:04:27 INFO - PROCESS | 29073 | _x_x_mozilla_cycle_collect,903 02:04:27 INFO - PROCESS | 29073 | __end_cc_report 02:04:27 INFO - PROCESS | 29073 | __startTimestamp1464080667465__endTimestamp 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | ------- Summary: start ------- 02:04:27 INFO - PROCESS | 29073 | Number of tests: 6 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#0] dojo.html Cycles:165 Average:5293.01 Median:5518.75 stddev:604.63 (11.0%) stddev-sans-first:580.47 02:04:27 INFO - PROCESS | 29073 | Values: 3056.6 3099.4 3131.6 3151.4 3155.1 5216.6 5258.8 5338.3 5481.2 5483.4 5277.7 5284.6 5292.9 5308.4 5330.4 4758.5 4771.5 4805.4 4931.5 4932.5 4910.0 4930.4 4965.6 4976.8 5002.7 4679.1 4755.8 4823.3 4832.7 4846.1 4845.2 4862.1 4925.9 4929.7 4972.0 4605.6 4874.9 4877.9 4902.6 4941.6 5112.3 5160.3 5172.3 5227.4 5232.2 5616.0 5622.5 5655.9 5664.2 5667.6 5548.2 5673.1 5713.7 5716.1 5726.1 5327.3 5364.4 5399.4 5422.5 5427.1 5906.4 5918.2 5927.0 5927.6 5936.5 5322.3 5619.1 5624.0 5696.7 5757.0 5768.7 5769.4 5779.1 5810.4 5838.8 5745.9 5764.9 5765.0 5765.8 5768.4 5544.0 5572.8 5605.9 5649.5 5824.0 4335.3 4338.4 4342.6 4345.2 4376.3 3854.4 3863.9 3899.0 3917.8 3922.2 5121.5 5128.1 5183.1 5196.2 5236.9 5512.0 5518.5 5527.6 5529.7 5559.6 5220.2 5289.4 5294.0 5299.6 5334.7 4740.0 4886.4 4893.4 4928.8 4991.7 5943.6 5948.8 5952.6 5966.4 5972.9 5764.5 5773.7 5779.4 5786.0 5787.6 5668.5 5851.6 5917.3 5930.3 5979.2 5591.7 5634.4 5634.6 5636.4 5637.9 5419.8 5759.0 5768.9 5777.3 5778.8 5504.3 5597.5 5601.1 5609.5 5614.1 5568.7 5617.6 5618.1 5623.7 5631.2 5304.8 5436.6 5518.8 5519.5 5524.0 5587.0 5693.5 5702.4 5707.8 5712.1 5536.0 5554.3 5554.4 5561.4 5618.7 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#1] ext.html Cycles:180 Average:56171.91 Median:3792.33 stddev:102740.64 (2709.2%) stddev-sans-first:102944.14 02:04:27 INFO - PROCESS | 29073 | Values: 604.6 627.8 631.9 649.3 651.8 32544.7 43607.6 44401.8 44525.0 44557.0 46597.3 47059.0 47068.5 47142.5 47218.3 8127.1 8771.3 8977.8 8979.9 10408.6 10249.0 10669.1 10678.1 10680.1 10682.5 10661.5 10765.9 10770.1 10773.9 10776.3 8162.6 10587.0 10675.6 10857.8 10861.9 10469.4 10554.2 10559.5 10566.1 10576.2 41855.0 42229.4 42343.6 42372.0 42401.8 3711.4 3873.2 4072.6 4121.0 4181.0 32496.2 32537.8 32877.0 33177.8 34624.0 4432.3 4584.8 4620.8 4626.8 4649.6 234325.0 322225.0 323402.0 323694.0 325193.0 60616.0 60810.4 60985.4 61061.7 61108.4 57660.7 57669.0 57827.0 57963.0 58026.0 16777.3 16987.2 17033.7 17037.7 17046.0 12901.9 13019.9 13031.7 13049.4 13049.7 16115.0 18619.9 18673.9 18817.6 19114.7 5526.3 6606.6 6656.7 6744.5 6954.3 1086.6 1129.6 1155.4 1160.4 1225.7 31585.2 32414.0 32699.0 33004.3 33274.5 1097.6 1178.6 1182.5 1190.7 1210.2 17166.4 17252.0 17360.8 17493.7 17519.7 450648.0 454989.0 455709.9 455795.0 458433.0 58652.4 59625.7 59658.4 59820.4 59951.7 1374.6 1410.7 1422.5 1431.9 1439.1 30145.6 31858.4 32146.8 32334.0 32584.3 52819.2 53006.2 53136.5 53294.2 53334.7 391969.0 392218.0 392281.0 393107.0 396367.0 28031.9 28837.1 28968.1 30569.2 42218.6 48671.0 49294.7 49698.8 50137.5 50321.0 41145.6 41485.6 42126.8 42654.0 43077.8 40878.6 40910.0 41446.1 41738.2 41975.0 41289.0 42290.2 42687.4 42917.4 43082.8 34674.8 36394.6 36674.0 36896.6 36994.4 27755.2 28065.2 28198.2 28291.9 28347.3 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#2] jquery.html Cycles:180 Average:27875.49 Median:2548.91 stddev:80432.94 (3155.6%) stddev-sans-first:80632.07 02:04:27 INFO - PROCESS | 29073 | Values: 377.3 392.8 404.5 404.8 425.1 14474.0 18414.2 19155.0 19485.7 19493.3 11511.3 11963.6 12094.3 12109.4 12140.0 3902.3 5146.7 5307.8 5315.5 5321.5 5631.3 5911.3 5922.2 6005.7 6011.2 5911.3 5916.7 5920.1 5937.9 5976.1 5864.2 5901.6 5909.3 5955.1 5959.7 5468.5 5708.3 5735.9 5740.3 5797.6 13279.3 13570.6 13644.2 13661.2 13762.0 2082.2 2200.7 2280.3 2361.4 2736.5 9821.7 9872.9 9879.7 10218.1 10279.3 1864.1 1970.0 1988.6 1994.8 2005.2 84147.6 86257.6 86320.6 86999.0 87689.6 11034.6 11123.7 11162.3 11218.8 11333.4 15574.5 15618.7 15710.3 15725.1 15725.6 7939.8 8271.8 8314.0 8366.4 8444.6 7897.2 7953.8 7958.3 8053.2 8136.3 4593.7 4742.8 4772.3 4800.8 4868.9 1967.8 1970.1 2000.2 2001.2 2014.4 447.8 448.1 1034.2 1087.6 1088.1 11547.7 11810.5 11910.7 18381.7 20021.0 995.3 1004.2 1004.4 1012.2 1034.4 10814.8 11177.7 11219.3 11253.5 11262.9 477938.0 485715.0 486111.0 489349.0 501160.0 60241.7 64011.0 81706.2 89639.6 93084.0 1027.4 1053.6 1063.7 1074.3 1075.6 17390.1 17403.2 17685.0 17739.4 17996.5 30210.0 30537.0 31053.7 38296.8 39624.0 58127.9 59059.7 59439.0 60033.1 60149.7 7400.4 7878.2 8019.3 8027.2 8132.8 9618.0 13133.2 13179.8 13625.0 13844.8 11650.2 11684.8 11690.9 12105.5 12153.6 8100.7 11310.9 11470.1 11830.2 12010.4 11416.9 11839.3 12064.8 12405.1 12432.3 7527.5 7759.3 7950.6 8034.9 8095.1 10920.5 11714.1 11869.9 11947.0 11988.8 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#3] mootools.html Cycles:180 Average:6017.52 Median:4705.71 stddev:3508.19 (74.6%) stddev-sans-first:3500.72 02:04:27 INFO - PROCESS | 29073 | Values: 1379.7 1535.5 1553.5 1731.7 1858.3 8557.5 8969.7 8982.5 9175.8 9246.8 8949.9 9128.6 9129.9 9130.9 9140.8 2029.8 2318.9 2386.2 2398.6 2407.3 2436.9 2457.5 2459.6 2467.5 2469.4 2356.6 2373.0 2375.2 2378.7 2379.1 1996.1 2337.5 2392.9 2400.4 2430.7 2286.7 2290.1 2297.7 2306.0 2328.6 8972.2 9156.4 9180.1 9180.9 9188.9 5264.3 5384.4 5399.2 5401.8 5402.0 3533.5 3559.9 3560.6 3639.3 3661.4 1164.1 1166.9 1169.2 1185.0 2018.3 12583.4 13126.8 13147.6 13159.1 13160.6 4691.4 4729.4 4794.3 4810.8 4815.4 10059.5 10111.9 10142.7 10228.6 10232.9 4720.0 5257.0 5280.3 5291.6 5312.5 4799.3 4955.3 4969.5 5028.6 5032.2 3978.5 3995.6 4013.3 4045.8 4062.1 1169.9 1175.5 1184.1 1185.9 1193.8 947.3 961.3 961.9 963.7 986.9 5986.0 6033.9 6051.1 6070.2 6173.0 451.6 455.3 459.5 461.1 464.4 4024.2 4024.3 4097.0 4216.0 4265.9 11346.3 11595.8 11700.0 11727.5 11731.4 11372.1 11483.1 11494.8 11548.8 11573.3 8562.1 8718.7 8725.0 8726.9 8729.3 5689.4 5782.1 5830.6 5854.3 5904.8 10420.5 10758.1 10933.7 10954.0 10980.6 10283.9 10627.5 10958.5 10963.0 10992.7 7811.6 8438.3 8667.2 8685.3 8901.5 8876.9 8882.0 8945.5 8948.6 8968.5 7271.2 7795.5 7915.8 8121.6 8283.7 7928.6 8043.4 8059.1 8117.8 8198.5 7250.5 7606.5 7671.0 7679.3 7679.6 5204.5 5208.2 5277.4 5322.9 5366.5 5191.3 5389.1 5439.0 5558.1 5559.1 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#4] prototype.html Cycles:180 Average:4721.35 Median:5465.75 stddev:1406.09 (25.7%) stddev-sans-first:1370.80 02:04:27 INFO - PROCESS | 29073 | Values: 326.6 326.7 333.6 336.8 336.9 5389.8 5399.5 5410.7 5436.7 5476.6 5343.9 5353.3 5379.2 5379.7 5382.0 3985.7 4050.9 4184.0 4202.4 4257.3 4137.9 4157.7 4158.0 4164.5 4182.8 4114.3 4127.2 4134.6 4175.7 4184.2 3949.0 4005.4 4111.5 4119.4 4133.6 3623.9 3627.1 3637.8 3640.1 3655.6 5136.3 5157.2 5159.5 5167.3 5178.6 4484.5 4735.9 4751.3 4757.2 4762.7 5570.8 5590.9 5596.4 5603.8 5649.1 4008.6 4020.6 4030.2 4034.2 4043.9 5636.8 5831.3 5865.6 5901.6 5964.4 4015.7 4022.6 4024.7 4033.8 4037.7 4092.4 4092.8 4093.3 4110.0 4113.3 4494.6 4657.0 4675.7 4728.7 4733.5 5516.0 5558.9 5578.7 5603.8 5649.6 1385.8 1412.4 1416.8 1419.7 1420.6 869.1 902.9 910.2 920.6 942.1 5424.9 5439.3 5460.8 5470.7 5482.8 5719.1 5758.9 5761.4 5762.5 5779.2 5190.9 5459.3 5471.6 5495.9 5508.8 3008.5 3032.9 3044.7 3059.7 3092.1 5664.9 5891.6 5958.6 5977.4 6007.3 5813.0 5821.7 5844.1 5853.1 5874.5 5896.7 5901.7 5927.1 5944.8 5956.8 5473.5 5726.9 5763.2 5763.9 5782.4 5620.7 5680.3 5699.6 5714.8 5770.5 5796.9 5984.8 6003.5 6011.8 6021.8 4071.2 4087.1 4093.7 4103.7 4113.7 5849.0 5864.4 5876.6 5889.4 5893.9 5544.5 5685.3 5688.3 5701.4 5731.4 5620.3 5648.7 5652.7 5655.7 5659.5 5315.3 5397.9 5535.1 5565.0 5580.8 5646.0 5652.5 5658.7 5684.0 5685.3 5508.0 5540.1 5554.7 5555.2 5558.4 02:04:27 INFO - PROCESS | 29073 | 02:04:27 INFO - PROCESS | 29073 | [#5] yui.html Cycles:180 Average:15480.53 Median:4695.34 stddev:18014.97 (383.7%) stddev-sans-first:18031.91 02:04:27 INFO - PROCESS | 29073 | Values: 829.4 848.2 855.5 865.0 871.0 13855.2 14623.6 14636.5 14734.3 14747.4 13613.9 13666.0 13667.8 13716.2 13717.9 660.4 788.7 812.8 815.1 816.5 803.7 808.5 808.8 810.6 811.0 697.6 852.2 857.6 859.7 860.0 844.1 862.2 863.4 866.1 866.2 617.8 619.0 619.2 621.7 622.3 13983.8 14016.0 14033.0 14038.8 14083.0 13391.5 13420.4 13594.0 13715.8 13761.1 10975.8 10999.5 11039.7 11072.9 11280.4 3715.3 3732.5 3786.8 3791.8 3792.5 51126.0 53119.7 53529.0 58245.7 58744.4 11077.0 11124.6 11173.4 11336.6 11593.7 21328.9 21365.9 21389.3 21411.3 21418.6 8201.1 8309.2 8326.6 8394.2 8562.4 4726.5 4768.9 4772.7 4774.4 4865.7 3557.1 3615.2 3698.7 3703.3 3706.1 688.4 701.1 702.4 708.0 716.4 690.7 750.5 765.9 776.5 783.5 9191.7 9352.9 9532.7 9642.0 9775.0 695.5 703.6 727.6 735.0 736.3 4331.6 4562.0 4651.4 4664.2 4740.6 64755.7 65547.7 66004.7 66146.3 71056.0 54189.7 54405.7 56358.0 59624.7 62664.7 49292.8 49314.0 49839.3 55124.0 55280.4 9771.6 9868.7 9884.3 10131.6 10149.4 36363.3 36776.8 37114.8 37509.4 37812.6 48383.5 49123.3 49458.3 49628.5 49635.8 12404.5 12462.7 12778.4 13041.5 13292.6 13397.9 14115.6 14221.0 14434.6 14483.9 12256.9 12514.9 13413.8 13516.1 13617.5 12100.3 13046.9 13410.1 13420.6 13750.2 12695.2 12996.4 13004.8 13039.6 13141.3 11162.4 11258.1 11616.8 11617.8 11797.8 11192.9 11293.5 11381.6 11501.7 11670.2 02:04:27 INFO - PROCESS | 29073 | -------- Summary: end -------- 02:04:27 INFO - PROCESS | 29073 | 02:04:28 INFO - TEST-INFO | 29073: exit 0 02:04:28 INFO - TEST-OK | dromaeo_css | took 1112873ms 02:04:28 INFO - TEST-START | kraken 02:04:28 INFO - operating with platform_type : linux_ 02:04:28 INFO - Initialising browser for kraken test... 02:04:28 INFO - TEST-INFO | started process 29253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9fXYES/profile http://localhost:43202/getInfo.html) 02:04:32 INFO - PROCESS | 29253 | __metrics Screen width/height:1600/1200 02:04:32 INFO - PROCESS | 29253 | colorDepth:24 02:04:32 INFO - PROCESS | 29253 | Browser inner width/height: 1024/697 02:04:32 INFO - PROCESS | 29253 | __metrics 02:04:33 ERROR - PROCESS | 29253 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:04:34 INFO - TEST-INFO | 29253: exit 0 02:04:34 INFO - Browser initialized. 02:04:34 INFO - Running cycle 1/1 for kraken test... 02:04:34 INFO - TEST-INFO | started process 29335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9fXYES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:04:46 INFO - PROCESS | 29335 | RSS: Main: 153239552 02:04:46 INFO - PROCESS | 29335 | 02:04:48 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43202/tests/kraken/driver.html?testName=audio-beat-detection) 02:04:49 INFO - PROCESS | 29335 | RSS: Main: 208494592 02:04:49 INFO - PROCESS | 29335 | 02:04:52 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43202/tests/kraken/driver.html?testName=audio-dft) 02:04:53 INFO - PROCESS | 29335 | RSS: Main: 195567616 02:04:53 INFO - PROCESS | 29335 | 02:04:56 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43202/tests/kraken/driver.html?testName=audio-fft) 02:04:56 INFO - PROCESS | 29335 | RSS: Main: 266231808 02:04:56 INFO - PROCESS | 29335 | 02:04:59 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43202/tests/kraken/driver.html?testName=audio-oscillator) 02:04:59 INFO - PROCESS | 29335 | RSS: Main: 174817280 02:04:59 INFO - PROCESS | 29335 | 02:05:01 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:02 INFO - PROCESS | 29335 | RSS: Main: 179486720 02:05:02 INFO - PROCESS | 29335 | 02:05:05 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43202/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:06 INFO - PROCESS | 29335 | RSS: Main: 215027712 02:05:06 INFO - PROCESS | 29335 | 02:05:09 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43202/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:10 INFO - PROCESS | 29335 | RSS: Main: 213336064 02:05:10 INFO - PROCESS | 29335 | 02:05:13 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43202/tests/kraken/driver.html?testName=json-parse-financial) 02:05:14 INFO - PROCESS | 29335 | RSS: Main: 214462464 02:05:14 INFO - PROCESS | 29335 | 02:05:15 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:16 INFO - PROCESS | 29335 | RSS: Main: 204664832 02:05:16 INFO - PROCESS | 29335 | 02:05:18 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:18 INFO - PROCESS | 29335 | RSS: Main: 206618624 02:05:18 INFO - PROCESS | 29335 | 02:05:20 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:21 INFO - PROCESS | 29335 | RSS: Main: 217354240 02:05:21 INFO - PROCESS | 29335 | 02:05:24 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:24 INFO - PROCESS | 29335 | RSS: Main: 222867456 02:05:24 INFO - PROCESS | 29335 | 02:05:27 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:28 INFO - PROCESS | 29335 | RSS: Main: 219590656 02:05:28 INFO - PROCESS | 29335 | 02:05:29 INFO - PROCESS | 29335 | Cycle 1(1): loaded http://localhost:43202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43202/tests/kraken/driver.html?testName=ai-astar) 02:05:30 INFO - PROCESS | 29335 | RSS: Main: 265224192 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | __start_tp_report 02:05:30 INFO - PROCESS | 29335 | _x_x_mozilla_page_load 02:05:30 INFO - PROCESS | 29335 | _x_x_mozilla_page_load_details 02:05:30 INFO - PROCESS | 29335 | |i|pagename|runs| 02:05:30 INFO - PROCESS | 29335 | |0;ai-astar;110;104;108;109;109;112;108;109;111;109 02:05:30 INFO - PROCESS | 29335 | |1;audio-beat-detection;154;123;129;209;130;125;149;124;154;124 02:05:30 INFO - PROCESS | 29335 | |2;audio-dft;161;171;162;161;159;162;162;159;161;164 02:05:30 INFO - PROCESS | 29335 | |3;audio-fft;75;75;74;142;76;76;75;76;115;75 02:05:30 INFO - PROCESS | 29335 | |4;audio-oscillator;93;93;160;92;92;93;135;93;92;146 02:05:30 INFO - PROCESS | 29335 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;117;117;117 02:05:30 INFO - PROCESS | 29335 | |6;imaging-darkroom;145;145;149;146;146;146;146;147;146;145 02:05:30 INFO - PROCESS | 29335 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;95 02:05:30 INFO - PROCESS | 29335 | |8;json-parse-financial;56;55;56;56;56;56;56;107;54;54 02:05:30 INFO - PROCESS | 29335 | |9;json-stringify-tinderbox;60;63;61;61;61;62;61;61;62;61 02:05:30 INFO - PROCESS | 29335 | |10;stanford-crypto-aes;84;81;79;79;79;79;80;79;85;84 02:05:30 INFO - PROCESS | 29335 | |11;stanford-crypto-ccm;119;119;137;131;120;127;118;126;196;122 02:05:30 INFO - PROCESS | 29335 | |12;stanford-crypto-pbkdf2;167;165;162;170;162;166;173;159;164;164 02:05:30 INFO - PROCESS | 29335 | |13;stanford-crypto-sha256-iterative;68;62;62;66;63;60;66;70;62;62 02:05:30 INFO - PROCESS | 29335 | __end_tp_report 02:05:30 INFO - PROCESS | 29335 | __start_cc_report 02:05:30 INFO - PROCESS | 29335 | _x_x_mozilla_cycle_collect,1858 02:05:30 INFO - PROCESS | 29335 | __end_cc_report 02:05:30 INFO - PROCESS | 29335 | __startTimestamp1464080730193__endTimestamp 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | ------- Summary: start ------- 02:05:30 INFO - PROCESS | 29335 | Number of tests: 14 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:2.13 (2.0%) stddev-sans-first:2.22 02:05:30 INFO - PROCESS | 29335 | Values: 110.0 104.0 108.0 109.0 109.0 112.0 108.0 109.0 111.0 109.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:139.50 stddev:26.74 (19.2%) stddev-sans-first:28.02 02:05:30 INFO - PROCESS | 29335 | Values: 154.0 123.0 129.0 209.0 130.0 125.0 149.0 124.0 154.0 124.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:3.43 (2.1%) stddev-sans-first:3.61 02:05:30 INFO - PROCESS | 29335 | Values: 161.0 171.0 162.0 161.0 159.0 162.0 162.0 159.0 161.0 164.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.00 stddev:23.34 (31.1%) stddev-sans-first:24.43 02:05:30 INFO - PROCESS | 29335 | Values: 75.0 75.0 74.0 142.0 76.0 76.0 75.0 76.0 115.0 75.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.50 stddev:26.95 (29.1%) stddev-sans-first:27.96 02:05:30 INFO - PROCESS | 29335 | Values: 93.0 93.0 160.0 92.0 92.0 93.0 135.0 93.0 92.0 146.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:05:30 INFO - PROCESS | 29335 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 02:05:30 INFO - PROCESS | 29335 | Values: 145.0 145.0 149.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:05:30 INFO - PROCESS | 29335 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:56.00 stddev:16.32 (29.2%) stddev-sans-first:17.23 02:05:30 INFO - PROCESS | 29335 | Values: 56.0 55.0 56.0 56.0 56.0 56.0 56.0 107.0 54.0 54.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 02:05:30 INFO - PROCESS | 29335 | Values: 60.0 63.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.47 (3.1%) stddev-sans-first:2.35 02:05:30 INFO - PROCESS | 29335 | Values: 84.0 81.0 79.0 79.0 79.0 79.0 80.0 79.0 85.0 84.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:126.50 stddev:23.47 (18.6%) stddev-sans-first:24.46 02:05:30 INFO - PROCESS | 29335 | Values: 119.0 119.0 137.0 131.0 120.0 127.0 118.0 126.0 196.0 122.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.50 stddev:4.08 (2.5%) stddev-sans-first:4.27 02:05:30 INFO - PROCESS | 29335 | Values: 167.0 165.0 162.0 170.0 162.0 166.0 173.0 159.0 164.0 164.0 02:05:30 INFO - PROCESS | 29335 | 02:05:30 INFO - PROCESS | 29335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:3.21 (5.0%) stddev-sans-first:3.08 02:05:30 INFO - PROCESS | 29335 | Values: 68.0 62.0 62.0 66.0 63.0 60.0 66.0 70.0 62.0 62.0 02:05:30 INFO - PROCESS | 29335 | -------- Summary: end -------- 02:05:30 INFO - PROCESS | 29335 | 02:05:31 INFO - TEST-INFO | 29335: exit 0 02:05:31 INFO - TEST-OK | kraken | took 62997ms 02:05:31 INFO - SUITE-END | took 1175s 02:05:31 INFO - Completed test suite (00:19:36) 02:05:31 INFO - javascript benchmark 02:05:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.6484854241767, 3099.411111888741, 3131.5928929239203, 3151.353972435651, 3155.0850253426506, 5216.6087543434205, 5258.7633556489955, 5338.25264462975, 5481.177823326503, 5483.396826349099, 5277.736113194344, 5284.603654725892, 5292.947070529303, 5308.389535203452, 5330.413654498012, 4758.4765675775725, 4771.522847715218, 4805.351277577517, 4931.5315045070665, 4932.53140951609, 4910.042541704369, 4930.359053323081, 4965.627577931651, 4976.800927962895, 5002.74986250686, 4679.110968915912, 4755.809767609308, 4823.252395878644, 4832.661713680044, 4846.127697014536, 4845.248986407112, 4862.051899879525, 4925.852224433273, 4929.65492415531, 4971.975140124312, 4605.608523275526, 4874.902501949977, 4877.853664390074, 4902.558769710708, 4941.629377796679, 5112.335396398445, 5160.277561141444, 5172.32759741235, 5227.398849132361, 5232.162853943389, 5616.045272303718, 5622.522085622686, 5655.943440565583, 5664.235328230678, 5667.603267771257, 5548.223248745179, 5673.149027645845, 5713.74288157034, 5716.085426331767, 5726.083826587767, 5327.254184414146, 5364.356277246717, 5399.352077750695, 5422.53908417781, 5427.050266203438, 5906.350301466835, 5918.23063001807, 5927.022041363127, 5927.555433342516, 5936.495397891142, 5322.28149199853, 5619.072852979294, 5624.0439125348785, 5696.743646535916, 5756.971215143897, 5768.711564421762, 5769.423057694281, 5779.133130030529, 5810.360860305363, 5838.795642152504, 5745.942540574624, 5764.855878603068, 5765.019946609086, 5765.769369225268, 5768.423157684198, 5544.0, 5572.832815015556, 5605.887882242332, 5649.548036157097, 5824.0390335595, 4335.3063509838275, 4338.436003319612, 4342.5874541918465, 4345.196138714348, 4376.321670141133, 3854.3640299350295, 3863.9034024149623, 3899.0, 3917.804109794556, 3922.1763429679518, 5121.539061484485, 5128.076946149654, 5183.092958732283, 5196.220566914993, 5236.869078272997, 5511.972440137773, 5518.53092487135, 5527.640703354269, 5529.723513824292, 5559.610827242135, 5220.190870415092, 5289.3917199521775, 5293.973530132324, 5299.5760339172775, 5334.653247538898, 4740.004599034172, 4886.413630364379, 4893.412790465167, 4928.753562321869, 4991.67554108989, 5943.64338139713, 5948.821535353946, 5952.642841429528, 5966.373530779206, 5972.880542389128, 5764.4523770242595, 5773.711314434177, 5779.393163717918, 5785.971070144622, 5787.594868359174, 5668.461496157858, 5851.61964472308, 5917.260342457193, 5930.28836539618, 5979.162917191684, 5591.720413979204, 5634.380218175916, 5634.577406694596, 5636.351819540805, 5637.915431268616, 5419.83740487786, 5759.0, 5768.884622307614, 5777.3356064051495, 5778.768849246151, 5504.256925315031, 5597.496225339739, 5601.075822489243, 5609.467100625598, 5614.101743720985, 5568.749406276808, 5617.550595952396, 5618.073017951992, 5623.662580245198, 5631.183478395692, 5304.761285742074, 5436.592255580927, 5518.751656175402, 5519.475649813261, 5523.990214189522, 5587.0, 5693.5445164387575, 5702.37273899879, 5707.828765137053, 5712.057510510719, 5536.031194541019, 5554.305711786027, 5554.444555544414, 5561.443855614406, 5618.6628802272], "value": 5252.548870707962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6281536854835, 627.8210709947666, 631.9052142178673, 649.3376755709177, 651.7718798420552, 32544.67455325446, 43607.563924360744, 44401.77799111, 44525.0, 44557.0, 46597.30104048442, 47059.0, 47068.529314706844, 47142.52857471433, 47218.29172562414, 8127.106018338008, 8771.342149338809, 8977.820443591125, 8979.910200898006, 10408.63569775058, 10249.0, 10669.093127084207, 10678.092362149187, 10680.145588352952, 10682.519286632081, 10661.520231589559, 10765.892341076567, 10770.138388928906, 10773.892261077406, 10776.299540529879, 8162.632681529316, 10587.047165755042, 10675.612170417835, 10857.83713244294, 10861.891381086247, 10469.424181670005, 10554.155667546578, 10559.524821383056, 10566.101881340095, 10576.153907687367, 41855.0, 42229.366559501635, 42343.576564234274, 42372.0, 42401.75982401766, 3711.4247291669835, 3873.2447172801317, 4072.5520192779068, 4120.958790412087, 4180.958190418088, 32496.187595310308, 32537.83731081353, 32877.0, 33177.834110829535, 34624.0, 4432.335149727567, 4584.7936842842155, 4620.792064357112, 4626.768661566942, 4649.604783593365, 234325.0, 322224.9999999977, 323402.0, 323694.0, 325193.0, 60616.0, 60810.39189608136, 60985.390146098856, 61061.69469152626, 61108.38891611027, 57660.711696442086, 57669.0, 57827.0, 57963.0, 58026.0, 16777.328906843835, 16987.235574399183, 17033.7444938326, 17037.7444338335, 17046.0, 12901.870981290067, 13019.869801301866, 13031.674208144683, 13049.412776424893, 13049.739005219843, 16115.004461230616, 18619.906900465412, 18673.906630467034, 18817.623647526972, 19114.71327930082, 5526.253955716007, 6606.636634985122, 6656.733730650816, 6744.5278830482375, 6954.269801670853, 1086.6359769477315, 1129.6498085593491, 1155.3645494977898, 1160.4313886195703, 1225.6813228560638, 31585.210369740482, 32414.0, 32699.0, 33004.3399132016, 33274.500882486784, 1097.6322931817772, 1178.640514643042, 1182.467889449751, 1190.6666133482638, 1210.2133613151345, 17166.39917602903, 17252.0, 17360.826391736173, 17493.65012699739, 17519.73720394195, 450648.0, 454989.0, 455709.93595351913, 455795.0, 458433.0, 58652.4134758647, 59625.70187149037, 59658.40341596615, 59820.40179598148, 59951.70024149851, 1374.6219789557952, 1410.703752212047, 1422.49501426994, 1431.935562899672, 1439.0574173916102, 30145.604889448245, 31858.362832743678, 32146.839265803523, 32334.0, 32584.34831303408, 52819.20771188358, 53006.20490692565, 53136.468635313155, 53294.20058699045, 53334.73332633312, 391969.0, 392218.0, 392281.0, 393107.0, 396367.0, 28031.859840700665, 28837.134885953456, 28968.13095607051, 30569.23576910595, 42218.57781422146, 48671.0, 49294.7216268742, 49698.75150624224, 50137.498625013286, 50321.0, 41145.58854411537, 41485.58514414817, 42126.78936605297, 42654.0, 43077.78461107674, 40878.59121408748, 40910.0, 41446.12944791381, 41738.165236695706, 41975.0, 41289.0, 42290.154196916505, 42687.3596896053, 42917.356239657056, 43082.78458607687, 34674.82662586772, 36394.63605363912, 36674.0, 36896.63103369039, 36994.44508332431, 27755.167344979684, 28065.158045258675, 28198.15405537837, 28291.897674837444, 28347.291317716397], "value": 20690.996000085754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.32647224703874, 392.842862854858, 404.5186228388218, 404.7793952296, 425.0775816478242, 14474.0, 18414.171362288696, 19155.0, 19485.707714384294, 19493.3177338793, 11511.251768635053, 11963.58127465539, 12094.274343539371, 12109.394530273474, 12139.999999999978, 3902.317094508464, 5146.691198528081, 5307.761150748206, 5315.468453154673, 5321.494458026481, 5631.267935168423, 5911.261092363455, 5922.170896074553, 6005.669688167149, 6011.188489553898, 5911.261092363455, 5916.674582897939, 5920.052791553352, 5937.940620593804, 5976.073708575178, 5864.179014937933, 5901.557383196256, 5909.290885093795, 5955.136505206764, 5959.702014899238, 5468.535174510172, 5708.257926469574, 5735.913961290584, 5740.282464691913, 5797.594168408213, 13279.269640169787, 13570.59288221345, 13644.181349119084, 13661.248631325274, 13762.036657433984, 2082.1775398717573, 2200.7249093863265, 2280.270313499681, 2361.3624321433117, 2736.466389054135, 9821.656242031566, 9872.851907221397, 9879.703608891745, 10218.080372766412, 10279.280450368477, 1864.0679660169915, 1969.9803001970083, 1988.6321030609383, 1994.8204661580382, 2005.1678553400468, 84147.57926210391, 86257.56871215603, 86320.5683971576, 86999.0, 87689.56155219246, 11034.613788517363, 11123.72190695239, 11162.330260184253, 11218.831717524243, 11333.43332833355, 15574.454894078879, 15618.68762624741, 15710.293036813371, 15725.135117568643, 15725.606859828367, 7939.801504962306, 8271.793205169919, 8314.0, 8366.37252206087, 8444.57777111142, 7897.1707970662255, 7953.761387158394, 7958.283754462011, 8053.1946805319, 8136.349092072738, 4593.655475839326, 4742.842006886858, 4772.26029965349, 4800.759962001886, 4868.932572479315, 1967.7737060238255, 1970.1232951336517, 2000.21991423345, 2001.2495314257153, 2014.3856123882063, 447.7873010320137, 448.1373356289196, 1034.2139973619953, 1087.6410784441273, 1088.0588291128274, 11547.711307217218, 11810.468528916219, 11910.702232444084, 18381.724274135897, 20021.0, 995.3430735714538, 1004.1866088468364, 1004.3873237325225, 1012.2357619997002, 1034.4414016431194, 10814.756303025095, 11177.72055698614, 11219.30736623221, 11253.549858005752, 11262.943685281685, 477938.0, 485715.0, 486111.0, 489349.0, 501160.0, 60241.69879150576, 64011.0, 81706.18293816986, 89639.55180224057, 93084.0, 1027.3887037212846, 1053.6312290698195, 1063.6596289187385, 1074.258761454594, 1075.6074032977906, 17390.131168019987, 17403.21685524129, 17685.0, 17739.37912173068, 17996.460106196835, 30210.0, 30537.0, 31053.689463105078, 38296.808515957244, 39624.0, 58127.93104482646, 59059.70470147622, 59439.0, 60033.099503508354, 60149.699251503465, 7400.444966627632, 7878.172791856772, 8019.278264956182, 8027.157148499324, 8132.75601731949, 9617.951910240405, 13133.212007279593, 13179.802302965654, 13624.960178400623, 13844.792328114885, 11650.242734222249, 11684.824727629262, 11690.941545292559, 12105.515779368727, 12153.635390938285, 8100.675972961016, 11310.94344528272, 11470.139739519736, 11830.231034982698, 12010.39948002579, 11416.885831141915, 11839.28964262147, 12064.819027714766, 12405.069619778373, 12432.254064756144, 7527.473076884566, 7759.262870027338, 7950.64222110018, 8034.919650803417, 8095.109537950939, 10920.508577114208, 11714.121440891797, 11869.881301186877, 11946.9690152676, 11988.76022479528], "value": 8760.39455615036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.6619828142107, 1535.5393381985402, 1553.5494706535105, 1731.696953033219, 1858.2845604442293, 8557.529335886524, 8969.686060987866, 8982.461052336865, 9175.816483670322, 9246.768830779218, 8949.86575201371, 9128.589213485393, 9129.863052054225, 9130.90869091309, 9140.81718365634, 2029.786872378401, 2318.860868347896, 2386.212549858551, 2398.59223931932, 2407.325948734357, 2436.89474519765, 2457.4716435966266, 2459.6187590923437, 2467.494163696438, 2469.4320306329464, 2356.646503024543, 2372.96440553391, 2375.156819329139, 2378.7383387827413, 2379.131616959806, 1996.1416590865922, 2337.532493501298, 2392.8564286142887, 2400.411899084718, 2430.6718592989896, 2286.748457669655, 2290.118304452781, 2297.7012988311412, 2305.965410518844, 2328.569214695287, 8972.237359824423, 9156.359054866161, 9180.081991800833, 9180.8622870657, 9188.8621670675, 5264.263003179558, 5384.40771515133, 5399.19012148177, 5401.78392864285, 5401.972990135024, 3533.469979503095, 3559.94660080099, 3560.6439356064448, 3639.253952939641, 3661.4324779659196, 1164.0687450039934, 1166.9170530602833, 1169.216624861345, 1185.0282768130137, 2018.3339497965635, 12583.433745481476, 13126.803097953538, 13147.60557183286, 13159.144655597356, 13160.60518184456, 4691.437027556715, 4729.361536192639, 4794.328793968847, 4810.7835147418455, 4815.446223684251, 10059.497025148714, 10111.949440252898, 10142.695719128438, 10228.64199753005, 10232.897671023344, 4719.976400117977, 5257.027449921777, 5280.313559237351, 5291.576673866081, 5312.5218730314455, 4799.28010798383, 4955.2567114933045, 4969.478204788517, 5028.572571331405, 5032.169692000779, 3978.536326726943, 3995.640392364643, 4013.3177359848896, 4045.8381664733083, 4062.106336605942, 1169.8888605582456, 1175.4710380328886, 1184.0586733546852, 1185.9407029648482, 1193.7791508570942, 947.2564037230741, 961.3030552849128, 961.8941916389192, 963.7349728824629, 986.9161121304626, 5985.970070149621, 6033.939660603338, 6051.062085376773, 6070.2412198475195, 6173.0, 451.6296636757827, 455.3329372469282, 459.4601343421533, 461.1353711790393, 464.42643335480653, 4024.195160967818, 4024.3158663027357, 4097.0, 4216.0292597598645, 4265.872023839228, 11346.31922084661, 11595.768084638428, 11700.0, 11727.472263748152, 11731.413429328499, 11372.14708896836, 11483.13876459269, 11494.770104598028, 11548.826767598493, 11573.305601663928, 8562.100979397199, 8718.738437846874, 8724.956375218084, 8726.912730872737, 8729.25801306896, 5689.431056894277, 5782.10377391505, 5830.5627077968475, 5854.297484301911, 5904.822855314347, 10420.531076101744, 10758.085562726943, 10933.726656833644, 10954.0, 10980.615678451215, 10283.897161028293, 10627.521761520904, 10958.452077396258, 10963.0, 10992.725181870517, 7811.609419529114, 8438.324934005388, 8667.219950204511, 8685.261752750834, 8901.465912045298, 8876.911230887608, 8882.022977472601, 8945.507997060224, 8948.642054318016, 8968.461892286483, 7271.236520165518, 7795.532268063935, 7915.802104947423, 8121.634526446206, 8283.668653253802, 7928.603569821371, 8043.436959412785, 8059.073206581318, 8117.837643246984, 8198.549079800669, 7250.528715633467, 7606.505577137468, 7671.002769639911, 7679.308862202429, 7679.616019199129, 5204.479552044765, 5208.192730126836, 5277.366715994105, 5322.946770532245, 5366.5170134686505, 5191.299174611379, 5389.083855744611, 5438.972805135949, 5558.055130627884, 5559.082751345983], "value": 4699.456460017828, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6015461137413, 326.7386091127099, 333.57968959111514, 336.7861408005916, 336.8837750975914, 5389.757460914258, 5399.460053994599, 5410.702411367378, 5436.728163591824, 5476.576090216542, 5343.866403339918, 5353.277307563478, 5379.193121031847, 5379.677219366831, 5381.973090134544, 3985.6811455083525, 4050.8784736457956, 4184.0, 4202.432671589327, 4257.297545904922, 4137.9172416551655, 4157.708960372775, 4157.958420415787, 4164.521080075785, 4182.811773470186, 4114.259433302004, 4127.236461254663, 4134.607212314841, 4175.665946724254, 4184.184084103601, 3948.9802550987206, 4005.4192142139373, 4111.465509483778, 4119.402686610425, 4133.627973482401, 3623.855045798165, 3627.111357717376, 3637.781733096023, 3640.0899775056237, 3655.6161603031564, 5136.306598609177, 5157.226416037587, 5159.458256883048, 5167.328247327823, 5178.585713142939, 4484.5291244419195, 4735.905281894377, 4751.311059896296, 4757.167495688275, 4762.714237145782, 5570.777168913239, 5590.91613625796, 5596.412376700469, 5603.831885043455, 5649.12438572022, 4008.599140085997, 4020.638142567154, 4030.1536677297804, 4034.23349563582, 4043.8786836394956, 5636.830895073113, 5831.300243970751, 5865.56008299375, 5901.616394934315, 5964.403559644001, 4015.6988225883174, 4022.6379625833815, 4024.657904078186, 4033.757974521538, 4037.6971727120585, 4092.4475195848777, 4092.7748973806133, 4093.2836753568604, 4110.0, 4113.341865301538, 4494.5730155635165, 4657.0, 4675.696079754873, 4728.692634978715, 4733.479317275097, 5516.0, 5558.861028474321, 5578.721063946787, 5603.80386686464, 5649.604527683105, 1385.7990591364196, 1412.3785534364847, 1416.8087308213464, 1419.673475100712, 1420.5596265157835, 869.1301831451497, 902.9232515236279, 910.2081189365163, 920.6409500294891, 942.0861764088822, 5424.891502169935, 5439.3200849893765, 5460.836174914759, 5470.671759694431, 5482.780688772485, 5719.055521122838, 5758.90580789657, 5761.366249712528, 5762.538996880239, 5779.248697669276, 5190.92213616796, 5459.29029226206, 5471.644343117685, 5495.945040549544, 5508.779648814003, 3008.503596906486, 3032.9241768955953, 3044.6955304469375, 3059.709327613873, 3092.098359508886, 5664.858378540487, 5891.587588868738, 5958.582899197015, 5977.432143946318, 6007.279126504847, 5813.0, 5821.708914554255, 5844.12338149281, 5853.122031695195, 5874.50066744323, 5896.6756828374855, 5901.698337648407, 5927.103326935339, 5944.762209511658, 5956.76172953077, 5473.534749546333, 5726.885462290647, 5763.193152958673, 5763.9135412968, 5782.363939966516, 5620.718964051863, 5680.318361796611, 5699.601027928005, 5714.79998200061, 5770.451807078321, 5796.8550786229, 5984.760609575743, 6003.489703375262, 6011.849703757441, 6021.789237376671, 4071.226466971266, 4087.1417002428634, 4093.6725061995567, 4103.651189648914, 4113.691473139466, 5848.982101175087, 5864.44287792659, 5876.6180198286975, 5889.440503152194, 5893.882122357614, 5544.500994910478, 5685.346185188756, 5688.260526131577, 5701.4298570142655, 5731.420860612824, 5620.325560932714, 5648.689322087324, 5652.7173641318595, 5655.7172141393585, 5659.547236221175, 5315.3090098286975, 5397.865053373697, 5535.114381698909, 5565.0, 5580.832575022756, 5645.971770141123, 5652.519535839499, 5658.745356458887, 5683.9715801420725, 5685.346185188756, 5507.972460137674, 5540.141278101901, 5554.666719996813, 5555.194496797861, 5558.388577256418], "value": 4268.47982162401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.3903980574278, 848.1518481518482, 855.5166331022972, 864.9740507784767, 871.0244526130739, 13855.168689878601, 14623.63440913975, 14636.4877229297, 14734.263286835669, 14747.410103595857, 13613.863861361384, 13666.0, 13667.794983075262, 13716.177029378245, 13717.862821371784, 660.4320284555279, 788.6687591211676, 812.760235730461, 815.1115284340068, 816.5264146794844, 803.6945960534988, 808.4744915804745, 808.7937575918162, 810.623060276971, 811.0429692962302, 697.591908733389, 852.1606217875387, 857.618359829876, 859.7377799771067, 860.0195776814437, 844.1010324004945, 862.2067697718084, 863.404251066765, 866.1035827918138, 866.2204016385241, 617.7528988404629, 618.9535784816112, 619.2074145094286, 621.673621348791, 622.2999125983268, 13983.79024314636, 14016.0, 14033.0, 14038.789418158736, 14083.0, 13391.464341426332, 13420.396082176325, 13594.0, 13715.794263086062, 13761.105528140739, 10975.83536246957, 10999.505022274017, 11039.724006899893, 11072.944635276852, 11280.435978201058, 3715.349813782604, 3732.5147730794824, 3786.7917264550438, 3791.8104094795426, 3792.5069740933777, 51126.0, 53119.73440132775, 53529.0, 58245.708771456295, 58744.41255587432, 11077.0, 11124.61063862761, 11173.441327933571, 11336.6032188873, 11593.6521904343, 21328.893355533433, 21365.89317053436, 21389.25137620176, 21411.250606228707, 21418.57162856734, 8201.097879233279, 8309.210624990616, 8326.583670816435, 8394.202550757791, 8562.357823163287, 4726.503717109723, 4768.928466073012, 4772.737499437495, 4774.40319960005, 4865.70805751656, 3557.0573797943566, 3615.222727113683, 3698.7424275746375, 3703.333399987974, 3706.09200745819, 688.3804575881646, 701.0885848397165, 702.4345401951479, 708.0335342257781, 716.4232792601902, 690.6581242285, 750.4933522036424, 765.9004329437138, 776.5069181070061, 783.475071701961, 9191.68499298465, 9352.859707104399, 9532.714018579454, 9641.951790241144, 9775.0, 695.4575431163701, 703.5778532880333, 727.5998200989435, 734.9595772232578, 736.3446532586003, 4331.5884990925815, 4561.977190114095, 4651.440454099973, 4664.183767840615, 4740.644451666139, 64755.676221619535, 65547.67226163839, 66004.6699766498, 66146.33853661497, 71056.0, 54189.729051354494, 54405.727971360684, 56358.0, 59624.701876491206, 62664.68667656633, 49292.753536232805, 49314.0, 49839.25241121386, 55124.0, 55280.44719552834, 9771.560279787569, 9868.654597089067, 9884.25868059884, 10131.64539241123, 10149.441780702133, 36363.27273454463, 36776.81611592032, 37114.814425927696, 37509.43735844019, 37812.62187378091, 48383.51616483931, 49123.26315105205, 49458.25812612742, 49628.50371496239, 49635.751821240665, 12404.503819847105, 12462.68843278889, 12778.361081945679, 13041.543545975845, 13292.601221963356, 13397.866021339662, 14115.576532704035, 14220.989824465518, 14434.566962991126, 14483.855161448251, 12256.877431225574, 12514.874851251736, 13413.798793018308, 13516.12145210558, 13617.455301787817, 12100.273983561014, 13046.869531304565, 13410.128341658152, 13420.597382078553, 13750.18698578908, 12695.238285702519, 12996.350182491027, 13004.798080767769, 13039.608811735663, 13141.342932853127, 11162.441877906234, 11258.09935205198, 11616.825747613624, 11617.767644647229, 11797.823032654689, 11192.944035279772, 11293.462592077027, 11381.601643942422, 11501.699660068187, 11670.183087183816], "value": 6973.143097946122, "unit": "score"}], "name": "dromaeo_css", "value": 7146.251137316693, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 108.0, 109.0, 109.0, 112.0, 108.0, 109.0, 111.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 129.0, 209.0, 130.0, 125.0, 149.0, 124.0, 154.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 171.0, 162.0, 161.0, 159.0, 162.0, 162.0, 159.0, 161.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 142.0, 76.0, 76.0, 75.0, 76.0, 115.0, 75.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 160.0, 92.0, 92.0, 93.0, 135.0, 93.0, 92.0, 146.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 149.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 107.0, 54.0, 54.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 85.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 137.0, 131.0, 120.0, 127.0, 118.0, 126.0, 196.0, 122.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 162.0, 170.0, 162.0, 166.0, 173.0, 159.0, 164.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 62.0, 66.0, 63.0, 60.0, 66.0, 70.0, 62.0, 62.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1529.6, "alertThreshold": 2.0}]} 02:05:31 INFO - Return code: 0 02:05:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:05:31 ERROR - # TBPL SUCCESS # 02:05:31 INFO - Running post-action listener: _resource_record_post_action 02:05:31 INFO - ##### 02:05:31 INFO - ##### Finished run-tests step (success) 02:05:31 INFO - ##### 02:05:31 INFO - Running post-run listener: _resource_record_post_run 02:05:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538198016; Read time: 8; Write time: 349312 02:05:31 INFO - TinderboxPrint: CPU usage
13.1% 02:05:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:05:31 INFO - TinderboxPrint: I/O write bytes / time
538,198,016 / 349,312 02:05:31 INFO - TinderboxPrint: CPU idle
8,280.1 (86.9%) 02:05:31 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 02:05:31 INFO - TinderboxPrint: Swap in / out
0 / 0 02:05:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253743104; Read time: 0; Write time: 202752 02:05:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284454912; Read time: 8; Write time: 146560 02:05:32 INFO - Running post-run listener: _upload_blobber_files 02:05:32 INFO - Blob upload gear active. 02:05:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:05:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:05:32 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:05:32 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:05:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:05:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:05:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:05:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:33 INFO - (blobuploader) - INFO - Done attempting. 02:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:36 INFO - (blobuploader) - INFO - Done attempting. 02:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:37 INFO - (blobuploader) - INFO - Done attempting. 02:05:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:05:37 INFO - Return code: 0 02:05:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:05:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:05:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6310146726da5fdddb9b628a7e7d8f4fdfe21c5f9ec64e9bca430529e0e77f115e95fda8937e99b35cd057a3d18f253d9562a21b04595c4fc6bef8c327466b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc0f88e803a7368940aa84a6844c2e35dbf1bdbbc9208c1ae5c676bd7ea333803dd6111250bc3b6e0357e89e3d47e7fd1c1506ea9f2899ab3691a9845296ad3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/366917719464cf8f01d7489c35bcba1071825b1fe5d3d5d47c62485ab52cca632dc58d12ea89e2074dfb7b5e9f50b902fed0307e9fe8763d0c7f28baadd9de8b"} 02:05:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:05:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:05:37 INFO - Contents: 02:05:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6310146726da5fdddb9b628a7e7d8f4fdfe21c5f9ec64e9bca430529e0e77f115e95fda8937e99b35cd057a3d18f253d9562a21b04595c4fc6bef8c327466b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc0f88e803a7368940aa84a6844c2e35dbf1bdbbc9208c1ae5c676bd7ea333803dd6111250bc3b6e0357e89e3d47e7fd1c1506ea9f2899ab3691a9845296ad3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/366917719464cf8f01d7489c35bcba1071825b1fe5d3d5d47c62485ab52cca632dc58d12ea89e2074dfb7b5e9f50b902fed0307e9fe8763d0c7f28baadd9de8b"} 02:05:37 INFO - Running post-run listener: copy_logs_to_upload_dir 02:05:37 INFO - Copying logs to upload dir... 02:05:37 INFO - mkdir: /builds/slave/test/build/upload/logs 02:05:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.961978 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 02:05:37.094781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:37.097876) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6310146726da5fdddb9b628a7e7d8f4fdfe21c5f9ec64e9bca430529e0e77f115e95fda8937e99b35cd057a3d18f253d9562a21b04595c4fc6bef8c327466b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc0f88e803a7368940aa84a6844c2e35dbf1bdbbc9208c1ae5c676bd7ea333803dd6111250bc3b6e0357e89e3d47e7fd1c1506ea9f2899ab3691a9845296ad3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/366917719464cf8f01d7489c35bcba1071825b1fe5d3d5d47c62485ab52cca632dc58d12ea89e2074dfb7b5e9f50b902fed0307e9fe8763d0c7f28baadd9de8b"} build_url:https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/VxDfRuLmQiCtEQVsg9s41A/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/Firefox/sha512/ad6310146726da5fdddb9b628a7e7d8f4fdfe21c5f9ec64e9bca430529e0e77f115e95fda8937e99b35cd057a3d18f253d9562a21b04595c4fc6bef8c327466b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc0f88e803a7368940aa84a6844c2e35dbf1bdbbc9208c1ae5c676bd7ea333803dd6111250bc3b6e0357e89e3d47e7fd1c1506ea9f2899ab3691a9845296ad3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/366917719464cf8f01d7489c35bcba1071825b1fe5d3d5d47c62485ab52cca632dc58d12ea89e2074dfb7b5e9f50b902fed0307e9fe8763d0c7f28baadd9de8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:37.122511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:37.122812) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1464079501.978541-157722871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:37.208342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:05:37.208666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:05:37.208970) ========= ========= Total master_lag: 0.15 =========