builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1464079508.19 results: success (0) buildid: 20160523193033 builduid: 06a868e8689c40f29754689df9b8e090 revision: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.190688) ========= 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:08.191616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.192299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.210374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.211044) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 01:45:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.3M=0s 2016-05-24 01:45:08 (44.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104242 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.332408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.333223) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:08.383465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-24 01:45:08.383845) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 01:45:08,477 truncating revision to first 12 chars 2016-05-24 01:45:08,478 Setting DEBUG logging. 2016-05-24 01:45:08,478 attempt 1/10 2016-05-24 01:45:08,478 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:09,599 unpacking tar archive at: mozilla-central-46fe2115d46a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420723 ========= master_lag: 0.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-24 01:45:10.606117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:10.606483) ========= script_repo_revision: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:10.606968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:10.607273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:45:10.622163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-24 01:45:10.622483) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:45:10 INFO - MultiFileLogger online at 20160524 01:45:10 in /builds/slave/test 01:45:10 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:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:45:10 INFO - {'append_to_log': False, 01:45:10 INFO - 'base_work_dir': '/builds/slave/test', 01:45:10 INFO - 'blob_upload_branch': 'Firefox', 01:45:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:45:10 INFO - 'branch': 'Firefox', 01:45:10 INFO - 'buildbot_json_path': 'buildprops.json', 01:45:10 INFO - 'config_files': ('talos/linux_config.py',), 01:45:10 INFO - 'default_actions': ('clobber', 01:45:10 INFO - 'read-buildbot-config', 01:45:10 INFO - 'download-and-extract', 01:45:10 INFO - 'populate-webroot', 01:45:10 INFO - 'create-virtualenv', 01:45:10 INFO - 'install', 01:45:10 INFO - 'run-tests'), 01:45:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:45:10 INFO - 'download_minidump_stackwalk': True, 01:45:10 INFO - 'download_symbols': 'ondemand', 01:45:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:45:10 INFO - 'tooltool.py': '/tools/tooltool.py', 01:45:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:45:10 INFO - '/tools/misc-python/virtualenv.py')}, 01:45:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:45:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:45:10 INFO - 'installer_path': 'installer.exe', 01:45:10 INFO - 'log_level': 'info', 01:45:10 INFO - 'log_name': 'talos', 01:45:10 INFO - 'log_to_console': True, 01:45:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:45:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:45:10 INFO - 'opt_config_files': (), 01:45:10 INFO - 'pip_index': False, 01:45:10 INFO - 'sps_profile': False, 01:45:10 INFO - 'sps_profile_interval': 0, 01:45:10 INFO - 'suite': 'dromaeojs', 01:45:10 INFO - 'system_bits': '32', 01:45:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:45:10 INFO - 'title': 'talos-linux64-ix-066', 01:45:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:45:10 INFO - 'use_talos_json': True, 01:45:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:45:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:45:10 INFO - 'work_dir': 'build'} 01:45:10 INFO - ##### 01:45:10 INFO - ##### Running clobber step. 01:45:10 INFO - ##### 01:45:10 INFO - Running pre-action listener: _resource_record_pre_action 01:45:10 INFO - Running main action method: clobber 01:45:10 INFO - rmtree: /builds/slave/test/build 01:45:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:45:11 INFO - Running post-action listener: _resource_record_post_action 01:45:11 INFO - ##### 01:45:11 INFO - ##### Finished clobber step (success) 01:45:11 INFO - ##### 01:45:11 INFO - ##### 01:45:11 INFO - ##### Running read-buildbot-config step. 01:45:11 INFO - ##### 01:45:11 INFO - Running pre-action listener: _resource_record_pre_action 01:45:11 INFO - Running main action method: read_buildbot_config 01:45:11 INFO - Using buildbot properties: 01:45:11 INFO - { 01:45:11 INFO - "project": "", 01:45:11 INFO - "product": "firefox", 01:45:11 INFO - "script_repo_revision": "production", 01:45:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:45:11 INFO - "repository": "", 01:45:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:45:11 INFO - "buildid": "20160523193033", 01:45:11 INFO - "pgo_build": "True", 01:45:11 INFO - "basedir": "/builds/slave/test", 01:45:11 INFO - "buildnumber": 301, 01:45:11 INFO - "slavename": "talos-linux64-ix-066", 01:45:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:45:11 INFO - "platform": "ubuntu64_hw", 01:45:11 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:45:11 INFO - "branch": "mozilla-central", 01:45:11 INFO - "repo_path": "mozilla-central", 01:45:11 INFO - "revision": "46fe2115d46a5bb40523b8466341d8f9a26e1bdf", 01:45:11 INFO - "stage_platform": "linux64-pgo", 01:45:11 INFO - "builduid": "06a868e8689c40f29754689df9b8e090", 01:45:11 INFO - "slavebuilddir": "test" 01:45:11 INFO - } 01:45:11 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:11 INFO - Running post-action listener: _resource_record_post_action 01:45:11 INFO - ##### 01:45:11 INFO - ##### Finished read-buildbot-config step (success) 01:45:11 INFO - ##### 01:45:11 INFO - ##### 01:45:11 INFO - ##### Running download-and-extract step. 01:45:11 INFO - ##### 01:45:11 INFO - Running pre-action listener: _resource_record_pre_action 01:45:11 INFO - Running main action method: download_and_extract 01:45:11 INFO - mkdir: /builds/slave/test/build/tests 01:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:11 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:11 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:11 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:11 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:11 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:12 INFO - Downloaded 1361 bytes. 01:45:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:45:12 INFO - Using the following test package requirements: 01:45:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:45:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:45:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'jsshell-linux-x86_64.zip'], 01:45:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:45:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:45:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:45:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:45:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:45:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 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:12 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:12 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:12 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:12 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:14 INFO - Downloaded 24389070 bytes. 01:45:14 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:14 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:15 INFO - Return code: 0 01:45:15 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: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 - 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:15 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:15 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:15 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:15 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:16 INFO - Downloaded 24389070 bytes. 01:45:16 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:16 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:17 INFO - Return code: 0 01:45:17 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:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 10840359 bytes. 01:45:18 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:18 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:18 INFO - Return code: 0 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 - 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:18 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:18 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:18 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:18 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:22 INFO - Downloaded 58598567 bytes. 01:45:22 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:22 INFO - mkdir: /builds/slave/test/properties 01:45:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:45:22 INFO - Writing to file /builds/slave/test/properties/build_url 01:45:22 INFO - Contents: 01:45:22 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:22 INFO - Running post-action listener: _resource_record_post_action 01:45:22 INFO - Running post-action listener: set_extra_try_arguments 01:45:22 INFO - ##### 01:45:22 INFO - ##### Finished download-and-extract step (success) 01:45:22 INFO - ##### 01:45:22 INFO - ##### 01:45:22 INFO - ##### Running populate-webroot step. 01:45:22 INFO - ##### 01:45:22 INFO - Running pre-action listener: _resource_record_pre_action 01:45:22 INFO - Running main action method: populate_webroot 01:45:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:22 INFO - '--tppagecycles', 01:45:22 INFO - '7'], 01:45:22 INFO - 'tests': ['tsvgm']}}, 01:45:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:45:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:45:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:45:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['damp', 'tps']}, 01:45:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'tests': ['damp', 'tps']}, 01:45:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['dromaeo_dom']}, 01:45:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'other-e10s': {'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['a11yr', 01:45:22 INFO - 'ts_paint', 01:45:22 INFO - 'tpaint', 01:45:22 INFO - 'sessionrestore', 01:45:22 INFO - 'sessionrestore_no_auto_restore', 01:45:22 INFO - 'tabpaint']}, 01:45:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['tsvgx', 01:45:22 INFO - 'tsvgr_opacity', 01:45:22 INFO - 'tart', 01:45:22 INFO - 'tscrollx', 01:45:22 INFO - 'cart']}, 01:45:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:45:22 INFO - 'tsvgr_opacity', 01:45:22 INFO - 'tart', 01:45:22 INFO - 'tscrollx', 01:45:22 INFO - 'cart']}, 01:45:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'talos_options': ['--disable-e10s'], 01:45:22 INFO - 'tests': ['tp5o']}, 01:45:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'tests': ['tp5o']}, 01:45:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'talos_options': ['--disable-e10s', 01:45:22 INFO - '--xperf_path', 01:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:22 INFO - 'tests': ['tp5n']}, 01:45:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:22 INFO - 'talos_options': ['--xperf_path', 01:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:22 INFO - 'tests': ['tp5n']}}, 01:45:22 INFO - 'talos.zip': {'path': '', 01:45:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:22 INFO - Running post-action listener: _resource_record_post_action 01:45:22 INFO - ##### 01:45:22 INFO - ##### Finished populate-webroot step (success) 01:45:22 INFO - ##### 01:45:22 INFO - ##### 01:45:22 INFO - ##### Running create-virtualenv step. 01:45:22 INFO - ##### 01:45:22 INFO - Running pre-action listener: _resource_record_pre_action 01:45:22 INFO - Running main action method: create_virtualenv 01:45:22 INFO - Creating virtualenv /builds/slave/test/build/venv 01:45:22 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:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:45:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:22 INFO - Using real prefix '/usr' 01:45:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:45:23 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:25 INFO - Installing pip.................done. 01:45:25 INFO - Return code: 0 01:45:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:45:25 INFO - Using env: {'DISPLAY': ':0', 01:45:25 INFO - 'HOME': '/home/cltbld', 01:45:25 INFO - 'LANG': 'en_US.UTF-8', 01:45:25 INFO - 'LANGUAGE': 'en_US:en', 01:45:25 INFO - 'LOGNAME': 'cltbld', 01:45:25 INFO - 'MAIL': '/var/mail/cltbld', 01:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:25 INFO - 'MOZ_NO_REMOTE': '1', 01:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:25 INFO - 'NO_EM_RESTART': '1', 01:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:25 INFO - 'PWD': '/builds/slave/test', 01:45:25 INFO - 'SHELL': '/bin/bash', 01:45:25 INFO - 'SHLVL': '1', 01:45:25 INFO - 'TERM': 'linux', 01:45:25 INFO - 'TMOUT': '86400', 01:45:25 INFO - 'USER': 'cltbld', 01:45:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:25 INFO - '_': '/tools/buildbot/bin/python'} 01:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:25 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:25 INFO - Cleaning up... 01:45:25 INFO - Return code: 0 01:45:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:45:25 INFO - Using env: {'DISPLAY': ':0', 01:45:25 INFO - 'HOME': '/home/cltbld', 01:45:25 INFO - 'LANG': 'en_US.UTF-8', 01:45:25 INFO - 'LANGUAGE': 'en_US:en', 01:45:25 INFO - 'LOGNAME': 'cltbld', 01:45:25 INFO - 'MAIL': '/var/mail/cltbld', 01:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:25 INFO - 'MOZ_NO_REMOTE': '1', 01:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:25 INFO - 'NO_EM_RESTART': '1', 01:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:25 INFO - 'PWD': '/builds/slave/test', 01:45:25 INFO - 'SHELL': '/bin/bash', 01:45:25 INFO - 'SHLVL': '1', 01:45:25 INFO - 'TERM': 'linux', 01:45:25 INFO - 'TMOUT': '86400', 01:45:25 INFO - 'USER': 'cltbld', 01:45:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:25 INFO - '_': '/tools/buildbot/bin/python'} 01:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:25 INFO - Downloading/unpacking psutil>=3.1.1 01:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:27 INFO - Installing collected packages: psutil 01:45:27 INFO - Running setup.py install for psutil 01:45:27 INFO - building 'psutil._psutil_linux' extension 01:45:27 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:28 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:28 INFO - building 'psutil._psutil_posix' extension 01:45:28 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:28 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:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:28 INFO - Successfully installed psutil 01:45:28 INFO - Cleaning up... 01:45:28 INFO - Return code: 0 01:45:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:45:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:28 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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 01:45:28 INFO - 'HOME': '/home/cltbld', 01:45:28 INFO - 'LANG': 'en_US.UTF-8', 01:45:28 INFO - 'LANGUAGE': 'en_US:en', 01:45:28 INFO - 'LOGNAME': 'cltbld', 01:45:28 INFO - 'MAIL': '/var/mail/cltbld', 01:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:28 INFO - 'MOZ_NO_REMOTE': '1', 01:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:28 INFO - 'NO_EM_RESTART': '1', 01:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:28 INFO - 'PWD': '/builds/slave/test', 01:45:28 INFO - 'SHELL': '/bin/bash', 01:45:28 INFO - 'SHLVL': '1', 01:45:28 INFO - 'TERM': 'linux', 01:45:28 INFO - 'TMOUT': '86400', 01:45:28 INFO - 'USER': 'cltbld', 01:45:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:28 INFO - '_': '/tools/buildbot/bin/python'} 01:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 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 mozsystemmonitor-0.3.tar.gz 01:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45:30 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:30 INFO - Installing collected packages: mozsystemmonitor 01:45:30 INFO - Running setup.py install for mozsystemmonitor 01:45:30 INFO - Successfully installed mozsystemmonitor 01:45:30 INFO - Cleaning up... 01:45:30 INFO - Return code: 0 01:45:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:30 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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 01:45:30 INFO - 'HOME': '/home/cltbld', 01:45:30 INFO - 'LANG': 'en_US.UTF-8', 01:45:30 INFO - 'LANGUAGE': 'en_US:en', 01:45:30 INFO - 'LOGNAME': 'cltbld', 01:45:30 INFO - 'MAIL': '/var/mail/cltbld', 01:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:30 INFO - 'MOZ_NO_REMOTE': '1', 01:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:30 INFO - 'NO_EM_RESTART': '1', 01:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:30 INFO - 'PWD': '/builds/slave/test', 01:45:30 INFO - 'SHELL': '/bin/bash', 01:45:30 INFO - 'SHLVL': '1', 01:45:30 INFO - 'TERM': 'linux', 01:45:30 INFO - 'TMOUT': '86400', 01:45:30 INFO - 'USER': 'cltbld', 01:45:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:30 INFO - '_': '/tools/buildbot/bin/python'} 01:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:30 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:30 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 - 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:30 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:30 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:30 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:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45:32 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:32 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:32 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:32 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:32 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:32 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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 docopt-0.6.1.tar.gz 01:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:33 INFO - Running setup.py install for blobuploader 01:45:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:45:33 INFO - Running setup.py install for requests 01:45:33 INFO - Running setup.py install for docopt 01:45:34 INFO - Successfully installed blobuploader requests docopt 01:45:34 INFO - Cleaning up... 01:45:34 INFO - Return code: 0 01:45:34 INFO - Installing None 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', '--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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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', '--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:34 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: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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:34 INFO - Running setup.py (path:/tmp/pip-KyInJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:34 INFO - Running setup.py (path:/tmp/pip-1wpuey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:34 INFO - Running setup.py (path:/tmp/pip-g3o3Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:34 INFO - Running setup.py (path:/tmp/pip-tIm5hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:34 INFO - Running setup.py (path:/tmp/pip-nnZ0T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:34 INFO - Running setup.py (path:/tmp/pip-y_41Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:34 INFO - Running setup.py (path:/tmp/pip-WdpWeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:34 INFO - Running setup.py (path:/tmp/pip-CVJjJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:34 INFO - Running setup.py (path:/tmp/pip-7Tbgtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:35 INFO - Running setup.py (path:/tmp/pip-S9c6dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:35 INFO - Running setup.py (path:/tmp/pip-Cl5Qn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:35 INFO - Running setup.py (path:/tmp/pip-zncOcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:35 INFO - Running setup.py (path:/tmp/pip-ZHmSsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:35 INFO - Running setup.py (path:/tmp/pip-o_Gl4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:35 INFO - Running setup.py (path:/tmp/pip-0unixD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:35 INFO - Running setup.py (path:/tmp/pip-xor_An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:35 INFO - Running setup.py (path:/tmp/pip-sWIEP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:35 INFO - Running setup.py install for manifestparser 01:45:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:45:35 INFO - Running setup.py install for mozcrash 01:45:35 INFO - Running setup.py install for mozdebug 01:45:35 INFO - Running setup.py install for mozdevice 01:45:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozfile 01:45:36 INFO - Running setup.py install for mozhttpd 01:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozinfo 01:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozInstall 01:45:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozleak 01:45:36 INFO - Running setup.py install for mozlog 01:45:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for moznetwork 01:45:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozprocess 01:45:36 INFO - Running setup.py install for mozprofile 01:45:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:45:36 INFO - Running setup.py install for mozrunner 01:45:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:45:37 INFO - Running setup.py install for mozscreenshot 01:45:37 INFO - Running setup.py install for moztest 01:45:37 INFO - Running setup.py install for mozversion 01:45:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:45:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:37 INFO - Cleaning up... 01:45:37 INFO - Return code: 0 01:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:37 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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 01:45:37 INFO - 'HOME': '/home/cltbld', 01:45:37 INFO - 'LANG': 'en_US.UTF-8', 01:45:37 INFO - 'LANGUAGE': 'en_US:en', 01:45:37 INFO - 'LOGNAME': 'cltbld', 01:45:37 INFO - 'MAIL': '/var/mail/cltbld', 01:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:37 INFO - 'MOZ_NO_REMOTE': '1', 01:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:37 INFO - 'NO_EM_RESTART': '1', 01:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:37 INFO - 'PWD': '/builds/slave/test', 01:45:37 INFO - 'SHELL': '/bin/bash', 01:45:37 INFO - 'SHLVL': '1', 01:45:37 INFO - 'TERM': 'linux', 01:45:37 INFO - 'TMOUT': '86400', 01:45:37 INFO - 'USER': 'cltbld', 01:45:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:37 INFO - '_': '/tools/buildbot/bin/python'} 01:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:37 INFO - Running setup.py (path:/tmp/pip-BQ16eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:37 INFO - Running setup.py (path:/tmp/pip-z7d4Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:37 INFO - Running setup.py (path:/tmp/pip-3jf0nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:37 INFO - Running setup.py (path:/tmp/pip-ouNshT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:37 INFO - Running setup.py (path:/tmp/pip-KJQBsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:37 INFO - Running setup.py (path:/tmp/pip-e1T2l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:38 INFO - Running setup.py (path:/tmp/pip-FlhNNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:38 INFO - Running setup.py (path:/tmp/pip-ov_L0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:38 INFO - Running setup.py (path:/tmp/pip-yxh5fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:38 INFO - Running setup.py (path:/tmp/pip-FCn04d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:38 INFO - Running setup.py (path:/tmp/pip-mIJpnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:38 INFO - Running setup.py (path:/tmp/pip-gv19tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:38 INFO - Running setup.py (path:/tmp/pip-l3e13y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:38 INFO - Running setup.py (path:/tmp/pip-2L8XAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:38 INFO - Running setup.py (path:/tmp/pip-bUHrd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:38 INFO - Running setup.py (path:/tmp/pip-CNXmDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:38 INFO - Running setup.py (path:/tmp/pip-3L0Jwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:45:38 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:38 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:38 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:38 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:38 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:38 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:40 INFO - Downloading blessings-1.6.tar.gz 01:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:45:41 INFO - Installing collected packages: blessings 01:45:41 INFO - Running setup.py install for blessings 01:45:41 INFO - Successfully installed blessings 01:45:41 INFO - Cleaning up... 01:45:41 INFO - Return code: 0 01:45:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:41 INFO - Reading from file tmpfile_stdout 01:45:41 INFO - Current package versions: 01:45:41 INFO - argparse == 1.2.1 01:45:41 INFO - blessings == 1.6 01:45:41 INFO - blobuploader == 1.2.4 01:45:41 INFO - docopt == 0.6.1 01:45:41 INFO - manifestparser == 1.1 01:45:41 INFO - mozInstall == 1.12 01:45:41 INFO - mozcrash == 0.17 01:45:41 INFO - mozdebug == 0.1 01:45:41 INFO - mozdevice == 0.48 01:45:41 INFO - mozfile == 1.2 01:45:41 INFO - mozhttpd == 0.7 01:45:41 INFO - mozinfo == 0.9 01:45:41 INFO - mozleak == 0.1 01:45:41 INFO - mozlog == 3.2 01:45:41 INFO - moznetwork == 0.27 01:45:41 INFO - mozprocess == 0.22 01:45:41 INFO - mozprofile == 0.28 01:45:41 INFO - mozrunner == 6.11 01:45:41 INFO - mozscreenshot == 0.1 01:45:41 INFO - mozsystemmonitor == 0.3 01:45:41 INFO - moztest == 0.7 01:45:41 INFO - mozversion == 1.4 01:45:41 INFO - psutil == 3.1.1 01:45:41 INFO - requests == 1.2.3 01:45:41 INFO - wsgiref == 0.1.2 01:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 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 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 01:45:41 INFO - 'HOME': '/home/cltbld', 01:45:41 INFO - 'LANG': 'en_US.UTF-8', 01:45:41 INFO - 'LANGUAGE': 'en_US:en', 01:45:41 INFO - 'LOGNAME': 'cltbld', 01:45:41 INFO - 'MAIL': '/var/mail/cltbld', 01:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:41 INFO - 'MOZ_NO_REMOTE': '1', 01:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:41 INFO - 'NO_EM_RESTART': '1', 01:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:41 INFO - 'PWD': '/builds/slave/test', 01:45:41 INFO - 'SHELL': '/bin/bash', 01:45:41 INFO - 'SHLVL': '1', 01:45:41 INFO - 'TERM': 'linux', 01:45:41 INFO - 'TMOUT': '86400', 01:45:41 INFO - 'USER': 'cltbld', 01:45:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:41 INFO - '_': '/tools/buildbot/bin/python'} 01:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Cleaning up... 01:45:41 INFO - Return code: 0 01:45:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:45:41 INFO - Using env: {'DISPLAY': ':0', 01:45:41 INFO - 'HOME': '/home/cltbld', 01:45:41 INFO - 'LANG': 'en_US.UTF-8', 01:45:41 INFO - 'LANGUAGE': 'en_US:en', 01:45:41 INFO - 'LOGNAME': 'cltbld', 01:45:41 INFO - 'MAIL': '/var/mail/cltbld', 01:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:41 INFO - 'MOZ_NO_REMOTE': '1', 01:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:41 INFO - 'NO_EM_RESTART': '1', 01:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:41 INFO - 'PWD': '/builds/slave/test', 01:45:41 INFO - 'SHELL': '/bin/bash', 01:45:41 INFO - 'SHLVL': '1', 01:45:41 INFO - 'TERM': 'linux', 01:45:41 INFO - 'TMOUT': '86400', 01:45:41 INFO - 'USER': 'cltbld', 01:45:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:41 INFO - '_': '/tools/buildbot/bin/python'} 01:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:41 INFO - Downloading/unpacking jsonschema 01:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:45:43 INFO - Downloading/unpacking functools32 (from jsonschema) 01:45:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading functools32-3.2.3-2.tar.gz 01:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:45:43 INFO - warning: no files found matching '*.txt' 01:45:43 INFO - no previously-included directories found matching 'build' 01:45:43 INFO - no previously-included directories found matching 'dist' 01:45:43 INFO - no previously-included directories found matching '.git*' 01:45:43 INFO - Installing collected packages: jsonschema, functools32 01:45:44 INFO - Running setup.py install for functools32 01:45:44 INFO - warning: no files found matching '*.txt' 01:45:44 INFO - no previously-included directories found matching 'build' 01:45:44 INFO - no previously-included directories found matching 'dist' 01:45:44 INFO - no previously-included directories found matching '.git*' 01:45:44 INFO - Successfully installed jsonschema functools32 01:45:44 INFO - Cleaning up... 01:45:44 INFO - Return code: 0 01:45:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a653f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', '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:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:45:44 INFO - Using env: {'DISPLAY': ':0', 01:45:44 INFO - 'HOME': '/home/cltbld', 01:45:44 INFO - 'LANG': 'en_US.UTF-8', 01:45:44 INFO - 'LANGUAGE': 'en_US:en', 01:45:44 INFO - 'LOGNAME': 'cltbld', 01:45:44 INFO - 'MAIL': '/var/mail/cltbld', 01:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:44 INFO - 'MOZ_NO_REMOTE': '1', 01:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:44 INFO - 'NO_EM_RESTART': '1', 01:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:44 INFO - 'PWD': '/builds/slave/test', 01:45:44 INFO - 'SHELL': '/bin/bash', 01:45:44 INFO - 'SHLVL': '1', 01:45:44 INFO - 'TERM': 'linux', 01:45:44 INFO - 'TMOUT': '86400', 01:45:44 INFO - 'USER': 'cltbld', 01:45:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:44 INFO - '_': '/tools/buildbot/bin/python'} 01:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:44 INFO - Downloading/unpacking flake8 01:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:45:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:45:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:47 INFO - no previously-included directories found matching 'docs/_build' 01:45:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:45:47 INFO - Running setup.py install for pep8 01:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:47 INFO - no previously-included directories found matching 'docs/_build' 01:45:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:45:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:45:47 INFO - Cleaning up... 01:45:47 INFO - Return code: 0 01:45:47 INFO - Running post-action listener: _resource_record_post_action 01:45:47 INFO - Running post-action listener: _start_resource_monitoring 01:45:47 INFO - Starting resource monitoring. 01:45:47 INFO - ##### 01:45:47 INFO - ##### Finished create-virtualenv step (success) 01:45:47 INFO - ##### 01:45:47 INFO - ##### 01:45:47 INFO - ##### Running install step. 01:45:47 INFO - ##### 01:45:47 INFO - Running pre-action listener: _resource_record_pre_action 01:45:47 INFO - Running main action method: install 01:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:47 INFO - Reading from file tmpfile_stdout 01:45:47 INFO - Detecting whether we're running mozinstall >=1.0... 01:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:45:47 INFO - Reading from file tmpfile_stdout 01:45:47 INFO - Output received: 01:45:47 INFO - Usage: mozinstall [options] installer 01:45:47 INFO - Options: 01:45:47 INFO - -h, --help show this help message and exit 01:45:47 INFO - -d DEST, --destination=DEST 01:45:47 INFO - Directory to install application into. [default: 01:45:47 INFO - "/builds/slave/test"] 01:45:47 INFO - --app=APP Application being installed. [default: firefox] 01:45:47 INFO - mkdir: /builds/slave/test/build/application 01:45:47 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:47 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:46:04 INFO - Reading from file tmpfile_stdout 01:46:04 INFO - Output received: 01:46:04 INFO - /builds/slave/test/build/application/firefox/firefox 01:46:04 INFO - Running post-action listener: _resource_record_post_action 01:46:04 INFO - ##### 01:46:04 INFO - ##### Finished install step (success) 01:46:04 INFO - ##### 01:46:04 INFO - ##### 01:46:04 INFO - ##### Running run-tests step. 01:46:04 INFO - ##### 01:46:04 INFO - Running pre-action listener: _resource_record_pre_action 01:46:04 INFO - Running main action method: run_tests 01:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:46:04 INFO - Python 2.7.3 01:46:04 INFO - Return code: 0 01:46:04 INFO - grabbing minidump binary from tooltool 01:46: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:46:04 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 0x10a29c0>, '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 0x10a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:46:04 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:46:04 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:46:04 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:46:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:46:04 INFO - Return code: 0 01:46:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:46:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:46:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:46:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:46:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:46:05 INFO - Return code: 0 01:46:05 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-066', '--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:46:05 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-066 --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:46:05 INFO - Using env: {'DISPLAY': ':0', 01:46:05 INFO - 'HOME': '/home/cltbld', 01:46:05 INFO - 'LANG': 'en_US.UTF-8', 01:46:05 INFO - 'LANGUAGE': 'en_US:en', 01:46:05 INFO - 'LOGNAME': 'cltbld', 01:46:05 INFO - 'MAIL': '/var/mail/cltbld', 01:46:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:46:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:05 INFO - 'MOZ_NO_REMOTE': '1', 01:46:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:05 INFO - 'NO_EM_RESTART': '1', 01:46:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:05 INFO - 'PWD': '/builds/slave/test', 01:46:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:46:05 INFO - 'SHELL': '/bin/bash', 01:46:05 INFO - 'SHLVL': '1', 01:46:05 INFO - 'TERM': 'linux', 01:46:05 INFO - 'TMOUT': '86400', 01:46:05 INFO - 'USER': 'cltbld', 01:46:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994', 01:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:05 INFO - '_': '/tools/buildbot/bin/python'} 01:46:05 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-066', '--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:46:05 INFO - mozversion application_buildid: 20160523193033 01:46:05 INFO - mozversion application_changeset: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf 01:46:05 INFO - mozversion application_display_name: Nightly 01:46:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:46:05 INFO - mozversion application_name: Firefox 01:46:05 INFO - mozversion application_remotingname: firefox 01:46:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:46:05 INFO - mozversion application_vendor: Mozilla 01:46:05 INFO - mozversion application_version: 49.0a1 01:46:05 INFO - mozversion platform_buildid: 20160523193033 01:46:05 INFO - mozversion platform_changeset: 46fe2115d46a5bb40523b8466341d8f9a26e1bdf 01:46:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:46:05 INFO - mozversion platform_version: 49.0a1 01:46:05 INFO - using testdate: 1464079565 01:46:05 INFO - actual date: 1464079565 01:46:05 INFO - starting webserver on 'localhost:49261' 01:46:05 INFO - SUITE-START | Running 2 tests 01:46:05 INFO - TEST-START | dromaeo_css 01:46:05 INFO - operating with platform_type : linux_ 01:46:05 INFO - Initialising browser for dromaeo_css test... 01:46:05 INFO - TEST-INFO | started process 12124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNCl9C/profile http://localhost:49261/getInfo.html) 01:46:09 INFO - PROCESS | 12124 | __metrics Screen width/height:1600/1200 01:46:09 INFO - PROCESS | 12124 | colorDepth:24 01:46:09 INFO - PROCESS | 12124 | Browser inner width/height: 1024/697 01:46:09 INFO - PROCESS | 12124 | __metrics 01:46:10 ERROR - PROCESS | 12124 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:46:11 INFO - TEST-INFO | 12124: exit 0 01:46:11 INFO - Browser initialized. 01:46:11 INFO - Running cycle 1/1 for dromaeo_css test... 01:46:11 INFO - TEST-INFO | started process 12207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNCl9C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:23 INFO - PROCESS | 12207 | RSS: Main: 152842240 01:46:23 INFO - PROCESS | 12207 | 01:47:14 INFO - PROCESS | 12207 | 1464079634403 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:22 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49261/tests/dromaeo/cssquery-ext.html) 01:49:23 INFO - PROCESS | 12207 | RSS: Main: 264441856 01:49:23 INFO - PROCESS | 12207 | 01:52:25 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-ext.html (next: http://localhost:49261/tests/dromaeo/cssquery-jquery.html) 01:52:25 INFO - PROCESS | 12207 | RSS: Main: 237735936 01:52:25 INFO - PROCESS | 12207 | 01:55:27 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49261/tests/dromaeo/cssquery-mootools.html) 01:55:28 INFO - PROCESS | 12207 | RSS: Main: 244604928 01:55:28 INFO - PROCESS | 12207 | 01:58:30 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49261/tests/dromaeo/cssquery-prototype.html) 01:58:31 INFO - PROCESS | 12207 | RSS: Main: 235053056 01:58:31 INFO - PROCESS | 12207 | 02:01:33 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49261/tests/dromaeo/cssquery-yui.html) 02:01:34 INFO - PROCESS | 12207 | RSS: Main: 210247680 02:01:34 INFO - PROCESS | 12207 | 02:04:36 INFO - PROCESS | 12207 | Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-yui.html (next: http://localhost:49261/tests/dromaeo/cssquery-dojo.html) 02:04:37 INFO - PROCESS | 12207 | RSS: Main: 278859776 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | __start_tp_report 02:04:37 INFO - PROCESS | 12207 | _x_x_mozilla_page_load 02:04:37 INFO - PROCESS | 12207 | _x_x_mozilla_page_load_details 02:04:37 INFO - PROCESS | 12207 | |i|pagename|runs| 02:04:37 INFO - PROCESS | 12207 | |0;dojo.html;3053.2824786175247;3071.6621171671113;3096.7522598192145;3112.2686168750356;3128.327409606934;5216.191490318997;5218.895622087561;5259.526642602165;5286.867828304295;5300.840974770758;5313.920291195635;5324.76038578264;5334.199870019499;5373.892522149555;5446.891062178754;4590.862274131765;4786.641001924852;4969.925451118236;4991.450940396553;5006.499350065001;4738.123447162286;4924.28597853311;4948.678335908173;4949.381327334083;4963.404391473028;4827.106985207748;4838.298446725223;4873.488283730193;4877.707337559722;4901.828436004723;4934.580560652349;4936.432310284292;4938.9012219755405;4940.777665005084;4949.950500494985;4590.036092420596;4730.0776348612035;4773.76131193439;4908.410990681141;4962.429320628138;5299.6025298102795;5323.307969963918;5325.467453254682;5344.144936810092;5359.517643412111;5648.209250704905;5658.85852853682;5698.17376480408;5699.572532060112;5708.77164913403;5470.617056806025;5603;5631.690257035862;5674.574406919498;5832.533397328203;5332.653377530448;5364.14173732201;5366.4633536646415;5369.114096174127;5376.11294136467;5905.320888097924;5916.408359164049;5919.082542205965;5921.911171332434;5922.911156332659;5332.786688532493;5445.264889239981;5475.09660905954;5508.6970216637665;5596.916046259309;5622.57830662702;5677.2619559457835;5678.261825962599;5681.289838770153;5685.260916080883;5482.972585137049;5598.720063996784;5604.327480702342;5617.578681598897;5617.9438205618235;5633.492985631231;5664.971675141598;5672.978863804472;5721.485066344049;5730.942690573124;4355.237833379146;4358.5205627380965;4359.324304732771;4363.083752411965;4398.824047038082;3721;3884.4950156479476;3884.5726970033274;3898.181381909774;3919.666828319625;5509.146082357241;5521.420250873681;5535.446455354432;5542.085555883315;5586.944130558723;5831.183634291203;5843.561732870052;5845.853853653608;5888.116782482662;5902.2032025676845;5092.439831618519;5419.891602167934;5447.1829225616475;5509.090999984957;5531.889362212733;4902.240152776325;4923.75381230937;4927.975360123177;4943.357363542788;4958.876028099255;5973.402659734079;5981.282246130405;5983.401659833982;5986.610870293504;6017.578769486182;5581.581381396492;5608.943910560843;5628.240187574625;5649.406812284651;5764.337101233412;5826.184334193301;5841.883162336644;5847.152162936265;5850.853728656647;5852.882942341044;5566.77732890696;5568.721563921868;5569.359523654832;5570.721463926869;5582.441755824385;5559.749811258423;5647;5666.518345940642;5691.8292451226525;5728.3985181557;5572.86067848307;5579.46995035471;5588.552915766811;5590.0496915523645;5595.440455954372;5391.245225668331;5530.778768849201;5568.136938774496;5581.358143813513;5615.045442274742;5395.217693434509;5436.836894893159;5443.646162999551;5510.834674959758;5522.282103326542;5591.580631452576;5616.7191640416995;5624.634398764068;5654.7455364509515;5665.575081868794;5400.054990376747;5453.481919217668;5518.172274158747;5519.558435325244;5547.944520554743 02:04:37 INFO - PROCESS | 12207 | |1;ext.html;580.399286738226;621.7109044294402;633.9080833279174;638.0110828216264;644.326678620841;43514.12971740563;44676.77661611691;44951.55048449514;45048;48315.758421207844;45021.04768475465;45337.31994020084;45395.546044539544;45450.7727461363;45456.318155227695;8796.472211667304;8968.282537396992;8975.820483590323;8980.32647551433;8983.550822458883;8811.559422028906;8821.16198961101;8863.911360886374;8883.244924181452;8890.288776897865;8887.066857979917;8912.465252084863;8964.775880603005;8994.280457563413;9000.27997760181;8878.556072196365;8934.10658934108;8956.059613740561;8958.776030599221;8959.37284390093;8715.912840871573;8793.7801554961;8810.515421651806;8818.206361427438;8819.955900220459;42164.57835421637;42508.36237456441;42513;42662.78668606668;42668.14663706708;3578.4274516077303;3581.4269716845442;3621.963780362189;3819.656230939201;4044.474218351625;32010.839945800355;32386.35227295441;32698;32749.836250818593;34063;4338.522762496123;4425.424694789689;4501.527339629324;4535.818567257305;4547.136044151601;316006.41996790096;318835;320886;320978;321425;57759.71120144457;57783.711081445166;57991.420085799444;58137.41862581405;58164.70917645385;60899;60983.39016609777;61000;61126;61147;16659.75010374821;16843;16865.988040717595;16868.072256025793;16882.915585421993;13221.405036773369;13248.40382182804;13289.66775830612;13292.136011159244;13295.80056299137;14050.648733781532;16442.671146577002;16448.177591120395;16601.91699041497;16619.83380166207;6216.5391133083685;6230.7507699691505;6269.592476489013;6404.199475065617;6493.967530162319;998.9450580218157;1054.926155169146;1094.7700982793542;1136.8976792088752;1172.3610632205468;32239.194020149684;32772;32885.17787055295;33203.50194747081;33442.10274218623;1113.5768408005067;1131.9773604527863;1150.5110328110686;1155.5204590095184;1161.0189389965465;17049.48851534456;17113.401030963858;17175.914120429567;17309.221085051202;17420;465825;468932.93201204017;469300;470356;471450;58056;58381.372838221534;58436;59045.40954590485;59112.40887591155;1262.6906407929932;1396.7136736968896;1413.2297897645808;1527.1905889878383;1630.9592260193353;30512.389752204388;34372.312553748285;34461.65538344585;34604.480932785526;34905.47641785426;50822.237666434296;52003.479965201375;52257.47742522526;52285.47714522806;52414.737926310125;405455;410728;414655;415002;415580;38865.05674716309;43307.56692433036;43353.783231084904;45006.77496612496;45628.543714563755;49249.753751231015;49430.75284623554;49812.25281620851;50237;51018.74490627523;40843.59156408398;41852;42310.57689423066;42957;43400;39546.80226598849;41456.58543414648;42048.789756051025;42154.156916862106;42896.142077158904;41945.1610967785;42705;43470;43847.56152438435;45596.54403456056;35942.28115437729;38802;38819.805900970314;39159.80420097881;39392.2121557573;28315.858420707766;28717.856410717814;28895.56656650194;28981.13056608305;29022 02:04:37 INFO - PROCESS | 12207 | |2;jquery.html;393.5120450641204;395.7032225830627;397.9442877997081;402.4988888833402;418.6692512914797;12986.218610756929;19121.904390478045;19664.606707865853;19697.803021969776;20526.2815801447;18778.718319225223;19123.61752764944;19391.612167756637;19522.414327570197;19609.313674021378;5551.7224138793;5650.6892120933335;5690.5447564194765;5691.8292451226325;5734.913976290359;5593.524550413199;5639.802606908759;5665.716714164296;5721.027425337703;5723.141528770676;4071.9185616287805;5946.345901950782;6248.812535623939;6249.812505624838;6338.144350512668;6188.783392581238;6289.685515724218;6311.810645680637;6332.936670633281;6356.555041147121;5428.945710542923;5557.499825015728;5567.526760225385;5581.413951535071;5590.440955904418;22487.66268505974;22503;23177.304680859434;23794.88102559476;23860.880695596585;2067.472794437409;2238.2278114050628;2344.6483027545833;2518.458531415736;2589.805764567665;9526.190273826733;9569.33014688972;10032.247581431422;10121.139703125244;10198.745031374201;1813.9909300453414;1867.3930972434014;1876.6340563590106;1880.2948894164688;1898.8101189880902;79707.60146199232;80181.59909200475;80882.19117808864;81903.5904820478;83166.58416707939;10888.891111088946;10922.60865226283;10985.780284394268;11107.444627768578;11197.776044479066;15331;15497.14765687898;15518.068915865084;15518.456854010055;15529.068255904456;8155.469894456842;8318.12659670738;8364.37267204962;8367.456115352483;8461.915380846112;8054.758357249292;8106.108328083906;8243.587820608946;8296.142293833396;8359.331253499706;4664.39362882823;4712.340272361872;4778.402699662543;4781.52184781526;4839.322494850724;1894.7915729269769;1932.1884808380514;1957.9216831326871;1963.891985940787;1967.567135230247;421.3700517726019;422.82452782095083;432.62145622580243;959.6161535385902;1113.432149603708;11242.269252498561;11655.242409243372;11763.176577639655;17422.390216342366;20639.484012899797;1009.7677534167036;1015.3197357770312;1027.8817935937313;1040.5681642118436;1042.124615323117;10487.213458990605;11012.944935275273;11067.557297708163;11082.501287442085;11142.108631309477;490809;492749;502578;504984;506336;58787.70606146942;80476.59761701271;95271.52364238273;96287.51856240814;96766.51616741871;1043.6868939318326;1043.7390652336917;1051.4690081508636;1067.4716015572187;1069.9625513107003;17110.315587376863;17192.91403542974;17353.652926941642;17484.82515174832;17612.559686007953;41816.163676725686;42086.36870447007;43507.78246108749;43773.34339984839;44406.3339049921;58839.41160588511;59468.405315946286;60277.39722602718;61318.080228797495;61462.38537614566;8491.915080849112;8621.094785047731;8725.389222754346;8825.293976481738;9051.90948090537;8638.740837774876;11572.074234061087;12756.681082973;13833.30833458303;13864.930675346559;12083.818742718691;12210.450529726362;12260;12303.261804291771;12322.50709971627;12114.454849531969;12121;12131.53910345149;12133.69665758363;12255.87744122583;12378.876211237772;12435.93782031084;12461.179931328908;12649.051321150766;12674.176178548365;8583.399162058597;8643.481391116553;8734.91265087341;8846.292296616126;8919.55402229873;11637.825432618687;12121.212121212093;12207.694807629525;12216.938915305367;12407.069469789982 02:04:37 INFO - PROCESS | 12207 | |3;mootools.html;1318.386950068218;1527.0074451606458;1555.4789145636212;1720.2516905146263;1838.4117082533594;8570.828583428327;8927.866082008775;8934.195922366995;9195.67815126469;9202.40184388016;8913.242374398167;9087.31845111616;9099.727008189748;9115;9131.543422828849;2044.8568600197991;2355.211004313557;2396.688430504032;2423.0550085466684;2448.926532204037;2454.7790698837102;2459.950800983979;2461.10169788027;2461.852288862674;2465.3959779853963;2322.105989194164;2334.054707843318;2356.858588484688;2358.351453350334;2360.5986982213067;1987.1157334985937;2283.3834864586634;2338.53229354129;2372.240882917467;2374.3233178544033;2333.1134169015663;2350.15394457995;2363.61000434928;2368.9170879019325;2371.3004663624274;8993.325500587482;9102;9109.635614575409;9118.224950879183;9128.178463938211;5259.342582177228;5388.7305634718105;5395.082835917903;5403.162509810985;5403.729813509309;3531.0819187011307;3571.732120090978;3580.2839432113683;3603;3645;1137.8975892169744;1166.7958107331267;1189.8393716848202;1211.3277131192185;2151.7740637233023;12265.816012759815;12266.877331226662;12285.324307163102;12297.93851030748;12553.435095420637;4570.428696412949;4665.883352916137;4740.525947405301;4740.928886066712;4753.786079626425;9764.560594773253;9775.071368220008;9780.315377923476;9808.950955245178;9816.165625921734;5213.983273261678;5216.791328346823;5216.817411390583;5217.0870097733505;5218.478152184827;4372.497162826252;4888.486708895586;4991.376077990251;5029.044481548494;5121.027004869063;3827.2536855312946;3932.446683559978;3934.724569280123;3989.4614227078973;4023.275810354106;1180.651707746217;1184.8874356936078;1193.9223950443193;1200.111917181297;1205.180477275461;840.8570543007703;865.3812524045212;878.2973621103092;902.1114202510522;979.6424305128577;5816.418358164235;5848.561357898175;6071.089336599457;6078.544109191828;6164.938350616526;447.9977600112044;451.8034654925118;467.97894094765815;470.47541990680827;472.57704354602436;4011.6991225658194;4014.458048163519;4022.2960981828064;4130.793460326971;4198.958010419857;11224.887751122384;11459.31244125355;11606.651800446;11617.186796924303;11618;10807.78384432307;11257.21199516026;11464.885351146548;11465.197436179555;11471.827922581168;8229.300509456643;8504.702335418355;8609.053004169537;8640.265577425864;8647.481151130953;5987.473194335416;5997.790077347447;6139.754409823557;6219.036049412348;6295.748170073146;10223.846642300223;10458.372497650165;10497;10664.786704265716;10875.945620271848;10805.621803236849;10808.567657293936;10913.23607347478;10939.56241750321;10943.562257509611;7126.251743567058;7744.341730952707;7831;7992.120866704774;8173.060098088796;8862.158094980967;8886.4668119913;8931.062238465127;8958.328125390752;8966.417182883091;7741.806454838674;7947.602619868868;7976.162502937108;8019.759407217793;8032;7873.842523149619;7951.522908625501;8015.198480151938;8040.276375126266;8093.0692970309165;7385.889211661937;7387.1135463744695;7387.7783666490095;7484.550926944401;7486.5508069516;5145.665531740425;5240.502152295679;5258.631895767259;5309.415964243853;5364.919526207032;4865.440474345354;5030.597552195889;5075.5178258065425;5144.254083157996;5192.324997750268 02:04:37 INFO - PROCESS | 12207 | |4;prototype.html;314.2207325831935;325.86639477814094;327.94728920166267;333.29175502058126;338.12257192585247;5178.585713142949;5216.035033518801;5219.634625576211;5252.973735131323;5289.444608316129;5136.845894623168;5211.817586384477;5237.193168356911;5238.738063096849;5263.131583288753;4059.2287465381555;4061.6344528992386;4063.7358571692744;4069.450624165744;4079.938800917989;3867.5165604299464;3913.5890731473214;4067.9186416271655;4070.124923141524;4082.326416141333;4003.65968892643;4011.438398624195;4019.256437559061;4031.57668444812;4032.6370626643597;3842.9231415371814;3981.920361592781;4002.699797515169;4004.438269075063;4021.3163762160502;3434.0899661589697;3535.2045789697368;3544.113971507123;3549.574051113857;3550.378683730363;5024.472430394792;5033.119204139298;5044.772985215674;5047.217681259411;5067.479756073163;4590.60979816716;4591.104734576759;4596.931046034312;4597.816037382217;4605.286180642006;5134.409542902539;5352.545033672142;5372.979133964534;5390.326209223847;5394.541463975567;3810.2950954073585;3852.9614703853163;3854.3447613905705;3859.1895701902354;3863.2466668999555;5582.699918650084;5684.8010319638615;5702.8289151325525;5706.857328566777;5715.485606295411;3851.9614803851605;3936.980315098406;3941.704372172041;3951.9012024699614;3953.8616148434667;3966.7421617594764;3997.780122093313;4011;4014.578469260744;4034.616711412411;4592.897704550884;4615.538446155425;4615.838445654386;4631.305304204397;4638.1187574360765;5218.373795144607;5483.122700367922;5489.725513724377;5496.890062198813;5549.694766787785;1369.472752990086;1371.430856194688;1375.0924389902616;1377.8415482219473;1382.5783136143573;857.9442336248123;881.1849039638437;882.8013696918142;891.4562117108559;893.1381217125505;4744.4069491313585;5111.309973153651;5156.948430515722;5299.49654782795;5336.439673834269;5568.99758043548;5574.247476590608;5592.2730045094695;5604.915926261109;5608.4111168326735;5135.974320128375;5274.525292723597;5282.6302158849285;5320.946790532045;5321.2018197269945;2930.1356099950567;2937.162908571047;2939.4855900217376;2945.3078526546246;2963.5406511990677;5665.66006039639;5671.071835575924;5731.5701322400155;5750.424957504216;5780.450857168562;5449.264349312872;5599.544118529212;5650.208970744099;5659.603827732019;5661.1508273758445;5691.373948865621;5726.4517289805635;5733.770649173986;5739.139129130664;5752.913706294409;5558.333000040021;5565.805196818092;5607.635503692247;5628.296462942132;5639.7180140993605;5187.766550505312;5504.504594586347;5505.394406615349;5507.889842203053;5527.673358394037;5775.249217601685;5785.305763308262;5793.884122317614;5799.94200057994;5812.73842677089;3737.6449237322413;3999.9400008999305;4022.8994275143355;4023.818928148182;4025.6578190854107;5531.640443371168;5561.277033985556;5569.66582005081;5570.888582228414;5596.776128954796;5419.593530485308;5427.375851776938;5432.402435731988;5453.2365468833605;5458.8263523342675;5269.604779641466;5437.891242175214;5452.236686863763;5455.454454554513;5459.890802184013;5342;5358.97320513395;5364.168553874156;5367.42363665435;5370.919436208538;5290.391604965324;5349.625526213128;5453.291072160594;5456.2906822114455;5476.2607048049595;5336.17289320156;5348.545373643128;5352.625316227826;5353.304070470814;5366.946330536644 02:04:37 INFO - PROCESS | 12207 | |5;yui.html;788.2078511096349;807.3581502705349;810.3193317613204;841.0748177005291;871.1636828644502;14105.788413173797;14583;14689;14732.926335368335;14795.778063329059;13401.262930538816;13447.529336473226;13457.865421345783;13467.865321346784;13475.528356507524;676.6379986707088;794.1066300412036;796.7291121018852;823.3495538524559;825.4428260923883;794.6543253684637;802.3821657323857;803.7829785957788;806.9475484093545;807.2573232625969;865.4028720183054;866.8396346675854;872.6029656506274;874;874.3442418186361;716.451914285572;824.8721448175543;842.692417267699;843.7257891185359;845.9788505287418;607.380471918645;607.8632307730769;607.872346807171;608.6317777744445;609.4667166229549;13663.726725465534;13684.589462316146;13692.931535342259;13715;13726.313684315845;12146.696332591757;12739.745205095938;12806.80789788154;12885.935570322183;13314.267715275655;11774.764504709943;11819.409029548488;11866.347350895698;11877.881221187765;11946.581869634609;4286.61587926314;4290.356446533014;4317.395564620955;4369.4756629204385;4501.324801279801;55423.44576554264;56153;56743;57274;57524.71237643827;10103.646372376932;10224.386536807815;10272.33229840073;10676.3965178766;10746.623868164577;18767.718484222747;20264.088116034814;20303.593928121354;20308;20332.898335508227;8226.177382261725;8301.377396695272;8406.747797566082;8413.495190288602;8484.109168537214;4653.557911998355;4726.834560790356;4789.185838407479;4861.27080937855;4983.6760610560195;3362.4620060790157;3434.433318502469;3436.1581412554083;3440.1571614954496;3444.362792883325;524.3445692883895;617.4813156948185;625.968701564929;689.9448044156455;692.0656416792763;735.9595222262827;751.2299892610118;755.1693137548652;770.8111512679317;777.4441274488768;9867.555959981819;10013.749656258506;10016.899831001743;10113.089821916063;10203;649.4382359259207;714.8427345983876;753.4123383760675;767.4551068741256;786.9134395216636;4551.613112885376;4658.743769092733;4946.777395017233;5039.034776437193;5061.873453163626;69465;69876;71240;72008.2799172012;72077;60914;61174.38825611687;61360;64236;67291.3270867285;55302;55606;56155;56828.43171568314;57262;9322.34596283793;9384.577694003923;9384.76538086526;9415.670451534163;9596.856047159159;37372.813135935234;37993.810030949666;38007.429888552244;38175.80912095422;39179.608203917596;46897.29654055124;50108.74945625394;50748;50774;50934.49065509297;11943.462544185706;12055;12059.236967669212;12104.45529951172;12259.509619615115;13255;13359.332033398485;13483.73032539324;14122.223277719824;14299.142051476945;11798.646040618794;12377.443015064164;12676.23942563449;12720.300383478627;12746.936265318614;11919.76160476803;12100.757984840078;12223.327716975651;12256.38718064111;12932.676683082622;12478.875211248134;12597.181183223061;12740.43867408267;12765.74468510606;12864.421101050288;10342.844857326996;10504.212184086071;10554.366737995744;10572;11092.445377730919;10809.891901081202;10930.45347732626;10985.83521247166;11164.274322169033;11182.944085279521 02:04:37 INFO - PROCESS | 12207 | __end_tp_report 02:04:37 INFO - PROCESS | 12207 | __start_cc_report 02:04:37 INFO - PROCESS | 12207 | _x_x_mozilla_cycle_collect,943 02:04:37 INFO - PROCESS | 12207 | __end_cc_report 02:04:37 INFO - PROCESS | 12207 | __startTimestamp1464080677191__endTimestamp 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | ------- Summary: start ------- 02:04:37 INFO - PROCESS | 12207 | Number of tests: 6 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#0] dojo.html Cycles:165 Average:5296.83 Median:5510.83 stddev:600.67 (10.9%) stddev-sans-first:576.15 02:04:37 INFO - PROCESS | 12207 | Values: 3053.3 3071.7 3096.8 3112.3 3128.3 5216.2 5218.9 5259.5 5286.9 5300.8 5313.9 5324.8 5334.2 5373.9 5446.9 4590.9 4786.6 4969.9 4991.5 5006.5 4738.1 4924.3 4948.7 4949.4 4963.4 4827.1 4838.3 4873.5 4877.7 4901.8 4934.6 4936.4 4938.9 4940.8 4950.0 4590.0 4730.1 4773.8 4908.4 4962.4 5299.6 5323.3 5325.5 5344.1 5359.5 5648.2 5658.9 5698.2 5699.6 5708.8 5470.6 5603.0 5631.7 5674.6 5832.5 5332.7 5364.1 5366.5 5369.1 5376.1 5905.3 5916.4 5919.1 5921.9 5922.9 5332.8 5445.3 5475.1 5508.7 5596.9 5622.6 5677.3 5678.3 5681.3 5685.3 5483.0 5598.7 5604.3 5617.6 5617.9 5633.5 5665.0 5673.0 5721.5 5730.9 4355.2 4358.5 4359.3 4363.1 4398.8 3721.0 3884.5 3884.6 3898.2 3919.7 5509.1 5521.4 5535.4 5542.1 5586.9 5831.2 5843.6 5845.9 5888.1 5902.2 5092.4 5419.9 5447.2 5509.1 5531.9 4902.2 4923.8 4928.0 4943.4 4958.9 5973.4 5981.3 5983.4 5986.6 6017.6 5581.6 5608.9 5628.2 5649.4 5764.3 5826.2 5841.9 5847.2 5850.9 5852.9 5566.8 5568.7 5569.4 5570.7 5582.4 5559.7 5647.0 5666.5 5691.8 5728.4 5572.9 5579.5 5588.6 5590.0 5595.4 5391.2 5530.8 5568.1 5581.4 5615.0 5395.2 5436.8 5443.6 5510.8 5522.3 5591.6 5616.7 5624.6 5654.7 5665.6 5400.1 5453.5 5518.2 5519.6 5547.9 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#1] ext.html Cycles:180 Average:57713.37 Median:43132.28 stddev:106806.45 (247.6%) stddev-sans-first:107019.93 02:04:37 INFO - PROCESS | 12207 | Values: 580.4 621.7 633.9 638.0 644.3 43514.1 44676.8 44951.6 45048.0 48315.8 45021.0 45337.3 45395.5 45450.8 45456.3 8796.5 8968.3 8975.8 8980.3 8983.6 8811.6 8821.2 8863.9 8883.2 8890.3 8887.1 8912.5 8964.8 8994.3 9000.3 8878.6 8934.1 8956.1 8958.8 8959.4 8715.9 8793.8 8810.5 8818.2 8820.0 42164.6 42508.4 42513.0 42662.8 42668.1 3578.4 3581.4 3622.0 3819.7 4044.5 32010.8 32386.4 32698.0 32749.8 34063.0 4338.5 4425.4 4501.5 4535.8 4547.1 316006.4 318835.0 320886.0 320978.0 321425.0 57759.7 57783.7 57991.4 58137.4 58164.7 60899.0 60983.4 61000.0 61126.0 61147.0 16659.8 16843.0 16866.0 16868.1 16882.9 13221.4 13248.4 13289.7 13292.1 13295.8 14050.6 16442.7 16448.2 16601.9 16619.8 6216.5 6230.8 6269.6 6404.2 6494.0 998.9 1054.9 1094.8 1136.9 1172.4 32239.2 32772.0 32885.2 33203.5 33442.1 1113.6 1132.0 1150.5 1155.5 1161.0 17049.5 17113.4 17175.9 17309.2 17420.0 465825.0 468932.9 469300.0 470356.0 471450.0 58056.0 58381.4 58436.0 59045.4 59112.4 1262.7 1396.7 1413.2 1527.2 1631.0 30512.4 34372.3 34461.7 34604.5 34905.5 50822.2 52003.5 52257.5 52285.5 52414.7 405455.0 410728.0 414655.0 415002.0 415580.0 38865.1 43307.6 43353.8 45006.8 45628.5 49249.8 49430.8 49812.3 50237.0 51018.7 40843.6 41852.0 42310.6 42957.0 43400.0 39546.8 41456.6 42048.8 42154.2 42896.1 41945.2 42705.0 43470.0 43847.6 45596.5 35942.3 38802.0 38819.8 39159.8 39392.2 28315.9 28717.9 28895.6 28981.1 29022.0 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#2] jquery.html Cycles:180 Average:29107.48 Median:13189.67 stddev:82261.16 (623.7%) stddev-sans-first:82463.67 02:04:37 INFO - PROCESS | 12207 | Values: 393.5 395.7 397.9 402.5 418.7 12986.2 19121.9 19664.6 19697.8 20526.3 18778.7 19123.6 19391.6 19522.4 19609.3 5551.7 5650.7 5690.5 5691.8 5734.9 5593.5 5639.8 5665.7 5721.0 5723.1 4071.9 5946.3 6248.8 6249.8 6338.1 6188.8 6289.7 6311.8 6332.9 6356.6 5428.9 5557.5 5567.5 5581.4 5590.4 22487.7 22503.0 23177.3 23794.9 23860.9 2067.5 2238.2 2344.6 2518.5 2589.8 9526.2 9569.3 10032.2 10121.1 10198.7 1814.0 1867.4 1876.6 1880.3 1898.8 79707.6 80181.6 80882.2 81903.6 83166.6 10888.9 10922.6 10985.8 11107.4 11197.8 15331.0 15497.1 15518.1 15518.5 15529.1 8155.5 8318.1 8364.4 8367.5 8461.9 8054.8 8106.1 8243.6 8296.1 8359.3 4664.4 4712.3 4778.4 4781.5 4839.3 1894.8 1932.2 1957.9 1963.9 1967.6 421.4 422.8 432.6 959.6 1113.4 11242.3 11655.2 11763.2 17422.4 20639.5 1009.8 1015.3 1027.9 1040.6 1042.1 10487.2 11012.9 11067.6 11082.5 11142.1 490809.0 492749.0 502578.0 504984.0 506336.0 58787.7 80476.6 95271.5 96287.5 96766.5 1043.7 1043.7 1051.5 1067.5 1070.0 17110.3 17192.9 17353.7 17484.8 17612.6 41816.2 42086.4 43507.8 43773.3 44406.3 58839.4 59468.4 60277.4 61318.1 61462.4 8491.9 8621.1 8725.4 8825.3 9051.9 8638.7 11572.1 12756.7 13833.3 13864.9 12083.8 12210.5 12260.0 12303.3 12322.5 12114.5 12121.0 12131.5 12133.7 12255.9 12378.9 12435.9 12461.2 12649.1 12674.2 8583.4 8643.5 8734.9 8846.3 8919.6 11637.8 12121.2 12207.7 12216.9 12407.1 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#3] mootools.html Cycles:180 Average:5932.04 Median:4809.61 stddev:3424.64 (71.2%) stddev-sans-first:3416.69 02:04:37 INFO - PROCESS | 12207 | Values: 1318.4 1527.0 1555.5 1720.3 1838.4 8570.8 8927.9 8934.2 9195.7 9202.4 8913.2 9087.3 9099.7 9115.0 9131.5 2044.9 2355.2 2396.7 2423.1 2448.9 2454.8 2460.0 2461.1 2461.9 2465.4 2322.1 2334.1 2356.9 2358.4 2360.6 1987.1 2283.4 2338.5 2372.2 2374.3 2333.1 2350.2 2363.6 2368.9 2371.3 8993.3 9102.0 9109.6 9118.2 9128.2 5259.3 5388.7 5395.1 5403.2 5403.7 3531.1 3571.7 3580.3 3603.0 3645.0 1137.9 1166.8 1189.8 1211.3 2151.8 12265.8 12266.9 12285.3 12297.9 12553.4 4570.4 4665.9 4740.5 4740.9 4753.8 9764.6 9775.1 9780.3 9809.0 9816.2 5214.0 5216.8 5216.8 5217.1 5218.5 4372.5 4888.5 4991.4 5029.0 5121.0 3827.3 3932.4 3934.7 3989.5 4023.3 1180.7 1184.9 1193.9 1200.1 1205.2 840.9 865.4 878.3 902.1 979.6 5816.4 5848.6 6071.1 6078.5 6164.9 448.0 451.8 468.0 470.5 472.6 4011.7 4014.5 4022.3 4130.8 4199.0 11224.9 11459.3 11606.7 11617.2 11618.0 10807.8 11257.2 11464.9 11465.2 11471.8 8229.3 8504.7 8609.1 8640.3 8647.5 5987.5 5997.8 6139.8 6219.0 6295.7 10223.8 10458.4 10497.0 10664.8 10875.9 10805.6 10808.6 10913.2 10939.6 10943.6 7126.3 7744.3 7831.0 7992.1 8173.1 8862.2 8886.5 8931.1 8958.3 8966.4 7741.8 7947.6 7976.2 8019.8 8032.0 7873.8 7951.5 8015.2 8040.3 8093.1 7385.9 7387.1 7387.8 7484.6 7486.6 5145.7 5240.5 5258.6 5309.4 5364.9 4865.4 5030.6 5075.5 5144.3 5192.3 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#4] prototype.html Cycles:180 Average:4567.45 Median:5266.37 stddev:1352.77 (25.7%) stddev-sans-first:1318.36 02:04:37 INFO - PROCESS | 12207 | Values: 314.2 325.9 327.9 333.3 338.1 5178.6 5216.0 5219.6 5253.0 5289.4 5136.8 5211.8 5237.2 5238.7 5263.1 4059.2 4061.6 4063.7 4069.5 4079.9 3867.5 3913.6 4067.9 4070.1 4082.3 4003.7 4011.4 4019.3 4031.6 4032.6 3842.9 3981.9 4002.7 4004.4 4021.3 3434.1 3535.2 3544.1 3549.6 3550.4 5024.5 5033.1 5044.8 5047.2 5067.5 4590.6 4591.1 4596.9 4597.8 4605.3 5134.4 5352.5 5373.0 5390.3 5394.5 3810.3 3853.0 3854.3 3859.2 3863.2 5582.7 5684.8 5702.8 5706.9 5715.5 3852.0 3937.0 3941.7 3951.9 3953.9 3966.7 3997.8 4011.0 4014.6 4034.6 4592.9 4615.5 4615.8 4631.3 4638.1 5218.4 5483.1 5489.7 5496.9 5549.7 1369.5 1371.4 1375.1 1377.8 1382.6 857.9 881.2 882.8 891.5 893.1 4744.4 5111.3 5156.9 5299.5 5336.4 5569.0 5574.2 5592.3 5604.9 5608.4 5136.0 5274.5 5282.6 5320.9 5321.2 2930.1 2937.2 2939.5 2945.3 2963.5 5665.7 5671.1 5731.6 5750.4 5780.5 5449.3 5599.5 5650.2 5659.6 5661.2 5691.4 5726.5 5733.8 5739.1 5752.9 5558.3 5565.8 5607.6 5628.3 5639.7 5187.8 5504.5 5505.4 5507.9 5527.7 5775.2 5785.3 5793.9 5799.9 5812.7 3737.6 3999.9 4022.9 4023.8 4025.7 5531.6 5561.3 5569.7 5570.9 5596.8 5419.6 5427.4 5432.4 5453.2 5458.8 5269.6 5437.9 5452.2 5455.5 5459.9 5342.0 5359.0 5364.2 5367.4 5370.9 5290.4 5349.6 5453.3 5456.3 5476.3 5336.2 5348.5 5352.6 5353.3 5366.9 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - PROCESS | 12207 | [#5] yui.html Cycles:180 Average:15792.43 Median:4656.15 stddev:19141.19 (411.1%) stddev-sans-first:19161.72 02:04:37 INFO - PROCESS | 12207 | Values: 788.2 807.4 810.3 841.1 871.2 14105.8 14583.0 14689.0 14732.9 14795.8 13401.3 13447.5 13457.9 13467.9 13475.5 676.6 794.1 796.7 823.3 825.4 794.7 802.4 803.8 806.9 807.3 865.4 866.8 872.6 874.0 874.3 716.5 824.9 842.7 843.7 846.0 607.4 607.9 607.9 608.6 609.5 13663.7 13684.6 13692.9 13715.0 13726.3 12146.7 12739.7 12806.8 12885.9 13314.3 11774.8 11819.4 11866.3 11877.9 11946.6 4286.6 4290.4 4317.4 4369.5 4501.3 55423.4 56153.0 56743.0 57274.0 57524.7 10103.6 10224.4 10272.3 10676.4 10746.6 18767.7 20264.1 20303.6 20308.0 20332.9 8226.2 8301.4 8406.7 8413.5 8484.1 4653.6 4726.8 4789.2 4861.3 4983.7 3362.5 3434.4 3436.2 3440.2 3444.4 524.3 617.5 626.0 689.9 692.1 736.0 751.2 755.2 770.8 777.4 9867.6 10013.7 10016.9 10113.1 10203.0 649.4 714.8 753.4 767.5 786.9 4551.6 4658.7 4946.8 5039.0 5061.9 69465.0 69876.0 71240.0 72008.3 72077.0 60914.0 61174.4 61360.0 64236.0 67291.3 55302.0 55606.0 56155.0 56828.4 57262.0 9322.3 9384.6 9384.8 9415.7 9596.9 37372.8 37993.8 38007.4 38175.8 39179.6 46897.3 50108.7 50748.0 50774.0 50934.5 11943.5 12055.0 12059.2 12104.5 12259.5 13255.0 13359.3 13483.7 14122.2 14299.1 11798.6 12377.4 12676.2 12720.3 12746.9 11919.8 12100.8 12223.3 12256.4 12932.7 12478.9 12597.2 12740.4 12765.7 12864.4 10342.8 10504.2 10554.4 10572.0 11092.4 10809.9 10930.5 10985.8 11164.3 11182.9 02:04:37 INFO - PROCESS | 12207 | -------- Summary: end -------- 02:04:37 INFO - PROCESS | 12207 | 02:04:37 INFO - TEST-INFO | 12207: exit 0 02:04:37 INFO - TEST-OK | dromaeo_css | took 1112185ms 02:04:37 INFO - TEST-START | kraken 02:04:37 INFO - operating with platform_type : linux_ 02:04:37 INFO - Initialising browser for kraken test... 02:04:37 INFO - TEST-INFO | started process 12387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhdV_7/profile http://localhost:49261/getInfo.html) 02:04:41 INFO - PROCESS | 12387 | __metrics Screen width/height:1600/1200 02:04:41 INFO - PROCESS | 12387 | colorDepth:24 02:04:41 INFO - PROCESS | 12387 | Browser inner width/height: 1024/697 02:04:41 INFO - PROCESS | 12387 | __metrics 02:04:43 ERROR - PROCESS | 12387 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:04:43 INFO - TEST-INFO | 12387: exit 0 02:04:43 INFO - Browser initialized. 02:04:43 INFO - Running cycle 1/1 for kraken test... 02:04:43 INFO - TEST-INFO | started process 12469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLhdV_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:04:55 INFO - PROCESS | 12469 | RSS: Main: 153116672 02:04:55 INFO - PROCESS | 12469 | 02:04:58 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection) 02:04:59 INFO - PROCESS | 12469 | RSS: Main: 208510976 02:04:59 INFO - PROCESS | 12469 | 02:05:01 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-dft) 02:05:02 INFO - PROCESS | 12469 | RSS: Main: 196550656 02:05:02 INFO - PROCESS | 12469 | 02:05:05 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-fft) 02:05:06 INFO - PROCESS | 12469 | RSS: Main: 266002432 02:05:06 INFO - PROCESS | 12469 | 02:05:08 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator) 02:05:08 INFO - PROCESS | 12469 | RSS: Main: 175235072 02:05:08 INFO - PROCESS | 12469 | 02:05:11 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:11 INFO - PROCESS | 12469 | RSS: Main: 179167232 02:05:11 INFO - PROCESS | 12469 | 02:05:15 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:15 INFO - PROCESS | 12469 | RSS: Main: 215527424 02:05:15 INFO - PROCESS | 12469 | 02:05:19 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:19 INFO - PROCESS | 12469 | RSS: Main: 213393408 02:05:19 INFO - PROCESS | 12469 | 02:05:22 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial) 02:05:23 INFO - PROCESS | 12469 | RSS: Main: 213979136 02:05:23 INFO - PROCESS | 12469 | 02:05:25 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:25 INFO - PROCESS | 12469 | RSS: Main: 203468800 02:05:25 INFO - PROCESS | 12469 | 02:05:27 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:28 INFO - PROCESS | 12469 | RSS: Main: 207241216 02:05:28 INFO - PROCESS | 12469 | 02:05:30 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:30 INFO - PROCESS | 12469 | RSS: Main: 217858048 02:05:30 INFO - PROCESS | 12469 | 02:05:33 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:34 INFO - PROCESS | 12469 | RSS: Main: 223088640 02:05:34 INFO - PROCESS | 12469 | 02:05:37 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:37 INFO - PROCESS | 12469 | RSS: Main: 220065792 02:05:37 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49261/tests/kraken/driver.html?testName=ai-astar) 02:05:39 INFO - PROCESS | 12469 | RSS: Main: 265822208 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | __start_tp_report 02:05:39 INFO - PROCESS | 12469 | _x_x_mozilla_page_load 02:05:39 INFO - PROCESS | 12469 | _x_x_mozilla_page_load_details 02:05:39 INFO - PROCESS | 12469 | |i|pagename|runs| 02:05:39 INFO - PROCESS | 12469 | |0;ai-astar;109;105;112;110;110;109;108;110;109;108 02:05:39 INFO - PROCESS | 12469 | |1;audio-beat-detection;152;124;128;207;126;126;163;124;153;130 02:05:39 INFO - PROCESS | 12469 | |2;audio-dft;161;160;162;160;160;160;161;160;161;162 02:05:39 INFO - PROCESS | 12469 | |3;audio-fft;75;75;75;144;74;74;73;76;130;74 02:05:39 INFO - PROCESS | 12469 | |4;audio-oscillator;91;94;165;92;92;92;134;92;92;136 02:05:39 INFO - PROCESS | 12469 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;117 02:05:39 INFO - PROCESS | 12469 | |6;imaging-darkroom;146;146;147;147;146;146;147;146;146;146 02:05:39 INFO - PROCESS | 12469 | |7;imaging-desaturate;95;95;94;95;94;94;95;94;95;94 02:05:39 INFO - PROCESS | 12469 | |8;json-parse-financial;56;55;56;55;59;56;56;107;53;54 02:05:39 INFO - PROCESS | 12469 | |9;json-stringify-tinderbox;61;71;61;60;61;60;61;61;61;61 02:05:39 INFO - PROCESS | 12469 | |10;stanford-crypto-aes;78;78;78;83;85;81;80;79;84;80 02:05:39 INFO - PROCESS | 12469 | |11;stanford-crypto-ccm;123;121;129;127;119;128;120;115;191;122 02:05:39 INFO - PROCESS | 12469 | |12;stanford-crypto-pbkdf2;166;161;160;163;163;164;163;160;164;159 02:05:39 INFO - PROCESS | 12469 | |13;stanford-crypto-sha256-iterative;61;64;61;62;64;71;62;60;60;62 02:05:39 INFO - PROCESS | 12469 | __end_tp_report 02:05:39 INFO - PROCESS | 12469 | __start_cc_report 02:05:39 INFO - PROCESS | 12469 | _x_x_mozilla_cycle_collect,1869 02:05:39 INFO - PROCESS | 12469 | __end_cc_report 02:05:39 INFO - PROCESS | 12469 | __startTimestamp1464080739618__endTimestamp 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | ------- Summary: start ------- 02:05:39 INFO - PROCESS | 12469 | Number of tests: 14 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.83 (1.7%) stddev-sans-first:1.94 02:05:39 INFO - PROCESS | 12469 | Values: 109.0 105.0 112.0 110.0 110.0 109.0 108.0 110.0 109.0 108.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:141.00 stddev:26.60 (18.9%) stddev-sans-first:28.03 02:05:39 INFO - PROCESS | 12469 | Values: 152.0 124.0 128.0 207.0 126.0 126.0 163.0 124.0 153.0 130.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:05:39 INFO - PROCESS | 12469 | Values: 161.0 160.0 162.0 160.0 160.0 160.0 161.0 160.0 161.0 162.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#3] audio-fft Cycles:10 Average:87.00 Median:74.50 stddev:26.57 (35.7%) stddev-sans-first:27.83 02:05:39 INFO - PROCESS | 12469 | Values: 75.0 75.0 75.0 144.0 74.0 74.0 73.0 76.0 130.0 74.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.00 stddev:26.82 (29.2%) stddev-sans-first:27.73 02:05:39 INFO - PROCESS | 12469 | Values: 91.0 94.0 165.0 92.0 92.0 92.0 134.0 92.0 92.0 136.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:05:39 INFO - PROCESS | 12469 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:05:39 INFO - PROCESS | 12469 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:05:39 INFO - PROCESS | 12469 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:56.00 stddev:16.34 (29.2%) stddev-sans-first:17.25 02:05:39 INFO - PROCESS | 12469 | Values: 56.0 55.0 56.0 55.0 59.0 56.0 56.0 107.0 53.0 54.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:3.26 (5.3%) stddev-sans-first:3.44 02:05:39 INFO - PROCESS | 12469 | Values: 61.0 71.0 61.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:2.59 (3.2%) stddev-sans-first:2.57 02:05:39 INFO - PROCESS | 12469 | Values: 78.0 78.0 78.0 83.0 85.0 81.0 80.0 79.0 84.0 80.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:125.00 stddev:22.04 (17.6%) stddev-sans-first:23.25 02:05:39 INFO - PROCESS | 12469 | Values: 123.0 121.0 129.0 127.0 119.0 128.0 120.0 115.0 191.0 122.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:2.21 (1.4%) stddev-sans-first:1.90 02:05:39 INFO - PROCESS | 12469 | Values: 166.0 161.0 160.0 163.0 163.0 164.0 163.0 160.0 164.0 159.0 02:05:39 INFO - PROCESS | 12469 | 02:05:39 INFO - PROCESS | 12469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:3.23 (5.2%) stddev-sans-first:3.37 02:05:39 INFO - PROCESS | 12469 | Values: 61.0 64.0 61.0 62.0 64.0 71.0 62.0 60.0 60.0 62.0 02:05:39 INFO - PROCESS | 12469 | -------- Summary: end -------- 02:05:39 INFO - PROCESS | 12469 | 02:05:40 INFO - TEST-INFO | 12469: exit 0 02:05:40 INFO - TEST-OK | kraken | took 62757ms 02:05:40 INFO - SUITE-END | took 1174s 02:05:40 INFO - Completed test suite (00:19:35) 02:05:40 INFO - javascript benchmark 02:05:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.2824786175247, 3071.6621171671113, 3096.7522598192145, 3112.2686168750356, 3128.327409606934, 5216.191490318997, 5218.895622087561, 5259.526642602165, 5286.867828304295, 5300.840974770758, 5313.920291195635, 5324.76038578264, 5334.199870019499, 5373.892522149555, 5446.891062178754, 4590.862274131765, 4786.641001924852, 4969.925451118236, 4991.450940396553, 5006.499350065001, 4738.123447162286, 4924.28597853311, 4948.678335908173, 4949.381327334083, 4963.404391473028, 4827.106985207748, 4838.298446725223, 4873.488283730193, 4877.707337559722, 4901.828436004723, 4934.580560652349, 4936.432310284292, 4938.9012219755405, 4940.777665005084, 4949.950500494985, 4590.036092420596, 4730.0776348612035, 4773.76131193439, 4908.410990681141, 4962.429320628138, 5299.6025298102795, 5323.307969963918, 5325.467453254682, 5344.144936810092, 5359.517643412111, 5648.209250704905, 5658.85852853682, 5698.17376480408, 5699.572532060112, 5708.77164913403, 5470.617056806025, 5603.0, 5631.690257035862, 5674.574406919498, 5832.533397328203, 5332.653377530448, 5364.14173732201, 5366.4633536646415, 5369.114096174127, 5376.11294136467, 5905.320888097924, 5916.408359164049, 5919.082542205965, 5921.911171332434, 5922.911156332659, 5332.786688532493, 5445.264889239981, 5475.09660905954, 5508.6970216637665, 5596.916046259309, 5622.57830662702, 5677.2619559457835, 5678.261825962599, 5681.289838770153, 5685.260916080883, 5482.972585137049, 5598.720063996784, 5604.327480702342, 5617.578681598897, 5617.9438205618235, 5633.492985631231, 5664.971675141598, 5672.978863804472, 5721.485066344049, 5730.942690573124, 4355.237833379146, 4358.5205627380965, 4359.324304732771, 4363.083752411965, 4398.824047038082, 3721.0, 3884.4950156479476, 3884.5726970033274, 3898.181381909774, 3919.666828319625, 5509.146082357241, 5521.420250873681, 5535.446455354432, 5542.085555883315, 5586.944130558723, 5831.183634291203, 5843.561732870052, 5845.853853653608, 5888.116782482662, 5902.2032025676845, 5092.439831618519, 5419.891602167934, 5447.1829225616475, 5509.090999984957, 5531.889362212733, 4902.240152776325, 4923.75381230937, 4927.975360123177, 4943.357363542788, 4958.876028099255, 5973.402659734079, 5981.282246130405, 5983.401659833982, 5986.610870293504, 6017.578769486182, 5581.581381396492, 5608.943910560843, 5628.240187574625, 5649.406812284651, 5764.337101233412, 5826.184334193301, 5841.883162336644, 5847.152162936265, 5850.853728656647, 5852.882942341044, 5566.77732890696, 5568.721563921868, 5569.359523654832, 5570.721463926869, 5582.441755824385, 5559.749811258423, 5647.0, 5666.518345940642, 5691.8292451226525, 5728.3985181557, 5572.86067848307, 5579.46995035471, 5588.552915766811, 5590.0496915523645, 5595.440455954372, 5391.245225668331, 5530.778768849201, 5568.136938774496, 5581.358143813513, 5615.045442274742, 5395.217693434509, 5436.836894893159, 5443.646162999551, 5510.834674959758, 5522.282103326542, 5591.580631452576, 5616.7191640416995, 5624.634398764068, 5654.7455364509515, 5665.575081868794, 5400.054990376747, 5453.481919217668, 5518.172274158747, 5519.558435325244, 5547.944520554743], "value": 5256.462456940902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.399286738226, 621.7109044294402, 633.9080833279174, 638.0110828216264, 644.326678620841, 43514.12971740563, 44676.77661611691, 44951.55048449514, 45048.0, 48315.758421207844, 45021.04768475465, 45337.31994020084, 45395.546044539544, 45450.7727461363, 45456.318155227695, 8796.472211667304, 8968.282537396992, 8975.820483590323, 8980.32647551433, 8983.550822458883, 8811.559422028906, 8821.16198961101, 8863.911360886374, 8883.244924181452, 8890.288776897865, 8887.066857979917, 8912.465252084863, 8964.775880603005, 8994.280457563413, 9000.27997760181, 8878.556072196365, 8934.10658934108, 8956.059613740561, 8958.776030599221, 8959.37284390093, 8715.912840871573, 8793.7801554961, 8810.515421651806, 8818.206361427438, 8819.955900220459, 42164.57835421637, 42508.36237456441, 42513.0, 42662.78668606668, 42668.14663706708, 3578.4274516077303, 3581.4269716845442, 3621.963780362189, 3819.656230939201, 4044.474218351625, 32010.839945800355, 32386.35227295441, 32698.0, 32749.836250818593, 34063.0, 4338.522762496123, 4425.424694789689, 4501.527339629324, 4535.818567257305, 4547.136044151601, 316006.41996790096, 318835.0, 320886.0, 320978.0, 321425.0, 57759.71120144457, 57783.711081445166, 57991.420085799444, 58137.41862581405, 58164.70917645385, 60899.0, 60983.39016609777, 61000.0, 61126.0, 61147.0, 16659.75010374821, 16843.0, 16865.988040717595, 16868.072256025793, 16882.915585421993, 13221.405036773369, 13248.40382182804, 13289.66775830612, 13292.136011159244, 13295.80056299137, 14050.648733781532, 16442.671146577002, 16448.177591120395, 16601.91699041497, 16619.83380166207, 6216.5391133083685, 6230.7507699691505, 6269.592476489013, 6404.199475065617, 6493.967530162319, 998.9450580218157, 1054.926155169146, 1094.7700982793542, 1136.8976792088752, 1172.3610632205468, 32239.194020149684, 32772.0, 32885.17787055295, 33203.50194747081, 33442.10274218623, 1113.5768408005067, 1131.9773604527863, 1150.5110328110686, 1155.5204590095184, 1161.0189389965465, 17049.48851534456, 17113.401030963858, 17175.914120429567, 17309.221085051202, 17420.0, 465825.0, 468932.93201204017, 469300.0, 470356.0, 471450.0, 58056.0, 58381.372838221534, 58436.0, 59045.40954590485, 59112.40887591155, 1262.6906407929932, 1396.7136736968896, 1413.2297897645808, 1527.1905889878383, 1630.9592260193353, 30512.389752204388, 34372.312553748285, 34461.65538344585, 34604.480932785526, 34905.47641785426, 50822.237666434296, 52003.479965201375, 52257.47742522526, 52285.47714522806, 52414.737926310125, 405455.0, 410728.0, 414655.0, 415002.0, 415580.0, 38865.05674716309, 43307.56692433036, 43353.783231084904, 45006.77496612496, 45628.543714563755, 49249.753751231015, 49430.75284623554, 49812.25281620851, 50237.0, 51018.74490627523, 40843.59156408398, 41852.0, 42310.57689423066, 42957.0, 43400.0, 39546.80226598849, 41456.58543414648, 42048.789756051025, 42154.156916862106, 42896.142077158904, 41945.1610967785, 42705.0, 43470.0, 43847.56152438435, 45596.54403456056, 35942.28115437729, 38802.0, 38819.805900970314, 39159.80420097881, 39392.2121557573, 28315.858420707766, 28717.856410717814, 28895.56656650194, 28981.13056608305, 29022.0], "value": 20468.54012272045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.5120450641204, 395.7032225830627, 397.9442877997081, 402.4988888833402, 418.6692512914797, 12986.218610756929, 19121.904390478045, 19664.606707865853, 19697.803021969776, 20526.2815801447, 18778.718319225223, 19123.61752764944, 19391.612167756637, 19522.414327570197, 19609.313674021378, 5551.7224138793, 5650.6892120933335, 5690.5447564194765, 5691.8292451226325, 5734.913976290359, 5593.524550413199, 5639.802606908759, 5665.716714164296, 5721.027425337703, 5723.141528770676, 4071.9185616287805, 5946.345901950782, 6248.812535623939, 6249.812505624838, 6338.144350512668, 6188.783392581238, 6289.685515724218, 6311.810645680637, 6332.936670633281, 6356.555041147121, 5428.945710542923, 5557.499825015728, 5567.526760225385, 5581.413951535071, 5590.440955904418, 22487.66268505974, 22503.0, 23177.304680859434, 23794.88102559476, 23860.880695596585, 2067.472794437409, 2238.2278114050628, 2344.6483027545833, 2518.458531415736, 2589.805764567665, 9526.190273826733, 9569.33014688972, 10032.247581431422, 10121.139703125244, 10198.745031374201, 1813.9909300453414, 1867.3930972434014, 1876.6340563590106, 1880.2948894164688, 1898.8101189880902, 79707.60146199232, 80181.59909200475, 80882.19117808864, 81903.5904820478, 83166.58416707939, 10888.891111088946, 10922.60865226283, 10985.780284394268, 11107.444627768578, 11197.776044479066, 15331.0, 15497.14765687898, 15518.068915865084, 15518.456854010055, 15529.068255904456, 8155.469894456842, 8318.12659670738, 8364.37267204962, 8367.456115352483, 8461.915380846112, 8054.758357249292, 8106.108328083906, 8243.587820608946, 8296.142293833396, 8359.331253499706, 4664.39362882823, 4712.340272361872, 4778.402699662543, 4781.52184781526, 4839.322494850724, 1894.7915729269769, 1932.1884808380514, 1957.9216831326871, 1963.891985940787, 1967.567135230247, 421.3700517726019, 422.82452782095083, 432.62145622580243, 959.6161535385902, 1113.432149603708, 11242.269252498561, 11655.242409243372, 11763.176577639655, 17422.390216342366, 20639.484012899797, 1009.7677534167036, 1015.3197357770312, 1027.8817935937313, 1040.5681642118436, 1042.124615323117, 10487.213458990605, 11012.944935275273, 11067.557297708163, 11082.501287442085, 11142.108631309477, 490809.0, 492749.0, 502578.0, 504984.0, 506336.0, 58787.70606146942, 80476.59761701271, 95271.52364238273, 96287.51856240814, 96766.51616741871, 1043.6868939318326, 1043.7390652336917, 1051.4690081508636, 1067.4716015572187, 1069.9625513107003, 17110.315587376863, 17192.91403542974, 17353.652926941642, 17484.82515174832, 17612.559686007953, 41816.163676725686, 42086.36870447007, 43507.78246108749, 43773.34339984839, 44406.3339049921, 58839.41160588511, 59468.405315946286, 60277.39722602718, 61318.080228797495, 61462.38537614566, 8491.915080849112, 8621.094785047731, 8725.389222754346, 8825.293976481738, 9051.90948090537, 8638.740837774876, 11572.074234061087, 12756.681082973, 13833.30833458303, 13864.930675346559, 12083.818742718691, 12210.450529726362, 12260.0, 12303.261804291771, 12322.50709971627, 12114.454849531969, 12121.0, 12131.53910345149, 12133.69665758363, 12255.87744122583, 12378.876211237772, 12435.93782031084, 12461.179931328908, 12649.051321150766, 12674.176178548365, 8583.399162058597, 8643.481391116553, 8734.91265087341, 8846.292296616126, 8919.55402229873, 11637.825432618687, 12121.212121212093, 12207.694807629525, 12216.938915305367, 12407.069469789982], "value": 9132.479322997897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.386950068218, 1527.0074451606458, 1555.4789145636212, 1720.2516905146263, 1838.4117082533594, 8570.828583428327, 8927.866082008775, 8934.195922366995, 9195.67815126469, 9202.40184388016, 8913.242374398167, 9087.31845111616, 9099.727008189748, 9115.0, 9131.543422828849, 2044.8568600197991, 2355.211004313557, 2396.688430504032, 2423.0550085466684, 2448.926532204037, 2454.7790698837102, 2459.950800983979, 2461.10169788027, 2461.852288862674, 2465.3959779853963, 2322.105989194164, 2334.054707843318, 2356.858588484688, 2358.351453350334, 2360.5986982213067, 1987.1157334985937, 2283.3834864586634, 2338.53229354129, 2372.240882917467, 2374.3233178544033, 2333.1134169015663, 2350.15394457995, 2363.61000434928, 2368.9170879019325, 2371.3004663624274, 8993.325500587482, 9102.0, 9109.635614575409, 9118.224950879183, 9128.178463938211, 5259.342582177228, 5388.7305634718105, 5395.082835917903, 5403.162509810985, 5403.729813509309, 3531.0819187011307, 3571.732120090978, 3580.2839432113683, 3603.0, 3645.0, 1137.8975892169744, 1166.7958107331267, 1189.8393716848202, 1211.3277131192185, 2151.7740637233023, 12265.816012759815, 12266.877331226662, 12285.324307163102, 12297.93851030748, 12553.435095420637, 4570.428696412949, 4665.883352916137, 4740.525947405301, 4740.928886066712, 4753.786079626425, 9764.560594773253, 9775.071368220008, 9780.315377923476, 9808.950955245178, 9816.165625921734, 5213.983273261678, 5216.791328346823, 5216.817411390583, 5217.0870097733505, 5218.478152184827, 4372.497162826252, 4888.486708895586, 4991.376077990251, 5029.044481548494, 5121.027004869063, 3827.2536855312946, 3932.446683559978, 3934.724569280123, 3989.4614227078973, 4023.275810354106, 1180.651707746217, 1184.8874356936078, 1193.9223950443193, 1200.111917181297, 1205.180477275461, 840.8570543007703, 865.3812524045212, 878.2973621103092, 902.1114202510522, 979.6424305128577, 5816.418358164235, 5848.561357898175, 6071.089336599457, 6078.544109191828, 6164.938350616526, 447.9977600112044, 451.8034654925118, 467.97894094765815, 470.47541990680827, 472.57704354602436, 4011.6991225658194, 4014.458048163519, 4022.2960981828064, 4130.793460326971, 4198.958010419857, 11224.887751122384, 11459.31244125355, 11606.651800446, 11617.186796924303, 11618.0, 10807.78384432307, 11257.21199516026, 11464.885351146548, 11465.197436179555, 11471.827922581168, 8229.300509456643, 8504.702335418355, 8609.053004169537, 8640.265577425864, 8647.481151130953, 5987.473194335416, 5997.790077347447, 6139.754409823557, 6219.036049412348, 6295.748170073146, 10223.846642300223, 10458.372497650165, 10497.0, 10664.786704265716, 10875.945620271848, 10805.621803236849, 10808.567657293936, 10913.23607347478, 10939.56241750321, 10943.562257509611, 7126.251743567058, 7744.341730952707, 7831.0, 7992.120866704774, 8173.060098088796, 8862.158094980967, 8886.4668119913, 8931.062238465127, 8958.328125390752, 8966.417182883091, 7741.806454838674, 7947.602619868868, 7976.162502937108, 8019.759407217793, 8032.0, 7873.842523149619, 7951.522908625501, 8015.198480151938, 8040.276375126266, 8093.0692970309165, 7385.889211661937, 7387.1135463744695, 7387.7783666490095, 7484.550926944401, 7486.5508069516, 5145.665531740425, 5240.502152295679, 5258.631895767259, 5309.415964243853, 5364.919526207032, 4865.440474345354, 5030.597552195889, 5075.5178258065425, 5144.254083157996, 5192.324997750268], "value": 4647.3464208419755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2207325831935, 325.86639477814094, 327.94728920166267, 333.29175502058126, 338.12257192585247, 5178.585713142949, 5216.035033518801, 5219.634625576211, 5252.973735131323, 5289.444608316129, 5136.845894623168, 5211.817586384477, 5237.193168356911, 5238.738063096849, 5263.131583288753, 4059.2287465381555, 4061.6344528992386, 4063.7358571692744, 4069.450624165744, 4079.938800917989, 3867.5165604299464, 3913.5890731473214, 4067.9186416271655, 4070.124923141524, 4082.326416141333, 4003.65968892643, 4011.438398624195, 4019.256437559061, 4031.57668444812, 4032.6370626643597, 3842.9231415371814, 3981.920361592781, 4002.699797515169, 4004.438269075063, 4021.3163762160502, 3434.0899661589697, 3535.2045789697368, 3544.113971507123, 3549.574051113857, 3550.378683730363, 5024.472430394792, 5033.119204139298, 5044.772985215674, 5047.217681259411, 5067.479756073163, 4590.60979816716, 4591.104734576759, 4596.931046034312, 4597.816037382217, 4605.286180642006, 5134.409542902539, 5352.545033672142, 5372.979133964534, 5390.326209223847, 5394.541463975567, 3810.2950954073585, 3852.9614703853163, 3854.3447613905705, 3859.1895701902354, 3863.2466668999555, 5582.699918650084, 5684.8010319638615, 5702.8289151325525, 5706.857328566777, 5715.485606295411, 3851.9614803851605, 3936.980315098406, 3941.704372172041, 3951.9012024699614, 3953.8616148434667, 3966.7421617594764, 3997.780122093313, 4011.0, 4014.578469260744, 4034.616711412411, 4592.897704550884, 4615.538446155425, 4615.838445654386, 4631.305304204397, 4638.1187574360765, 5218.373795144607, 5483.122700367922, 5489.725513724377, 5496.890062198813, 5549.694766787785, 1369.472752990086, 1371.430856194688, 1375.0924389902616, 1377.8415482219473, 1382.5783136143573, 857.9442336248123, 881.1849039638437, 882.8013696918142, 891.4562117108559, 893.1381217125505, 4744.4069491313585, 5111.309973153651, 5156.948430515722, 5299.49654782795, 5336.439673834269, 5568.99758043548, 5574.247476590608, 5592.2730045094695, 5604.915926261109, 5608.4111168326735, 5135.974320128375, 5274.525292723597, 5282.6302158849285, 5320.946790532045, 5321.2018197269945, 2930.1356099950567, 2937.162908571047, 2939.4855900217376, 2945.3078526546246, 2963.5406511990677, 5665.66006039639, 5671.071835575924, 5731.5701322400155, 5750.424957504216, 5780.450857168562, 5449.264349312872, 5599.544118529212, 5650.208970744099, 5659.603827732019, 5661.1508273758445, 5691.373948865621, 5726.4517289805635, 5733.770649173986, 5739.139129130664, 5752.913706294409, 5558.333000040021, 5565.805196818092, 5607.635503692247, 5628.296462942132, 5639.7180140993605, 5187.766550505312, 5504.504594586347, 5505.394406615349, 5507.889842203053, 5527.673358394037, 5775.249217601685, 5785.305763308262, 5793.884122317614, 5799.94200057994, 5812.73842677089, 3737.6449237322413, 3999.9400008999305, 4022.8994275143355, 4023.818928148182, 4025.6578190854107, 5531.640443371168, 5561.277033985556, 5569.66582005081, 5570.888582228414, 5596.776128954796, 5419.593530485308, 5427.375851776938, 5432.402435731988, 5453.2365468833605, 5458.8263523342675, 5269.604779641466, 5437.891242175214, 5452.236686863763, 5455.454454554513, 5459.890802184013, 5342.0, 5358.97320513395, 5364.168553874156, 5367.42363665435, 5370.919436208538, 5290.391604965324, 5349.625526213128, 5453.291072160594, 5456.2906822114455, 5476.2607048049595, 5336.17289320156, 5348.545373643128, 5352.625316227826, 5353.304070470814, 5366.946330536644], "value": 4133.833029863449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.2078511096349, 807.3581502705349, 810.3193317613204, 841.0748177005291, 871.1636828644502, 14105.788413173797, 14583.0, 14689.0, 14732.926335368335, 14795.778063329059, 13401.262930538816, 13447.529336473226, 13457.865421345783, 13467.865321346784, 13475.528356507524, 676.6379986707088, 794.1066300412036, 796.7291121018852, 823.3495538524559, 825.4428260923883, 794.6543253684637, 802.3821657323857, 803.7829785957788, 806.9475484093545, 807.2573232625969, 865.4028720183054, 866.8396346675854, 872.6029656506274, 874.0, 874.3442418186361, 716.451914285572, 824.8721448175543, 842.692417267699, 843.7257891185359, 845.9788505287418, 607.380471918645, 607.8632307730769, 607.872346807171, 608.6317777744445, 609.4667166229549, 13663.726725465534, 13684.589462316146, 13692.931535342259, 13715.0, 13726.313684315845, 12146.696332591757, 12739.745205095938, 12806.80789788154, 12885.935570322183, 13314.267715275655, 11774.764504709943, 11819.409029548488, 11866.347350895698, 11877.881221187765, 11946.581869634609, 4286.61587926314, 4290.356446533014, 4317.395564620955, 4369.4756629204385, 4501.324801279801, 55423.44576554264, 56153.0, 56743.0, 57274.0, 57524.71237643827, 10103.646372376932, 10224.386536807815, 10272.33229840073, 10676.3965178766, 10746.623868164577, 18767.718484222747, 20264.088116034814, 20303.593928121354, 20308.0, 20332.898335508227, 8226.177382261725, 8301.377396695272, 8406.747797566082, 8413.495190288602, 8484.109168537214, 4653.557911998355, 4726.834560790356, 4789.185838407479, 4861.27080937855, 4983.6760610560195, 3362.4620060790157, 3434.433318502469, 3436.1581412554083, 3440.1571614954496, 3444.362792883325, 524.3445692883895, 617.4813156948185, 625.968701564929, 689.9448044156455, 692.0656416792763, 735.9595222262827, 751.2299892610118, 755.1693137548652, 770.8111512679317, 777.4441274488768, 9867.555959981819, 10013.749656258506, 10016.899831001743, 10113.089821916063, 10203.0, 649.4382359259207, 714.8427345983876, 753.4123383760675, 767.4551068741256, 786.9134395216636, 4551.613112885376, 4658.743769092733, 4946.777395017233, 5039.034776437193, 5061.873453163626, 69465.0, 69876.0, 71240.0, 72008.2799172012, 72077.0, 60914.0, 61174.38825611687, 61360.0, 64236.0, 67291.3270867285, 55302.0, 55606.0, 56155.0, 56828.43171568314, 57262.0, 9322.34596283793, 9384.577694003923, 9384.76538086526, 9415.670451534163, 9596.856047159159, 37372.813135935234, 37993.810030949666, 38007.429888552244, 38175.80912095422, 39179.608203917596, 46897.29654055124, 50108.74945625394, 50748.0, 50774.0, 50934.49065509297, 11943.462544185706, 12055.0, 12059.236967669212, 12104.45529951172, 12259.509619615115, 13255.0, 13359.332033398485, 13483.73032539324, 14122.223277719824, 14299.142051476945, 11798.646040618794, 12377.443015064164, 12676.23942563449, 12720.300383478627, 12746.936265318614, 11919.76160476803, 12100.757984840078, 12223.327716975651, 12256.38718064111, 12932.676683082622, 12478.875211248134, 12597.181183223061, 12740.43867408267, 12765.74468510606, 12864.421101050288, 10342.844857326996, 10504.212184086071, 10554.366737995744, 10572.0, 11092.445377730919, 10809.891901081202, 10930.45347732626, 10985.83521247166, 11164.274322169033, 11182.944085279521], "value": 6933.026228464077, "unit": "score"}], "name": "dromaeo_css", "value": 7125.512915519116, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 112.0, 110.0, 110.0, 109.0, 108.0, 110.0, 109.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 128.0, 207.0, 126.0, 126.0, 163.0, 124.0, 153.0, 130.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 144.0, 74.0, 74.0, 73.0, 76.0, 130.0, 74.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 165.0, 92.0, 92.0, 92.0, 134.0, 92.0, 92.0, 136.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 59.0, 56.0, 56.0, 107.0, 53.0, 54.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 71.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 83.0, 85.0, 81.0, 80.0, 79.0, 84.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 129.0, 127.0, 119.0, 128.0, 120.0, 115.0, 191.0, 122.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 160.0, 163.0, 163.0, 164.0, 163.0, 160.0, 164.0, 159.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 61.0, 62.0, 64.0, 71.0, 62.0, 60.0, 60.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1523.1, "alertThreshold": 2.0}]} 02:05:40 INFO - Return code: 0 02:05:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:05:40 ERROR - # TBPL SUCCESS # 02:05:40 INFO - Running post-action listener: _resource_record_post_action 02:05:40 INFO - ##### 02:05:40 INFO - ##### Finished run-tests step (success) 02:05:40 INFO - ##### 02:05:40 INFO - Running post-run listener: _resource_record_post_run 02:05:41 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 489033728; Read time: 16; Write time: 609644 02:05:41 INFO - TinderboxPrint: CPU usage
13.1% 02:05:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:05:41 INFO - TinderboxPrint: I/O write bytes / time
489,033,728 / 609,644 02:05:41 INFO - TinderboxPrint: CPU idle
8,271.5 (86.9%) 02:05:41 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 02:05:41 INFO - TinderboxPrint: Swap in / out
0 / 0 02:05:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 198836224; Read time: 0; Write time: 312252 02:05:41 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283000832; Read time: 16; Write time: 285476 02:05:41 INFO - Running post-run listener: _upload_blobber_files 02:05:41 INFO - Blob upload gear active. 02:05:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:05:41 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:41 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:41 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:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:46 INFO - (blobuploader) - INFO - Done attempting. 02:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:46 INFO - (blobuploader) - INFO - Done attempting. 02:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:47 INFO - (blobuploader) - INFO - Done attempting. 02:05:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:05:47 INFO - Return code: 0 02:05:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:05:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:05:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce4eacd480766a362c753573db34e9dc19618cc000bf86d85b6aeaddd0ff889e688d03b670d7198c067bb6d59264b3ffc31712181a77dcd72e8cb3270690f836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd6b501e0bb5d3ca36c91fde3cda5d1caac15acb59ea0458a4aca23a383e39f75f9039916d73864b84180a5ed47a3abce862149f7ef6c5521fdaf07912e088d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab0474e29280abf74258bbf694e542b39cc1824fa787d3a14a1cdb5c331bed2162e675bbbb97ed26af291ca1c57ddd203dfed78c563f0775f553a0902d6568d"} 02:05:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:05:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:05:47 INFO - Contents: 02:05:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce4eacd480766a362c753573db34e9dc19618cc000bf86d85b6aeaddd0ff889e688d03b670d7198c067bb6d59264b3ffc31712181a77dcd72e8cb3270690f836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd6b501e0bb5d3ca36c91fde3cda5d1caac15acb59ea0458a4aca23a383e39f75f9039916d73864b84180a5ed47a3abce862149f7ef6c5521fdaf07912e088d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab0474e29280abf74258bbf694e542b39cc1824fa787d3a14a1cdb5c331bed2162e675bbbb97ed26af291ca1c57ddd203dfed78c563f0775f553a0902d6568d"} 02:05:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:05:47 INFO - Copying logs to upload dir... 02:05:47 INFO - mkdir: /builds/slave/test/build/upload/logs 02:05:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.002661 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-24 02:05:47.622198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:47.625860) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 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/ce4eacd480766a362c753573db34e9dc19618cc000bf86d85b6aeaddd0ff889e688d03b670d7198c067bb6d59264b3ffc31712181a77dcd72e8cb3270690f836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd6b501e0bb5d3ca36c91fde3cda5d1caac15acb59ea0458a4aca23a383e39f75f9039916d73864b84180a5ed47a3abce862149f7ef6c5521fdaf07912e088d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab0474e29280abf74258bbf694e542b39cc1824fa787d3a14a1cdb5c331bed2162e675bbbb97ed26af291ca1c57ddd203dfed78c563f0775f553a0902d6568d"} 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.011383 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/ce4eacd480766a362c753573db34e9dc19618cc000bf86d85b6aeaddd0ff889e688d03b670d7198c067bb6d59264b3ffc31712181a77dcd72e8cb3270690f836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd6b501e0bb5d3ca36c91fde3cda5d1caac15acb59ea0458a4aca23a383e39f75f9039916d73864b84180a5ed47a3abce862149f7ef6c5521fdaf07912e088d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab0474e29280abf74258bbf694e542b39cc1824fa787d3a14a1cdb5c331bed2162e675bbbb97ed26af291ca1c57ddd203dfed78c563f0775f553a0902d6568d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:47.651298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:47.651794) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464079507.583880-1306700994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:05:47.736627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:05:47.737265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:05:47.737709) ========= ========= Total master_lag: 0.94 =========