builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1470176691.25 results: success (0) buildid: 20160802123004 builduid: 8e3773f8af9641808f1b1be6d8c87889 revision: cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.251860) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.252399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.252694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.272375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.273108) ========= 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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 15:24:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-02 15:24:51 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.420308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.420704) ========= 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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.470937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:51.471256) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 --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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 15:24:51,509 truncating revision to first 12 chars 2016-08-02 15:24:51,509 Setting DEBUG logging. 2016-08-02 15:24:51,509 attempt 1/10 2016-08-02 15:24:51,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cfa39f8b7c54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 15:24:51,912 unpacking tar archive at: autoland-cfa39f8b7c54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:52.256057) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:52.256395) ========= script_repo_revision: cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:52.256807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:52.257101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 15:24:52.266863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-02 15:24:52.267239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:52 INFO - MultiFileLogger online at 20160802 15:24:52 in /builds/slave/test 15:24:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:24:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:52 INFO - {'append_to_log': False, 15:24:52 INFO - 'base_work_dir': '/builds/slave/test', 15:24:52 INFO - 'blob_upload_branch': 'Autoland', 15:24:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:52 INFO - 'branch': 'Autoland', 15:24:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:52 INFO - 'config_files': ('talos/linux_config.py',), 15:24:52 INFO - 'default_actions': ('clobber', 15:24:52 INFO - 'read-buildbot-config', 15:24:52 INFO - 'download-and-extract', 15:24:52 INFO - 'populate-webroot', 15:24:52 INFO - 'create-virtualenv', 15:24:52 INFO - 'install', 15:24:52 INFO - 'run-tests'), 15:24:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:52 INFO - 'download_minidump_stackwalk': True, 15:24:52 INFO - 'download_symbols': 'ondemand', 15:24:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:52 INFO - 'installer_path': 'installer.exe', 15:24:52 INFO - 'log_level': 'info', 15:24:52 INFO - 'log_name': 'talos', 15:24:52 INFO - 'log_to_console': True, 15:24:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:52 INFO - 'opt_config_files': (), 15:24:52 INFO - 'pip_index': False, 15:24:52 INFO - 'sps_profile': False, 15:24:52 INFO - 'sps_profile_interval': 0, 15:24:52 INFO - 'suite': 'dromaeojs', 15:24:52 INFO - 'system_bits': '32', 15:24:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:52 INFO - 'title': 'talos-linux64-ix-016', 15:24:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:52 INFO - 'use_talos_json': True, 15:24:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:52 INFO - 'work_dir': 'build'} 15:24:52 INFO - [mozharness: 2016-08-02 22:24:52.399266Z] Running clobber step. 15:24:52 INFO - Running pre-action listener: _resource_record_pre_action 15:24:52 INFO - Running main action method: clobber 15:24:52 INFO - rmtree: /builds/slave/test/build 15:24:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:53 INFO - Running post-action listener: _resource_record_post_action 15:24:53 INFO - [mozharness: 2016-08-02 22:24:53.376053Z] Finished clobber step (success) 15:24:53 INFO - [mozharness: 2016-08-02 22:24:53.376154Z] Running read-buildbot-config step. 15:24:53 INFO - Running pre-action listener: _resource_record_pre_action 15:24:53 INFO - Running main action method: read_buildbot_config 15:24:53 INFO - Using buildbot properties: 15:24:53 INFO - { 15:24:53 INFO - "project": "", 15:24:53 INFO - "product": "firefox", 15:24:53 INFO - "script_repo_revision": "production", 15:24:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:24:53 INFO - "repository": "", 15:24:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:24:53 INFO - "buildid": "20160802123004", 15:24:53 INFO - "pgo_build": "True", 15:24:53 INFO - "basedir": "/builds/slave/test", 15:24:53 INFO - "buildnumber": 76, 15:24:53 INFO - "slavename": "talos-linux64-ix-016", 15:24:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:53 INFO - "platform": "ubuntu64_hw", 15:24:53 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:24:53 INFO - "branch": "autoland", 15:24:53 INFO - "repo_path": "integration/autoland", 15:24:53 INFO - "revision": "cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15", 15:24:53 INFO - "stage_platform": "linux64-pgo", 15:24:53 INFO - "builduid": "8e3773f8af9641808f1b1be6d8c87889", 15:24:53 INFO - "slavebuilddir": "test" 15:24:53 INFO - } 15:24:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:24:53 INFO - Running post-action listener: _resource_record_post_action 15:24:53 INFO - [mozharness: 2016-08-02 22:24:53.378575Z] Finished read-buildbot-config step (success) 15:24:53 INFO - [mozharness: 2016-08-02 22:24:53.378664Z] Running download-and-extract step. 15:24:53 INFO - Running pre-action listener: _resource_record_pre_action 15:24:53 INFO - Running main action method: download_and_extract 15:24:53 INFO - mkdir: /builds/slave/test/build/tests 15:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:53 INFO - https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:24:56 INFO - Downloaded 1361 bytes. 15:24:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:56 INFO - Using the following test package requirements: 15:24:56 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:56 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:56 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:24:56 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'jsshell-linux-x86_64.zip'], 15:24:56 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:56 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:56 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:24:56 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:24:56 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:56 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:56 INFO - https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:24:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:24:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:25:00 INFO - Downloaded 21810631 bytes. 15:25:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:25:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:25:01 INFO - Return code: 0 15:25:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:25: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')]} 15:25:01 INFO - https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:25:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:25:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:25:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:25:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:25:04 INFO - Downloaded 21810631 bytes. 15:25:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:25:05 INFO - Return code: 0 15:25:05 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')]} 15:25:05 INFO - https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:25:06 INFO - Downloaded 14413723 bytes. 15:25:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:25:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:25:06 INFO - Return code: 0 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:06 INFO - https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:25:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:25:08 INFO - Downloaded 59364646 bytes. 15:25:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:08 INFO - mkdir: /builds/slave/test/properties 15:25:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:08 INFO - Contents: 15:25:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:08 INFO - Running post-action listener: _resource_record_post_action 15:25:08 INFO - Running post-action listener: set_extra_try_arguments 15:25:08 INFO - [mozharness: 2016-08-02 22:25:08.812926Z] Finished download-and-extract step (success) 15:25:08 INFO - [mozharness: 2016-08-02 22:25:08.813161Z] Running populate-webroot step. 15:25:08 INFO - Running pre-action listener: _resource_record_pre_action 15:25:08 INFO - Running main action method: populate_webroot 15:25:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:25:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:25:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:25:08 INFO - '--tppagecycles', 15:25:08 INFO - '7'], 15:25:08 INFO - 'tests': ['tsvgm']}}, 15:25:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:25:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:25:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['damp', 'tps']}, 15:25:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'tests': ['damp', 'tps']}, 15:25:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['dromaeo_dom']}, 15:25:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['basic_compositor_video']}, 15:25:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:25:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['a11yr', 15:25:08 INFO - 'ts_paint', 15:25:08 INFO - 'tpaint', 15:25:08 INFO - 'sessionrestore', 15:25:08 INFO - 'sessionrestore_no_auto_restore', 15:25:08 INFO - 'tabpaint']}, 15:25:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['tsvgx', 15:25:08 INFO - 'tsvgr_opacity', 15:25:08 INFO - 'tart', 15:25:08 INFO - 'tscrollx', 15:25:08 INFO - 'cart']}, 15:25:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:08 INFO - 'tsvgr_opacity', 15:25:08 INFO - 'tart', 15:25:08 INFO - 'tscrollx', 15:25:08 INFO - 'cart']}, 15:25:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'talos_options': ['--disable-e10s'], 15:25:08 INFO - 'tests': ['tp5o']}, 15:25:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'tests': ['tp5o']}, 15:25:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'talos_options': ['--disable-e10s', 15:25:08 INFO - '--xperf_path', 15:25:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:08 INFO - 'tests': ['tp5n']}, 15:25:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:08 INFO - 'talos_options': ['--xperf_path', 15:25:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:08 INFO - 'tests': ['tp5n']}}, 15:25:08 INFO - 'talos.zip': {'path': '', 15:25:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:25:08 INFO - Running post-action listener: _resource_record_post_action 15:25:08 INFO - [mozharness: 2016-08-02 22:25:08.834854Z] Finished populate-webroot step (success) 15:25:08 INFO - [mozharness: 2016-08-02 22:25:08.834980Z] Running create-virtualenv step. 15:25:08 INFO - Running pre-action listener: _resource_record_pre_action 15:25:08 INFO - Running main action method: create_virtualenv 15:25:08 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:08 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 15:25:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:08 INFO - Using real prefix '/usr' 15:25:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:09 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:11 INFO - Installing pip.................done. 15:25:11 INFO - Return code: 0 15:25:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:11 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:11 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 15:25:11 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 15:25:11 INFO - Using env: {'DISPLAY': ':0', 15:25:11 INFO - 'HOME': '/home/cltbld', 15:25:11 INFO - 'LANG': 'en_US.UTF-8', 15:25:11 INFO - 'LANGUAGE': 'en_US:en', 15:25:11 INFO - 'LOGNAME': 'cltbld', 15:25:11 INFO - 'MAIL': '/var/mail/cltbld', 15:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:11 INFO - 'MOZ_NO_REMOTE': '1', 15:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:11 INFO - 'NO_EM_RESTART': '1', 15:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:11 INFO - 'PWD': '/builds/slave/test', 15:25:11 INFO - 'SHELL': '/bin/bash', 15:25:11 INFO - 'SHLVL': '1', 15:25:11 INFO - 'TERM': 'linux', 15:25:11 INFO - 'TMOUT': '86400', 15:25:11 INFO - 'USER': 'cltbld', 15:25:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:11 INFO - '_': '/tools/buildbot/bin/python'} 15:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:11 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 15:25:11 INFO - Cleaning up... 15:25:11 INFO - Return code: 0 15:25:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:11 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:11 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 15:25:11 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 15:25:11 INFO - Using env: {'DISPLAY': ':0', 15:25:11 INFO - 'HOME': '/home/cltbld', 15:25:11 INFO - 'LANG': 'en_US.UTF-8', 15:25:11 INFO - 'LANGUAGE': 'en_US:en', 15:25:11 INFO - 'LOGNAME': 'cltbld', 15:25:11 INFO - 'MAIL': '/var/mail/cltbld', 15:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:11 INFO - 'MOZ_NO_REMOTE': '1', 15:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:11 INFO - 'NO_EM_RESTART': '1', 15:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:11 INFO - 'PWD': '/builds/slave/test', 15:25:11 INFO - 'SHELL': '/bin/bash', 15:25:11 INFO - 'SHLVL': '1', 15:25:11 INFO - 'TERM': 'linux', 15:25:11 INFO - 'TMOUT': '86400', 15:25:11 INFO - 'USER': 'cltbld', 15:25:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:11 INFO - '_': '/tools/buildbot/bin/python'} 15:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:11 INFO - Downloading/unpacking psutil>=3.1.1 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:11 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 15:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:13 INFO - Installing collected packages: psutil 15:25:13 INFO - Running setup.py install for psutil 15:25:13 INFO - building 'psutil._psutil_linux' extension 15:25:13 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 15:25:14 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 15:25:14 INFO - building 'psutil._psutil_posix' extension 15:25:14 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 15:25:14 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 15:25:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:14 INFO - Successfully installed psutil 15:25:14 INFO - Cleaning up... 15:25:14 INFO - Return code: 0 15:25:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25:14 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')]} 15:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:14 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')]} 15:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:14 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:14 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 15:25:14 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 15:25:14 INFO - Using env: {'DISPLAY': ':0', 15:25:14 INFO - 'HOME': '/home/cltbld', 15:25:14 INFO - 'LANG': 'en_US.UTF-8', 15:25:14 INFO - 'LANGUAGE': 'en_US:en', 15:25:14 INFO - 'LOGNAME': 'cltbld', 15:25:14 INFO - 'MAIL': '/var/mail/cltbld', 15:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:14 INFO - 'MOZ_NO_REMOTE': '1', 15:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:14 INFO - 'NO_EM_RESTART': '1', 15:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:14 INFO - 'PWD': '/builds/slave/test', 15:25:14 INFO - 'SHELL': '/bin/bash', 15:25:14 INFO - 'SHLVL': '1', 15:25:14 INFO - 'TERM': 'linux', 15:25:14 INFO - 'TMOUT': '86400', 15:25:14 INFO - 'USER': 'cltbld', 15:25:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:14 INFO - '_': '/tools/buildbot/bin/python'} 15:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:16 INFO - Installing collected packages: mozsystemmonitor 15:25:16 INFO - Running setup.py install for mozsystemmonitor 15:25:16 INFO - Successfully installed mozsystemmonitor 15:25:16 INFO - Cleaning up... 15:25:16 INFO - Return code: 0 15:25:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:16 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 15:25:16 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 15:25:16 INFO - Using env: {'DISPLAY': ':0', 15:25:16 INFO - 'HOME': '/home/cltbld', 15:25:16 INFO - 'LANG': 'en_US.UTF-8', 15:25:16 INFO - 'LANGUAGE': 'en_US:en', 15:25:16 INFO - 'LOGNAME': 'cltbld', 15:25:16 INFO - 'MAIL': '/var/mail/cltbld', 15:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:16 INFO - 'MOZ_NO_REMOTE': '1', 15:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:16 INFO - 'NO_EM_RESTART': '1', 15:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:16 INFO - 'PWD': '/builds/slave/test', 15:25:16 INFO - 'SHELL': '/bin/bash', 15:25:16 INFO - 'SHLVL': '1', 15:25:16 INFO - 'TERM': 'linux', 15:25:16 INFO - 'TMOUT': '86400', 15:25:16 INFO - 'USER': 'cltbld', 15:25:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:16 INFO - '_': '/tools/buildbot/bin/python'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:16 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 15:25:16 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 15:25:16 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 15:25:16 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 15:25:16 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 15:25:16 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 15:25:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:19 INFO - warning: no files found matching '*.txt' 15:25:19 INFO - no previously-included directories found matching 'build' 15:25:19 INFO - no previously-included directories found matching 'dist' 15:25:19 INFO - no previously-included directories found matching '.git*' 15:25:19 INFO - Installing collected packages: jsonschema, functools32 15:25:19 INFO - Running setup.py install for functools32 15:25:19 INFO - warning: no files found matching '*.txt' 15:25:19 INFO - no previously-included directories found matching 'build' 15:25:19 INFO - no previously-included directories found matching 'dist' 15:25:19 INFO - no previously-included directories found matching '.git*' 15:25:19 INFO - Successfully installed jsonschema functools32 15:25:19 INFO - Cleaning up... 15:25:19 INFO - Return code: 0 15:25:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:19 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:19 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 15:25:19 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 15:25:19 INFO - Using env: {'DISPLAY': ':0', 15:25:19 INFO - 'HOME': '/home/cltbld', 15:25:19 INFO - 'LANG': 'en_US.UTF-8', 15:25:19 INFO - 'LANGUAGE': 'en_US:en', 15:25:19 INFO - 'LOGNAME': 'cltbld', 15:25:19 INFO - 'MAIL': '/var/mail/cltbld', 15:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:19 INFO - 'MOZ_NO_REMOTE': '1', 15:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:19 INFO - 'NO_EM_RESTART': '1', 15:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:19 INFO - 'PWD': '/builds/slave/test', 15:25:19 INFO - 'SHELL': '/bin/bash', 15:25:19 INFO - 'SHLVL': '1', 15:25:19 INFO - 'TERM': 'linux', 15:25:19 INFO - 'TMOUT': '86400', 15:25:19 INFO - 'USER': 'cltbld', 15:25:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:19 INFO - '_': '/tools/buildbot/bin/python'} 15:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:19 INFO - Cleaning up... 15:25:19 INFO - Return code: 0 15:25:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:19 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:19 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 15:25:19 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 15:25:19 INFO - Using env: {'DISPLAY': ':0', 15:25:19 INFO - 'HOME': '/home/cltbld', 15:25:19 INFO - 'LANG': 'en_US.UTF-8', 15:25:19 INFO - 'LANGUAGE': 'en_US:en', 15:25:19 INFO - 'LOGNAME': 'cltbld', 15:25:19 INFO - 'MAIL': '/var/mail/cltbld', 15:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:19 INFO - 'MOZ_NO_REMOTE': '1', 15:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:19 INFO - 'NO_EM_RESTART': '1', 15:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:19 INFO - 'PWD': '/builds/slave/test', 15:25:19 INFO - 'SHELL': '/bin/bash', 15:25:19 INFO - 'SHLVL': '1', 15:25:19 INFO - 'TERM': 'linux', 15:25:19 INFO - 'TMOUT': '86400', 15:25:19 INFO - 'USER': 'cltbld', 15:25:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:19 INFO - '_': '/tools/buildbot/bin/python'} 15:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:19 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 15:25:19 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 15:25:19 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 15:25:19 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 15:25:19 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 15:25:19 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 15:25:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:22 INFO - Downloading docopt-0.6.1.tar.gz 15:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:22 INFO - Running setup.py install for blobuploader 15:25:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:22 INFO - Running setup.py install for requests 15:25:22 INFO - Running setup.py install for docopt 15:25:22 INFO - Successfully installed blobuploader requests docopt 15:25:22 INFO - Cleaning up... 15:25:22 INFO - Return code: 0 15:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:22 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')]} 15:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:22 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')]} 15:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:22 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:22 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 15:25:22 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 15:25:22 INFO - Using env: {'DISPLAY': ':0', 15:25:22 INFO - 'HOME': '/home/cltbld', 15:25:22 INFO - 'LANG': 'en_US.UTF-8', 15:25:22 INFO - 'LANGUAGE': 'en_US:en', 15:25:22 INFO - 'LOGNAME': 'cltbld', 15:25:22 INFO - 'MAIL': '/var/mail/cltbld', 15:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:22 INFO - 'MOZ_NO_REMOTE': '1', 15:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:22 INFO - 'NO_EM_RESTART': '1', 15:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:22 INFO - 'PWD': '/builds/slave/test', 15:25:22 INFO - 'SHELL': '/bin/bash', 15:25:22 INFO - 'SHLVL': '1', 15:25:22 INFO - 'TERM': 'linux', 15:25:22 INFO - 'TMOUT': '86400', 15:25:22 INFO - 'USER': 'cltbld', 15:25:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:22 INFO - '_': '/tools/buildbot/bin/python'} 15:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:23 INFO - Running setup.py (path:/tmp/pip-hZnTd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:23 INFO - Running setup.py (path:/tmp/pip-ffo_aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:23 INFO - Running setup.py (path:/tmp/pip-0XBDBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:23 INFO - Running setup.py (path:/tmp/pip-1ej68s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:23 INFO - Running setup.py (path:/tmp/pip-w24NYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:23 INFO - Running setup.py (path:/tmp/pip-ed_Xlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:23 INFO - Running setup.py (path:/tmp/pip-wBFSB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:23 INFO - Running setup.py (path:/tmp/pip-XkPSO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:23 INFO - Running setup.py (path:/tmp/pip-VHdz7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:23 INFO - Running setup.py (path:/tmp/pip-KWVTf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:23 INFO - Running setup.py (path:/tmp/pip-os_jYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:23 INFO - Running setup.py (path:/tmp/pip-1LA8MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:24 INFO - Running setup.py (path:/tmp/pip-zfGdeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:24 INFO - Running setup.py (path:/tmp/pip-IJwuXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:24 INFO - Running setup.py (path:/tmp/pip-jQXNZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:24 INFO - Running setup.py (path:/tmp/pip-2dwfKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:24 INFO - Running setup.py (path:/tmp/pip-ZkTdx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:24 INFO - Running setup.py install for manifestparser 15:25:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:24 INFO - Running setup.py install for mozcrash 15:25:24 INFO - Running setup.py install for mozdebug 15:25:24 INFO - Running setup.py install for mozdevice 15:25:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:24 INFO - Running setup.py install for mozfile 15:25:24 INFO - Running setup.py install for mozhttpd 15:25:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozinfo 15:25:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozInstall 15:25:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozleak 15:25:25 INFO - Running setup.py install for mozlog 15:25:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for moznetwork 15:25:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozprocess 15:25:25 INFO - Running setup.py install for mozprofile 15:25:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozrunner 15:25:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozscreenshot 15:25:25 INFO - Running setup.py install for moztest 15:25:26 INFO - Running setup.py install for mozversion 15:25:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:26 INFO - Cleaning up... 15:25:26 INFO - Return code: 0 15:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:26 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')]} 15:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:26 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')]} 15:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:26 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:26 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 15:25:26 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 15:25:26 INFO - Using env: {'DISPLAY': ':0', 15:25:26 INFO - 'HOME': '/home/cltbld', 15:25:26 INFO - 'LANG': 'en_US.UTF-8', 15:25:26 INFO - 'LANGUAGE': 'en_US:en', 15:25:26 INFO - 'LOGNAME': 'cltbld', 15:25:26 INFO - 'MAIL': '/var/mail/cltbld', 15:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:26 INFO - 'MOZ_NO_REMOTE': '1', 15:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:26 INFO - 'NO_EM_RESTART': '1', 15:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:26 INFO - 'PWD': '/builds/slave/test', 15:25:26 INFO - 'SHELL': '/bin/bash', 15:25:26 INFO - 'SHLVL': '1', 15:25:26 INFO - 'TERM': 'linux', 15:25:26 INFO - 'TMOUT': '86400', 15:25:26 INFO - 'USER': 'cltbld', 15:25:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:26 INFO - '_': '/tools/buildbot/bin/python'} 15:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:26 INFO - Running setup.py (path:/tmp/pip-qVSWGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:26 INFO - Running setup.py (path:/tmp/pip-0rtCEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:26 INFO - Running setup.py (path:/tmp/pip-8bI8Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:26 INFO - Running setup.py (path:/tmp/pip-z9g4Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:26 INFO - Running setup.py (path:/tmp/pip-JEnNUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:26 INFO - Running setup.py (path:/tmp/pip-vIKPvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:26 INFO - Running setup.py (path:/tmp/pip-sjhRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:26 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)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:26 INFO - Running setup.py (path:/tmp/pip-DsQ9IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:27 INFO - Running setup.py (path:/tmp/pip-0lRAbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:27 INFO - Running setup.py (path:/tmp/pip-ZnbtM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:27 INFO - Running setup.py (path:/tmp/pip-XIWn2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:27 INFO - Running setup.py (path:/tmp/pip-coalit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:27 INFO - Running setup.py (path:/tmp/pip-hcO2JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:27 INFO - Running setup.py (path:/tmp/pip-Ixqvbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:27 INFO - Running setup.py (path:/tmp/pip-AG3NRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:27 INFO - Running setup.py (path:/tmp/pip-UTQFjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:27 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)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:27 INFO - Running setup.py (path:/tmp/pip-8i8RRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:27 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)) 15:25:27 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)) 15:25:27 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)) 15:25:27 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)) 15:25:27 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)) 15:25:27 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)) 15:25:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:29 INFO - Downloading blessings-1.6.tar.gz 15:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:29 INFO - Installing collected packages: blessings 15:25:29 INFO - Running setup.py install for blessings 15:25:29 INFO - Successfully installed blessings 15:25:29 INFO - Cleaning up... 15:25:29 INFO - Return code: 0 15:25:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:30 INFO - Reading from file tmpfile_stdout 15:25:30 INFO - Current package versions: 15:25:30 INFO - argparse == 1.2.1 15:25:30 INFO - blessings == 1.6 15:25:30 INFO - blobuploader == 1.2.4 15:25:30 INFO - docopt == 0.6.1 15:25:30 INFO - functools32 == 3.2.3-2 15:25:30 INFO - jsonschema == 2.5.1 15:25:30 INFO - manifestparser == 1.1 15:25:30 INFO - mozInstall == 1.12 15:25:30 INFO - mozcrash == 0.17 15:25:30 INFO - mozdebug == 0.1 15:25:30 INFO - mozdevice == 0.48 15:25:30 INFO - mozfile == 1.2 15:25:30 INFO - mozhttpd == 0.7 15:25:30 INFO - mozinfo == 0.9 15:25:30 INFO - mozleak == 0.1 15:25:30 INFO - mozlog == 3.3 15:25:30 INFO - moznetwork == 0.27 15:25:30 INFO - mozprocess == 0.23 15:25:30 INFO - mozprofile == 0.28 15:25:30 INFO - mozrunner == 6.12 15:25:30 INFO - mozscreenshot == 0.1 15:25:30 INFO - mozsystemmonitor == 0.3 15:25:30 INFO - moztest == 0.7 15:25:30 INFO - mozversion == 1.4 15:25:30 INFO - psutil == 3.1.1 15:25:30 INFO - requests == 1.2.3 15:25:30 INFO - wsgiref == 0.1.2 15:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:30 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 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:30 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 15:25:30 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 15:25:30 INFO - Using env: {'DISPLAY': ':0', 15:25:30 INFO - 'HOME': '/home/cltbld', 15:25:30 INFO - 'LANG': 'en_US.UTF-8', 15:25:30 INFO - 'LANGUAGE': 'en_US:en', 15:25:30 INFO - 'LOGNAME': 'cltbld', 15:25:30 INFO - 'MAIL': '/var/mail/cltbld', 15:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:30 INFO - 'MOZ_NO_REMOTE': '1', 15:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:30 INFO - 'NO_EM_RESTART': '1', 15:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:30 INFO - 'PWD': '/builds/slave/test', 15:25:30 INFO - 'SHELL': '/bin/bash', 15:25:30 INFO - 'SHLVL': '1', 15:25:30 INFO - 'TERM': 'linux', 15:25:30 INFO - 'TMOUT': '86400', 15:25:30 INFO - 'USER': 'cltbld', 15:25:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:30 INFO - '_': '/tools/buildbot/bin/python'} 15:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 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)) 15:25:30 INFO - Cleaning up... 15:25:30 INFO - Return code: 0 15:25:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, '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': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', '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 15:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:25:30 INFO - Using env: {'DISPLAY': ':0', 15:25:30 INFO - 'HOME': '/home/cltbld', 15:25:30 INFO - 'LANG': 'en_US.UTF-8', 15:25:30 INFO - 'LANGUAGE': 'en_US:en', 15:25:30 INFO - 'LOGNAME': 'cltbld', 15:25:30 INFO - 'MAIL': '/var/mail/cltbld', 15:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:30 INFO - 'MOZ_NO_REMOTE': '1', 15:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:30 INFO - 'NO_EM_RESTART': '1', 15:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:30 INFO - 'PWD': '/builds/slave/test', 15:25:30 INFO - 'SHELL': '/bin/bash', 15:25:30 INFO - 'SHLVL': '1', 15:25:30 INFO - 'TERM': 'linux', 15:25:30 INFO - 'TMOUT': '86400', 15:25:30 INFO - 'USER': 'cltbld', 15:25:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:30 INFO - '_': '/tools/buildbot/bin/python'} 15:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:30 INFO - Cleaning up... 15:25:30 INFO - Return code: 0 15:25:30 INFO - Running post-action listener: _resource_record_post_action 15:25:30 INFO - Running post-action listener: _start_resource_monitoring 15:25:30 INFO - Starting resource monitoring. 15:25:30 INFO - [mozharness: 2016-08-02 22:25:30.487850Z] Finished create-virtualenv step (success) 15:25:30 INFO - [mozharness: 2016-08-02 22:25:30.488328Z] Running install step. 15:25:30 INFO - Running pre-action listener: _resource_record_pre_action 15:25:30 INFO - Running main action method: install 15:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:30 INFO - Reading from file tmpfile_stdout 15:25:30 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:30 INFO - Reading from file tmpfile_stdout 15:25:30 INFO - Output received: 15:25:30 INFO - Usage: mozinstall [options] installer 15:25:30 INFO - Options: 15:25:30 INFO - -h, --help show this help message and exit 15:25:30 INFO - -d DEST, --destination=DEST 15:25:30 INFO - Directory to install application into. [default: 15:25:30 INFO - "/builds/slave/test"] 15:25:30 INFO - --app=APP Application being installed. [default: firefox] 15:25:30 INFO - mkdir: /builds/slave/test/build/application 15:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:25:47 INFO - Reading from file tmpfile_stdout 15:25:47 INFO - Output received: 15:25:47 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:47 INFO - Running post-action listener: _resource_record_post_action 15:25:47 INFO - [mozharness: 2016-08-02 22:25:47.658496Z] Finished install step (success) 15:25:47 INFO - [mozharness: 2016-08-02 22:25:47.658775Z] Running run-tests step. 15:25:47 INFO - Running pre-action listener: _resource_record_pre_action 15:25:47 INFO - Running main action method: run_tests 15:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:47 INFO - Python 2.7.3 15:25:47 INFO - Return code: 0 15:25:47 INFO - grabbing minidump binary from tooltool 15:25: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')]} 15:25:47 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 0x2c993b0>, '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 0x2c9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:47 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 15:25:47 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 15:25:47 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 15:25:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:47 INFO - Return code: 0 15:25:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 15:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 15:25:47 INFO - Using env: {'DISPLAY': ':0', 15:25:47 INFO - 'HOME': '/home/cltbld', 15:25:47 INFO - 'LANG': 'en_US.UTF-8', 15:25:47 INFO - 'LANGUAGE': 'en_US:en', 15:25:47 INFO - 'LOGNAME': 'cltbld', 15:25:47 INFO - 'MAIL': '/var/mail/cltbld', 15:25:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:47 INFO - 'MOZ_NO_REMOTE': '1', 15:25:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:47 INFO - 'NO_EM_RESTART': '1', 15:25:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:47 INFO - 'PWD': '/builds/slave/test', 15:25:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:47 INFO - 'SHELL': '/bin/bash', 15:25:47 INFO - 'SHLVL': '1', 15:25:47 INFO - 'TERM': 'linux', 15:25:47 INFO - 'TMOUT': '86400', 15:25:47 INFO - 'USER': 'cltbld', 15:25:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806', 15:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:47 INFO - '_': '/tools/buildbot/bin/python'} 15:25:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 15:25:47 INFO - mozversion application_buildid: 20160802123004 15:25:47 INFO - mozversion application_changeset: cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 15:25:47 INFO - mozversion application_display_name: Nightly 15:25:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:47 INFO - mozversion application_name: Firefox 15:25:47 INFO - mozversion application_remotingname: firefox 15:25:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:25:47 INFO - mozversion application_vendor: Mozilla 15:25:47 INFO - mozversion application_version: 51.0a1 15:25:47 INFO - mozversion platform_buildid: 20160802123004 15:25:47 INFO - mozversion platform_changeset: cfa39f8b7c54dd0763d68da1bc94bb7fe8ee1e15 15:25:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:25:47 INFO - mozversion platform_version: 51.0a1 15:25:47 INFO - using testdate: 1470176747 15:25:47 INFO - actual date: 1470176747 15:25:47 INFO - starting webserver on 'localhost:55518' 15:25:47 INFO - SUITE-START | Running 2 tests 15:25:47 INFO - TEST-START | dromaeo_css 15:25:47 INFO - operating with platform_type : linux_ 15:25:47 INFO - Initialising browser for dromaeo_css test... 15:25:47 INFO - TEST-INFO | started process 16985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjGev2/profile http://localhost:55518/getInfo.html) 15:25:51 INFO - PROCESS | 16985 | __metrics Screen width/height:1600/1200 15:25:51 INFO - PROCESS | 16985 | colorDepth:24 15:25:51 INFO - PROCESS | 16985 | Browser inner width/height: 1024/697 15:25:51 INFO - PROCESS | 16985 | __metrics 15:25:52 INFO - PROCESS | 16985 | 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" 15:25:52 INFO - PROCESS | 16985 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:25:53 INFO - TEST-INFO | 16985: exit 0 15:25:53 INFO - Browser initialized. 15:25:53 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:53 INFO - TEST-INFO | started process 17066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjGev2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:05 INFO - PROCESS | 17066 | RSS: Main: 156303360 15:26:05 INFO - PROCESS | 17066 | 15:26:57 INFO - PROCESS | 17066 | 1470176817157 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] 15:29:04 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55518/tests/dromaeo/cssquery-ext.html) 15:29:05 INFO - PROCESS | 17066 | RSS: Main: 254033920 15:29:05 INFO - PROCESS | 17066 | 15:32:08 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-ext.html (next: http://localhost:55518/tests/dromaeo/cssquery-jquery.html) 15:32:09 INFO - PROCESS | 17066 | RSS: Main: 242016256 15:32:09 INFO - PROCESS | 17066 | 15:35:10 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55518/tests/dromaeo/cssquery-mootools.html) 15:35:11 INFO - PROCESS | 17066 | RSS: Main: 183783424 15:35:11 INFO - PROCESS | 17066 | 15:38:13 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55518/tests/dromaeo/cssquery-prototype.html) 15:38:14 INFO - PROCESS | 17066 | RSS: Main: 211800064 15:38:14 INFO - PROCESS | 17066 | 15:41:16 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55518/tests/dromaeo/cssquery-yui.html) 15:41:17 INFO - PROCESS | 17066 | RSS: Main: 186658816 15:41:17 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-yui.html (next: http://localhost:55518/tests/dromaeo/cssquery-dojo.html) 15:44:20 INFO - PROCESS | 17066 | RSS: Main: 276430848 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | __start_tp_report 15:44:20 INFO - PROCESS | 17066 | _x_x_mozilla_page_load 15:44:20 INFO - PROCESS | 17066 | _x_x_mozilla_page_load_details 15:44:20 INFO - PROCESS | 17066 | |i|pagename|runs| 15:44:20 INFO - PROCESS | 17066 | |0;dojo.html;2978.1661134882233;2991.506401443762;3005.278733104055;3032.181311046019;3050.496668049772;5099.821506247282;5140.845774626758;5188.818391356303;5229.712365819878;5238.135707608245;5184.144616138342;5228.372595288562;5232.084385232588;5252.3171987641645;5274.841754747355;4754.857354279377;4815.590674792629;4816.590589799871;4825.300331451937;4953.752312384367;4869.732164730938;4880.048390563841;4893.535114164149;4903.043906438246;4913.410390753097;4673.439187297512;4726.645501587394;4734.644901632357;4790;4812.278158276252;4736;4739.763011849428;4752.097101550694;4824.179889418807;4870.318155458239;4754.595859351959;4791.401074865642;4796.808127674889;4808.278758186265;4839.612830973549;5103;5164.406093299243;5171.870703232412;5275.393329767087;5289.18017707256;5528.5577153828;5550.833474995757;5585.2459917910965;5586.692731899744;5587.078132108198;5547.389787123454;5580.358258800249;5600.439956004408;5606.327240731098;5657.717114144276;5046.44489106198;5092.7453627318855;5149.794008239666;5191.97404012985;5207.843764687065;5702.572307076985;5745.6552606843725;5751;5756.079027355687;5763.077907534775;5490.80782172622;5491;5495.422980587061;5501.367342755554;5548.55611551075;5389.380221274525;5406.78372865081;5496.80761173357;5508.7521061552325;5543.6673799571345;5535.114381698909;5538.307711536058;5542.473465020817;5550.417206193291;5582.553395728413;5510.834674959758;5549.528290095306;5554.583406244467;5568.888622227532;5574.303212098488;4264.616184543406;4272.764997925082;4306.633936115465;4363.825446982085;4378.8905277367685;3799.259144466858;3818.8281527330782;3838.1556057667267;3916.6475017248586;3930.8231129599235;5250.658707184097;5259.579233661298;5261.368635763656;5270.947290527122;5315.654482458628;5567.192757050205;5568.554515638739;5576.33084029919;5577.637453565587;5616.691081990448;5167.974160129175;5294.073537130987;5346.812861549827;5356.0894647909945;5357.276767636319;4855.271709243571;4879.39007624047;4885.560299573055;4889.193283108319;4924.556789888856;5803.5357171426185;5865.354810970704;5866.23738913947;5872.207252021008;5872.647641141545;5423.728813559227;5526.419725928719;5592.4966752990795;5595.35653399848;5713.22871412354;5824.301083869963;5826.883462330815;5833.970830145822;5845.298564172326;5848.064309710426;5513.421090785409;5546.306711661043;5548.029094908456;5554.361248456317;5567.805126820542;5424.349078110652;5556.194351819045;5617.915731264116;5624.959382514248;5718.914216286676;5556.194351819045;5558.360788509373;5561.221429000024;5566.387697353207;5570.944290557205;5480.862978425571;5544.584156188383;5547.918155959549;5548.694821784679;5568.972155139199;5352.063388907003;5389.541888939327;5405.621606487508;5418.701971391612;5512.862178445571;5494.203340515683;5515.034868898007;5575.358833734173;5576.191452239484;5578.414266502121;5403.270558474713;5408.918866216931;5418.647787893774;5420.566354691694;5420.9186862197885 15:44:20 INFO - PROCESS | 17066 | |1;ext.html;569.9715014249286;590.7577893063842;599.5353600959256;604.1210039392685;614.6711509342501;45035.77482112589;46052.3092153618;46147.30779038313;46153.7692311538;49924.50075499244;47908.281375779305;48350.75824620881;48378.06487740486;48421;48480;9006.729798106067;9148.542572871364;9152.633894644207;9168.358214924958;9168.587413566405;8955.104489551026;9044.3668943174;9051.547422628875;9053.366264361497;9059.909400906006;9074.183323500883;9120;9122;9128.45229286245;9129.863052054225;9044.14080662336;9067;9070.455772653597;9077.500737459437;9084.50035248061;9029.277657787361;9101.089891010846;9121.133492318218;9134.223590994774;9135.817283654356;44747.55252447499;45086.32370514412;45094.54905450969;45191.322130168075;45197.774011130066;3563.518924945151;3678.319510890494;3717.866050854488;3725.3666876631037;3747.925041499182;34438.40273566802;34493.82753086218;34769.6523034769;34856.47715284273;35695.28609427823;4343.109662519176;4413.9337909931055;4416.492103408117;4487.842925497592;4573.176828170928;256580;257688;257996;258051;258788;61818.69090654518;62036;62183.37816621776;62226.68886655538;62283;56439.71780141155;56780.71609641925;56958.430415695315;63799.362006380274;64386;16615.750763738553;17118.657626847395;17172.141392930305;18092.457226283233;18103.094845257685;13267.402966866513;13371;13373.331333433289;13374.662533746547;13380.19718816874;18939.81060189408;18961.620767584845;18978.62042759137;19003.904980475287;19185.712214316798;5286.20706893969;5996.430339117776;6131.877362452815;6429.807105786834;6446.677666116675;974.8635191073255;1073.5491093740648;1094.7810437912449;1101.6529793115303;1106.3006264714072;34204;34261.143471413416;34438.31123377568;34565.30869382648;34985.47521787175;1136.8181091025563;1154.32472003877;1157.4444266752007;1204.6205445284706;1237.1587320622064;17315.393961211295;18154.18306176225;18222;18313.633727325647;18323.725144122847;568016;571162;571877;572899;574314;62992.370076299565;63145.368546314865;63217.68391158015;63221.68389158025;63324;1335.4457899971403;1383.661003054238;1401.7967394727912;1402.6773842016394;1414.2928535732135;32358.19104522406;33483.83258083694;33796;33879.830600846835;34692.47961280532;58656;60552.69723651354;60704.392956069874;66179.66910165419;66230;391621;392901;393327;394413;395105;26056.34859128537;28956.42087158287;29063.709362906946;30014.54978175373;30464;51114.488855110976;51144.488555113974;51456.74271628768;52099.47900521098;52401.7379913098;42827.78586107049;44352.556474434845;44464.777676111415;44547.55452445434;44968.12806676846;43336.566634333256;43863;44222.557774423134;44599;45029;44061.33907991447;44734.3289850659;45134.54865451303;45235.54764452313;45271;35938;37276;38584.2283154341;39037.219255615295;39632.801835990635;27652.170434886986;29834.850825745732;29882.551761723156;30191.396172076875;30251.394972099995 15:44:20 INFO - PROCESS | 17066 | |2;jquery.html;368.20651496026056;371;373.88783364990496;377.65067312735715;388.5240580289146;18392.81607183928;19354.193641921913;19901.905395203277;19950.70073948892;20092.296769613065;18835.62328753424;19155.521111972208;19164.808351916476;19611.921344326056;20036;5052.9747351263195;5125.897482050356;5129.358830146231;5268.9473105269035;5275.182346736262;5308.283381743454;5399.62202645815;5403.540699040586;5404.405515393323;5404.675719456825;5377.569794416457;5387.568994480433;5389.487998640143;5448.564114870801;5753.712314384285;5649.689267090308;5720.599558030939;5749.195112684228;5777.682227477487;5783.161441590988;5054.974725126388;5180.974095129538;5204.375474942994;5244.029854476896;5284.947150528484;14358.425662973468;14465.349059292357;14483.710325793425;16606.75089873641;23527.764722352727;2256.9210077647203;2395.3053614451787;2473.863937483438;2793.2318612381555;2929.501984662591;9957.950210248902;10087.546060427298;10182.439965801877;10276.332038417479;10307.896921030844;1854.1748921729836;1907.523956168813;1936.8584156498232;1972.7731310899287;2019.4850313170195;80720.59639701822;88746.5562672189;90956.5452172735;91168;92756.53621731848;10520.526576304084;10569.312994655324;10837.945810270898;10857.891421085846;11183.161262905314;14527;14528.273586320642;14533.055351402125;14540.200288984208;14546;7899.289063984269;8160.26557609818;8206.425550211428;8423.789405264795;8451.746447606458;8047.597620119088;8055.355571554262;8057.879131813028;8276.29651479619;8315.584220789058;4424.933625995613;4436.578525040116;4472.9776351118035;4578.908421831545;4644.187267228222;1895.118769772035;1955.7750858651152;1958.3831093205595;1989.651810933081;2020.3130935482006;863.2575984653193;980.6028558433845;1027.306568066552;1037.6108959140322;1055.0451841083832;19738.40784776459;20107.29624463137;20650.17399304011;20770.169193232403;20970;983.4689267795453;994.8209322321907;1038.9272750907364;1058.6347710040025;1073.4471747050275;10674.519646615921;11460.484278207501;11535.423228838525;11564.653060408202;11597.88402115968;470490;481792;505140;508067;509077;64586;92724.53637731768;95433.5228323854;95614;97512;993.8062077894886;1009.4599389326822;1024.7335692719946;1025.3130402630256;1027.8355463126013;15626.84373156254;18209;18669.43991680252;18684.25262989465;18955.33656322077;29603.407931841673;30707.385852282383;33065.50401743928;42248;42897;57525.424745752;60877.086843698264;63259;63331.683341583;63636;8450.577471126542;8535.743927682179;8639.438436501607;8674.132586741276;8795.428297160664;12649.683757906127;13598.524051658145;13668.794968075288;13745.725085498434;13967.231802250973;11235.606753763579;11996.820047699117;12146.149769516049;12310.446029928495;12442.564510242099;11669.541307336583;11909.40452977365;11941.64175074749;12095.75808483843;12162.209456385306;11084.778304434027;12261.26432414058;12334.50661973511;12401.379931003234;12632.178908370926;8344.87482687748;8454.535000575028;8704.303655707401;8800.823983520422;9003.864942026006;11306.49120789583;11380.658580242605;11965.641030769091;12014.75970480603;12121.393930303626 15:44:20 INFO - PROCESS | 17066 | |3;mootools.html;1461.2255504582572;1518.0057062623982;1629.6496253305536;1740.912954352282;1773.7073382891815;8543.316534677226;9233.49215793132;9236.122568356011;9250.722478325653;9259.675911343104;7811.648475818588;8489.66041358345;8758.167974042472;8783.956080219607;9058.456492610449;2331.3355693627277;2363.6690863279155;2370.0993622423457;2370.6207006878903;2373.6320870265135;2296.9655455168104;2325.848819826706;2345.8006069484113;2347.8473899196583;2350.5533948549805;2348;2351.988240058797;2365.077619728299;2386.904523819054;2388.3790214544256;2231.7768223177713;2257.142285931344;2262.8981695823645;2263.954720905589;2288.645259984705;2247.224707475918;2249.898754556049;2254.7745225477483;2256.4584499720113;2259.559385919746;8989.730308090768;9053.321000924958;9101.544922753903;9127.908720912772;9136.132067453582;5228.320318358589;5388.703621300827;5393.1370980642905;5394;5398.6220964532495;3196.3447493263825;3226.9031929042167;3365.3774051800497;3372.9038062629497;3380.797152170853;1052.7578656908877;1054.393723608928;1072.2762135558467;1075.4891426572315;1082.718493191776;12778.297193654345;12849.036322275773;12900.483980640669;12903;12905.483780648856;4395.846145384896;4570.497245303014;4650.09323181983;4745.311929770164;4755.072760811678;10809.891901080888;10812.72968175786;10814.35113893169;10819.67540973772;10823.83764243537;5301.867453313698;5318.9202161967605;5322.042032434199;5323.068463018956;5324.988252232063;4303.074838909587;4704.482506924235;4823.927641085386;4846.39420072491;4898.657094003457;3881.767093974314;3961.8415263389143;4028.879133625996;4056.411820286042;4064.552899181088;1227.92018518796;1230.3110258255406;1234.111439763369;1236.6537369536545;1244.7261602447447;953.4088864903804;962.870012548311;973.6786860336072;974.7514383832078;992.369845148336;6083.11794789753;6135.631862088289;6141;6185.443310102112;6222.968885155546;452.1341630777025;460.67062050633956;462.96065333326226;467.9321498382715;469.9718016918927;4116.156187981456;4147.917041659211;4160.979195104005;4168.062186008124;4175.561566035583;10963.725906852233;11438.828417573743;11446.713832154262;11447.313161210353;11473.311601303949;10559.947200264103;11344.43277836105;11349.54601815918;11351.432428378548;11353.602623908124;8040.075391329955;8484.745457636282;8487.10885357041;8489.95755021221;8492.320614350838;6290.308066112815;6291.905621415591;6324.430801227912;6429.58207716497;6583.80248592543;10540.051395374454;10555.419451930218;10558.04977552024;10672.733181670521;10676.572937082741;10470.21473389514;10473.895261047292;10584.100351469904;10642.787144257227;10738;7289.1981881994;7850.725224617339;7979.9601001994615;8074.717384891501;8283.17168283167;8871;8909.465432074096;8940.284777217938;8945.865812012955;8959.776005599912;7633.732819351519;7708.653110609924;7720.150783413932;7893.526388416713;8160.469569477965;7750.457467977413;7761.573113478813;7880.645370958206;7952.284294413531;7962.920370796218;7139.678714457758;7154.856902861809;7215.71137154508;7216.097987751531;7222.494425390382;5079.3650793650795;5097.61767867404;5118.564921981673;5170.146925757358;5307.867303317448;4985.775640096132;5079.6698214615935;5125.79496820138;5170.37955445349;5362.222477740784 15:44:20 INFO - PROCESS | 17066 | |4;prototype.html;303.0574912023606;311.76773303888604;319.38837126901984;323.8575026988124;333.4098645397646;5158.303629010083;5255.710935898524;5306.442823503535;5362.383325917521;5414.0796064669;5193.272941788153;5240.323096609077;5264.736763161845;5272.472752724735;5294.311739473873;4154.148399578079;4158.688098392618;4172.33242681171;4189.329707246841;4205.243056249874;3940.290747665419;4052.4731784868072;4156.438880751105;4174.97912510437;4191.245575796355;3982.3230050891416;4032.4354590357375;4051.7366371185926;4072.124493233954;4076.1440097579543;4003.739756915791;4031.5162180538377;4034.152827906143;4044.7370920890344;4080.163566468867;3551.289742051574;3555.7866528008403;3573.749837511375;3578.691743825244;3587.802670853102;5040.243963405482;5061.392632884041;5066.240063990394;5069.163588007974;5071.1632580624155;4555;4567.794449249792;4573.405457290531;4573.530293641463;4574.794134263966;5382.838514844561;5385.973070134624;5386.037679276383;5403.486668766461;5407.351117865881;3764.9811750941344;3811.676007539335;3821.178446633987;3850.9807450962844;3883.10688541637;5612.915806262909;5616.241807356037;5645.407232240596;5657.915131273035;5669.6314739541795;3936.7637941723588;3944.546377166605;3947.684185265172;3961.7622942623534;3994.6604538614542;3918.8236529356245;3927.351986922183;3936.4292177634657;4036;4040.373742069984;4552.772361381918;4558.8404405846295;4566.5387076135985;4570.497245303014;4574.313852922089;5416.431274716177;5430.42980487051;5437.673739575559;5464.398916119224;5465.6335916021;1316.605018494448;1329.4416345134873;1349.5964197234962;1355.8779709826163;1364.7748121559832;937.301710225886;942.797932635881;965.8647789309503;966.6665000574791;972.8083098204643;5287.259783630295;5291.867703307448;5292.44429334922;5292.576593872481;5293.20601909709;5490.917636235459;5524.845310328895;5528.06022976095;5536.252605898152;5544.61187716856;5111.568760746997;5258.50044245796;5280.683159010472;5283.682979021271;5293.973530132324;2577.3170109920884;2632.802075055845;2647.9540581470596;2659.614355918381;2678.424138810165;5146.922796158061;5159.458256883048;5175.637705360588;5178.56607394524;5181.316072276525;4879.463259041502;4997.575206107522;5022.6233032522705;5078.847634570969;5109.923351149736;5070.442251352349;5071.174377224196;5093.847184584469;5101.826579886647;5121.411037730709;4923.261510773413;4928.334674818853;4932.482089380564;4936.629752768485;4969.304297398439;4697.205162928052;4779.713217206979;4811.951880481291;4902.975485122552;4915.582175515121;5082.390113186441;5093.1341671915125;5103.336566246513;5129.435762066244;5138.152204886152;3688.7786732796117;3692.9659695285363;3694.3006217140414;3700.686256378947;3713.5729391119285;4766.666333356632;4878.438979517259;4913.63147763912;4972.378452693413;5372.919406208832;5369.905736762587;5483.862903427446;5513.090340094;5546.195801608825;5558.694271815089;5477.1510415885605;5492.890142197213;5517.200005999188;5518.503334699736;5526.143447765442;5289.444608316226;5458.536024437967;5498.3127109111365;5516.668999860021;5518.503334699896;5528.834134975958;5539.418361072029;5555.50000499957;5564.610477266552;5573.247611572386;5397.487238712316;5455.227051208294;5455.372632147195;5467.808626698046;5477.780888764564 15:44:20 INFO - PROCESS | 17066 | |5;yui.html;683.7265093962416;762.2034973452742;782.8277778888643;797.9481333713309;822.4284122534841;15990.200489975497;17065.232064557094;17098.31606735729;17101;17108.914455427723;15254.923725381357;15366.769498457532;15387.538373848802;15407.306671199794;15432.305546250418;670.4937771982171;769.9615019249043;782.8590853646341;794.4637369775407;794.7695168401185;781.663884529652;792.8414317136567;794.0986979777936;794.7575989323254;798.2735710503443;867.3061550759398;868.5440143924427;869.2958703450194;872.9738107856774;873.9257163141141;867.800405906645;868.8957325120995;869.3523325122792;870;870.0733718589713;514.8429728932674;608.3976862905736;622.7228883147002;625.0312016374646;626.8338890194102;14697.265136743226;14760.778588321184;14790.260486975609;14826.406943722346;14851.851481485155;13964.162150271017;14392.856071439257;14741.410343586243;14742.852571474255;14880.479183228643;11754.764904701859;11978.401079946056;11997.400129993466;12415.875841241652;12718.236905785683;4534.161180181677;4568.794404251784;4636.629069674418;4760.309755085494;4760.523947605247;79699;79743.60128199322;80041.79937301003;81486.18513814846;82346;9671.419714816993;9993.650222242331;10007;10134.138598219086;10198;17861.7320740189;18189.54526136857;18250.087495625165;18329.3584724534;18352.35766748184;7896.289333959856;8108.635111420001;8309.95845020771;8330.432880199593;8354.916450835413;4658.1848176568965;4738.857834264978;4847.878803029953;4871.7089971157675;4884.6324324055295;3181.5545823584716;3288.243703948105;3322.534845121685;3332.583427071616;3336.332733453319;588.0591054313151;597.6205109755336;604.3865476541314;606.8027890935464;608.1789584061481;565.8047973449153;589.0927970924728;617.5306766857221;620.7175735040546;641.377863472431;8642.524661143572;8721;8956.283497320199;9078.098640468419;9094.636214551343;670.8825955457874;681.4310051107282;686.615495322621;717.5083974320789;727.5561907236581;4383.9342409863875;4567.10941366437;5479.671219726829;5682.062459694104;5692.715364231772;70269;92120.53939730393;106572;122143;123380.38309808394;99261.014779704;100439;100630.4968475153;100751.49624251832;101146;77653.68155821337;80471.59764201376;90003;92466.53766731123;93316;9968.414529316595;10008.599656013677;10193.643222487177;10295.433751143459;10412.427316497666;37746;45367.319490208334;49534;51553.742231288605;52400.73799630978;66239.66880165569;68970.65514672395;73868.63065684852;77062.2293777055;77988.61005694936;13519.594412167651;13953.093048951785;14075;14093.15441073539;14788.556343309718;15051.924740376227;15187.789914709228;15640.765388518954;15669.764953525479;16359.836401635832;14692.926535367254;14907.92546037263;15085.170315632746;15129.621759456102;15478.380864765284;14629;15078.170700611572;15186.088834669956;15527.45653902108;15723.606909827346;14635.780463293273;14962.775558366415;14971.326290316743;15402.69194616079;15446.150461724263;11499.655010349703;11741.882581174079;11750.941245294061;11856.288622682667;11879.643610691694;11420.091618814144;11520.831566819046;12288.447019884305;12764.234145951272;12805.28446792186 15:44:20 INFO - PROCESS | 17066 | __end_tp_report 15:44:20 INFO - PROCESS | 17066 | __start_cc_report 15:44:20 INFO - PROCESS | 17066 | _x_x_mozilla_cycle_collect,957 15:44:20 INFO - PROCESS | 17066 | __end_cc_report 15:44:20 INFO - PROCESS | 17066 | __startTimestamp1470177860904__endTimestamp 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | ------- Summary: start ------- 15:44:20 INFO - PROCESS | 17066 | Number of tests: 6 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#0] dojo.html Cycles:165 Average:5209.16 Median:5418.65 stddev:583.37 (10.8%) stddev-sans-first:558.29 15:44:20 INFO - PROCESS | 17066 | Values: 2978.2 2991.5 3005.3 3032.2 3050.5 5099.8 5140.8 5188.8 5229.7 5238.1 5184.1 5228.4 5232.1 5252.3 5274.8 4754.9 4815.6 4816.6 4825.3 4953.8 4869.7 4880.0 4893.5 4903.0 4913.4 4673.4 4726.6 4734.6 4790.0 4812.3 4736.0 4739.8 4752.1 4824.2 4870.3 4754.6 4791.4 4796.8 4808.3 4839.6 5103.0 5164.4 5171.9 5275.4 5289.2 5528.6 5550.8 5585.2 5586.7 5587.1 5547.4 5580.4 5600.4 5606.3 5657.7 5046.4 5092.7 5149.8 5192.0 5207.8 5702.6 5745.7 5751.0 5756.1 5763.1 5490.8 5491.0 5495.4 5501.4 5548.6 5389.4 5406.8 5496.8 5508.8 5543.7 5535.1 5538.3 5542.5 5550.4 5582.6 5510.8 5549.5 5554.6 5568.9 5574.3 4264.6 4272.8 4306.6 4363.8 4378.9 3799.3 3818.8 3838.2 3916.6 3930.8 5250.7 5259.6 5261.4 5270.9 5315.7 5567.2 5568.6 5576.3 5577.6 5616.7 5168.0 5294.1 5346.8 5356.1 5357.3 4855.3 4879.4 4885.6 4889.2 4924.6 5803.5 5865.4 5866.2 5872.2 5872.6 5423.7 5526.4 5592.5 5595.4 5713.2 5824.3 5826.9 5834.0 5845.3 5848.1 5513.4 5546.3 5548.0 5554.4 5567.8 5424.3 5556.2 5617.9 5625.0 5718.9 5556.2 5558.4 5561.2 5566.4 5570.9 5480.9 5544.6 5547.9 5548.7 5569.0 5352.1 5389.5 5405.6 5418.7 5512.9 5494.2 5515.0 5575.4 5576.2 5578.4 5403.3 5408.9 5418.6 5420.6 5420.9 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#1] ext.html Cycles:180 Average:59073.86 Median:44666.66 stddev:113513.25 (254.1%) stddev-sans-first:113746.69 15:44:20 INFO - PROCESS | 17066 | Values: 570.0 590.8 599.5 604.1 614.7 45035.8 46052.3 46147.3 46153.8 49924.5 47908.3 48350.8 48378.1 48421.0 48480.0 9006.7 9148.5 9152.6 9168.4 9168.6 8955.1 9044.4 9051.5 9053.4 9059.9 9074.2 9120.0 9122.0 9128.5 9129.9 9044.1 9067.0 9070.5 9077.5 9084.5 9029.3 9101.1 9121.1 9134.2 9135.8 44747.6 45086.3 45094.5 45191.3 45197.8 3563.5 3678.3 3717.9 3725.4 3747.9 34438.4 34493.8 34769.7 34856.5 35695.3 4343.1 4413.9 4416.5 4487.8 4573.2 256580.0 257688.0 257996.0 258051.0 258788.0 61818.7 62036.0 62183.4 62226.7 62283.0 56439.7 56780.7 56958.4 63799.4 64386.0 16615.8 17118.7 17172.1 18092.5 18103.1 13267.4 13371.0 13373.3 13374.7 13380.2 18939.8 18961.6 18978.6 19003.9 19185.7 5286.2 5996.4 6131.9 6429.8 6446.7 974.9 1073.5 1094.8 1101.7 1106.3 34204.0 34261.1 34438.3 34565.3 34985.5 1136.8 1154.3 1157.4 1204.6 1237.2 17315.4 18154.2 18222.0 18313.6 18323.7 568016.0 571162.0 571877.0 572899.0 574314.0 62992.4 63145.4 63217.7 63221.7 63324.0 1335.4 1383.7 1401.8 1402.7 1414.3 32358.2 33483.8 33796.0 33879.8 34692.5 58656.0 60552.7 60704.4 66179.7 66230.0 391621.0 392901.0 393327.0 394413.0 395105.0 26056.3 28956.4 29063.7 30014.5 30464.0 51114.5 51144.5 51456.7 52099.5 52401.7 42827.8 44352.6 44464.8 44547.6 44968.1 43336.6 43863.0 44222.6 44599.0 45029.0 44061.3 44734.3 45134.5 45235.5 45271.0 35938.0 37276.0 38584.2 39037.2 39632.8 27652.2 29834.9 29882.6 30191.4 30251.4 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#2] jquery.html Cycles:180 Average:29103.63 Median:2434.58 stddev:81778.01 (3359.0%) stddev-sans-first:81978.96 15:44:20 INFO - PROCESS | 17066 | Values: 368.2 371.0 373.9 377.7 388.5 18392.8 19354.2 19901.9 19950.7 20092.3 18835.6 19155.5 19164.8 19611.9 20036.0 5053.0 5125.9 5129.4 5268.9 5275.2 5308.3 5399.6 5403.5 5404.4 5404.7 5377.6 5387.6 5389.5 5448.6 5753.7 5649.7 5720.6 5749.2 5777.7 5783.2 5055.0 5181.0 5204.4 5244.0 5284.9 14358.4 14465.3 14483.7 16606.8 23527.8 2256.9 2395.3 2473.9 2793.2 2929.5 9958.0 10087.5 10182.4 10276.3 10307.9 1854.2 1907.5 1936.9 1972.8 2019.5 80720.6 88746.6 90956.5 91168.0 92756.5 10520.5 10569.3 10837.9 10857.9 11183.2 14527.0 14528.3 14533.1 14540.2 14546.0 7899.3 8160.3 8206.4 8423.8 8451.7 8047.6 8055.4 8057.9 8276.3 8315.6 4424.9 4436.6 4473.0 4578.9 4644.2 1895.1 1955.8 1958.4 1989.7 2020.3 863.3 980.6 1027.3 1037.6 1055.0 19738.4 20107.3 20650.2 20770.2 20970.0 983.5 994.8 1038.9 1058.6 1073.4 10674.5 11460.5 11535.4 11564.7 11597.9 470490.0 481792.0 505140.0 508067.0 509077.0 64586.0 92724.5 95433.5 95614.0 97512.0 993.8 1009.5 1024.7 1025.3 1027.8 15626.8 18209.0 18669.4 18684.3 18955.3 29603.4 30707.4 33065.5 42248.0 42897.0 57525.4 60877.1 63259.0 63331.7 63636.0 8450.6 8535.7 8639.4 8674.1 8795.4 12649.7 13598.5 13668.8 13745.7 13967.2 11235.6 11996.8 12146.1 12310.4 12442.6 11669.5 11909.4 11941.6 12095.8 12162.2 11084.8 12261.3 12334.5 12401.4 12632.2 8344.9 8454.5 8704.3 8800.8 9003.9 11306.5 11380.7 11965.6 12014.8 12121.4 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#3] mootools.html Cycles:180 Average:5931.30 Median:2556.53 stddev:3471.02 (135.8%) stddev-sans-first:3464.50 15:44:20 INFO - PROCESS | 17066 | Values: 1461.2 1518.0 1629.6 1740.9 1773.7 8543.3 9233.5 9236.1 9250.7 9259.7 7811.6 8489.7 8758.2 8784.0 9058.5 2331.3 2363.7 2370.1 2370.6 2373.6 2297.0 2325.8 2345.8 2347.8 2350.6 2348.0 2352.0 2365.1 2386.9 2388.4 2231.8 2257.1 2262.9 2264.0 2288.6 2247.2 2249.9 2254.8 2256.5 2259.6 8989.7 9053.3 9101.5 9127.9 9136.1 5228.3 5388.7 5393.1 5394.0 5398.6 3196.3 3226.9 3365.4 3372.9 3380.8 1052.8 1054.4 1072.3 1075.5 1082.7 12778.3 12849.0 12900.5 12903.0 12905.5 4395.8 4570.5 4650.1 4745.3 4755.1 10809.9 10812.7 10814.4 10819.7 10823.8 5301.9 5318.9 5322.0 5323.1 5325.0 4303.1 4704.5 4823.9 4846.4 4898.7 3881.8 3961.8 4028.9 4056.4 4064.6 1227.9 1230.3 1234.1 1236.7 1244.7 953.4 962.9 973.7 974.8 992.4 6083.1 6135.6 6141.0 6185.4 6223.0 452.1 460.7 463.0 467.9 470.0 4116.2 4147.9 4161.0 4168.1 4175.6 10963.7 11438.8 11446.7 11447.3 11473.3 10559.9 11344.4 11349.5 11351.4 11353.6 8040.1 8484.7 8487.1 8490.0 8492.3 6290.3 6291.9 6324.4 6429.6 6583.8 10540.1 10555.4 10558.0 10672.7 10676.6 10470.2 10473.9 10584.1 10642.8 10738.0 7289.2 7850.7 7980.0 8074.7 8283.2 8871.0 8909.5 8940.3 8945.9 8959.8 7633.7 7708.7 7720.2 7893.5 8160.5 7750.5 7761.6 7880.6 7952.3 7962.9 7139.7 7154.9 7215.7 7216.1 7222.5 5079.4 5097.6 5118.6 5170.1 5307.9 4985.8 5079.7 5125.8 5170.4 5362.2 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#4] prototype.html Cycles:180 Average:4458.75 Median:5069.80 stddev:1298.58 (25.6%) stddev-sans-first:1264.21 15:44:20 INFO - PROCESS | 17066 | Values: 303.1 311.8 319.4 323.9 333.4 5158.3 5255.7 5306.4 5362.4 5414.1 5193.3 5240.3 5264.7 5272.5 5294.3 4154.1 4158.7 4172.3 4189.3 4205.2 3940.3 4052.5 4156.4 4175.0 4191.2 3982.3 4032.4 4051.7 4072.1 4076.1 4003.7 4031.5 4034.2 4044.7 4080.2 3551.3 3555.8 3573.7 3578.7 3587.8 5040.2 5061.4 5066.2 5069.2 5071.2 4555.0 4567.8 4573.4 4573.5 4574.8 5382.8 5386.0 5386.0 5403.5 5407.4 3765.0 3811.7 3821.2 3851.0 3883.1 5612.9 5616.2 5645.4 5657.9 5669.6 3936.8 3944.5 3947.7 3961.8 3994.7 3918.8 3927.4 3936.4 4036.0 4040.4 4552.8 4558.8 4566.5 4570.5 4574.3 5416.4 5430.4 5437.7 5464.4 5465.6 1316.6 1329.4 1349.6 1355.9 1364.8 937.3 942.8 965.9 966.7 972.8 5287.3 5291.9 5292.4 5292.6 5293.2 5490.9 5524.8 5528.1 5536.3 5544.6 5111.6 5258.5 5280.7 5283.7 5294.0 2577.3 2632.8 2648.0 2659.6 2678.4 5146.9 5159.5 5175.6 5178.6 5181.3 4879.5 4997.6 5022.6 5078.8 5109.9 5070.4 5071.2 5093.8 5101.8 5121.4 4923.3 4928.3 4932.5 4936.6 4969.3 4697.2 4779.7 4812.0 4903.0 4915.6 5082.4 5093.1 5103.3 5129.4 5138.2 3688.8 3693.0 3694.3 3700.7 3713.6 4766.7 4878.4 4913.6 4972.4 5372.9 5369.9 5483.9 5513.1 5546.2 5558.7 5477.2 5492.9 5517.2 5518.5 5526.1 5289.4 5458.5 5498.3 5516.7 5518.5 5528.8 5539.4 5555.5 5564.6 5573.2 5397.5 5455.2 5455.4 5467.8 5477.8 15:44:20 INFO - PROCESS | 17066 | 15:44:20 INFO - PROCESS | 17066 | [#5] yui.html Cycles:180 Average:20654.73 Median:4647.41 stddev:29270.33 (629.8%) stddev-sans-first:29314.03 15:44:20 INFO - PROCESS | 17066 | Values: 683.7 762.2 782.8 797.9 822.4 15990.2 17065.2 17098.3 17101.0 17108.9 15254.9 15366.8 15387.5 15407.3 15432.3 670.5 770.0 782.9 794.5 794.8 781.7 792.8 794.1 794.8 798.3 867.3 868.5 869.3 873.0 873.9 867.8 868.9 869.4 870.0 870.1 514.8 608.4 622.7 625.0 626.8 14697.3 14760.8 14790.3 14826.4 14851.9 13964.2 14392.9 14741.4 14742.9 14880.5 11754.8 11978.4 11997.4 12415.9 12718.2 4534.2 4568.8 4636.6 4760.3 4760.5 79699.0 79743.6 80041.8 81486.2 82346.0 9671.4 9993.7 10007.0 10134.1 10198.0 17861.7 18189.5 18250.1 18329.4 18352.4 7896.3 8108.6 8310.0 8330.4 8354.9 4658.2 4738.9 4847.9 4871.7 4884.6 3181.6 3288.2 3322.5 3332.6 3336.3 588.1 597.6 604.4 606.8 608.2 565.8 589.1 617.5 620.7 641.4 8642.5 8721.0 8956.3 9078.1 9094.6 670.9 681.4 686.6 717.5 727.6 4383.9 4567.1 5479.7 5682.1 5692.7 70269.0 92120.5 106572.0 122143.0 123380.4 99261.0 100439.0 100630.5 100751.5 101146.0 77653.7 80471.6 90003.0 92466.5 93316.0 9968.4 10008.6 10193.6 10295.4 10412.4 37746.0 45367.3 49534.0 51553.7 52400.7 66239.7 68970.7 73868.6 77062.2 77988.6 13519.6 13953.1 14075.0 14093.2 14788.6 15051.9 15187.8 15640.8 15669.8 16359.8 14692.9 14907.9 15085.2 15129.6 15478.4 14629.0 15078.2 15186.1 15527.5 15723.6 14635.8 14962.8 14971.3 15402.7 15446.2 11499.7 11741.9 11750.9 11856.3 11879.6 11420.1 11520.8 12288.4 12764.2 12805.3 15:44:20 INFO - PROCESS | 17066 | -------- Summary: end -------- 15:44:20 INFO - PROCESS | 17066 | 15:44:21 INFO - TEST-INFO | 17066: exit 0 15:44:21 INFO - TEST-OK | dromaeo_css | took 1113738ms 15:44:21 INFO - TEST-START | kraken 15:44:21 INFO - operating with platform_type : linux_ 15:44:21 INFO - Initialising browser for kraken test... 15:44:21 INFO - TEST-INFO | started process 17260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGnAK7t/profile http://localhost:55518/getInfo.html) 15:44:25 INFO - PROCESS | 17260 | __metrics Screen width/height:1600/1200 15:44:25 INFO - PROCESS | 17260 | colorDepth:24 15:44:25 INFO - PROCESS | 17260 | Browser inner width/height: 1024/697 15:44:25 INFO - PROCESS | 17260 | __metrics 15:44:26 INFO - PROCESS | 17260 | 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" 15:44:26 INFO - PROCESS | 17260 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:27 INFO - TEST-INFO | 17260: exit 0 15:44:27 INFO - Browser initialized. 15:44:27 INFO - Running cycle 1/1 for kraken test... 15:44:27 INFO - TEST-INFO | started process 17340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGnAK7t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:39 INFO - PROCESS | 17340 | RSS: Main: 155402240 15:44:39 INFO - PROCESS | 17340 | 15:44:41 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:42 INFO - PROCESS | 17340 | RSS: Main: 212635648 15:44:42 INFO - PROCESS | 17340 | 15:44:45 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-dft) 15:44:45 INFO - PROCESS | 17340 | RSS: Main: 190754816 15:44:45 INFO - PROCESS | 17340 | 15:44:48 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-fft) 15:44:49 INFO - PROCESS | 17340 | RSS: Main: 267481088 15:44:49 INFO - PROCESS | 17340 | 15:44:51 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator) 15:44:51 INFO - PROCESS | 17340 | RSS: Main: 178274304 15:44:51 INFO - PROCESS | 17340 | 15:44:54 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:54 INFO - PROCESS | 17340 | RSS: Main: 183193600 15:44:54 INFO - PROCESS | 17340 | 15:44:57 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:58 INFO - PROCESS | 17340 | RSS: Main: 219971584 15:44:58 INFO - PROCESS | 17340 | 15:45:01 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:02 INFO - PROCESS | 17340 | RSS: Main: 218857472 15:45:02 INFO - PROCESS | 17340 | 15:45:05 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial) 15:45:05 INFO - PROCESS | 17340 | RSS: Main: 219267072 15:45:05 INFO - PROCESS | 17340 | 15:45:07 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:07 INFO - PROCESS | 17340 | RSS: Main: 183123968 15:45:07 INFO - PROCESS | 17340 | 15:45:09 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:10 INFO - PROCESS | 17340 | RSS: Main: 188551168 15:45:10 INFO - PROCESS | 17340 | 15:45:12 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:12 INFO - PROCESS | 17340 | RSS: Main: 193925120 15:45:12 INFO - PROCESS | 17340 | 15:45:15 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:15 INFO - PROCESS | 17340 | RSS: Main: 189018112 15:45:15 INFO - PROCESS | 17340 | 15:45:18 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:19 INFO - PROCESS | 17340 | RSS: Main: 192503808 15:45:19 INFO - PROCESS | 17340 | 15:45:20 INFO - PROCESS | 17340 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55518/tests/kraken/driver.html?testName=ai-astar) 15:45:21 INFO - PROCESS | 17340 | RSS: Main: 243089408 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | __start_tp_report 15:45:21 INFO - PROCESS | 17340 | _x_x_mozilla_page_load 15:45:21 INFO - PROCESS | 17340 | _x_x_mozilla_page_load_details 15:45:21 INFO - PROCESS | 17340 | |i|pagename|runs| 15:45:21 INFO - PROCESS | 17340 | |0;ai-astar;102;112;113;111;112;112;111;111;111;111 15:45:21 INFO - PROCESS | 17340 | |1;audio-beat-detection;150;118;118;176;119;118;147;118;149;118 15:45:21 INFO - PROCESS | 17340 | |2;audio-dft;160;160;161;160;161;161;160;162;161;160 15:45:21 INFO - PROCESS | 17340 | |3;audio-fft;75;75;74;109;75;76;74;75;102;75 15:45:21 INFO - PROCESS | 17340 | |4;audio-oscillator;83;84;118;85;84;85;114;84;86;132 15:45:21 INFO - PROCESS | 17340 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;118;118 15:45:21 INFO - PROCESS | 17340 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;145;146 15:45:21 INFO - PROCESS | 17340 | |7;imaging-desaturate;94;95;95;96;94;95;95;95;96;95 15:45:21 INFO - PROCESS | 17340 | |8;json-parse-financial;50;49;50;50;48;50;50;48;48;49 15:45:21 INFO - PROCESS | 17340 | |9;json-stringify-tinderbox;60;62;61;60;61;60;60;61;60;60 15:45:21 INFO - PROCESS | 17340 | |10;stanford-crypto-aes;82;75;80;77;76;75;78;81;74;74 15:45:21 INFO - PROCESS | 17340 | |11;stanford-crypto-ccm;132;127;118;118;119;129;119;120;163;123 15:45:21 INFO - PROCESS | 17340 | |12;stanford-crypto-pbkdf2;159;160;159;160;158;155;159;157;158;158 15:45:21 INFO - PROCESS | 17340 | |13;stanford-crypto-sha256-iterative;70;65;65;63;63;63;62;63;62;61 15:45:21 INFO - PROCESS | 17340 | __end_tp_report 15:45:21 INFO - PROCESS | 17340 | __start_cc_report 15:45:21 INFO - PROCESS | 17340 | _x_x_mozilla_cycle_collect,1684 15:45:21 INFO - PROCESS | 17340 | __end_cc_report 15:45:21 INFO - PROCESS | 17340 | __startTimestamp1470177921066__endTimestamp 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | ------- Summary: start ------- 15:45:21 INFO - PROCESS | 17340 | Number of tests: 14 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:0.73 15:45:21 INFO - PROCESS | 17340 | Values: 102.0 112.0 113.0 111.0 112.0 112.0 111.0 111.0 111.0 111.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:133.00 stddev:20.85 (15.7%) stddev-sans-first:21.19 15:45:21 INFO - PROCESS | 17340 | Values: 150.0 118.0 118.0 176.0 119.0 118.0 147.0 118.0 149.0 118.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 15:45:21 INFO - PROCESS | 17340 | Values: 160.0 160.0 161.0 160.0 161.0 161.0 160.0 162.0 161.0 160.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.03 (17.4%) stddev-sans-first:13.64 15:45:21 INFO - PROCESS | 17340 | Values: 75.0 75.0 74.0 109.0 75.0 76.0 74.0 75.0 102.0 75.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.39 (21.9%) stddev-sans-first:18.94 15:45:21 INFO - PROCESS | 17340 | Values: 83.0 84.0 118.0 85.0 84.0 85.0 114.0 84.0 86.0 132.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:45:21 INFO - PROCESS | 17340 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 118.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:45:21 INFO - PROCESS | 17340 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 15:45:21 INFO - PROCESS | 17340 | Values: 94.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 96.0 95.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:50.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 15:45:21 INFO - PROCESS | 17340 | Values: 50.0 49.0 50.0 50.0 48.0 50.0 50.0 48.0 48.0 49.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 15:45:21 INFO - PROCESS | 17340 | Values: 60.0 62.0 61.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:2.94 (3.8%) stddev-sans-first:2.55 15:45:21 INFO - PROCESS | 17340 | Values: 82.0 75.0 80.0 77.0 76.0 75.0 78.0 81.0 74.0 74.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:125.00 stddev:13.66 (10.9%) stddev-sans-first:14.36 15:45:21 INFO - PROCESS | 17340 | Values: 132.0 127.0 118.0 118.0 119.0 129.0 119.0 120.0 163.0 123.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 15:45:21 INFO - PROCESS | 17340 | Values: 159.0 160.0 159.0 160.0 158.0 155.0 159.0 157.0 158.0 158.0 15:45:21 INFO - PROCESS | 17340 | 15:45:21 INFO - PROCESS | 17340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.54 (4.0%) stddev-sans-first:1.32 15:45:21 INFO - PROCESS | 17340 | Values: 70.0 65.0 65.0 63.0 63.0 63.0 62.0 63.0 62.0 61.0 15:45:21 INFO - PROCESS | 17340 | -------- Summary: end -------- 15:45:21 INFO - PROCESS | 17340 | 15:45:22 INFO - TEST-INFO | 17340: exit 0 15:45:22 INFO - TEST-OK | kraken | took 60455ms 15:45:22 INFO - SUITE-END | took 1174s 15:45:22 INFO - Completed test suite (00:19:34) 15:45:22 INFO - javascript benchmark 15:45:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2978.1661134882233, 2991.506401443762, 3005.278733104055, 3032.181311046019, 3050.496668049772, 5099.821506247282, 5140.845774626758, 5188.818391356303, 5229.712365819878, 5238.135707608245, 5184.144616138342, 5228.372595288562, 5232.084385232588, 5252.3171987641645, 5274.841754747355, 4754.857354279377, 4815.590674792629, 4816.590589799871, 4825.300331451937, 4953.752312384367, 4869.732164730938, 4880.048390563841, 4893.535114164149, 4903.043906438246, 4913.410390753097, 4673.439187297512, 4726.645501587394, 4734.644901632357, 4790.0, 4812.278158276252, 4736.0, 4739.763011849428, 4752.097101550694, 4824.179889418807, 4870.318155458239, 4754.595859351959, 4791.401074865642, 4796.808127674889, 4808.278758186265, 4839.612830973549, 5103.0, 5164.406093299243, 5171.870703232412, 5275.393329767087, 5289.18017707256, 5528.5577153828, 5550.833474995757, 5585.2459917910965, 5586.692731899744, 5587.078132108198, 5547.389787123454, 5580.358258800249, 5600.439956004408, 5606.327240731098, 5657.717114144276, 5046.44489106198, 5092.7453627318855, 5149.794008239666, 5191.97404012985, 5207.843764687065, 5702.572307076985, 5745.6552606843725, 5751.0, 5756.079027355687, 5763.077907534775, 5490.80782172622, 5491.0, 5495.422980587061, 5501.367342755554, 5548.55611551075, 5389.380221274525, 5406.78372865081, 5496.80761173357, 5508.7521061552325, 5543.6673799571345, 5535.114381698909, 5538.307711536058, 5542.473465020817, 5550.417206193291, 5582.553395728413, 5510.834674959758, 5549.528290095306, 5554.583406244467, 5568.888622227532, 5574.303212098488, 4264.616184543406, 4272.764997925082, 4306.633936115465, 4363.825446982085, 4378.8905277367685, 3799.259144466858, 3818.8281527330782, 3838.1556057667267, 3916.6475017248586, 3930.8231129599235, 5250.658707184097, 5259.579233661298, 5261.368635763656, 5270.947290527122, 5315.654482458628, 5567.192757050205, 5568.554515638739, 5576.33084029919, 5577.637453565587, 5616.691081990448, 5167.974160129175, 5294.073537130987, 5346.812861549827, 5356.0894647909945, 5357.276767636319, 4855.271709243571, 4879.39007624047, 4885.560299573055, 4889.193283108319, 4924.556789888856, 5803.5357171426185, 5865.354810970704, 5866.23738913947, 5872.207252021008, 5872.647641141545, 5423.728813559227, 5526.419725928719, 5592.4966752990795, 5595.35653399848, 5713.22871412354, 5824.301083869963, 5826.883462330815, 5833.970830145822, 5845.298564172326, 5848.064309710426, 5513.421090785409, 5546.306711661043, 5548.029094908456, 5554.361248456317, 5567.805126820542, 5424.349078110652, 5556.194351819045, 5617.915731264116, 5624.959382514248, 5718.914216286676, 5556.194351819045, 5558.360788509373, 5561.221429000024, 5566.387697353207, 5570.944290557205, 5480.862978425571, 5544.584156188383, 5547.918155959549, 5548.694821784679, 5568.972155139199, 5352.063388907003, 5389.541888939327, 5405.621606487508, 5418.701971391612, 5512.862178445571, 5494.203340515683, 5515.034868898007, 5575.358833734173, 5576.191452239484, 5578.414266502121, 5403.270558474713, 5408.918866216931, 5418.647787893774, 5420.566354691694, 5420.9186862197885], "value": 5170.031572628845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9715014249286, 590.7577893063842, 599.5353600959256, 604.1210039392685, 614.6711509342501, 45035.77482112589, 46052.3092153618, 46147.30779038313, 46153.7692311538, 49924.50075499244, 47908.281375779305, 48350.75824620881, 48378.06487740486, 48421.0, 48480.0, 9006.729798106067, 9148.542572871364, 9152.633894644207, 9168.358214924958, 9168.587413566405, 8955.104489551026, 9044.3668943174, 9051.547422628875, 9053.366264361497, 9059.909400906006, 9074.183323500883, 9120.0, 9122.0, 9128.45229286245, 9129.863052054225, 9044.14080662336, 9067.0, 9070.455772653597, 9077.500737459437, 9084.50035248061, 9029.277657787361, 9101.089891010846, 9121.133492318218, 9134.223590994774, 9135.817283654356, 44747.55252447499, 45086.32370514412, 45094.54905450969, 45191.322130168075, 45197.774011130066, 3563.518924945151, 3678.319510890494, 3717.866050854488, 3725.3666876631037, 3747.925041499182, 34438.40273566802, 34493.82753086218, 34769.6523034769, 34856.47715284273, 35695.28609427823, 4343.109662519176, 4413.9337909931055, 4416.492103408117, 4487.842925497592, 4573.176828170928, 256580.0, 257688.0, 257996.0, 258051.0, 258788.0, 61818.69090654518, 62036.0, 62183.37816621776, 62226.68886655538, 62283.0, 56439.71780141155, 56780.71609641925, 56958.430415695315, 63799.362006380274, 64386.0, 16615.750763738553, 17118.657626847395, 17172.141392930305, 18092.457226283233, 18103.094845257685, 13267.402966866513, 13371.0, 13373.331333433289, 13374.662533746547, 13380.19718816874, 18939.81060189408, 18961.620767584845, 18978.62042759137, 19003.904980475287, 19185.712214316798, 5286.20706893969, 5996.430339117776, 6131.877362452815, 6429.807105786834, 6446.677666116675, 974.8635191073255, 1073.5491093740648, 1094.7810437912449, 1101.6529793115303, 1106.3006264714072, 34204.0, 34261.143471413416, 34438.31123377568, 34565.30869382648, 34985.47521787175, 1136.8181091025563, 1154.32472003877, 1157.4444266752007, 1204.6205445284706, 1237.1587320622064, 17315.393961211295, 18154.18306176225, 18222.0, 18313.633727325647, 18323.725144122847, 568016.0, 571162.0, 571877.0, 572899.0, 574314.0, 62992.370076299565, 63145.368546314865, 63217.68391158015, 63221.68389158025, 63324.0, 1335.4457899971403, 1383.661003054238, 1401.7967394727912, 1402.6773842016394, 1414.2928535732135, 32358.19104522406, 33483.83258083694, 33796.0, 33879.830600846835, 34692.47961280532, 58656.0, 60552.69723651354, 60704.392956069874, 66179.66910165419, 66230.0, 391621.0, 392901.0, 393327.0, 394413.0, 395105.0, 26056.34859128537, 28956.42087158287, 29063.709362906946, 30014.54978175373, 30464.0, 51114.488855110976, 51144.488555113974, 51456.74271628768, 52099.47900521098, 52401.7379913098, 42827.78586107049, 44352.556474434845, 44464.777676111415, 44547.55452445434, 44968.12806676846, 43336.566634333256, 43863.0, 44222.557774423134, 44599.0, 45029.0, 44061.33907991447, 44734.3289850659, 45134.54865451303, 45235.54764452313, 45271.0, 35938.0, 37276.0, 38584.2283154341, 39037.219255615295, 39632.801835990635, 27652.170434886986, 29834.850825745732, 29882.551761723156, 30191.396172076875, 30251.394972099995], "value": 20764.348550719358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.20651496026056, 371.0, 373.88783364990496, 377.65067312735715, 388.5240580289146, 18392.81607183928, 19354.193641921913, 19901.905395203277, 19950.70073948892, 20092.296769613065, 18835.62328753424, 19155.521111972208, 19164.808351916476, 19611.921344326056, 20036.0, 5052.9747351263195, 5125.897482050356, 5129.358830146231, 5268.9473105269035, 5275.182346736262, 5308.283381743454, 5399.62202645815, 5403.540699040586, 5404.405515393323, 5404.675719456825, 5377.569794416457, 5387.568994480433, 5389.487998640143, 5448.564114870801, 5753.712314384285, 5649.689267090308, 5720.599558030939, 5749.195112684228, 5777.682227477487, 5783.161441590988, 5054.974725126388, 5180.974095129538, 5204.375474942994, 5244.029854476896, 5284.947150528484, 14358.425662973468, 14465.349059292357, 14483.710325793425, 16606.75089873641, 23527.764722352727, 2256.9210077647203, 2395.3053614451787, 2473.863937483438, 2793.2318612381555, 2929.501984662591, 9957.950210248902, 10087.546060427298, 10182.439965801877, 10276.332038417479, 10307.896921030844, 1854.1748921729836, 1907.523956168813, 1936.8584156498232, 1972.7731310899287, 2019.4850313170195, 80720.59639701822, 88746.5562672189, 90956.5452172735, 91168.0, 92756.53621731848, 10520.526576304084, 10569.312994655324, 10837.945810270898, 10857.891421085846, 11183.161262905314, 14527.0, 14528.273586320642, 14533.055351402125, 14540.200288984208, 14546.0, 7899.289063984269, 8160.26557609818, 8206.425550211428, 8423.789405264795, 8451.746447606458, 8047.597620119088, 8055.355571554262, 8057.879131813028, 8276.29651479619, 8315.584220789058, 4424.933625995613, 4436.578525040116, 4472.9776351118035, 4578.908421831545, 4644.187267228222, 1895.118769772035, 1955.7750858651152, 1958.3831093205595, 1989.651810933081, 2020.3130935482006, 863.2575984653193, 980.6028558433845, 1027.306568066552, 1037.6108959140322, 1055.0451841083832, 19738.40784776459, 20107.29624463137, 20650.17399304011, 20770.169193232403, 20970.0, 983.4689267795453, 994.8209322321907, 1038.9272750907364, 1058.6347710040025, 1073.4471747050275, 10674.519646615921, 11460.484278207501, 11535.423228838525, 11564.653060408202, 11597.88402115968, 470490.0, 481792.0, 505140.0, 508067.0, 509077.0, 64586.0, 92724.53637731768, 95433.5228323854, 95614.0, 97512.0, 993.8062077894886, 1009.4599389326822, 1024.7335692719946, 1025.3130402630256, 1027.8355463126013, 15626.84373156254, 18209.0, 18669.43991680252, 18684.25262989465, 18955.33656322077, 29603.407931841673, 30707.385852282383, 33065.50401743928, 42248.0, 42897.0, 57525.424745752, 60877.086843698264, 63259.0, 63331.683341583, 63636.0, 8450.577471126542, 8535.743927682179, 8639.438436501607, 8674.132586741276, 8795.428297160664, 12649.683757906127, 13598.524051658145, 13668.794968075288, 13745.725085498434, 13967.231802250973, 11235.606753763579, 11996.820047699117, 12146.149769516049, 12310.446029928495, 12442.564510242099, 11669.541307336583, 11909.40452977365, 11941.64175074749, 12095.75808483843, 12162.209456385306, 11084.778304434027, 12261.26432414058, 12334.50661973511, 12401.379931003234, 12632.178908370926, 8344.87482687748, 8454.535000575028, 8704.303655707401, 8800.823983520422, 9003.864942026006, 11306.49120789583, 11380.658580242605, 11965.641030769091, 12014.75970480603, 12121.393930303626], "value": 9143.794687898222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.2255504582572, 1518.0057062623982, 1629.6496253305536, 1740.912954352282, 1773.7073382891815, 8543.316534677226, 9233.49215793132, 9236.122568356011, 9250.722478325653, 9259.675911343104, 7811.648475818588, 8489.66041358345, 8758.167974042472, 8783.956080219607, 9058.456492610449, 2331.3355693627277, 2363.6690863279155, 2370.0993622423457, 2370.6207006878903, 2373.6320870265135, 2296.9655455168104, 2325.848819826706, 2345.8006069484113, 2347.8473899196583, 2350.5533948549805, 2348.0, 2351.988240058797, 2365.077619728299, 2386.904523819054, 2388.3790214544256, 2231.7768223177713, 2257.142285931344, 2262.8981695823645, 2263.954720905589, 2288.645259984705, 2247.224707475918, 2249.898754556049, 2254.7745225477483, 2256.4584499720113, 2259.559385919746, 8989.730308090768, 9053.321000924958, 9101.544922753903, 9127.908720912772, 9136.132067453582, 5228.320318358589, 5388.703621300827, 5393.1370980642905, 5394.0, 5398.6220964532495, 3196.3447493263825, 3226.9031929042167, 3365.3774051800497, 3372.9038062629497, 3380.797152170853, 1052.7578656908877, 1054.393723608928, 1072.2762135558467, 1075.4891426572315, 1082.718493191776, 12778.297193654345, 12849.036322275773, 12900.483980640669, 12903.0, 12905.483780648856, 4395.846145384896, 4570.497245303014, 4650.09323181983, 4745.311929770164, 4755.072760811678, 10809.891901080888, 10812.72968175786, 10814.35113893169, 10819.67540973772, 10823.83764243537, 5301.867453313698, 5318.9202161967605, 5322.042032434199, 5323.068463018956, 5324.988252232063, 4303.074838909587, 4704.482506924235, 4823.927641085386, 4846.39420072491, 4898.657094003457, 3881.767093974314, 3961.8415263389143, 4028.879133625996, 4056.411820286042, 4064.552899181088, 1227.92018518796, 1230.3110258255406, 1234.111439763369, 1236.6537369536545, 1244.7261602447447, 953.4088864903804, 962.870012548311, 973.6786860336072, 974.7514383832078, 992.369845148336, 6083.11794789753, 6135.631862088289, 6141.0, 6185.443310102112, 6222.968885155546, 452.1341630777025, 460.67062050633956, 462.96065333326226, 467.9321498382715, 469.9718016918927, 4116.156187981456, 4147.917041659211, 4160.979195104005, 4168.062186008124, 4175.561566035583, 10963.725906852233, 11438.828417573743, 11446.713832154262, 11447.313161210353, 11473.311601303949, 10559.947200264103, 11344.43277836105, 11349.54601815918, 11351.432428378548, 11353.602623908124, 8040.075391329955, 8484.745457636282, 8487.10885357041, 8489.95755021221, 8492.320614350838, 6290.308066112815, 6291.905621415591, 6324.430801227912, 6429.58207716497, 6583.80248592543, 10540.051395374454, 10555.419451930218, 10558.04977552024, 10672.733181670521, 10676.572937082741, 10470.21473389514, 10473.895261047292, 10584.100351469904, 10642.787144257227, 10738.0, 7289.1981881994, 7850.725224617339, 7979.9601001994615, 8074.717384891501, 8283.17168283167, 8871.0, 8909.465432074096, 8940.284777217938, 8945.865812012955, 8959.776005599912, 7633.732819351519, 7708.653110609924, 7720.150783413932, 7893.526388416713, 8160.469569477965, 7750.457467977413, 7761.573113478813, 7880.645370958206, 7952.284294413531, 7962.920370796218, 7139.678714457758, 7154.856902861809, 7215.71137154508, 7216.097987751531, 7222.494425390382, 5079.3650793650795, 5097.61767867404, 5118.564921981673, 5170.146925757358, 5307.867303317448, 4985.775640096132, 5079.6698214615935, 5125.79496820138, 5170.37955445349, 5362.222477740784], "value": 4619.499461594852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.0574912023606, 311.76773303888604, 319.38837126901984, 323.8575026988124, 333.4098645397646, 5158.303629010083, 5255.710935898524, 5306.442823503535, 5362.383325917521, 5414.0796064669, 5193.272941788153, 5240.323096609077, 5264.736763161845, 5272.472752724735, 5294.311739473873, 4154.148399578079, 4158.688098392618, 4172.33242681171, 4189.329707246841, 4205.243056249874, 3940.290747665419, 4052.4731784868072, 4156.438880751105, 4174.97912510437, 4191.245575796355, 3982.3230050891416, 4032.4354590357375, 4051.7366371185926, 4072.124493233954, 4076.1440097579543, 4003.739756915791, 4031.5162180538377, 4034.152827906143, 4044.7370920890344, 4080.163566468867, 3551.289742051574, 3555.7866528008403, 3573.749837511375, 3578.691743825244, 3587.802670853102, 5040.243963405482, 5061.392632884041, 5066.240063990394, 5069.163588007974, 5071.1632580624155, 4555.0, 4567.794449249792, 4573.405457290531, 4573.530293641463, 4574.794134263966, 5382.838514844561, 5385.973070134624, 5386.037679276383, 5403.486668766461, 5407.351117865881, 3764.9811750941344, 3811.676007539335, 3821.178446633987, 3850.9807450962844, 3883.10688541637, 5612.915806262909, 5616.241807356037, 5645.407232240596, 5657.915131273035, 5669.6314739541795, 3936.7637941723588, 3944.546377166605, 3947.684185265172, 3961.7622942623534, 3994.6604538614542, 3918.8236529356245, 3927.351986922183, 3936.4292177634657, 4036.0, 4040.373742069984, 4552.772361381918, 4558.8404405846295, 4566.5387076135985, 4570.497245303014, 4574.313852922089, 5416.431274716177, 5430.42980487051, 5437.673739575559, 5464.398916119224, 5465.6335916021, 1316.605018494448, 1329.4416345134873, 1349.5964197234962, 1355.8779709826163, 1364.7748121559832, 937.301710225886, 942.797932635881, 965.8647789309503, 966.6665000574791, 972.8083098204643, 5287.259783630295, 5291.867703307448, 5292.44429334922, 5292.576593872481, 5293.20601909709, 5490.917636235459, 5524.845310328895, 5528.06022976095, 5536.252605898152, 5544.61187716856, 5111.568760746997, 5258.50044245796, 5280.683159010472, 5283.682979021271, 5293.973530132324, 2577.3170109920884, 2632.802075055845, 2647.9540581470596, 2659.614355918381, 2678.424138810165, 5146.922796158061, 5159.458256883048, 5175.637705360588, 5178.56607394524, 5181.316072276525, 4879.463259041502, 4997.575206107522, 5022.6233032522705, 5078.847634570969, 5109.923351149736, 5070.442251352349, 5071.174377224196, 5093.847184584469, 5101.826579886647, 5121.411037730709, 4923.261510773413, 4928.334674818853, 4932.482089380564, 4936.629752768485, 4969.304297398439, 4697.205162928052, 4779.713217206979, 4811.951880481291, 4902.975485122552, 4915.582175515121, 5082.390113186441, 5093.1341671915125, 5103.336566246513, 5129.435762066244, 5138.152204886152, 3688.7786732796117, 3692.9659695285363, 3694.3006217140414, 3700.686256378947, 3713.5729391119285, 4766.666333356632, 4878.438979517259, 4913.63147763912, 4972.378452693413, 5372.919406208832, 5369.905736762587, 5483.862903427446, 5513.090340094, 5546.195801608825, 5558.694271815089, 5477.1510415885605, 5492.890142197213, 5517.200005999188, 5518.503334699736, 5526.143447765442, 5289.444608316226, 5458.536024437967, 5498.3127109111365, 5516.668999860021, 5518.503334699896, 5528.834134975958, 5539.418361072029, 5555.50000499957, 5564.610477266552, 5573.247611572386, 5397.487238712316, 5455.227051208294, 5455.372632147195, 5467.808626698046, 5477.780888764564], "value": 4046.764788494684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.7265093962416, 762.2034973452742, 782.8277778888643, 797.9481333713309, 822.4284122534841, 15990.200489975497, 17065.232064557094, 17098.31606735729, 17101.0, 17108.914455427723, 15254.923725381357, 15366.769498457532, 15387.538373848802, 15407.306671199794, 15432.305546250418, 670.4937771982171, 769.9615019249043, 782.8590853646341, 794.4637369775407, 794.7695168401185, 781.663884529652, 792.8414317136567, 794.0986979777936, 794.7575989323254, 798.2735710503443, 867.3061550759398, 868.5440143924427, 869.2958703450194, 872.9738107856774, 873.9257163141141, 867.800405906645, 868.8957325120995, 869.3523325122792, 870.0, 870.0733718589713, 514.8429728932674, 608.3976862905736, 622.7228883147002, 625.0312016374646, 626.8338890194102, 14697.265136743226, 14760.778588321184, 14790.260486975609, 14826.406943722346, 14851.851481485155, 13964.162150271017, 14392.856071439257, 14741.410343586243, 14742.852571474255, 14880.479183228643, 11754.764904701859, 11978.401079946056, 11997.400129993466, 12415.875841241652, 12718.236905785683, 4534.161180181677, 4568.794404251784, 4636.629069674418, 4760.309755085494, 4760.523947605247, 79699.0, 79743.60128199322, 80041.79937301003, 81486.18513814846, 82346.0, 9671.419714816993, 9993.650222242331, 10007.0, 10134.138598219086, 10198.0, 17861.7320740189, 18189.54526136857, 18250.087495625165, 18329.3584724534, 18352.35766748184, 7896.289333959856, 8108.635111420001, 8309.95845020771, 8330.432880199593, 8354.916450835413, 4658.1848176568965, 4738.857834264978, 4847.878803029953, 4871.7089971157675, 4884.6324324055295, 3181.5545823584716, 3288.243703948105, 3322.534845121685, 3332.583427071616, 3336.332733453319, 588.0591054313151, 597.6205109755336, 604.3865476541314, 606.8027890935464, 608.1789584061481, 565.8047973449153, 589.0927970924728, 617.5306766857221, 620.7175735040546, 641.377863472431, 8642.524661143572, 8721.0, 8956.283497320199, 9078.098640468419, 9094.636214551343, 670.8825955457874, 681.4310051107282, 686.615495322621, 717.5083974320789, 727.5561907236581, 4383.9342409863875, 4567.10941366437, 5479.671219726829, 5682.062459694104, 5692.715364231772, 70269.0, 92120.53939730393, 106572.0, 122143.0, 123380.38309808394, 99261.014779704, 100439.0, 100630.4968475153, 100751.49624251832, 101146.0, 77653.68155821337, 80471.59764201376, 90003.0, 92466.53766731123, 93316.0, 9968.414529316595, 10008.599656013677, 10193.643222487177, 10295.433751143459, 10412.427316497666, 37746.0, 45367.319490208334, 49534.0, 51553.742231288605, 52400.73799630978, 66239.66880165569, 68970.65514672395, 73868.63065684852, 77062.2293777055, 77988.61005694936, 13519.594412167651, 13953.093048951785, 14075.0, 14093.15441073539, 14788.556343309718, 15051.924740376227, 15187.789914709228, 15640.765388518954, 15669.764953525479, 16359.836401635832, 14692.926535367254, 14907.92546037263, 15085.170315632746, 15129.621759456102, 15478.380864765284, 14629.0, 15078.170700611572, 15186.088834669956, 15527.45653902108, 15723.606909827346, 14635.780463293273, 14962.775558366415, 14971.326290316743, 15402.69194616079, 15446.150461724263, 11499.655010349703, 11741.882581174079, 11750.941245294061, 11856.288622682667, 11879.643610691694, 11420.091618814144, 11520.831566819046, 12288.447019884305, 12764.234145951272, 12805.28446792186], "value": 7599.061789044169, "unit": "score"}], "name": "dromaeo_css", "value": 7201.25700906645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 118.0, 176.0, 119.0, 118.0, 147.0, 118.0, 149.0, 118.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 109.0, 75.0, 76.0, 74.0, 75.0, 102.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 85.0, 84.0, 85.0, 114.0, 84.0, 86.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 48.0, 50.0, 50.0, 48.0, 48.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 80.0, 77.0, 76.0, 75.0, 78.0, 81.0, 74.0, 74.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 118.0, 118.0, 119.0, 129.0, 119.0, 120.0, 163.0, 123.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 160.0, 158.0, 155.0, 159.0, 157.0, 158.0, 158.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 65.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1474.4, "alertThreshold": 2.0}]} 15:45:22 INFO - Return code: 0 15:45:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:22 INFO - # TBPL SUCCESS # 15:45:22 INFO - Running post-action listener: _resource_record_post_action 15:45:22 INFO - [mozharness: 2016-08-02 22:45:22.397489Z] Finished run-tests step (success) 15:45:22 INFO - Running post-run listener: _resource_record_post_run 15:45:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541601792; Read time: 16; Write time: 411708 15:45:22 INFO - TinderboxPrint: CPU usage
13.1% 15:45:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:45:22 INFO - TinderboxPrint: I/O write bytes / time
541,601,792 / 411,708 15:45:22 INFO - TinderboxPrint: CPU idle
8,263.2 (86.9%) 15:45:22 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 15:45:22 INFO - TinderboxPrint: Swap in / out
0 / 0 15:45:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247148544; Read time: 0; Write time: 220560 15:45:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293396480; Read time: 0; Write time: 191076 15:45:23 INFO - Running post-run listener: _upload_blobber_files 15:45:23 INFO - Blob upload gear active. 15:45:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:23 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 15:45:23 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:45:23 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:45:23 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:24 INFO - (blobuploader) - INFO - Done attempting. 15:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:29 INFO - (blobuploader) - INFO - Done attempting. 15:45:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:45:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:30 INFO - (blobuploader) - INFO - Done attempting. 15:45:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:30 INFO - Return code: 0 15:45:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/022db145c6f105464d0bc5004fc452d67ce42133e934cf038aecf0e5795b57cea60126dfd06ca9ebfa22e40765819778ad90a016e1015e784f1c0d65ea68fe8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3d72195358dd9b66563ade8e4268fc38105fedfd66b6ad33c6269917607c75eaa2737a566937a076301b95e521722661bae657e06600d1fc75fd283028e1c9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5427930328b3d97754baa79b998d461a57100421b5cbbe108f3915cb9b90641b6af60bb8627db957f747b445b780ab816e4a12236696f126ef713b0d93f2e86a"} 15:45:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:30 INFO - Contents: 15:45:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/022db145c6f105464d0bc5004fc452d67ce42133e934cf038aecf0e5795b57cea60126dfd06ca9ebfa22e40765819778ad90a016e1015e784f1c0d65ea68fe8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3d72195358dd9b66563ade8e4268fc38105fedfd66b6ad33c6269917607c75eaa2737a566937a076301b95e521722661bae657e06600d1fc75fd283028e1c9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5427930328b3d97754baa79b998d461a57100421b5cbbe108f3915cb9b90641b6af60bb8627db957f747b445b780ab816e4a12236696f126ef713b0d93f2e86a"} 15:45:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:30 INFO - Copying logs to upload dir... 15:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.835570 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-02 15:45:30.125569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 15:45:30.128860) ========= 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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/022db145c6f105464d0bc5004fc452d67ce42133e934cf038aecf0e5795b57cea60126dfd06ca9ebfa22e40765819778ad90a016e1015e784f1c0d65ea68fe8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3d72195358dd9b66563ade8e4268fc38105fedfd66b6ad33c6269917607c75eaa2737a566937a076301b95e521722661bae657e06600d1fc75fd283028e1c9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5427930328b3d97754baa79b998d461a57100421b5cbbe108f3915cb9b90641b6af60bb8627db957f747b445b780ab816e4a12236696f126ef713b0d93f2e86a"} build_url:https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/ZYPvr4z9QNmLfO97-xKfNg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/022db145c6f105464d0bc5004fc452d67ce42133e934cf038aecf0e5795b57cea60126dfd06ca9ebfa22e40765819778ad90a016e1015e784f1c0d65ea68fe8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3d72195358dd9b66563ade8e4268fc38105fedfd66b6ad33c6269917607c75eaa2737a566937a076301b95e521722661bae657e06600d1fc75fd283028e1c9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5427930328b3d97754baa79b998d461a57100421b5cbbe108f3915cb9b90641b6af60bb8627db957f747b445b780ab816e4a12236696f126ef713b0d93f2e86a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 15:45:30.154960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:45:30.155280) ========= 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=00204705a9daa57ed339a427000001b9-1470176651.237001-1935830806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:45:30.240375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 15:45:30.240955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 15:45:30.241433) ========= ========= Total master_lag: 0.18 =========