builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1469604504.42 results: success (0) buildid: 20160726231512 builduid: 0a10349439994204842790f69a1ef3fb revision: 78dd94ba93c77d0bba45f8e4525947629a305a41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.420608) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.421344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.421817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.438649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.439154) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 00:28:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-07-27 00:28:24 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.554900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.555267) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:24.606276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 00:28:24.606677) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78dd94ba93c77d0bba45f8e4525947629a305a41 --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 78dd94ba93c77d0bba45f8e4525947629a305a41 --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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 00:28:24,892 truncating revision to first 12 chars 2016-07-27 00:28:24,893 Setting DEBUG logging. 2016-07-27 00:28:24,893 attempt 1/10 2016-07-27 00:28:24,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78dd94ba93c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 00:28:26,156 unpacking tar archive at: mozilla-central-78dd94ba93c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 00:28:26.226526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:26.226971) ========= script_repo_revision: 78dd94ba93c77d0bba45f8e4525947629a305a41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:26.227502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:26.227864) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 00:28:26.239302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-27 00:28:26.239804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:28:26 INFO - MultiFileLogger online at 20160727 00:28:26 in /builds/slave/test 00:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:28:26 INFO - {'append_to_log': False, 00:28:26 INFO - 'base_work_dir': '/builds/slave/test', 00:28:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:28:26 INFO - 'branch': 'Firefox-Non-PGO', 00:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:28:26 INFO - 'config_files': ('talos/linux_config.py',), 00:28:26 INFO - 'default_actions': ('clobber', 00:28:26 INFO - 'read-buildbot-config', 00:28:26 INFO - 'download-and-extract', 00:28:26 INFO - 'populate-webroot', 00:28:26 INFO - 'create-virtualenv', 00:28:26 INFO - 'install', 00:28:26 INFO - 'run-tests'), 00:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:28:26 INFO - 'download_minidump_stackwalk': True, 00:28:26 INFO - 'download_symbols': 'ondemand', 00:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:28:26 INFO - 'installer_path': 'installer.exe', 00:28:26 INFO - 'log_level': 'info', 00:28:26 INFO - 'log_name': 'talos', 00:28:26 INFO - 'log_to_console': True, 00:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:28:26 INFO - 'opt_config_files': (), 00:28:26 INFO - 'pip_index': False, 00:28:26 INFO - 'sps_profile': False, 00:28:26 INFO - 'sps_profile_interval': 0, 00:28:26 INFO - 'suite': 'dromaeojs', 00:28:26 INFO - 'system_bits': '32', 00:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:28:26 INFO - 'title': 'talos-linux64-ix-040', 00:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:28:26 INFO - 'use_talos_json': True, 00:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:28:26 INFO - 'work_dir': 'build'} 00:28:26 INFO - [mozharness: 2016-07-27 07:28:26.623096Z] Running clobber step. 00:28:26 INFO - Running pre-action listener: _resource_record_pre_action 00:28:26 INFO - Running main action method: clobber 00:28:26 INFO - rmtree: /builds/slave/test/build 00:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:28:27 INFO - Running post-action listener: _resource_record_post_action 00:28:27 INFO - [mozharness: 2016-07-27 07:28:27.098861Z] Finished clobber step (success) 00:28:27 INFO - [mozharness: 2016-07-27 07:28:27.098965Z] Running read-buildbot-config step. 00:28:27 INFO - Running pre-action listener: _resource_record_pre_action 00:28:27 INFO - Running main action method: read_buildbot_config 00:28:27 INFO - Using buildbot properties: 00:28:27 INFO - { 00:28:27 INFO - "project": "", 00:28:27 INFO - "product": "firefox", 00:28:27 INFO - "script_repo_revision": "production", 00:28:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:28:27 INFO - "repository": "", 00:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 00:28:27 INFO - "buildid": "20160726231512", 00:28:27 INFO - "pgo_build": "False", 00:28:27 INFO - "basedir": "/builds/slave/test", 00:28:27 INFO - "buildnumber": 163, 00:28:27 INFO - "slavename": "talos-linux64-ix-040", 00:28:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:28:27 INFO - "platform": "ubuntu64_hw", 00:28:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 00:28:27 INFO - "branch": "mozilla-central", 00:28:27 INFO - "repo_path": "mozilla-central", 00:28:27 INFO - "revision": "78dd94ba93c77d0bba45f8e4525947629a305a41", 00:28:27 INFO - "stage_platform": "linux64", 00:28:27 INFO - "builduid": "0a10349439994204842790f69a1ef3fb", 00:28:27 INFO - "slavebuilddir": "test" 00:28:27 INFO - } 00:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:28:27 INFO - Running post-action listener: _resource_record_post_action 00:28:27 INFO - [mozharness: 2016-07-27 07:28:27.101760Z] Finished read-buildbot-config step (success) 00:28:27 INFO - [mozharness: 2016-07-27 07:28:27.101851Z] Running download-and-extract step. 00:28:27 INFO - Running pre-action listener: _resource_record_pre_action 00:28:27 INFO - Running main action method: download_and_extract 00:28:27 INFO - mkdir: /builds/slave/test/build/tests 00:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:27 INFO - https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:28:27 INFO - Downloaded 1361 bytes. 00:28:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:28:27 INFO - Using the following test package requirements: 00:28:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:28:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:28:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:28:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'jsshell-linux-x86_64.zip'], 00:28:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:28:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:28:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:28:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:28:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:28:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:28:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:27 INFO - https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:28:28 INFO - Downloaded 22744272 bytes. 00:28:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:28:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:28:29 INFO - Return code: 0 00:28:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:29 INFO - https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:28:30 INFO - Downloaded 22744272 bytes. 00:28:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:28:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:28:32 INFO - Return code: 0 00:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:32 INFO - https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:28:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:28:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:28:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:28:33 INFO - Downloaded 14413725 bytes. 00:28:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:28:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:28:33 INFO - Return code: 0 00:28:33 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')]} 00:28:33 INFO - https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:28:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:28:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:28:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:28:39 INFO - Downloaded 57170912 bytes. 00:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:28:39 INFO - mkdir: /builds/slave/test/properties 00:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 00:28:39 INFO - Contents: 00:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:28:40 INFO - Running post-action listener: _resource_record_post_action 00:28:40 INFO - Running post-action listener: set_extra_try_arguments 00:28:40 INFO - [mozharness: 2016-07-27 07:28:40.002389Z] Finished download-and-extract step (success) 00:28:40 INFO - [mozharness: 2016-07-27 07:28:40.002623Z] Running populate-webroot step. 00:28:40 INFO - Running pre-action listener: _resource_record_pre_action 00:28:40 INFO - Running main action method: populate_webroot 00:28:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:28:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:28:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:28:40 INFO - '--tppagecycles', 00:28:40 INFO - '7'], 00:28:40 INFO - 'tests': ['tsvgm']}}, 00:28:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:28:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:28:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:28:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:28:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:28:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:28:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['damp', 'tps']}, 00:28:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'tests': ['damp', 'tps']}, 00:28:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['dromaeo_dom']}, 00:28:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:28:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['basic_compositor_video']}, 00:28:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:28:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'other-e10s': {'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['a11yr', 00:28:40 INFO - 'ts_paint', 00:28:40 INFO - 'tpaint', 00:28:40 INFO - 'sessionrestore', 00:28:40 INFO - 'sessionrestore_no_auto_restore', 00:28:40 INFO - 'tabpaint']}, 00:28:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['tsvgx', 00:28:40 INFO - 'tsvgr_opacity', 00:28:40 INFO - 'tart', 00:28:40 INFO - 'tscrollx', 00:28:40 INFO - 'cart']}, 00:28:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:28:40 INFO - 'tsvgr_opacity', 00:28:40 INFO - 'tart', 00:28:40 INFO - 'tscrollx', 00:28:40 INFO - 'cart']}, 00:28:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'talos_options': ['--disable-e10s'], 00:28:40 INFO - 'tests': ['tp5o']}, 00:28:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'tests': ['tp5o']}, 00:28:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'talos_options': ['--disable-e10s', 00:28:40 INFO - '--xperf_path', 00:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:28:40 INFO - 'tests': ['tp5n']}, 00:28:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:40 INFO - 'talos_options': ['--xperf_path', 00:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:28:40 INFO - 'tests': ['tp5n']}}, 00:28:40 INFO - 'talos.zip': {'path': '', 00:28:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:28:40 INFO - Running post-action listener: _resource_record_post_action 00:28:40 INFO - [mozharness: 2016-07-27 07:28:40.022820Z] Finished populate-webroot step (success) 00:28:40 INFO - [mozharness: 2016-07-27 07:28:40.022909Z] Running create-virtualenv step. 00:28:40 INFO - Running pre-action listener: _resource_record_pre_action 00:28:40 INFO - Running main action method: create_virtualenv 00:28:40 INFO - Creating virtualenv /builds/slave/test/build/venv 00:28:40 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 00:28:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:28:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:28:40 INFO - Using real prefix '/usr' 00:28:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:28:40 INFO - Installing distribute.............................................................................................................................................................................................done. 00:28:42 INFO - Installing pip.................done. 00:28:42 INFO - Return code: 0 00:28:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:28:42 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')]} 00:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 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')]} 00:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:42 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 00:28:42 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 00:28:42 INFO - Using env: {'DISPLAY': ':0', 00:28:42 INFO - 'HOME': '/home/cltbld', 00:28:42 INFO - 'LANG': 'en_US.UTF-8', 00:28:42 INFO - 'LANGUAGE': 'en_US:en', 00:28:42 INFO - 'LOGNAME': 'cltbld', 00:28:42 INFO - 'MAIL': '/var/mail/cltbld', 00:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:42 INFO - 'MOZ_NO_REMOTE': '1', 00:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:42 INFO - 'NO_EM_RESTART': '1', 00:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:42 INFO - 'PWD': '/builds/slave/test', 00:28:42 INFO - 'SHELL': '/bin/bash', 00:28:42 INFO - 'SHLVL': '1', 00:28:42 INFO - 'TERM': 'linux', 00:28:42 INFO - 'TMOUT': '86400', 00:28:42 INFO - 'USER': 'cltbld', 00:28:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:42 INFO - '_': '/tools/buildbot/bin/python'} 00:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:42 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 00:28:42 INFO - Cleaning up... 00:28:42 INFO - Return code: 0 00:28:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:28:42 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')]} 00:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 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')]} 00:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:42 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 00:28:42 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 00:28:42 INFO - Using env: {'DISPLAY': ':0', 00:28:42 INFO - 'HOME': '/home/cltbld', 00:28:42 INFO - 'LANG': 'en_US.UTF-8', 00:28:42 INFO - 'LANGUAGE': 'en_US:en', 00:28:42 INFO - 'LOGNAME': 'cltbld', 00:28:42 INFO - 'MAIL': '/var/mail/cltbld', 00:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:42 INFO - 'MOZ_NO_REMOTE': '1', 00:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:42 INFO - 'NO_EM_RESTART': '1', 00:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:42 INFO - 'PWD': '/builds/slave/test', 00:28:42 INFO - 'SHELL': '/bin/bash', 00:28:42 INFO - 'SHLVL': '1', 00:28:42 INFO - 'TERM': 'linux', 00:28:42 INFO - 'TMOUT': '86400', 00:28:42 INFO - 'USER': 'cltbld', 00:28:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:42 INFO - '_': '/tools/buildbot/bin/python'} 00:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:43 INFO - Downloading/unpacking psutil>=3.1.1 00:28: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 00:28: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 00:28: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 00:28: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 00:28: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 00:28: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 00:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:28:45 INFO - Installing collected packages: psutil 00:28:45 INFO - Running setup.py install for psutil 00:28:45 INFO - building 'psutil._psutil_linux' extension 00:28:45 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 00:28:45 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 00:28:45 INFO - building 'psutil._psutil_posix' extension 00:28:45 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 00:28:45 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 00:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:28:45 INFO - Successfully installed psutil 00:28:45 INFO - Cleaning up... 00:28:45 INFO - Return code: 0 00:28:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:45 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:45 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 00:28:45 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 00:28:45 INFO - Using env: {'DISPLAY': ':0', 00:28:45 INFO - 'HOME': '/home/cltbld', 00:28:45 INFO - 'LANG': 'en_US.UTF-8', 00:28:45 INFO - 'LANGUAGE': 'en_US:en', 00:28:45 INFO - 'LOGNAME': 'cltbld', 00:28:45 INFO - 'MAIL': '/var/mail/cltbld', 00:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:45 INFO - 'MOZ_NO_REMOTE': '1', 00:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:45 INFO - 'NO_EM_RESTART': '1', 00:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:45 INFO - 'PWD': '/builds/slave/test', 00:28:45 INFO - 'SHELL': '/bin/bash', 00:28:45 INFO - 'SHLVL': '1', 00:28:45 INFO - 'TERM': 'linux', 00:28:45 INFO - 'TMOUT': '86400', 00:28:45 INFO - 'USER': 'cltbld', 00:28:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:45 INFO - '_': '/tools/buildbot/bin/python'} 00:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:28:45 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 00:28:45 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 00:28:45 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 00:28:45 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 00:28:45 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 00:28:45 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 00:28:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:28:47 INFO - Installing collected packages: mozsystemmonitor 00:28:47 INFO - Running setup.py install for mozsystemmonitor 00:28:47 INFO - Successfully installed mozsystemmonitor 00:28:47 INFO - Cleaning up... 00:28:47 INFO - Return code: 0 00:28:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:28:47 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')]} 00:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:47 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')]} 00:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:47 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:47 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==2.5.1'] in /builds/slave/test/build 00:28:47 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==2.5.1 00:28:47 INFO - Using env: {'DISPLAY': ':0', 00:28:47 INFO - 'HOME': '/home/cltbld', 00:28:47 INFO - 'LANG': 'en_US.UTF-8', 00:28:47 INFO - 'LANGUAGE': 'en_US:en', 00:28:47 INFO - 'LOGNAME': 'cltbld', 00:28:47 INFO - 'MAIL': '/var/mail/cltbld', 00:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:47 INFO - 'MOZ_NO_REMOTE': '1', 00:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:47 INFO - 'NO_EM_RESTART': '1', 00:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:47 INFO - 'PWD': '/builds/slave/test', 00:28:47 INFO - 'SHELL': '/bin/bash', 00:28:47 INFO - 'SHLVL': '1', 00:28:47 INFO - 'TERM': 'linux', 00:28:47 INFO - 'TMOUT': '86400', 00:28:47 INFO - 'USER': 'cltbld', 00:28:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:47 INFO - '_': '/tools/buildbot/bin/python'} 00:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:48 INFO - Downloading/unpacking jsonschema==2.5.1 00:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:28:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 INFO - Downloading functools32-3.2.3-2.tar.gz 00:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:28:50 INFO - warning: no files found matching '*.txt' 00:28:50 INFO - no previously-included directories found matching 'build' 00:28:50 INFO - no previously-included directories found matching 'dist' 00:28:50 INFO - no previously-included directories found matching '.git*' 00:28:50 INFO - Installing collected packages: jsonschema, functools32 00:28:50 INFO - Running setup.py install for functools32 00:28:50 INFO - warning: no files found matching '*.txt' 00:28:50 INFO - no previously-included directories found matching 'build' 00:28:50 INFO - no previously-included directories found matching 'dist' 00:28:50 INFO - no previously-included directories found matching '.git*' 00:28:50 INFO - Successfully installed jsonschema functools32 00:28:50 INFO - Cleaning up... 00:28:50 INFO - Return code: 0 00:28:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:50 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:50 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:28:50 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 functools32==3.2.3-2 00:28:50 INFO - Using env: {'DISPLAY': ':0', 00:28:50 INFO - 'HOME': '/home/cltbld', 00:28:50 INFO - 'LANG': 'en_US.UTF-8', 00:28:50 INFO - 'LANGUAGE': 'en_US:en', 00:28:50 INFO - 'LOGNAME': 'cltbld', 00:28:50 INFO - 'MAIL': '/var/mail/cltbld', 00:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:50 INFO - 'MOZ_NO_REMOTE': '1', 00:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:50 INFO - 'NO_EM_RESTART': '1', 00:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:50 INFO - 'PWD': '/builds/slave/test', 00:28:50 INFO - 'SHELL': '/bin/bash', 00:28:50 INFO - 'SHLVL': '1', 00:28:50 INFO - 'TERM': 'linux', 00:28:50 INFO - 'TMOUT': '86400', 00:28:50 INFO - 'USER': 'cltbld', 00:28:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:50 INFO - '_': '/tools/buildbot/bin/python'} 00:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:28:50 INFO - Cleaning up... 00:28:50 INFO - Return code: 0 00:28:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:50 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:50 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 00:28:50 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 00:28:50 INFO - Using env: {'DISPLAY': ':0', 00:28:50 INFO - 'HOME': '/home/cltbld', 00:28:50 INFO - 'LANG': 'en_US.UTF-8', 00:28:50 INFO - 'LANGUAGE': 'en_US:en', 00:28:50 INFO - 'LOGNAME': 'cltbld', 00:28:50 INFO - 'MAIL': '/var/mail/cltbld', 00:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:50 INFO - 'MOZ_NO_REMOTE': '1', 00:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:50 INFO - 'NO_EM_RESTART': '1', 00:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:50 INFO - 'PWD': '/builds/slave/test', 00:28:50 INFO - 'SHELL': '/bin/bash', 00:28:50 INFO - 'SHLVL': '1', 00:28:50 INFO - 'TERM': 'linux', 00:28:50 INFO - 'TMOUT': '86400', 00:28:50 INFO - 'USER': 'cltbld', 00:28:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:50 INFO - '_': '/tools/buildbot/bin/python'} 00:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:50 INFO - Downloading/unpacking blobuploader==1.2.4 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:50 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 00:28:52 INFO - Downloading blobuploader-1.2.4.tar.gz 00:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:28:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:28:52 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 00:28:52 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 00:28:52 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 00:28:52 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 00:28:52 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 00:28:52 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 00:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:28:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:28:53 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 00:28:53 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 00:28:53 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 00:28:53 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 00:28:53 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 00:28:53 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 00:28:53 INFO - Downloading docopt-0.6.1.tar.gz 00:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:28:53 INFO - Installing collected packages: blobuploader, requests, docopt 00:28:53 INFO - Running setup.py install for blobuploader 00:28:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:28:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:28:53 INFO - Running setup.py install for requests 00:28:54 INFO - Running setup.py install for docopt 00:28:54 INFO - Successfully installed blobuploader requests docopt 00:28:54 INFO - Cleaning up... 00:28:54 INFO - Return code: 0 00:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:54 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:54 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 00:28:54 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 00:28:54 INFO - Using env: {'DISPLAY': ':0', 00:28:54 INFO - 'HOME': '/home/cltbld', 00:28:54 INFO - 'LANG': 'en_US.UTF-8', 00:28:54 INFO - 'LANGUAGE': 'en_US:en', 00:28:54 INFO - 'LOGNAME': 'cltbld', 00:28:54 INFO - 'MAIL': '/var/mail/cltbld', 00:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:54 INFO - 'MOZ_NO_REMOTE': '1', 00:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:54 INFO - 'NO_EM_RESTART': '1', 00:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:54 INFO - 'PWD': '/builds/slave/test', 00:28:54 INFO - 'SHELL': '/bin/bash', 00:28:54 INFO - 'SHLVL': '1', 00:28:54 INFO - 'TERM': 'linux', 00:28:54 INFO - 'TMOUT': '86400', 00:28:54 INFO - 'USER': 'cltbld', 00:28:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:54 INFO - '_': '/tools/buildbot/bin/python'} 00:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:28:54 INFO - Running setup.py (path:/tmp/pip-_n7Ci2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:28:54 INFO - Running setup.py (path:/tmp/pip-3kdviX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:28:54 INFO - Running setup.py (path:/tmp/pip-y7n7Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:28:54 INFO - Running setup.py (path:/tmp/pip-WormDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:28:54 INFO - Running setup.py (path:/tmp/pip-9Jhn4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:28:54 INFO - Running setup.py (path:/tmp/pip-sPYTcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:28:54 INFO - Running setup.py (path:/tmp/pip-LZNxRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:28:54 INFO - Running setup.py (path:/tmp/pip-uy8QQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:28:55 INFO - Running setup.py (path:/tmp/pip-BS8Hpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:28:55 INFO - Running setup.py (path:/tmp/pip-FNt8Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:28:55 INFO - Running setup.py (path:/tmp/pip-Q2QvJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:28:55 INFO - Running setup.py (path:/tmp/pip-J4zlMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:28:55 INFO - Running setup.py (path:/tmp/pip-snUZay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:28:55 INFO - Running setup.py (path:/tmp/pip-bfIcFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:55 INFO - Running setup.py (path:/tmp/pip-FDapAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:28:55 INFO - Running setup.py (path:/tmp/pip-p0lbGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:28:55 INFO - Running setup.py (path:/tmp/pip-k1JxDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:28:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:28:55 INFO - Running setup.py install for manifestparser 00:28:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:28:55 INFO - Running setup.py install for mozcrash 00:28:55 INFO - Running setup.py install for mozdebug 00:28:55 INFO - Running setup.py install for mozdevice 00:28:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for mozfile 00:28:56 INFO - Running setup.py install for mozhttpd 00:28:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for mozinfo 00:28:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for mozInstall 00:28:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for mozleak 00:28:56 INFO - Running setup.py install for mozlog 00:28:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for moznetwork 00:28:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:28:56 INFO - Running setup.py install for mozprocess 00:28:56 INFO - Running setup.py install for mozprofile 00:28:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:28:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:28:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:28:57 INFO - Running setup.py install for mozrunner 00:28:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:28:57 INFO - Running setup.py install for mozscreenshot 00:28:57 INFO - Running setup.py install for moztest 00:28:57 INFO - Running setup.py install for mozversion 00:28:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:28:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:28:57 INFO - Cleaning up... 00:28:57 INFO - Return code: 0 00:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:28:57 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 00:28:57 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 00:28:57 INFO - Using env: {'DISPLAY': ':0', 00:28:57 INFO - 'HOME': '/home/cltbld', 00:28:57 INFO - 'LANG': 'en_US.UTF-8', 00:28:57 INFO - 'LANGUAGE': 'en_US:en', 00:28:57 INFO - 'LOGNAME': 'cltbld', 00:28:57 INFO - 'MAIL': '/var/mail/cltbld', 00:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:57 INFO - 'MOZ_NO_REMOTE': '1', 00:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:28:57 INFO - 'NO_EM_RESTART': '1', 00:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:57 INFO - 'PWD': '/builds/slave/test', 00:28:57 INFO - 'SHELL': '/bin/bash', 00:28:57 INFO - 'SHLVL': '1', 00:28:57 INFO - 'TERM': 'linux', 00:28:57 INFO - 'TMOUT': '86400', 00:28:57 INFO - 'USER': 'cltbld', 00:28:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:57 INFO - '_': '/tools/buildbot/bin/python'} 00:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:28:57 INFO - Running setup.py (path:/tmp/pip-CgQ6bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:28:57 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)) 00:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:28:57 INFO - Running setup.py (path:/tmp/pip-CooHDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:28:57 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)) 00:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:28:57 INFO - Running setup.py (path:/tmp/pip-Igh29A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:28:57 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)) 00:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:28:57 INFO - Running setup.py (path:/tmp/pip-bNov5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:28:57 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)) 00:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:28:57 INFO - Running setup.py (path:/tmp/pip-MIzhsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:28:58 INFO - Running setup.py (path:/tmp/pip-ImKusX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:28:58 INFO - Running setup.py (path:/tmp/pip-6DOZ9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:28:58 INFO - Running setup.py (path:/tmp/pip-uqggF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:28:58 INFO - Running setup.py (path:/tmp/pip-3a3Zxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:28:58 INFO - Running setup.py (path:/tmp/pip-e6C83j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:28:58 INFO - Running setup.py (path:/tmp/pip-cRWEgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:28:58 INFO - Running setup.py (path:/tmp/pip-3gODuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:28:58 INFO - Running setup.py (path:/tmp/pip-F64SeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:28:58 INFO - Running setup.py (path:/tmp/pip-sKT2CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:58 INFO - Running setup.py (path:/tmp/pip-2VDUDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:28:58 INFO - Running setup.py (path:/tmp/pip-8VuNJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:28:58 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)) 00:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:28:58 INFO - Running setup.py (path:/tmp/pip-e9BSTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:28:58 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)) 00:28:58 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)) 00:28:58 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)) 00:28:58 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)) 00:28:58 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)) 00:28:58 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)) 00:28:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:28:58 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 00:28:58 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 00:28:58 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 00:28:58 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 00:28:58 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 00:28:58 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 00:29:00 INFO - Downloading blessings-1.6.tar.gz 00:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:29:00 INFO - Installing collected packages: blessings 00:29:00 INFO - Running setup.py install for blessings 00:29:01 INFO - Successfully installed blessings 00:29:01 INFO - Cleaning up... 00:29:01 INFO - Return code: 0 00:29:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:01 INFO - Reading from file tmpfile_stdout 00:29:01 INFO - Current package versions: 00:29:01 INFO - argparse == 1.2.1 00:29:01 INFO - blessings == 1.6 00:29:01 INFO - blobuploader == 1.2.4 00:29:01 INFO - docopt == 0.6.1 00:29:01 INFO - functools32 == 3.2.3-2 00:29:01 INFO - jsonschema == 2.5.1 00:29:01 INFO - manifestparser == 1.1 00:29:01 INFO - mozInstall == 1.12 00:29:01 INFO - mozcrash == 0.17 00:29:01 INFO - mozdebug == 0.1 00:29:01 INFO - mozdevice == 0.48 00:29:01 INFO - mozfile == 1.2 00:29:01 INFO - mozhttpd == 0.7 00:29:01 INFO - mozinfo == 0.9 00:29:01 INFO - mozleak == 0.1 00:29:01 INFO - mozlog == 3.3 00:29:01 INFO - moznetwork == 0.27 00:29:01 INFO - mozprocess == 0.23 00:29:01 INFO - mozprofile == 0.28 00:29:01 INFO - mozrunner == 6.12 00:29:01 INFO - mozscreenshot == 0.1 00:29:01 INFO - mozsystemmonitor == 0.3 00:29:01 INFO - moztest == 0.7 00:29:01 INFO - mozversion == 1.4 00:29:01 INFO - psutil == 3.1.1 00:29:01 INFO - requests == 1.2.3 00:29:01 INFO - wsgiref == 0.1.2 00:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:01 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:29:01 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 00:29:01 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 00:29:01 INFO - Using env: {'DISPLAY': ':0', 00:29:01 INFO - 'HOME': '/home/cltbld', 00:29:01 INFO - 'LANG': 'en_US.UTF-8', 00:29:01 INFO - 'LANGUAGE': 'en_US:en', 00:29:01 INFO - 'LOGNAME': 'cltbld', 00:29:01 INFO - 'MAIL': '/var/mail/cltbld', 00:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:01 INFO - 'MOZ_NO_REMOTE': '1', 00:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:01 INFO - 'NO_EM_RESTART': '1', 00:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:01 INFO - 'PWD': '/builds/slave/test', 00:29:01 INFO - 'SHELL': '/bin/bash', 00:29:01 INFO - 'SHLVL': '1', 00:29:01 INFO - 'TERM': 'linux', 00:29:01 INFO - 'TMOUT': '86400', 00:29:01 INFO - 'USER': 'cltbld', 00:29:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:01 INFO - '_': '/tools/buildbot/bin/python'} 00:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 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)) 00:29:01 INFO - Cleaning up... 00:29:01 INFO - Return code: 0 00:29:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:01 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 0x19cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', '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 00:29:01 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 00:29:01 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 00:29:01 INFO - Using env: {'DISPLAY': ':0', 00:29:01 INFO - 'HOME': '/home/cltbld', 00:29:01 INFO - 'LANG': 'en_US.UTF-8', 00:29:01 INFO - 'LANGUAGE': 'en_US:en', 00:29:01 INFO - 'LOGNAME': 'cltbld', 00:29:01 INFO - 'MAIL': '/var/mail/cltbld', 00:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:01 INFO - 'MOZ_NO_REMOTE': '1', 00:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:01 INFO - 'NO_EM_RESTART': '1', 00:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:01 INFO - 'PWD': '/builds/slave/test', 00:29:01 INFO - 'SHELL': '/bin/bash', 00:29:01 INFO - 'SHLVL': '1', 00:29:01 INFO - 'TERM': 'linux', 00:29:01 INFO - 'TMOUT': '86400', 00:29:01 INFO - 'USER': 'cltbld', 00:29:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:01 INFO - '_': '/tools/buildbot/bin/python'} 00:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:29:01 INFO - Cleaning up... 00:29:01 INFO - Return code: 0 00:29:01 INFO - Running post-action listener: _resource_record_post_action 00:29:01 INFO - Running post-action listener: _start_resource_monitoring 00:29:01 INFO - Starting resource monitoring. 00:29:01 INFO - [mozharness: 2016-07-27 07:29:01.783220Z] Finished create-virtualenv step (success) 00:29:01 INFO - [mozharness: 2016-07-27 07:29:01.783698Z] Running install step. 00:29:01 INFO - Running pre-action listener: _resource_record_pre_action 00:29:01 INFO - Running main action method: install 00:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:01 INFO - Reading from file tmpfile_stdout 00:29:01 INFO - Detecting whether we're running mozinstall >=1.0... 00:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:29:02 INFO - Reading from file tmpfile_stdout 00:29:02 INFO - Output received: 00:29:02 INFO - Usage: mozinstall [options] installer 00:29:02 INFO - Options: 00:29:02 INFO - -h, --help show this help message and exit 00:29:02 INFO - -d DEST, --destination=DEST 00:29:02 INFO - Directory to install application into. [default: 00:29:02 INFO - "/builds/slave/test"] 00:29:02 INFO - --app=APP Application being installed. [default: firefox] 00:29:02 INFO - mkdir: /builds/slave/test/build/application 00:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:29:18 INFO - Reading from file tmpfile_stdout 00:29:18 INFO - Output received: 00:29:18 INFO - /builds/slave/test/build/application/firefox/firefox 00:29:18 INFO - Running post-action listener: _resource_record_post_action 00:29:18 INFO - [mozharness: 2016-07-27 07:29:18.492825Z] Finished install step (success) 00:29:18 INFO - [mozharness: 2016-07-27 07:29:18.493105Z] Running run-tests step. 00:29:18 INFO - Running pre-action listener: _resource_record_pre_action 00:29:18 INFO - Running main action method: run_tests 00:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:29:18 INFO - Python 2.7.3 00:29:18 INFO - Return code: 0 00:29:18 INFO - grabbing minidump binary from tooltool 00:29: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')]} 00:29:18 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 0x1c8b3b0>, '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 0x1c8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:29:18 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 00:29:18 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 00:29:18 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 00:29:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:29:18 INFO - Return code: 0 00:29:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:29:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:29:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:29:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:29:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 00:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 00:29:18 INFO - Using env: {'DISPLAY': ':0', 00:29:18 INFO - 'HOME': '/home/cltbld', 00:29:18 INFO - 'LANG': 'en_US.UTF-8', 00:29:18 INFO - 'LANGUAGE': 'en_US:en', 00:29:18 INFO - 'LOGNAME': 'cltbld', 00:29:18 INFO - 'MAIL': '/var/mail/cltbld', 00:29:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:29:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:18 INFO - 'MOZ_NO_REMOTE': '1', 00:29:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:18 INFO - 'NO_EM_RESTART': '1', 00:29:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:18 INFO - 'PWD': '/builds/slave/test', 00:29:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:29:18 INFO - 'SHELL': '/bin/bash', 00:29:18 INFO - 'SHLVL': '1', 00:29:18 INFO - 'TERM': 'linux', 00:29:18 INFO - 'TMOUT': '86400', 00:29:18 INFO - 'USER': 'cltbld', 00:29:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849', 00:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:18 INFO - '_': '/tools/buildbot/bin/python'} 00:29:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 00:29:18 INFO - mozversion application_buildid: 20160726231512 00:29:18 INFO - mozversion application_changeset: 78dd94ba93c77d0bba45f8e4525947629a305a41 00:29:18 INFO - mozversion application_display_name: Nightly 00:29:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:29:18 INFO - mozversion application_name: Firefox 00:29:18 INFO - mozversion application_remotingname: firefox 00:29:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:29:18 INFO - mozversion application_vendor: Mozilla 00:29:18 INFO - mozversion application_version: 50.0a1 00:29:18 INFO - mozversion platform_buildid: 20160726231512 00:29:18 INFO - mozversion platform_changeset: 78dd94ba93c77d0bba45f8e4525947629a305a41 00:29:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:29:18 INFO - mozversion platform_version: 50.0a1 00:29:18 INFO - using testdate: 1469604558 00:29:18 INFO - actual date: 1469604558 00:29:18 INFO - starting webserver on 'localhost:42605' 00:29:18 INFO - SUITE-START | Running 2 tests 00:29:18 INFO - TEST-START | dromaeo_css 00:29:18 INFO - operating with platform_type : linux_ 00:29:18 INFO - Initialising browser for dromaeo_css test... 00:29:18 INFO - TEST-INFO | started process 13409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpycpG0i/profile http://localhost:42605/getInfo.html) 00:29:22 INFO - PROCESS | 13409 | JavaScript error: , line 0: uncaught exception: undefined 00:29:23 INFO - PROCESS | 13409 | __metrics Screen width/height:1600/1200 00:29:23 INFO - PROCESS | 13409 | colorDepth:24 00:29:23 INFO - PROCESS | 13409 | Browser inner width/height: 1024/697 00:29:23 INFO - PROCESS | 13409 | __metrics 00:29:23 INFO - PROCESS | 13409 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:29:23 INFO - PROCESS | 13409 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:29:24 INFO - TEST-INFO | 13409: exit 0 00:29:24 INFO - Browser initialized. 00:29:24 INFO - Running cycle 1/1 for dromaeo_css test... 00:29:24 INFO - TEST-INFO | started process 13485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpycpG0i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:29:36 INFO - PROCESS | 13485 | RSS: Main: 159350784 00:29:36 INFO - PROCESS | 13485 | 00:30:27 INFO - PROCESS | 13485 | 1469604627784 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] 00:32:41 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42605/tests/dromaeo/cssquery-ext.html) 00:32:42 INFO - PROCESS | 13485 | RSS: Main: 275279872 00:32:42 INFO - PROCESS | 13485 | 00:35:45 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-ext.html (next: http://localhost:42605/tests/dromaeo/cssquery-jquery.html) 00:35:45 INFO - PROCESS | 13485 | RSS: Main: 240275456 00:35:45 INFO - PROCESS | 13485 | 00:38:47 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42605/tests/dromaeo/cssquery-mootools.html) 00:38:48 INFO - PROCESS | 13485 | RSS: Main: 184025088 00:38:48 INFO - PROCESS | 13485 | 00:41:50 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42605/tests/dromaeo/cssquery-prototype.html) 00:41:51 INFO - PROCESS | 13485 | RSS: Main: 185208832 00:41:51 INFO - PROCESS | 13485 | 00:44:54 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42605/tests/dromaeo/cssquery-yui.html) 00:44:54 INFO - PROCESS | 13485 | RSS: Main: 184983552 00:44:54 INFO - PROCESS | 13485 | 00:47:57 INFO - PROCESS | 13485 | Cycle 1(1): loaded http://localhost:42605/tests/dromaeo/cssquery-yui.html (next: http://localhost:42605/tests/dromaeo/cssquery-dojo.html) 00:47:58 INFO - PROCESS | 13485 | RSS: Main: 279232512 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | __start_tp_report 00:47:58 INFO - PROCESS | 13485 | _x_x_mozilla_page_load 00:47:58 INFO - PROCESS | 13485 | _x_x_mozilla_page_load_details 00:47:58 INFO - PROCESS | 13485 | |i|pagename|runs| 00:47:58 INFO - PROCESS | 13485 | |0;dojo.html;2610.960835587466;2621.9737802621967;2650.3639126609614;2667.906623268185;2672.3452754075256;4586.38083858679;4683.437987441512;4729.527047295269;4764.356811830397;4782.952170478294;4640.327152562876;4686.179918514264;4698.177818881691;4741.431028276603;4771.976140119304;4356.629686476637;4410.029793445453;4419.071994881071;4461.821527138911;4464.0179160584785;4362.25841606926;4401.515833258339;4428.889277768049;4436.933445998313;4477.48508921475;4473.194824931511;4503.527129651388;4529.23003089474;4534.478534968488;4534.818607255722;4258.552851950562;4303.677224208197;4442.866713998553;4484.439445069366;4486.910261794778;4278.935815962763;4310.202612516695;4317.266064768997;4363.018320877809;4380.3210502372185;4685.203515402356;4698.600618947359;4756.738379389132;4766.356541866873;4768.094062128219;4913.115639184945;5031.84904452867;5048.495150484922;5062.519060689228;5095.949040509585;4978.4025916890205;4979.128652485801;5012.899742005139;5076.6192535559985;5098.59211263098;4735.029318989599;4738.763061846894;4749.145153872267;4752.120857641313;4759.809607615656;5023.34696489454;5122.564582010496;5209.296744939385;5214.582833373321;5219.321488206509;4958.727270000185;5018.197088465828;5039.546440820343;5040.143175660147;5042.4705405931845;5062.848114556569;5077.543021128116;5108.106081435808;5125.7693403796175;5134.666246693953;4896.11869863428;4948.430930443045;5011.949880501148;5013;5064.898702026013;4983.401991761012;5050.393952725696;5067.87330316745;5125.384953805493;5150.6137039721425;4327;4332;4336.934945975813;4365.904365904384;4377.365282034088;3784.2242340320167;3810.980945095312;3839.424086387064;3839.673627741673;3840.385538313856;4258.403823464655;4349.891252718708;4393.692441529126;4403.801828917706;4405.669574781904;5151.25306830515;5152.896942061137;5154.407243167084;5154.742262886841;5189.325387699575;4383.561643835655;4415.51429342772;4425.491068527096;4451.844185453494;4470.240059189946;4424.13729322779;4506.932396014063;4535.682502224812;4538.205813982539;4602.608778253819;4759.309900064402;4774.069056533943;4775.044991001744;4805.038992201504;4836.588889944253;5082.822101226439;5112.616553758408;5117.513836185556;5133.153029750049;5135.7432128394175;4604.723716577016;4654.557817007379;4722.079194557028;4737.455192652889;4834.975825120852;5036.118679231193;5036.471170527188;5036.8992620146655;5052.873678157928;5060.797568097235;5083.186690129562;5090.134677104827;5092.439831618445;5096.413912400121;5136.2552429898205;4777.522247775195;4828.975855120702;4830.106430310263;4962.255661650781;4964.280179374043;4866.707997520019;4932.482089380564;4948.554630083309;4960.47914968923;5001.749912504288;4870.318155458168;4892.486288939753;4918.704877707349;4926.4088309403105;4933.654644174873;4861.1006963710415;4893.755312234302;4956.826511072095;4966.255061740623;4990.6506544541535;4864.343313652612;4864.440589332272;4872.4883887192755;4874.829380971649;4900.460949295503 00:47:58 INFO - PROCESS | 13485 | |1;ext.html;545.5673808134418;571.8084441712026;580.7822066724979;583.224311665485;594.940505949405;29768.851155744218;29850.552241716392;30383.240418989535;30760.38479230417;32906.34187316252;41590.58409415905;41977.7901110494;41978.790106049506;41986.58013419865;41991.79004104975;7794.181610930856;7921.04947406312;7929.5242285463055;7935.841283174362;7939.126696063428;7743.4966727162555;7745.1093124290865;7754.922450775504;7778.455508114434;7780;7822.647980840876;7870.212978702112;7876.448648594601;7883.684652613889;7886.250806173433;7805.765827025199;7835.569043702594;7839;7842.803929901798;7846.803829904241;7641.3122818946;7691.461597688164;7697.268759467842;7713.730019449348;7719.3052625263435;38666.61333386658;38752;38913.61086389157;39131;39167.804160979016;2898.7101289871057;3030.3484750778466;3185.2196211928226;3490.5462289902152;3624.039629498185;29634.70365296341;29750.553741693893;30122.849385752932;30216.395672086655;30325.393492130035;2831.1931099636504;2847.188551262901;2864.513032784411;2898.5797059426263;2900.1734505665995;187858.06070969556;188195.99999999863;188380;188756.0562197194;189609;31993.68006319907;54142;54170.45829541654;54470.72764636151;54554.72722636361;32429.837850810596;34060.82969585136;34216.65783342135;34269.14327141792;34282.48576271358;13338.533151339656;13400;13400.128991615515;13413.262270575016;13421.664458388423;11041.889581104248;11082.722931926766;11087.05760010392;11111.055560277468;11130.666080017612;7870.9606451967375;7881.842363152705;7910.694735368715;7970;7982.760517184493;3064.2952121011845;3088.336007758343;3098.8760449582214;3123.1099136746375;3130.89041883533;789.8420315936836;841.9410641255054;849.4181485682327;925.1026504290827;932.9160375566231;26706.866465667936;27547.86226068857;27905.581416278772;28109.71890281112;28110.85944570264;743.8623854586918;909.3043821476575;916.7478943290648;918.3479729392207;1007.2898606482412;13446.596602101952;14513.419463221353;14702.926485367505;15386.692266154614;15892.205389730467;428229;429111;429810;432556;433144;52339.47660523346;52652;52686.209706854424;52758;52762.20856687153;1079.6167360586878;1141.2182654881433;1183.47335435732;1186.905047596173;1208.256921992968;27677;28749.28126796847;29079.85460072686;29228.41543169082;29893.551596726502;42510.362344565474;43395;43409.565904340554;43466.13067738564;43533.12933741371;315996;318915;319129;319707;402942;35727.28545429129;38318.80840595779;38576.80711596424;38923;39001.219975599764;42268.788656056524;42993.355099674154;43014.78492607517;43052.13895722131;43289;36081;36560;36692;37354.8132259337;37529.62470375261;36682.26635467329;37340.06649833776;37411.62588374082;37493;38150.80924595359;35733.28533429265;36108.09729756777;36539.26921461609;36893.631063690096;37163.81418092892;31847.681523185398;33327;33967.66032339645;34195.82902085473;34244;24925.750742492342;25340.49319013646;25767;25835.612465813403;26039.739602604488 00:47:58 INFO - PROCESS | 13485 | |2;jquery.html;348.9877854275098;370.34264181078584;377.3867465368774;381.2907991136486;392.7682667226336;13060.346982650864;16488.340466381345;16635.66728665426;17520.64958700825;18578.53553661159;17280.395186168487;17576.736348954775;17950.10249487527;18126.63746725068;18133.184006719697;4808.494274056212;5143.665661731994;5161.561267292284;5163.199704045879;5175.042617115827;3761.9247615047684;5118.9488105119035;5136.974315128437;5188.740562971855;5664.1220610805185;5937.109433584954;5998.8800223995495;6011.969940150293;6028.63828170309;6029.065494848283;5850.853728656818;5870.970645146747;5871.79448719297;5889.381614930414;6010.969945150268;5104.668196567211;5115.462876397962;5120.539151476385;5124.359455068116;5135.460776618476;20862.26982055621;21394;21499.785002150093;21548.569028619495;21609.45976350588;1769.5841477252836;1810.4840120565707;1825.12394050855;1902.3436914264557;1941.1847024249848;12909.870901291055;13612.387442565108;13927.651808704763;14196.574102776933;14442.422303107864;1661.1427158050951;1663.3180396037567;1684.6293815360723;1704.6505466379363;1796.119901248392;68266.65866670685;69763;70961;71412;72347.27652723511;9208.90791092094;9366.578503967337;9402;9466.668666596635;9521.28590355726;12314.81527777084;12360.381980900918;12400.705869414187;12412.751744965231;12479.87520124787;7382.446316526282;7412.295831895961;7435.107787065479;7574.280443357872;7619.885701714478;7279.308465695751;7333.523320984119;7545.170031296553;7561.2060733623275;7562.546247225074;5888.587798854039;6080.300765411946;6172.074188871705;6189.597676151036;6245.906311405332;1616.854483096527;1648.4148127414835;1648.8186299507045;1659.485559476566;1773.1311657288095;808.9838203235902;845.6997765793178;885.4023534114447;909.490685216281;914.4330515080693;16932.407365742387;17357.218925148398;17866.642667146585;17989.550261243312;18362.632747345244;825.6903661127077;847.3771777743353;870.3211495033884;884.2969838978028;884.509097450908;9737.464439455898;10224.539895704711;10224.897751022394;10275.845862312071;10323.74190645225;401512;409001;409159;409731;411114;71826.64086679534;74144;74702.6264868683;74891;75711.62144189244;906.977325566866;919.7884486568126;934.3833070173653;939.7744541310036;948.4498990585444;14481.203533805741;15723.135227562594;16107.516774496784;16420;16493.67012659764;36791.44812827756;38088;38350.23299534049;38688.80655596704;38705.4194187093;49284.50715492799;50148;51122.48877511326;51490;53318.73340633272;6739.191297044386;6876.793696189123;6901.068355772108;7382.852342953218;8015.719449819228;10505.949405059433;11389.430528473378;11437.08503319749;11490.31058136481;11574.768504630028;9623.759406014906;9723.756906077404;9769.609215631295;9920.355176913477;10117.190624749855;9681.70954871355;9827.508624568885;9969.143598658624;10021.298509104292;10413.656927191321;9522.476263805556;9783.217342612432;9806.264530160124;10073;10187.898121018696;6958.965205173941;6987.545809522365;7003.859922801414;7140.464465165237;7297.817554561178;9474.763130921781;9485.762855928657;9699.418034917928;10007.29948903599;10030.197584193393 00:47:58 INFO - PROCESS | 13485 | |3;mootools.html;1249.7125661097953;1358.789387644915;1394.700139470014;1442.3581506229725;1658.1377683604526;6836.179658440988;7761.107472640648;8014.919850801491;8023.5587042712705;8307.626156822942;7886.921130788691;7951.4831535950125;7964.044314682246;7964.960175199116;7968.521888686669;2206.20576592427;2231.1744654477866;2236.709227800384;2236.9888150559223;2237.7762223777654;2174.4781252499442;2230.241717815942;2243.25972429098;2243.8317126215597;2247.359502541776;2194.3965409512352;2199.1093607089074;2205.845590808644;2206.30501392061;2242.607543679858;2128.9041993110345;2152.763196048433;2153.3755210988793;2157.9352619421365;2160.3950893749775;2121.0349291072525;2121.7878212178657;2125.08621292844;2126.617208902397;2127.329891084319;7875.645595948196;7910.090339610903;7961.283484486424;7963.4027447941635;7968.521888686697;4412.977935110304;4660.790264438108;4662.323963025342;4703.670743047988;4706.058788242365;2730.1127133681434;2830.9292267693268;2880.1071667783053;2885.9855700721573;2913.533834586456;943.9575219115087;947.7346343023895;960.078324808185;964.8938616752151;965.7682156282511;10800.351978881292;10900.890991090067;10903.400312982783;10973.122150227962;10973.286736362112;4154.1068670236045;4178.1643671265265;4229.703920725519;4266.807993640294;4321.330193819963;8475.194856488624;8478.830423391497;8479.448835825775;8484.957575212084;8503.362247831437;4513.796879140381;4515.277555591089;4517.141743068806;4517.6837621366185;4517.6837621366185;3632.891013269606;4014.197160567898;4157;4157.64660003897;4216.177845320194;3624.4200927851416;3759.8684046058256;3810.2950954073585;3853.556840963269;3876.1860009398342;1179.9351035692948;1188.043624881961;1193.797054500737;1210.7881120803825;1239.7954337534386;679.5548915460381;718.4073139659802;791.1692722641204;819.7909533069029;833.0752864320599;4989.750512474362;5088.821891233863;5190.24741412493;5198.740062996835;5458.863528411742;409.91801639672184;410.76175818025473;412.90503184267186;413.4996654048635;415.71108079884795;3486.9476957845654;3500.544929159193;3558.768680035789;3561.6794488495643;3658.396364599811;9443.811123777487;9868.506574671237;9879.802403952024;9898.752531186634;9899.950500247596;9799.216062714966;9809;9820.116189542832;9824.65613703517;9840.901590983998;7355.448341374418;7406.555606663617;7429.219931907072;7504.437167212481;7570.091589009354;5090.032893750324;5115.360579927509;5132.076226279306;5196.298499702491;5222.97388513055;8887.15572020657;8980.685676001309;9072.50101244438;9093.818123637622;9174.26605871542;9149.313801464783;9322.394044387092;9360.719178424659;9454.95272523633;9468.195203407788;5914.083317085859;6261.906071408841;6981.7207311709;7026.262242464672;7061.2232654409;7364.263573642593;7664.540127592362;7678.1170165431695;7678.385729141767;7682.577458239851;6606.43845273138;6713.362230588086;6744.5616034957575;6747.257801641914;6760.729570817112;6840;6949.4440444765305;6950.20072691647;6967.477439191979;7024.894626580503;6380.776672816429;6466.741330346734;6473.126127972663;6479.870402591828;6488.902666459912;4518.36742856007;4556.362109304634;4578.45058592971;4644.396228490275;4646.3030545417105;4531.954680453285;4585.2488506896925;4598.88502787433;4664.720116792868;4726.574608285271 00:47:58 INFO - PROCESS | 13485 | |4;prototype.html;306.98925537606186;310.4133188274162;317.0362099218376;319.88963807486414;321.82943040188695;4747.406574178228;4771.165046116933;4775.259834725619;4786.976065119669;4802.711837289765;4467.486239082498;4575.588197062264;4589.151007063696;4595.81616735331;4708.882277943053;3674.375356189441;3685.262947410515;3723.813809309537;3760.0975765816142;3771.7359784815076;3776.7922764247955;3780.3006443807844;3782.6406491383273;3795.411711184771;3800.619938006205;3676.191237927652;3735.3276410246144;3758.5113935188388;3761.924761504782;3813.3707938190164;3715.516982792247;3718.9070273243115;3724.5902950675404;3744.4570537271943;3748.3815170496973;3298.0541480526604;3312.5528053712683;3329.1510664780567;3330.117518857505;3337.9833100834585;4655.627549796008;4668.5564871337165;4674.509176536449;4675.859724208279;4708.811647534095;4175.645070169039;4266.509351424564;4268.3353492137785;4315.654747620183;4349.630281426083;4894.828680996184;4904.901901961976;4926.802927882881;4931.580815630676;4931.630127740434;3663.2124093320062;3669.5229620149476;3671.467637192592;3687.8340474678434;3701.241245544657;4915.5821755150855;5166.819161329373;5208.973955130238;5212.504812042887;5221.791128354899;3640.5995340512522;3642.927141457156;3660.7986560739414;3674.467202255658;3681.1533347330264;3713.164537978933;3727.440883867387;3729.5524537055726;3731.2910546995986;3737.7383583149463;4232.8359701082445;4255.638270747021;4260.8495706159165;4262.126264115849;4262.465512415528;4702.36518070063;4912.778924948386;4913.31213630092;4926.58124059459;5036.823711170092;1266.2845492296822;1278.3288773393856;1285.3637449462576;1286.3825363825417;1291.5092264939262;820.1388542030963;833.3333333333309;835.7868743470376;848.6181218451721;860.5482121885934;4363.978180109079;4364.912701745948;4365.497967733688;4369.213541562549;4378.321360189176;5028.74856257193;5041.117804384218;5054.9241761373605;5055.949440505621;5074.3657042869645;4259.829606815692;4351.4995775485595;4398.1643487737865;4419.624331931822;4435.933460998088;2661.5076210901047;2676.491466621336;2676.585129304961;2677.705452400234;2685.7448542388443;4759.785809638574;4762.095201911695;4779.3070004849105;4807.903841923142;4823.807047718122;4907.6564640475535;5110.923336149961;5170.6380553360905;5177.767000484987;5183.533481986639;4757.524247575215;4765.355227848578;4768.141734487756;4769.689970151929;4773.164696178224;4999.375203058948;5007.29897814299;5029.874253143701;5048.697078175322;5052.292679025013;4841.806327746851;4869.3112006987;4952.77712502931;4966.751662416937;4968.627352948471;4748.620110391092;4759.690620109682;4782.95217047839;4786.425628924551;4788.880277993078;3648.543932008499;3653.324135035027;3654.488371627921;3662.340778659867;3679.521662183899;4900.387451568554;4971.223128023831;5087.3386459759995;5088.4148322941855;5095.414027386898;4861.805527778849;4866;4870.488598697228;4875.8049678012485;4890.2909078184175;4867.342908707279;4870.829520966749;4881.219004959189;4921.047371577025;4933.777979990838;4661;4809.831655892027;4821.2045012572535;4821.662483626113;4843.152448321459;4774.641901857305;4902.583280421204;4904.558589726942;4914.91871788206;4994.32576602154;4796.160671882476;4809.258722528125;4811.831585894477;4871.878203044952;4901.975490122527 00:47:58 INFO - PROCESS | 13485 | |5;yui.html;566.2751677852349;611.7981066248138;660.247318057415;665.1087542692792;682.6723172877018;12291.631251062472;12682.873171268297;12836.80744788829;13197.80203296949;13201.933990330059;12683.492660293601;13061.41223644936;13086.672833179175;13155.802662960063;13208.867911320884;751.1924680967968;777.6228529163351;784.3333166808225;784.415610370275;785.1912530094012;782.9530228186298;786.3551887452292;786.6774622404815;786.9055713314382;786.9881951770728;804.9436539442241;808.9959550202241;809.3565615335792;809.9959500202491;811.0753740735566;807.0315621254518;807.2492581898832;807.6930766308794;807.7092246791151;807.8142027333716;589.260478099986;592.3898384663803;593.8604427959426;594.3580932592832;594.9940500594982;11777.764444711143;11784.528618855236;11792.1155913306;11794.587189448328;12269.263844169378;12284.14011019229;12853.100282980195;12873.549425770147;12926.741465170739;13149.934250328688;9761.902380976171;9793.118619324296;10032.849507257397;10153.512389464555;10417.062464378167;3146.638136614296;3170.4853753688267;3175.888843890453;3184.108449634083;3221.291315910496;64744.3525564743;65179;65468.67265663689;65594.67202663956;67108.32891671118;8686.956565217133;8881.24509416694;8890.288776897833;8933.73198804024;9357.90642093584;18795.15421806022;18802.811971880106;18805;18805.62388752217;18860.15129319184;6449.645269510222;6491.123698300763;6501.447376972916;6503.219613646393;6568.770093046721;3423.07576954221;3578.5884623268657;3726.795026273581;3812.313783518993;3855.8650447234213;2702.8378297302224;2796.189105159481;2806.8315901046003;2808.761255293282;2810.803243772957;489.96080313575544;502.87679518518195;517.9559737422286;522.5245027025388;534.9358077030781;498.3521422151189;510.1760656539736;522.7125081205322;522.8222404382528;524.9711265880337;7042.542234754725;7592.088949326006;7634.427417943676;7852.254035866584;7919.445638805229;480.1453412924999;523.2700382965818;559.975245301098;576.4869266352949;576.8010036537388;3623.655752703489;3676.062604035954;3697.507528353064;3788.412796016622;3806.2958352704836;104405.47797260965;104596.47701761442;110998;112489;116076.41961790306;86936.56531717427;93450.53274733583;93644;94907;95082.52458737663;82895;83390;84748;85044.14955850485;85554;7000.404965577983;7078.4691148163065;7109.431245500244;7178.712851486091;7206.207317195;31707.524387134672;38691.39258222578;40734.38898416467;40903.59096408998;43365.783171083945;40300;55039;55142.72428637831;56044.43955560392;57075.42924570701;11520.596779112691;11551.826722599335;11585.88414115848;11603.709907252387;11749.060075194135;12445.751084978068;12616.684582885502;12713.8092928608;13155.210687358407;13549.729005420033;11892;12175.939120304341;12520.31138287403;12638.810417843924;12639.620811375673;11657.242279251821;11904.58333958342;11952.924236818728;12466.56367027186;12492.687682808002;11419.200655954335;11646.184767066563;12023.519059237882;12407.25556466615;12408.75182496327;9630.874658979212;10372.27394082407;10681.03870651645;10823.891761082603;10912.781744365227;9090.909090909006;9203.35576509638;10102.595896164365;10130.594776209164;10140.543675534765 00:47:58 INFO - PROCESS | 13485 | __end_tp_report 00:47:58 INFO - PROCESS | 13485 | __start_cc_report 00:47:58 INFO - PROCESS | 13485 | _x_x_mozilla_cycle_collect,1140 00:47:58 INFO - PROCESS | 13485 | __end_cc_report 00:47:58 INFO - PROCESS | 13485 | __startTimestamp1469605678047__endTimestamp 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | ------- Summary: start ------- 00:47:58 INFO - PROCESS | 13485 | Number of tests: 6 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#0] dojo.html Cycles:165 Average:4695.97 Median:4782.95 stddev:482.39 (10.1%) stddev-sans-first:455.30 00:47:58 INFO - PROCESS | 13485 | Values: 2611.0 2622.0 2650.4 2667.9 2672.3 4586.4 4683.4 4729.5 4764.4 4783.0 4640.3 4686.2 4698.2 4741.4 4772.0 4356.6 4410.0 4419.1 4461.8 4464.0 4362.3 4401.5 4428.9 4436.9 4477.5 4473.2 4503.5 4529.2 4534.5 4534.8 4258.6 4303.7 4442.9 4484.4 4486.9 4278.9 4310.2 4317.3 4363.0 4380.3 4685.2 4698.6 4756.7 4766.4 4768.1 4913.1 5031.8 5048.5 5062.5 5095.9 4978.4 4979.1 5012.9 5076.6 5098.6 4735.0 4738.8 4749.1 4752.1 4759.8 5023.3 5122.6 5209.3 5214.6 5219.3 4958.7 5018.2 5039.5 5040.1 5042.5 5062.8 5077.5 5108.1 5125.8 5134.7 4896.1 4948.4 5011.9 5013.0 5064.9 4983.4 5050.4 5067.9 5125.4 5150.6 4327.0 4332.0 4336.9 4365.9 4377.4 3784.2 3811.0 3839.4 3839.7 3840.4 4258.4 4349.9 4393.7 4403.8 4405.7 5151.3 5152.9 5154.4 5154.7 5189.3 4383.6 4415.5 4425.5 4451.8 4470.2 4424.1 4506.9 4535.7 4538.2 4602.6 4759.3 4774.1 4775.0 4805.0 4836.6 5082.8 5112.6 5117.5 5133.2 5135.7 4604.7 4654.6 4722.1 4737.5 4835.0 5036.1 5036.5 5036.9 5052.9 5060.8 5083.2 5090.1 5092.4 5096.4 5136.3 4777.5 4829.0 4830.1 4962.3 4964.3 4866.7 4932.5 4948.6 4960.5 5001.7 4870.3 4892.5 4918.7 4926.4 4933.7 4861.1 4893.8 4956.8 4966.3 4990.7 4864.3 4864.4 4872.5 4874.8 4900.5 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#1] ext.html Cycles:180 Average:46725.45 Median:37251.94 stddev:88612.94 (237.9%) stddev-sans-first:88793.69 00:47:58 INFO - PROCESS | 13485 | Values: 545.6 571.8 580.8 583.2 594.9 29768.9 29850.6 30383.2 30760.4 32906.3 41590.6 41977.8 41978.8 41986.6 41991.8 7794.2 7921.0 7929.5 7935.8 7939.1 7743.5 7745.1 7754.9 7778.5 7780.0 7822.6 7870.2 7876.4 7883.7 7886.3 7805.8 7835.6 7839.0 7842.8 7846.8 7641.3 7691.5 7697.3 7713.7 7719.3 38666.6 38752.0 38913.6 39131.0 39167.8 2898.7 3030.3 3185.2 3490.5 3624.0 29634.7 29750.6 30122.8 30216.4 30325.4 2831.2 2847.2 2864.5 2898.6 2900.2 187858.1 188196.0 188380.0 188756.1 189609.0 31993.7 54142.0 54170.5 54470.7 54554.7 32429.8 34060.8 34216.7 34269.1 34282.5 13338.5 13400.0 13400.1 13413.3 13421.7 11041.9 11082.7 11087.1 11111.1 11130.7 7871.0 7881.8 7910.7 7970.0 7982.8 3064.3 3088.3 3098.9 3123.1 3130.9 789.8 841.9 849.4 925.1 932.9 26706.9 27547.9 27905.6 28109.7 28110.9 743.9 909.3 916.7 918.3 1007.3 13446.6 14513.4 14702.9 15386.7 15892.2 428229.0 429111.0 429810.0 432556.0 433144.0 52339.5 52652.0 52686.2 52758.0 52762.2 1079.6 1141.2 1183.5 1186.9 1208.3 27677.0 28749.3 29079.9 29228.4 29893.6 42510.4 43395.0 43409.6 43466.1 43533.1 315996.0 318915.0 319129.0 319707.0 402942.0 35727.3 38318.8 38576.8 38923.0 39001.2 42268.8 42993.4 43014.8 43052.1 43289.0 36081.0 36560.0 36692.0 37354.8 37529.6 36682.3 37340.1 37411.6 37493.0 38150.8 35733.3 36108.1 36539.3 36893.6 37163.8 31847.7 33327.0 33967.7 34195.8 34244.0 24925.8 25340.5 25767.0 25835.6 26039.7 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#2] jquery.html Cycles:180 Average:24956.58 Median:5129.91 stddev:67222.32 (1310.4%) stddev-sans-first:67385.50 00:47:58 INFO - PROCESS | 13485 | Values: 349.0 370.3 377.4 381.3 392.8 13060.3 16488.3 16635.7 17520.6 18578.5 17280.4 17576.7 17950.1 18126.6 18133.2 4808.5 5143.7 5161.6 5163.2 5175.0 3761.9 5118.9 5137.0 5188.7 5664.1 5937.1 5998.9 6012.0 6028.6 6029.1 5850.9 5871.0 5871.8 5889.4 6011.0 5104.7 5115.5 5120.5 5124.4 5135.5 20862.3 21394.0 21499.8 21548.6 21609.5 1769.6 1810.5 1825.1 1902.3 1941.2 12909.9 13612.4 13927.7 14196.6 14442.4 1661.1 1663.3 1684.6 1704.7 1796.1 68266.7 69763.0 70961.0 71412.0 72347.3 9208.9 9366.6 9402.0 9466.7 9521.3 12314.8 12360.4 12400.7 12412.8 12479.9 7382.4 7412.3 7435.1 7574.3 7619.9 7279.3 7333.5 7545.2 7561.2 7562.5 5888.6 6080.3 6172.1 6189.6 6245.9 1616.9 1648.4 1648.8 1659.5 1773.1 809.0 845.7 885.4 909.5 914.4 16932.4 17357.2 17866.6 17989.6 18362.6 825.7 847.4 870.3 884.3 884.5 9737.5 10224.5 10224.9 10275.8 10323.7 401512.0 409001.0 409159.0 409731.0 411114.0 71826.6 74144.0 74702.6 74891.0 75711.6 907.0 919.8 934.4 939.8 948.4 14481.2 15723.1 16107.5 16420.0 16493.7 36791.4 38088.0 38350.2 38688.8 38705.4 49284.5 50148.0 51122.5 51490.0 53318.7 6739.2 6876.8 6901.1 7382.9 8015.7 10505.9 11389.4 11437.1 11490.3 11574.8 9623.8 9723.8 9769.6 9920.4 10117.2 9681.7 9827.5 9969.1 10021.3 10413.7 9522.5 9783.2 9806.3 10073.0 10187.9 6959.0 6987.5 7003.9 7140.5 7297.8 9474.8 9485.8 9699.4 10007.3 10030.2 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#3] mootools.html Cycles:180 Average:5159.94 Median:5039.29 stddev:2944.55 (58.4%) stddev-sans-first:2938.14 00:47:58 INFO - PROCESS | 13485 | Values: 1249.7 1358.8 1394.7 1442.4 1658.1 6836.2 7761.1 8014.9 8023.6 8307.6 7886.9 7951.5 7964.0 7965.0 7968.5 2206.2 2231.2 2236.7 2237.0 2237.8 2174.5 2230.2 2243.3 2243.8 2247.4 2194.4 2199.1 2205.8 2206.3 2242.6 2128.9 2152.8 2153.4 2157.9 2160.4 2121.0 2121.8 2125.1 2126.6 2127.3 7875.6 7910.1 7961.3 7963.4 7968.5 4413.0 4660.8 4662.3 4703.7 4706.1 2730.1 2830.9 2880.1 2886.0 2913.5 944.0 947.7 960.1 964.9 965.8 10800.4 10900.9 10903.4 10973.1 10973.3 4154.1 4178.2 4229.7 4266.8 4321.3 8475.2 8478.8 8479.4 8485.0 8503.4 4513.8 4515.3 4517.1 4517.7 4517.7 3632.9 4014.2 4157.0 4157.6 4216.2 3624.4 3759.9 3810.3 3853.6 3876.2 1179.9 1188.0 1193.8 1210.8 1239.8 679.6 718.4 791.2 819.8 833.1 4989.8 5088.8 5190.2 5198.7 5458.9 409.9 410.8 412.9 413.5 415.7 3486.9 3500.5 3558.8 3561.7 3658.4 9443.8 9868.5 9879.8 9898.8 9900.0 9799.2 9809.0 9820.1 9824.7 9840.9 7355.4 7406.6 7429.2 7504.4 7570.1 5090.0 5115.4 5132.1 5196.3 5223.0 8887.2 8980.7 9072.5 9093.8 9174.3 9149.3 9322.4 9360.7 9455.0 9468.2 5914.1 6261.9 6981.7 7026.3 7061.2 7364.3 7664.5 7678.1 7678.4 7682.6 6606.4 6713.4 6744.6 6747.3 6760.7 6840.0 6949.4 6950.2 6967.5 7024.9 6380.8 6466.7 6473.1 6479.9 6488.9 4518.4 4556.4 4578.5 4644.4 4646.3 4532.0 4585.2 4598.9 4664.7 4726.6 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#4] prototype.html Cycles:180 Average:4116.17 Median:4708.85 stddev:1170.05 (24.8%) stddev-sans-first:1137.86 00:47:58 INFO - PROCESS | 13485 | Values: 307.0 310.4 317.0 319.9 321.8 4747.4 4771.2 4775.3 4787.0 4802.7 4467.5 4575.6 4589.2 4595.8 4708.9 3674.4 3685.3 3723.8 3760.1 3771.7 3776.8 3780.3 3782.6 3795.4 3800.6 3676.2 3735.3 3758.5 3761.9 3813.4 3715.5 3718.9 3724.6 3744.5 3748.4 3298.1 3312.6 3329.2 3330.1 3338.0 4655.6 4668.6 4674.5 4675.9 4708.8 4175.6 4266.5 4268.3 4315.7 4349.6 4894.8 4904.9 4926.8 4931.6 4931.6 3663.2 3669.5 3671.5 3687.8 3701.2 4915.6 5166.8 5209.0 5212.5 5221.8 3640.6 3642.9 3660.8 3674.5 3681.2 3713.2 3727.4 3729.6 3731.3 3737.7 4232.8 4255.6 4260.8 4262.1 4262.5 4702.4 4912.8 4913.3 4926.6 5036.8 1266.3 1278.3 1285.4 1286.4 1291.5 820.1 833.3 835.8 848.6 860.5 4364.0 4364.9 4365.5 4369.2 4378.3 5028.7 5041.1 5054.9 5055.9 5074.4 4259.8 4351.5 4398.2 4419.6 4435.9 2661.5 2676.5 2676.6 2677.7 2685.7 4759.8 4762.1 4779.3 4807.9 4823.8 4907.7 5110.9 5170.6 5177.8 5183.5 4757.5 4765.4 4768.1 4769.7 4773.2 4999.4 5007.3 5029.9 5048.7 5052.3 4841.8 4869.3 4952.8 4966.8 4968.6 4748.6 4759.7 4783.0 4786.4 4788.9 3648.5 3653.3 3654.5 3662.3 3679.5 4900.4 4971.2 5087.3 5088.4 5095.4 4861.8 4866.0 4870.5 4875.8 4890.3 4867.3 4870.8 4881.2 4921.0 4933.8 4661.0 4809.8 4821.2 4821.7 4843.2 4774.6 4902.6 4904.6 4914.9 4994.3 4796.2 4809.3 4811.8 4871.9 4902.0 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - PROCESS | 13485 | [#5] yui.html Cycles:180 Average:18177.13 Median:21922.96 stddev:27406.55 (125.0%) stddev-sans-first:27451.54 00:47:58 INFO - PROCESS | 13485 | Values: 566.3 611.8 660.2 665.1 682.7 12291.6 12682.9 12836.8 13197.8 13201.9 12683.5 13061.4 13086.7 13155.8 13208.9 751.2 777.6 784.3 784.4 785.2 783.0 786.4 786.7 786.9 787.0 804.9 809.0 809.4 810.0 811.1 807.0 807.2 807.7 807.7 807.8 589.3 592.4 593.9 594.4 595.0 11777.8 11784.5 11792.1 11794.6 12269.3 12284.1 12853.1 12873.5 12926.7 13149.9 9761.9 9793.1 10032.8 10153.5 10417.1 3146.6 3170.5 3175.9 3184.1 3221.3 64744.4 65179.0 65468.7 65594.7 67108.3 8687.0 8881.2 8890.3 8933.7 9357.9 18795.2 18802.8 18805.0 18805.6 18860.2 6449.6 6491.1 6501.4 6503.2 6568.8 3423.1 3578.6 3726.8 3812.3 3855.9 2702.8 2796.2 2806.8 2808.8 2810.8 490.0 502.9 518.0 522.5 534.9 498.4 510.2 522.7 522.8 525.0 7042.5 7592.1 7634.4 7852.3 7919.4 480.1 523.3 560.0 576.5 576.8 3623.7 3676.1 3697.5 3788.4 3806.3 104405.5 104596.5 110998.0 112489.0 116076.4 86936.6 93450.5 93644.0 94907.0 95082.5 82895.0 83390.0 84748.0 85044.1 85554.0 7000.4 7078.5 7109.4 7178.7 7206.2 31707.5 38691.4 40734.4 40903.6 43365.8 40300.0 55039.0 55142.7 56044.4 57075.4 11520.6 11551.8 11585.9 11603.7 11749.1 12445.8 12616.7 12713.8 13155.2 13549.7 11892.0 12175.9 12520.3 12638.8 12639.6 11657.2 11904.6 11952.9 12466.6 12492.7 11419.2 11646.2 12023.5 12407.3 12408.8 9630.9 10372.3 10681.0 10823.9 10912.8 9090.9 9203.4 10102.6 10130.6 10140.5 00:47:58 INFO - PROCESS | 13485 | -------- Summary: end -------- 00:47:58 INFO - PROCESS | 13485 | 00:47:58 INFO - TEST-INFO | 13485: exit 0 00:47:58 INFO - TEST-OK | dromaeo_css | took 1120150ms 00:47:58 INFO - TEST-START | kraken 00:47:58 INFO - operating with platform_type : linux_ 00:47:58 INFO - Initialising browser for kraken test... 00:47:58 INFO - TEST-INFO | started process 13676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3aGzIR/profile http://localhost:42605/getInfo.html) 00:48:02 INFO - PROCESS | 13676 | JavaScript error: , line 0: uncaught exception: undefined 00:48:03 INFO - PROCESS | 13676 | __metrics Screen width/height:1600/1200 00:48:03 INFO - PROCESS | 13676 | colorDepth:24 00:48:03 INFO - PROCESS | 13676 | Browser inner width/height: 1024/697 00:48:03 INFO - PROCESS | 13676 | __metrics 00:48:04 INFO - PROCESS | 13676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:48:04 INFO - PROCESS | 13676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:48:05 INFO - TEST-INFO | 13676: exit 0 00:48:05 INFO - Browser initialized. 00:48:05 INFO - Running cycle 1/1 for kraken test... 00:48:05 INFO - TEST-INFO | started process 13756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3aGzIR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:17 INFO - PROCESS | 13756 | RSS: Main: 159240192 00:48:17 INFO - PROCESS | 13756 | 00:48:19 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42605/tests/kraken/driver.html?testName=audio-beat-detection) 00:48:20 INFO - PROCESS | 13756 | RSS: Main: 214970368 00:48:20 INFO - PROCESS | 13756 | 00:48:23 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42605/tests/kraken/driver.html?testName=audio-dft) 00:48:23 INFO - PROCESS | 13756 | RSS: Main: 192888832 00:48:23 INFO - PROCESS | 13756 | 00:48:27 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42605/tests/kraken/driver.html?testName=audio-fft) 00:48:27 INFO - PROCESS | 13756 | RSS: Main: 271966208 00:48:27 INFO - PROCESS | 13756 | 00:48:30 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42605/tests/kraken/driver.html?testName=audio-oscillator) 00:48:30 INFO - PROCESS | 13756 | RSS: Main: 182108160 00:48:30 INFO - PROCESS | 13756 | 00:48:32 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:48:33 INFO - PROCESS | 13756 | RSS: Main: 186507264 00:48:33 INFO - PROCESS | 13756 | 00:48:36 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42605/tests/kraken/driver.html?testName=imaging-darkroom) 00:48:37 INFO - PROCESS | 13756 | RSS: Main: 222994432 00:48:37 INFO - PROCESS | 13756 | 00:48:40 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42605/tests/kraken/driver.html?testName=imaging-desaturate) 00:48:41 INFO - PROCESS | 13756 | RSS: Main: 222388224 00:48:41 INFO - PROCESS | 13756 | 00:48:44 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42605/tests/kraken/driver.html?testName=json-parse-financial) 00:48:44 INFO - PROCESS | 13756 | RSS: Main: 222224384 00:48:44 INFO - PROCESS | 13756 | 00:48:46 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:48:47 INFO - PROCESS | 13756 | RSS: Main: 187031552 00:48:47 INFO - PROCESS | 13756 | 00:48:49 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:48:49 INFO - PROCESS | 13756 | RSS: Main: 193695744 00:48:49 INFO - PROCESS | 13756 | 00:48:51 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:48:52 INFO - PROCESS | 13756 | RSS: Main: 197500928 00:48:52 INFO - PROCESS | 13756 | 00:48:55 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:48:55 INFO - PROCESS | 13756 | RSS: Main: 191315968 00:48:55 INFO - PROCESS | 13756 | 00:48:58 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:48:59 INFO - PROCESS | 13756 | RSS: Main: 195055616 00:48:59 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | Cycle 1(1): loaded http://localhost:42605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42605/tests/kraken/driver.html?testName=ai-astar) 00:49:01 INFO - PROCESS | 13756 | RSS: Main: 245653504 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | __start_tp_report 00:49:01 INFO - PROCESS | 13756 | _x_x_mozilla_page_load 00:49:01 INFO - PROCESS | 13756 | _x_x_mozilla_page_load_details 00:49:01 INFO - PROCESS | 13756 | |i|pagename|runs| 00:49:01 INFO - PROCESS | 13756 | |0;ai-astar;105;112;113;112;114;112;112;113;114;112 00:49:01 INFO - PROCESS | 13756 | |1;audio-beat-detection;156;122;122;185;123;124;150;122;186;123 00:49:01 INFO - PROCESS | 13756 | |2;audio-dft;163;162;163;162;163;161;161;160;161;161 00:49:01 INFO - PROCESS | 13756 | |3;audio-fft;76;76;76;120;77;77;76;75;104;76 00:49:01 INFO - PROCESS | 13756 | |4;audio-oscillator;85;86;111;85;86;86;127;85;85;133 00:49:01 INFO - PROCESS | 13756 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;117;117 00:49:01 INFO - PROCESS | 13756 | |6;imaging-darkroom;148;147;149;148;148;146;147;147;147;146 00:49:01 INFO - PROCESS | 13756 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;94 00:49:01 INFO - PROCESS | 13756 | |8;json-parse-financial;64;63;63;63;63;63;64;64;63;62 00:49:01 INFO - PROCESS | 13756 | |9;json-stringify-tinderbox;66;65;65;65;65;66;65;66;66;66 00:49:01 INFO - PROCESS | 13756 | |10;stanford-crypto-aes;81;81;78;79;79;80;78;79;79;84 00:49:01 INFO - PROCESS | 13756 | |11;stanford-crypto-ccm;140;133;132;137;131;136;128;130;174;130 00:49:01 INFO - PROCESS | 13756 | |12;stanford-crypto-pbkdf2;164;163;166;164;165;165;165;168;166;171 00:49:01 INFO - PROCESS | 13756 | |13;stanford-crypto-sha256-iterative;67;67;68;68;69;75;66;66;66;66 00:49:01 INFO - PROCESS | 13756 | __end_tp_report 00:49:01 INFO - PROCESS | 13756 | __start_cc_report 00:49:01 INFO - PROCESS | 13756 | _x_x_mozilla_cycle_collect,1930 00:49:01 INFO - PROCESS | 13756 | __end_cc_report 00:49:01 INFO - PROCESS | 13756 | __startTimestamp1469605741318__endTimestamp 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | ------- Summary: start ------- 00:49:01 INFO - PROCESS | 13756 | Number of tests: 14 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.56 (2.3%) stddev-sans-first:0.87 00:49:01 INFO - PROCESS | 13756 | Values: 105.0 112.0 113.0 112.0 114.0 112.0 112.0 113.0 114.0 112.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:137.00 stddev:26.43 (19.3%) stddev-sans-first:27.49 00:49:01 INFO - PROCESS | 13756 | Values: 156.0 122.0 122.0 185.0 123.0 124.0 150.0 122.0 186.0 123.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 00:49:01 INFO - PROCESS | 13756 | Values: 163.0 162.0 163.0 162.0 163.0 161.0 161.0 160.0 161.0 161.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.60 (20.5%) stddev-sans-first:16.32 00:49:01 INFO - PROCESS | 13756 | Values: 76.0 76.0 76.0 120.0 77.0 77.0 76.0 75.0 104.0 76.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.24 (22.6%) stddev-sans-first:19.92 00:49:01 INFO - PROCESS | 13756 | Values: 85.0 86.0 111.0 85.0 86.0 86.0 127.0 85.0 85.0 133.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 00:49:01 INFO - PROCESS | 13756 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 00:49:01 INFO - PROCESS | 13756 | Values: 148.0 147.0 149.0 148.0 148.0 146.0 147.0 147.0 147.0 146.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:49:01 INFO - PROCESS | 13756 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 00:49:01 INFO - PROCESS | 13756 | Values: 64.0 63.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 62.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 00:49:01 INFO - PROCESS | 13756 | Values: 66.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:1.81 (2.3%) stddev-sans-first:1.87 00:49:01 INFO - PROCESS | 13756 | Values: 81.0 81.0 78.0 79.0 79.0 80.0 78.0 79.0 79.0 84.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:134.50 stddev:13.48 (10.0%) stddev-sans-first:14.25 00:49:01 INFO - PROCESS | 13756 | Values: 140.0 133.0 132.0 137.0 131.0 136.0 128.0 130.0 174.0 130.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:2.31 (1.4%) stddev-sans-first:2.37 00:49:01 INFO - PROCESS | 13756 | Values: 164.0 163.0 166.0 164.0 165.0 165.0 165.0 168.0 166.0 171.0 00:49:01 INFO - PROCESS | 13756 | 00:49:01 INFO - PROCESS | 13756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.74 (4.1%) stddev-sans-first:2.89 00:49:01 INFO - PROCESS | 13756 | Values: 67.0 67.0 68.0 68.0 69.0 75.0 66.0 66.0 66.0 66.0 00:49:01 INFO - PROCESS | 13756 | -------- Summary: end -------- 00:49:01 INFO - PROCESS | 13756 | 00:49:02 INFO - TEST-INFO | 13756: exit 0 00:49:02 INFO - TEST-OK | kraken | took 63504ms 00:49:02 INFO - SUITE-END | took 1183s 00:49:02 INFO - Completed test suite (00:19:43) 00:49:02 INFO - javascript benchmark 00:49:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.960835587466, 2621.9737802621967, 2650.3639126609614, 2667.906623268185, 2672.3452754075256, 4586.38083858679, 4683.437987441512, 4729.527047295269, 4764.356811830397, 4782.952170478294, 4640.327152562876, 4686.179918514264, 4698.177818881691, 4741.431028276603, 4771.976140119304, 4356.629686476637, 4410.029793445453, 4419.071994881071, 4461.821527138911, 4464.0179160584785, 4362.25841606926, 4401.515833258339, 4428.889277768049, 4436.933445998313, 4477.48508921475, 4473.194824931511, 4503.527129651388, 4529.23003089474, 4534.478534968488, 4534.818607255722, 4258.552851950562, 4303.677224208197, 4442.866713998553, 4484.439445069366, 4486.910261794778, 4278.935815962763, 4310.202612516695, 4317.266064768997, 4363.018320877809, 4380.3210502372185, 4685.203515402356, 4698.600618947359, 4756.738379389132, 4766.356541866873, 4768.094062128219, 4913.115639184945, 5031.84904452867, 5048.495150484922, 5062.519060689228, 5095.949040509585, 4978.4025916890205, 4979.128652485801, 5012.899742005139, 5076.6192535559985, 5098.59211263098, 4735.029318989599, 4738.763061846894, 4749.145153872267, 4752.120857641313, 4759.809607615656, 5023.34696489454, 5122.564582010496, 5209.296744939385, 5214.582833373321, 5219.321488206509, 4958.727270000185, 5018.197088465828, 5039.546440820343, 5040.143175660147, 5042.4705405931845, 5062.848114556569, 5077.543021128116, 5108.106081435808, 5125.7693403796175, 5134.666246693953, 4896.11869863428, 4948.430930443045, 5011.949880501148, 5013.0, 5064.898702026013, 4983.401991761012, 5050.393952725696, 5067.87330316745, 5125.384953805493, 5150.6137039721425, 4327.0, 4332.0, 4336.934945975813, 4365.904365904384, 4377.365282034088, 3784.2242340320167, 3810.980945095312, 3839.424086387064, 3839.673627741673, 3840.385538313856, 4258.403823464655, 4349.891252718708, 4393.692441529126, 4403.801828917706, 4405.669574781904, 5151.25306830515, 5152.896942061137, 5154.407243167084, 5154.742262886841, 5189.325387699575, 4383.561643835655, 4415.51429342772, 4425.491068527096, 4451.844185453494, 4470.240059189946, 4424.13729322779, 4506.932396014063, 4535.682502224812, 4538.205813982539, 4602.608778253819, 4759.309900064402, 4774.069056533943, 4775.044991001744, 4805.038992201504, 4836.588889944253, 5082.822101226439, 5112.616553758408, 5117.513836185556, 5133.153029750049, 5135.7432128394175, 4604.723716577016, 4654.557817007379, 4722.079194557028, 4737.455192652889, 4834.975825120852, 5036.118679231193, 5036.471170527188, 5036.8992620146655, 5052.873678157928, 5060.797568097235, 5083.186690129562, 5090.134677104827, 5092.439831618445, 5096.413912400121, 5136.2552429898205, 4777.522247775195, 4828.975855120702, 4830.106430310263, 4962.255661650781, 4964.280179374043, 4866.707997520019, 4932.482089380564, 4948.554630083309, 4960.47914968923, 5001.749912504288, 4870.318155458168, 4892.486288939753, 4918.704877707349, 4926.4088309403105, 4933.654644174873, 4861.1006963710415, 4893.755312234302, 4956.826511072095, 4966.255061740623, 4990.6506544541535, 4864.343313652612, 4864.440589332272, 4872.4883887192755, 4874.829380971649, 4900.460949295503], "value": 4665.540297044431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5673808134418, 571.8084441712026, 580.7822066724979, 583.224311665485, 594.940505949405, 29768.851155744218, 29850.552241716392, 30383.240418989535, 30760.38479230417, 32906.34187316252, 41590.58409415905, 41977.7901110494, 41978.790106049506, 41986.58013419865, 41991.79004104975, 7794.181610930856, 7921.04947406312, 7929.5242285463055, 7935.841283174362, 7939.126696063428, 7743.4966727162555, 7745.1093124290865, 7754.922450775504, 7778.455508114434, 7780.0, 7822.647980840876, 7870.212978702112, 7876.448648594601, 7883.684652613889, 7886.250806173433, 7805.765827025199, 7835.569043702594, 7839.0, 7842.803929901798, 7846.803829904241, 7641.3122818946, 7691.461597688164, 7697.268759467842, 7713.730019449348, 7719.3052625263435, 38666.61333386658, 38752.0, 38913.61086389157, 39131.0, 39167.804160979016, 2898.7101289871057, 3030.3484750778466, 3185.2196211928226, 3490.5462289902152, 3624.039629498185, 29634.70365296341, 29750.553741693893, 30122.849385752932, 30216.395672086655, 30325.393492130035, 2831.1931099636504, 2847.188551262901, 2864.513032784411, 2898.5797059426263, 2900.1734505665995, 187858.06070969556, 188195.99999999863, 188380.0, 188756.0562197194, 189609.0, 31993.68006319907, 54142.0, 54170.45829541654, 54470.72764636151, 54554.72722636361, 32429.837850810596, 34060.82969585136, 34216.65783342135, 34269.14327141792, 34282.48576271358, 13338.533151339656, 13400.0, 13400.128991615515, 13413.262270575016, 13421.664458388423, 11041.889581104248, 11082.722931926766, 11087.05760010392, 11111.055560277468, 11130.666080017612, 7870.9606451967375, 7881.842363152705, 7910.694735368715, 7970.0, 7982.760517184493, 3064.2952121011845, 3088.336007758343, 3098.8760449582214, 3123.1099136746375, 3130.89041883533, 789.8420315936836, 841.9410641255054, 849.4181485682327, 925.1026504290827, 932.9160375566231, 26706.866465667936, 27547.86226068857, 27905.581416278772, 28109.71890281112, 28110.85944570264, 743.8623854586918, 909.3043821476575, 916.7478943290648, 918.3479729392207, 1007.2898606482412, 13446.596602101952, 14513.419463221353, 14702.926485367505, 15386.692266154614, 15892.205389730467, 428229.0, 429111.0, 429810.0, 432556.0, 433144.0, 52339.47660523346, 52652.0, 52686.209706854424, 52758.0, 52762.20856687153, 1079.6167360586878, 1141.2182654881433, 1183.47335435732, 1186.905047596173, 1208.256921992968, 27677.0, 28749.28126796847, 29079.85460072686, 29228.41543169082, 29893.551596726502, 42510.362344565474, 43395.0, 43409.565904340554, 43466.13067738564, 43533.12933741371, 315996.0, 318915.0, 319129.0, 319707.0, 402942.0, 35727.28545429129, 38318.80840595779, 38576.80711596424, 38923.0, 39001.219975599764, 42268.788656056524, 42993.355099674154, 43014.78492607517, 43052.13895722131, 43289.0, 36081.0, 36560.0, 36692.0, 37354.8132259337, 37529.62470375261, 36682.26635467329, 37340.06649833776, 37411.62588374082, 37493.0, 38150.80924595359, 35733.28533429265, 36108.09729756777, 36539.26921461609, 36893.631063690096, 37163.81418092892, 31847.681523185398, 33327.0, 33967.66032339645, 34195.82902085473, 34244.0, 24925.750742492342, 25340.49319013646, 25767.0, 25835.612465813403, 26039.739602604488], "value": 16503.39894473767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9877854275098, 370.34264181078584, 377.3867465368774, 381.2907991136486, 392.7682667226336, 13060.346982650864, 16488.340466381345, 16635.66728665426, 17520.64958700825, 18578.53553661159, 17280.395186168487, 17576.736348954775, 17950.10249487527, 18126.63746725068, 18133.184006719697, 4808.494274056212, 5143.665661731994, 5161.561267292284, 5163.199704045879, 5175.042617115827, 3761.9247615047684, 5118.9488105119035, 5136.974315128437, 5188.740562971855, 5664.1220610805185, 5937.109433584954, 5998.8800223995495, 6011.969940150293, 6028.63828170309, 6029.065494848283, 5850.853728656818, 5870.970645146747, 5871.79448719297, 5889.381614930414, 6010.969945150268, 5104.668196567211, 5115.462876397962, 5120.539151476385, 5124.359455068116, 5135.460776618476, 20862.26982055621, 21394.0, 21499.785002150093, 21548.569028619495, 21609.45976350588, 1769.5841477252836, 1810.4840120565707, 1825.12394050855, 1902.3436914264557, 1941.1847024249848, 12909.870901291055, 13612.387442565108, 13927.651808704763, 14196.574102776933, 14442.422303107864, 1661.1427158050951, 1663.3180396037567, 1684.6293815360723, 1704.6505466379363, 1796.119901248392, 68266.65866670685, 69763.0, 70961.0, 71412.0, 72347.27652723511, 9208.90791092094, 9366.578503967337, 9402.0, 9466.668666596635, 9521.28590355726, 12314.81527777084, 12360.381980900918, 12400.705869414187, 12412.751744965231, 12479.87520124787, 7382.446316526282, 7412.295831895961, 7435.107787065479, 7574.280443357872, 7619.885701714478, 7279.308465695751, 7333.523320984119, 7545.170031296553, 7561.2060733623275, 7562.546247225074, 5888.587798854039, 6080.300765411946, 6172.074188871705, 6189.597676151036, 6245.906311405332, 1616.854483096527, 1648.4148127414835, 1648.8186299507045, 1659.485559476566, 1773.1311657288095, 808.9838203235902, 845.6997765793178, 885.4023534114447, 909.490685216281, 914.4330515080693, 16932.407365742387, 17357.218925148398, 17866.642667146585, 17989.550261243312, 18362.632747345244, 825.6903661127077, 847.3771777743353, 870.3211495033884, 884.2969838978028, 884.509097450908, 9737.464439455898, 10224.539895704711, 10224.897751022394, 10275.845862312071, 10323.74190645225, 401512.0, 409001.0, 409159.0, 409731.0, 411114.0, 71826.64086679534, 74144.0, 74702.6264868683, 74891.0, 75711.62144189244, 906.977325566866, 919.7884486568126, 934.3833070173653, 939.7744541310036, 948.4498990585444, 14481.203533805741, 15723.135227562594, 16107.516774496784, 16420.0, 16493.67012659764, 36791.44812827756, 38088.0, 38350.23299534049, 38688.80655596704, 38705.4194187093, 49284.50715492799, 50148.0, 51122.48877511326, 51490.0, 53318.73340633272, 6739.191297044386, 6876.793696189123, 6901.068355772108, 7382.852342953218, 8015.719449819228, 10505.949405059433, 11389.430528473378, 11437.08503319749, 11490.31058136481, 11574.768504630028, 9623.759406014906, 9723.756906077404, 9769.609215631295, 9920.355176913477, 10117.190624749855, 9681.70954871355, 9827.508624568885, 9969.143598658624, 10021.298509104292, 10413.656927191321, 9522.476263805556, 9783.217342612432, 9806.264530160124, 10073.0, 10187.898121018696, 6958.965205173941, 6987.545809522365, 7003.859922801414, 7140.464465165237, 7297.817554561178, 9474.763130921781, 9485.762855928657, 9699.418034917928, 10007.29948903599, 10030.197584193393], "value": 8332.23330505887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.7125661097953, 1358.789387644915, 1394.700139470014, 1442.3581506229725, 1658.1377683604526, 6836.179658440988, 7761.107472640648, 8014.919850801491, 8023.5587042712705, 8307.626156822942, 7886.921130788691, 7951.4831535950125, 7964.044314682246, 7964.960175199116, 7968.521888686669, 2206.20576592427, 2231.1744654477866, 2236.709227800384, 2236.9888150559223, 2237.7762223777654, 2174.4781252499442, 2230.241717815942, 2243.25972429098, 2243.8317126215597, 2247.359502541776, 2194.3965409512352, 2199.1093607089074, 2205.845590808644, 2206.30501392061, 2242.607543679858, 2128.9041993110345, 2152.763196048433, 2153.3755210988793, 2157.9352619421365, 2160.3950893749775, 2121.0349291072525, 2121.7878212178657, 2125.08621292844, 2126.617208902397, 2127.329891084319, 7875.645595948196, 7910.090339610903, 7961.283484486424, 7963.4027447941635, 7968.521888686697, 4412.977935110304, 4660.790264438108, 4662.323963025342, 4703.670743047988, 4706.058788242365, 2730.1127133681434, 2830.9292267693268, 2880.1071667783053, 2885.9855700721573, 2913.533834586456, 943.9575219115087, 947.7346343023895, 960.078324808185, 964.8938616752151, 965.7682156282511, 10800.351978881292, 10900.890991090067, 10903.400312982783, 10973.122150227962, 10973.286736362112, 4154.1068670236045, 4178.1643671265265, 4229.703920725519, 4266.807993640294, 4321.330193819963, 8475.194856488624, 8478.830423391497, 8479.448835825775, 8484.957575212084, 8503.362247831437, 4513.796879140381, 4515.277555591089, 4517.141743068806, 4517.6837621366185, 4517.6837621366185, 3632.891013269606, 4014.197160567898, 4157.0, 4157.64660003897, 4216.177845320194, 3624.4200927851416, 3759.8684046058256, 3810.2950954073585, 3853.556840963269, 3876.1860009398342, 1179.9351035692948, 1188.043624881961, 1193.797054500737, 1210.7881120803825, 1239.7954337534386, 679.5548915460381, 718.4073139659802, 791.1692722641204, 819.7909533069029, 833.0752864320599, 4989.750512474362, 5088.821891233863, 5190.24741412493, 5198.740062996835, 5458.863528411742, 409.91801639672184, 410.76175818025473, 412.90503184267186, 413.4996654048635, 415.71108079884795, 3486.9476957845654, 3500.544929159193, 3558.768680035789, 3561.6794488495643, 3658.396364599811, 9443.811123777487, 9868.506574671237, 9879.802403952024, 9898.752531186634, 9899.950500247596, 9799.216062714966, 9809.0, 9820.116189542832, 9824.65613703517, 9840.901590983998, 7355.448341374418, 7406.555606663617, 7429.219931907072, 7504.437167212481, 7570.091589009354, 5090.032893750324, 5115.360579927509, 5132.076226279306, 5196.298499702491, 5222.97388513055, 8887.15572020657, 8980.685676001309, 9072.50101244438, 9093.818123637622, 9174.26605871542, 9149.313801464783, 9322.394044387092, 9360.719178424659, 9454.95272523633, 9468.195203407788, 5914.083317085859, 6261.906071408841, 6981.7207311709, 7026.262242464672, 7061.2232654409, 7364.263573642593, 7664.540127592362, 7678.1170165431695, 7678.385729141767, 7682.577458239851, 6606.43845273138, 6713.362230588086, 6744.5616034957575, 6747.257801641914, 6760.729570817112, 6840.0, 6949.4440444765305, 6950.20072691647, 6967.477439191979, 7024.894626580503, 6380.776672816429, 6466.741330346734, 6473.126127972663, 6479.870402591828, 6488.902666459912, 4518.36742856007, 4556.362109304634, 4578.45058592971, 4644.396228490275, 4646.3030545417105, 4531.954680453285, 4585.2488506896925, 4598.88502787433, 4664.720116792868, 4726.574608285271], "value": 4065.73016454903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.98925537606186, 310.4133188274162, 317.0362099218376, 319.88963807486414, 321.82943040188695, 4747.406574178228, 4771.165046116933, 4775.259834725619, 4786.976065119669, 4802.711837289765, 4467.486239082498, 4575.588197062264, 4589.151007063696, 4595.81616735331, 4708.882277943053, 3674.375356189441, 3685.262947410515, 3723.813809309537, 3760.0975765816142, 3771.7359784815076, 3776.7922764247955, 3780.3006443807844, 3782.6406491383273, 3795.411711184771, 3800.619938006205, 3676.191237927652, 3735.3276410246144, 3758.5113935188388, 3761.924761504782, 3813.3707938190164, 3715.516982792247, 3718.9070273243115, 3724.5902950675404, 3744.4570537271943, 3748.3815170496973, 3298.0541480526604, 3312.5528053712683, 3329.1510664780567, 3330.117518857505, 3337.9833100834585, 4655.627549796008, 4668.5564871337165, 4674.509176536449, 4675.859724208279, 4708.811647534095, 4175.645070169039, 4266.509351424564, 4268.3353492137785, 4315.654747620183, 4349.630281426083, 4894.828680996184, 4904.901901961976, 4926.802927882881, 4931.580815630676, 4931.630127740434, 3663.2124093320062, 3669.5229620149476, 3671.467637192592, 3687.8340474678434, 3701.241245544657, 4915.5821755150855, 5166.819161329373, 5208.973955130238, 5212.504812042887, 5221.791128354899, 3640.5995340512522, 3642.927141457156, 3660.7986560739414, 3674.467202255658, 3681.1533347330264, 3713.164537978933, 3727.440883867387, 3729.5524537055726, 3731.2910546995986, 3737.7383583149463, 4232.8359701082445, 4255.638270747021, 4260.8495706159165, 4262.126264115849, 4262.465512415528, 4702.36518070063, 4912.778924948386, 4913.31213630092, 4926.58124059459, 5036.823711170092, 1266.2845492296822, 1278.3288773393856, 1285.3637449462576, 1286.3825363825417, 1291.5092264939262, 820.1388542030963, 833.3333333333309, 835.7868743470376, 848.6181218451721, 860.5482121885934, 4363.978180109079, 4364.912701745948, 4365.497967733688, 4369.213541562549, 4378.321360189176, 5028.74856257193, 5041.117804384218, 5054.9241761373605, 5055.949440505621, 5074.3657042869645, 4259.829606815692, 4351.4995775485595, 4398.1643487737865, 4419.624331931822, 4435.933460998088, 2661.5076210901047, 2676.491466621336, 2676.585129304961, 2677.705452400234, 2685.7448542388443, 4759.785809638574, 4762.095201911695, 4779.3070004849105, 4807.903841923142, 4823.807047718122, 4907.6564640475535, 5110.923336149961, 5170.6380553360905, 5177.767000484987, 5183.533481986639, 4757.524247575215, 4765.355227848578, 4768.141734487756, 4769.689970151929, 4773.164696178224, 4999.375203058948, 5007.29897814299, 5029.874253143701, 5048.697078175322, 5052.292679025013, 4841.806327746851, 4869.3112006987, 4952.77712502931, 4966.751662416937, 4968.627352948471, 4748.620110391092, 4759.690620109682, 4782.95217047839, 4786.425628924551, 4788.880277993078, 3648.543932008499, 3653.324135035027, 3654.488371627921, 3662.340778659867, 3679.521662183899, 4900.387451568554, 4971.223128023831, 5087.3386459759995, 5088.4148322941855, 5095.414027386898, 4861.805527778849, 4866.0, 4870.488598697228, 4875.8049678012485, 4890.2909078184175, 4867.342908707279, 4870.829520966749, 4881.219004959189, 4921.047371577025, 4933.777979990838, 4661.0, 4809.831655892027, 4821.2045012572535, 4821.662483626113, 4843.152448321459, 4774.641901857305, 4902.583280421204, 4904.558589726942, 4914.91871788206, 4994.32576602154, 4796.160671882476, 4809.258722528125, 4811.831585894477, 4871.878203044952, 4901.975490122527], "value": 3748.94318940891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.2751677852349, 611.7981066248138, 660.247318057415, 665.1087542692792, 682.6723172877018, 12291.631251062472, 12682.873171268297, 12836.80744788829, 13197.80203296949, 13201.933990330059, 12683.492660293601, 13061.41223644936, 13086.672833179175, 13155.802662960063, 13208.867911320884, 751.1924680967968, 777.6228529163351, 784.3333166808225, 784.415610370275, 785.1912530094012, 782.9530228186298, 786.3551887452292, 786.6774622404815, 786.9055713314382, 786.9881951770728, 804.9436539442241, 808.9959550202241, 809.3565615335792, 809.9959500202491, 811.0753740735566, 807.0315621254518, 807.2492581898832, 807.6930766308794, 807.7092246791151, 807.8142027333716, 589.260478099986, 592.3898384663803, 593.8604427959426, 594.3580932592832, 594.9940500594982, 11777.764444711143, 11784.528618855236, 11792.1155913306, 11794.587189448328, 12269.263844169378, 12284.14011019229, 12853.100282980195, 12873.549425770147, 12926.741465170739, 13149.934250328688, 9761.902380976171, 9793.118619324296, 10032.849507257397, 10153.512389464555, 10417.062464378167, 3146.638136614296, 3170.4853753688267, 3175.888843890453, 3184.108449634083, 3221.291315910496, 64744.3525564743, 65179.0, 65468.67265663689, 65594.67202663956, 67108.32891671118, 8686.956565217133, 8881.24509416694, 8890.288776897833, 8933.73198804024, 9357.90642093584, 18795.15421806022, 18802.811971880106, 18805.0, 18805.62388752217, 18860.15129319184, 6449.645269510222, 6491.123698300763, 6501.447376972916, 6503.219613646393, 6568.770093046721, 3423.07576954221, 3578.5884623268657, 3726.795026273581, 3812.313783518993, 3855.8650447234213, 2702.8378297302224, 2796.189105159481, 2806.8315901046003, 2808.761255293282, 2810.803243772957, 489.96080313575544, 502.87679518518195, 517.9559737422286, 522.5245027025388, 534.9358077030781, 498.3521422151189, 510.1760656539736, 522.7125081205322, 522.8222404382528, 524.9711265880337, 7042.542234754725, 7592.088949326006, 7634.427417943676, 7852.254035866584, 7919.445638805229, 480.1453412924999, 523.2700382965818, 559.975245301098, 576.4869266352949, 576.8010036537388, 3623.655752703489, 3676.062604035954, 3697.507528353064, 3788.412796016622, 3806.2958352704836, 104405.47797260965, 104596.47701761442, 110998.0, 112489.0, 116076.41961790306, 86936.56531717427, 93450.53274733583, 93644.0, 94907.0, 95082.52458737663, 82895.0, 83390.0, 84748.0, 85044.14955850485, 85554.0, 7000.404965577983, 7078.4691148163065, 7109.431245500244, 7178.712851486091, 7206.207317195, 31707.524387134672, 38691.39258222578, 40734.38898416467, 40903.59096408998, 43365.783171083945, 40300.0, 55039.0, 55142.72428637831, 56044.43955560392, 57075.42924570701, 11520.596779112691, 11551.826722599335, 11585.88414115848, 11603.709907252387, 11749.060075194135, 12445.751084978068, 12616.684582885502, 12713.8092928608, 13155.210687358407, 13549.729005420033, 11892.0, 12175.939120304341, 12520.31138287403, 12638.810417843924, 12639.620811375673, 11657.242279251821, 11904.58333958342, 11952.924236818728, 12466.56367027186, 12492.687682808002, 11419.200655954335, 11646.184767066563, 12023.519059237882, 12407.25556466615, 12408.75182496327, 9630.874658979212, 10372.27394082407, 10681.03870651645, 10823.891761082603, 10912.781744365227, 9090.909090909006, 9203.35576509638, 10102.595896164365, 10130.594776209164, 10140.543675534765], "value": 6434.863876797409, "unit": "score"}], "name": "dromaeo_css", "value": 6306.84280005675, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 114.0, 112.0, 112.0, 113.0, 114.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 122.0, 185.0, 123.0, 124.0, 150.0, 122.0, 186.0, 123.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 163.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 120.0, 77.0, 77.0, 76.0, 75.0, 104.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 111.0, 85.0, 86.0, 86.0, 127.0, 85.0, 85.0, 133.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 78.0, 79.0, 79.0, 80.0, 78.0, 79.0, 79.0, 84.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 132.0, 137.0, 131.0, 136.0, 128.0, 130.0, 174.0, 130.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 164.0, 165.0, 165.0, 165.0, 168.0, 166.0, 171.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 69.0, 75.0, 66.0, 66.0, 66.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 00:49:02 INFO - Return code: 0 00:49:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:49:02 INFO - # TBPL SUCCESS # 00:49:02 INFO - Running post-action listener: _resource_record_post_action 00:49:02 INFO - [mozharness: 2016-07-27 07:49:02.623182Z] Finished run-tests step (success) 00:49:02 INFO - Running post-run listener: _resource_record_post_run 00:49:02 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537194496; Read time: 12; Write time: 416412 00:49:02 INFO - TinderboxPrint: CPU usage
13.0% 00:49:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:49:02 INFO - TinderboxPrint: I/O write bytes / time
537,194,496 / 416,412 00:49:02 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 00:49:02 INFO - TinderboxPrint: CPU user
1,199.2 (12.5%) 00:49:02 INFO - TinderboxPrint: Swap in / out
0 / 0 00:49:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252915712; Read time: 0; Write time: 233172 00:49:02 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284278784; Read time: 12; Write time: 183240 00:49:03 INFO - Running post-run listener: _upload_blobber_files 00:49:03 INFO - Blob upload gear active. 00:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:49:03 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 00:49:03 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:49:03 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:49:03 INFO - (blobuploader) - INFO - Open directory for files ... 00:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:09 INFO - (blobuploader) - INFO - Done attempting. 00:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:09 INFO - (blobuploader) - INFO - Done attempting. 00:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:10 INFO - (blobuploader) - INFO - Done attempting. 00:49:10 INFO - (blobuploader) - INFO - Iteration through files over. 00:49:10 INFO - Return code: 0 00:49:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:49:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:49:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce87ecb06c31e41ff792774300995ec193e48038d03d33c6acd54d1227cf2f6882c93a3c0f9b6693f1f4829a4580bd833ac32205d7947ec73db1096ef479da12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38706fe53ae2e2c76b7315a59a9405b8ca8dfffe6cd641e121f4ac7818f0c04bc4618b61eedf3d8e3673610b7e73917d6e49d4b685f17d21658427e3268ee0af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975bd3c2e7cfe8fa9dd9432b1163a3ebb21733626c1187009d845ba727ebadbba2f63f30647c01d2964d9dd1dd0f216f29c5cc50c8afe406708545f5b41c8d84"} 00:49:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:49:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:49:10 INFO - Contents: 00:49:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce87ecb06c31e41ff792774300995ec193e48038d03d33c6acd54d1227cf2f6882c93a3c0f9b6693f1f4829a4580bd833ac32205d7947ec73db1096ef479da12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38706fe53ae2e2c76b7315a59a9405b8ca8dfffe6cd641e121f4ac7818f0c04bc4618b61eedf3d8e3673610b7e73917d6e49d4b685f17d21658427e3268ee0af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975bd3c2e7cfe8fa9dd9432b1163a3ebb21733626c1187009d845ba727ebadbba2f63f30647c01d2964d9dd1dd0f216f29c5cc50c8afe406708545f5b41c8d84"} 00:49:10 INFO - Running post-run listener: copy_logs_to_upload_dir 00:49:10 INFO - Copying logs to upload dir... 00:49:10 INFO - mkdir: /builds/slave/test/build/upload/logs 00:49:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.995779 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-27 00:49:10.262525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 00:49:10.269187) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 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-Non-PGO/sha512/ce87ecb06c31e41ff792774300995ec193e48038d03d33c6acd54d1227cf2f6882c93a3c0f9b6693f1f4829a4580bd833ac32205d7947ec73db1096ef479da12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38706fe53ae2e2c76b7315a59a9405b8ca8dfffe6cd641e121f4ac7818f0c04bc4618b61eedf3d8e3673610b7e73917d6e49d4b685f17d21658427e3268ee0af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975bd3c2e7cfe8fa9dd9432b1163a3ebb21733626c1187009d845ba727ebadbba2f63f30647c01d2964d9dd1dd0f216f29c5cc50c8afe406708545f5b41c8d84"} build_url:https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/RxE--6hdRqGCkdFucG9RFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce87ecb06c31e41ff792774300995ec193e48038d03d33c6acd54d1227cf2f6882c93a3c0f9b6693f1f4829a4580bd833ac32205d7947ec73db1096ef479da12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38706fe53ae2e2c76b7315a59a9405b8ca8dfffe6cd641e121f4ac7818f0c04bc4618b61eedf3d8e3673610b7e73917d6e49d4b685f17d21658427e3268ee0af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975bd3c2e7cfe8fa9dd9432b1163a3ebb21733626c1187009d845ba727ebadbba2f63f30647c01d2964d9dd1dd0f216f29c5cc50c8afe406708545f5b41c8d84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 00:49:10.300061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:49:10.300638) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469604503.941837-749423849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 00:49:10.384465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 00:49:10.384970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 00:49:10.385506) ========= ========= Total master_lag: 0.19 =========