builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1469428737.15 results: success (0) buildid: 20160724221825 builduid: 78c51b74b0444631a80d3a3204d57f0d revision: d5407d5642bf63eef799eedf52052fc9a6074d71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.155167) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.155556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.155860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.172549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.173318) ========= 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=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-24 23:38:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-07-24 23:38:58 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.316413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.316686) ========= 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=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018104 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.378542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:57.378844) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d5407d5642bf63eef799eedf52052fc9a6074d71 --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 d5407d5642bf63eef799eedf52052fc9a6074d71 --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=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-24 23:38:58,272 truncating revision to first 12 chars 2016-07-24 23:38:58,272 Setting DEBUG logging. 2016-07-24 23:38:58,272 attempt 1/10 2016-07-24 23:38:58,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d5407d5642bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-24 23:38:58,569 unpacking tar archive at: autoland-d5407d5642bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:58.057262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:58.057652) ========= script_repo_revision: d5407d5642bf63eef799eedf52052fc9a6074d71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:58.058139) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:58.058478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 23:38:58.079301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-24 23:38:58.079726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:38:59 INFO - MultiFileLogger online at 20160724 23:38:59 in /builds/slave/test 23:38:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 23:38:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:38:59 INFO - {'append_to_log': False, 23:38:59 INFO - 'base_work_dir': '/builds/slave/test', 23:38:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:38:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:38:59 INFO - 'branch': 'Autoland-Non-PGO', 23:38:59 INFO - 'buildbot_json_path': 'buildprops.json', 23:38:59 INFO - 'config_files': ('talos/linux_config.py',), 23:38:59 INFO - 'default_actions': ('clobber', 23:38:59 INFO - 'read-buildbot-config', 23:38:59 INFO - 'download-and-extract', 23:38:59 INFO - 'populate-webroot', 23:38:59 INFO - 'create-virtualenv', 23:38:59 INFO - 'install', 23:38:59 INFO - 'run-tests'), 23:38:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:38:59 INFO - 'download_minidump_stackwalk': True, 23:38:59 INFO - 'download_symbols': 'ondemand', 23:38:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:38:59 INFO - 'tooltool.py': '/tools/tooltool.py', 23:38:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:38:59 INFO - '/tools/misc-python/virtualenv.py')}, 23:38:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:38:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:38:59 INFO - 'installer_path': 'installer.exe', 23:38:59 INFO - 'log_level': 'info', 23:38:59 INFO - 'log_name': 'talos', 23:38:59 INFO - 'log_to_console': True, 23:38:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:38:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:38:59 INFO - 'opt_config_files': (), 23:38:59 INFO - 'pip_index': False, 23:38:59 INFO - 'sps_profile': False, 23:38:59 INFO - 'sps_profile_interval': 0, 23:38:59 INFO - 'suite': 'dromaeojs', 23:38:59 INFO - 'system_bits': '32', 23:38:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:38:59 INFO - 'title': 'talos-linux64-ix-028', 23:38:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:38:59 INFO - 'use_talos_json': True, 23:38:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:38:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:38:59 INFO - 'work_dir': 'build'} 23:38:59 INFO - [mozharness: 2016-07-25 06:38:59.066013Z] Running clobber step. 23:38:59 INFO - Running pre-action listener: _resource_record_pre_action 23:38:59 INFO - Running main action method: clobber 23:38:59 INFO - rmtree: /builds/slave/test/build 23:38:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:39:00 INFO - Running post-action listener: _resource_record_post_action 23:39:00 INFO - [mozharness: 2016-07-25 06:39:00.048274Z] Finished clobber step (success) 23:39:00 INFO - [mozharness: 2016-07-25 06:39:00.048374Z] Running read-buildbot-config step. 23:39:00 INFO - Running pre-action listener: _resource_record_pre_action 23:39:00 INFO - Running main action method: read_buildbot_config 23:39:00 INFO - Using buildbot properties: 23:39:00 INFO - { 23:39:00 INFO - "project": "", 23:39:00 INFO - "product": "firefox", 23:39:00 INFO - "script_repo_revision": "production", 23:39:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 23:39:00 INFO - "repository": "", 23:39:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 23:39:00 INFO - "buildid": "20160724221825", 23:39:00 INFO - "pgo_build": "False", 23:39:00 INFO - "basedir": "/builds/slave/test", 23:39:00 INFO - "buildnumber": 94, 23:39:00 INFO - "slavename": "talos-linux64-ix-028", 23:39:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:39:00 INFO - "platform": "ubuntu64_hw", 23:39:00 INFO - "scheduler": "tests-autoland-linux64-talos", 23:39:00 INFO - "branch": "autoland", 23:39:00 INFO - "repo_path": "integration/autoland", 23:39:00 INFO - "revision": "d5407d5642bf63eef799eedf52052fc9a6074d71", 23:39:00 INFO - "stage_platform": "linux64", 23:39:00 INFO - "builduid": "78c51b74b0444631a80d3a3204d57f0d", 23:39:00 INFO - "slavebuilddir": "test" 23:39:00 INFO - } 23:39:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:39:00 INFO - Running post-action listener: _resource_record_post_action 23:39:00 INFO - [mozharness: 2016-07-25 06:39:00.050806Z] Finished read-buildbot-config step (success) 23:39:00 INFO - [mozharness: 2016-07-25 06:39:00.050895Z] Running download-and-extract step. 23:39:00 INFO - Running pre-action listener: _resource_record_pre_action 23:39:00 INFO - Running main action method: download_and_extract 23:39:00 INFO - mkdir: /builds/slave/test/build/tests 23:39:00 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')]} 23:39:00 INFO - https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:39:06 INFO - Downloaded 1361 bytes. 23:39:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:06 INFO - Using the following test package requirements: 23:39:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:39:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:39:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'jsshell-linux-x86_64.zip'], 23:39:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:39:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:39:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:39:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:39:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:39:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:39: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')]} 23:39:06 INFO - https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:39:10 INFO - Downloaded 22737746 bytes. 23:39:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:39:11 INFO - Return code: 0 23:39:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:39: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')]} 23:39:11 INFO - https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:39:13 INFO - Downloaded 22737746 bytes. 23:39:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:39:14 INFO - Return code: 0 23:39: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')]} 23:39:14 INFO - https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:39:15 INFO - Downloaded 14403248 bytes. 23:39:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:39:15 INFO - Return code: 0 23:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:15 INFO - https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:39:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:39:16 INFO - Downloaded 57159388 bytes. 23:39:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:16 INFO - mkdir: /builds/slave/test/properties 23:39:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:39:16 INFO - Writing to file /builds/slave/test/properties/build_url 23:39:16 INFO - Contents: 23:39:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:17 INFO - Running post-action listener: _resource_record_post_action 23:39:17 INFO - Running post-action listener: set_extra_try_arguments 23:39:17 INFO - [mozharness: 2016-07-25 06:39:17.729571Z] Finished download-and-extract step (success) 23:39:17 INFO - [mozharness: 2016-07-25 06:39:17.729804Z] Running populate-webroot step. 23:39:17 INFO - Running pre-action listener: _resource_record_pre_action 23:39:17 INFO - Running main action method: populate_webroot 23:39:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:39:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:39:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:39:17 INFO - '--tppagecycles', 23:39:17 INFO - '7'], 23:39:17 INFO - 'tests': ['tsvgm']}}, 23:39:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:39:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:39:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:39:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:39:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['damp', 'tps']}, 23:39:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'tests': ['damp', 'tps']}, 23:39:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['dromaeo_dom']}, 23:39:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:39:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['basic_compositor_video']}, 23:39:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:39:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'other-e10s': {'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['a11yr', 23:39:17 INFO - 'ts_paint', 23:39:17 INFO - 'tpaint', 23:39:17 INFO - 'sessionrestore', 23:39:17 INFO - 'sessionrestore_no_auto_restore', 23:39:17 INFO - 'tabpaint']}, 23:39:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['tsvgx', 23:39:17 INFO - 'tsvgr_opacity', 23:39:17 INFO - 'tart', 23:39:17 INFO - 'tscrollx', 23:39:17 INFO - 'cart']}, 23:39:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:39:17 INFO - 'tsvgr_opacity', 23:39:17 INFO - 'tart', 23:39:17 INFO - 'tscrollx', 23:39:17 INFO - 'cart']}, 23:39:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'talos_options': ['--disable-e10s'], 23:39:17 INFO - 'tests': ['tp5o']}, 23:39:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'tests': ['tp5o']}, 23:39:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'talos_options': ['--disable-e10s', 23:39:17 INFO - '--xperf_path', 23:39:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:17 INFO - 'tests': ['tp5n']}, 23:39:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:17 INFO - 'talos_options': ['--xperf_path', 23:39:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:17 INFO - 'tests': ['tp5n']}}, 23:39:17 INFO - 'talos.zip': {'path': '', 23:39:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:39:17 INFO - Running post-action listener: _resource_record_post_action 23:39:17 INFO - [mozharness: 2016-07-25 06:39:17.747759Z] Finished populate-webroot step (success) 23:39:17 INFO - [mozharness: 2016-07-25 06:39:17.747848Z] Running create-virtualenv step. 23:39:17 INFO - Running pre-action listener: _resource_record_pre_action 23:39:17 INFO - Running main action method: create_virtualenv 23:39:17 INFO - Creating virtualenv /builds/slave/test/build/venv 23:39:17 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 23:39:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:39:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:39:17 INFO - Using real prefix '/usr' 23:39:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:39:18 INFO - Installing distribute.............................................................................................................................................................................................done. 23:39:20 INFO - Installing pip.................done. 23:39:20 INFO - Return code: 0 23:39:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:39:20 INFO - Using env: {'DISPLAY': ':0', 23:39:20 INFO - 'HOME': '/home/cltbld', 23:39:20 INFO - 'LANG': 'en_US.UTF-8', 23:39:20 INFO - 'LANGUAGE': 'en_US:en', 23:39:20 INFO - 'LOGNAME': 'cltbld', 23:39:20 INFO - 'MAIL': '/var/mail/cltbld', 23:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:20 INFO - 'MOZ_NO_REMOTE': '1', 23:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:20 INFO - 'NO_EM_RESTART': '1', 23:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:20 INFO - 'PWD': '/builds/slave/test', 23:39:20 INFO - 'SHELL': '/bin/bash', 23:39:20 INFO - 'SHLVL': '1', 23:39:20 INFO - 'TERM': 'linux', 23:39:20 INFO - 'TMOUT': '86400', 23:39:20 INFO - 'USER': 'cltbld', 23:39:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:20 INFO - '_': '/tools/buildbot/bin/python'} 23:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:20 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 23:39:20 INFO - Cleaning up... 23:39:20 INFO - Return code: 0 23:39:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:39:20 INFO - Using env: {'DISPLAY': ':0', 23:39:20 INFO - 'HOME': '/home/cltbld', 23:39:20 INFO - 'LANG': 'en_US.UTF-8', 23:39:20 INFO - 'LANGUAGE': 'en_US:en', 23:39:20 INFO - 'LOGNAME': 'cltbld', 23:39:20 INFO - 'MAIL': '/var/mail/cltbld', 23:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:20 INFO - 'MOZ_NO_REMOTE': '1', 23:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:20 INFO - 'NO_EM_RESTART': '1', 23:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:20 INFO - 'PWD': '/builds/slave/test', 23:39:20 INFO - 'SHELL': '/bin/bash', 23:39:20 INFO - 'SHLVL': '1', 23:39:20 INFO - 'TERM': 'linux', 23:39:20 INFO - 'TMOUT': '86400', 23:39:20 INFO - 'USER': 'cltbld', 23:39:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:20 INFO - '_': '/tools/buildbot/bin/python'} 23:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:20 INFO - Downloading/unpacking psutil>=3.1.1 23:39:20 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 23:39:20 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 23:39:20 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 23:39:20 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 23:39:20 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 23:39:20 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 23:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:39:22 INFO - Installing collected packages: psutil 23:39:22 INFO - Running setup.py install for psutil 23:39:22 INFO - building 'psutil._psutil_linux' extension 23:39:22 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 23:39:23 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 23:39:23 INFO - building 'psutil._psutil_posix' extension 23:39:23 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 23:39:23 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 23:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:39:23 INFO - Successfully installed psutil 23:39:23 INFO - Cleaning up... 23:39:23 INFO - Return code: 0 23:39:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:39:23 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')]} 23:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:23 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')]} 23:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:23 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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:23 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 23:39:23 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 23:39:23 INFO - Using env: {'DISPLAY': ':0', 23:39:23 INFO - 'HOME': '/home/cltbld', 23:39:23 INFO - 'LANG': 'en_US.UTF-8', 23:39:23 INFO - 'LANGUAGE': 'en_US:en', 23:39:23 INFO - 'LOGNAME': 'cltbld', 23:39:23 INFO - 'MAIL': '/var/mail/cltbld', 23:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:23 INFO - 'MOZ_NO_REMOTE': '1', 23:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:23 INFO - 'NO_EM_RESTART': '1', 23:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:23 INFO - 'PWD': '/builds/slave/test', 23:39:23 INFO - 'SHELL': '/bin/bash', 23:39:23 INFO - 'SHLVL': '1', 23:39:23 INFO - 'TERM': 'linux', 23:39:23 INFO - 'TMOUT': '86400', 23:39:23 INFO - 'USER': 'cltbld', 23:39:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:23 INFO - '_': '/tools/buildbot/bin/python'} 23:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:39:25 INFO - Installing collected packages: mozsystemmonitor 23:39:25 INFO - Running setup.py install for mozsystemmonitor 23:39:25 INFO - Successfully installed mozsystemmonitor 23:39:25 INFO - Cleaning up... 23:39:25 INFO - Return code: 0 23:39:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:39:25 INFO - Using env: {'DISPLAY': ':0', 23:39:25 INFO - 'HOME': '/home/cltbld', 23:39:25 INFO - 'LANG': 'en_US.UTF-8', 23:39:25 INFO - 'LANGUAGE': 'en_US:en', 23:39:25 INFO - 'LOGNAME': 'cltbld', 23:39:25 INFO - 'MAIL': '/var/mail/cltbld', 23:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:25 INFO - 'MOZ_NO_REMOTE': '1', 23:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:25 INFO - 'NO_EM_RESTART': '1', 23:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:25 INFO - 'PWD': '/builds/slave/test', 23:39:25 INFO - 'SHELL': '/bin/bash', 23:39:25 INFO - 'SHLVL': '1', 23:39:25 INFO - 'TERM': 'linux', 23:39:25 INFO - 'TMOUT': '86400', 23:39:25 INFO - 'USER': 'cltbld', 23:39:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:25 INFO - '_': '/tools/buildbot/bin/python'} 23:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:25 INFO - Downloading/unpacking jsonschema==2.5.1 23:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:39:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:39: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 23:39: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 23:39: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 23:39: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 23:39: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 23:39: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 23:39:27 INFO - Downloading functools32-3.2.3-2.tar.gz 23:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:39:28 INFO - warning: no files found matching '*.txt' 23:39:28 INFO - no previously-included directories found matching 'build' 23:39:28 INFO - no previously-included directories found matching 'dist' 23:39:28 INFO - no previously-included directories found matching '.git*' 23:39:28 INFO - Installing collected packages: jsonschema, functools32 23:39:28 INFO - Running setup.py install for functools32 23:39:28 INFO - warning: no files found matching '*.txt' 23:39:28 INFO - no previously-included directories found matching 'build' 23:39:28 INFO - no previously-included directories found matching 'dist' 23:39:28 INFO - no previously-included directories found matching '.git*' 23:39:28 INFO - Successfully installed jsonschema functools32 23:39:28 INFO - Cleaning up... 23:39:28 INFO - Return code: 0 23:39:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:39:28 INFO - Using env: {'DISPLAY': ':0', 23:39:28 INFO - 'HOME': '/home/cltbld', 23:39:28 INFO - 'LANG': 'en_US.UTF-8', 23:39:28 INFO - 'LANGUAGE': 'en_US:en', 23:39:28 INFO - 'LOGNAME': 'cltbld', 23:39:28 INFO - 'MAIL': '/var/mail/cltbld', 23:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:28 INFO - 'MOZ_NO_REMOTE': '1', 23:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:28 INFO - 'NO_EM_RESTART': '1', 23:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:28 INFO - 'PWD': '/builds/slave/test', 23:39:28 INFO - 'SHELL': '/bin/bash', 23:39:28 INFO - 'SHLVL': '1', 23:39:28 INFO - 'TERM': 'linux', 23:39:28 INFO - 'TMOUT': '86400', 23:39:28 INFO - 'USER': 'cltbld', 23:39:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:28 INFO - '_': '/tools/buildbot/bin/python'} 23:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:39:28 INFO - Cleaning up... 23:39:28 INFO - Return code: 0 23:39:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:39:28 INFO - Using env: {'DISPLAY': ':0', 23:39:28 INFO - 'HOME': '/home/cltbld', 23:39:28 INFO - 'LANG': 'en_US.UTF-8', 23:39:28 INFO - 'LANGUAGE': 'en_US:en', 23:39:28 INFO - 'LOGNAME': 'cltbld', 23:39:28 INFO - 'MAIL': '/var/mail/cltbld', 23:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:28 INFO - 'MOZ_NO_REMOTE': '1', 23:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:28 INFO - 'NO_EM_RESTART': '1', 23:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:28 INFO - 'PWD': '/builds/slave/test', 23:39:28 INFO - 'SHELL': '/bin/bash', 23:39:28 INFO - 'SHLVL': '1', 23:39:28 INFO - 'TERM': 'linux', 23:39:28 INFO - 'TMOUT': '86400', 23:39:28 INFO - 'USER': 'cltbld', 23:39:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:28 INFO - '_': '/tools/buildbot/bin/python'} 23:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:28 INFO - Downloading/unpacking blobuploader==1.2.4 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:30 INFO - Downloading blobuploader-1.2.4.tar.gz 23:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:39:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:39:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:31 INFO - Downloading docopt-0.6.1.tar.gz 23:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:39:31 INFO - Installing collected packages: blobuploader, requests, docopt 23:39:31 INFO - Running setup.py install for blobuploader 23:39:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:39:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:39:31 INFO - Running setup.py install for requests 23:39:31 INFO - Running setup.py install for docopt 23:39:32 INFO - Successfully installed blobuploader requests docopt 23:39:32 INFO - Cleaning up... 23:39:32 INFO - Return code: 0 23:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:32 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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:32 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 23:39:32 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 23:39:32 INFO - Using env: {'DISPLAY': ':0', 23:39:32 INFO - 'HOME': '/home/cltbld', 23:39:32 INFO - 'LANG': 'en_US.UTF-8', 23:39:32 INFO - 'LANGUAGE': 'en_US:en', 23:39:32 INFO - 'LOGNAME': 'cltbld', 23:39:32 INFO - 'MAIL': '/var/mail/cltbld', 23:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:32 INFO - 'MOZ_NO_REMOTE': '1', 23:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:32 INFO - 'NO_EM_RESTART': '1', 23:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:32 INFO - 'PWD': '/builds/slave/test', 23:39:32 INFO - 'SHELL': '/bin/bash', 23:39:32 INFO - 'SHLVL': '1', 23:39:32 INFO - 'TERM': 'linux', 23:39:32 INFO - 'TMOUT': '86400', 23:39:32 INFO - 'USER': 'cltbld', 23:39:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:32 INFO - '_': '/tools/buildbot/bin/python'} 23:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:39:32 INFO - Running setup.py (path:/tmp/pip-su9XBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:39:32 INFO - Running setup.py (path:/tmp/pip-gcJ_Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:39:32 INFO - Running setup.py (path:/tmp/pip-O6yD1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:39:32 INFO - Running setup.py (path:/tmp/pip-rqMQMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:39:32 INFO - Running setup.py (path:/tmp/pip-_bcfcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:39:32 INFO - Running setup.py (path:/tmp/pip-kkENwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:39:32 INFO - Running setup.py (path:/tmp/pip-9B0qxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:39:32 INFO - Running setup.py (path:/tmp/pip-3K0XXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:39:32 INFO - Running setup.py (path:/tmp/pip-RAoFy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:39:32 INFO - Running setup.py (path:/tmp/pip-Z4SEKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:39:33 INFO - Running setup.py (path:/tmp/pip-50OtaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:39:33 INFO - Running setup.py (path:/tmp/pip-SArZZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:39:33 INFO - Running setup.py (path:/tmp/pip-I1BCPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:39:33 INFO - Running setup.py (path:/tmp/pip-yZHSlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:33 INFO - Running setup.py (path:/tmp/pip-ZHL8uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:39:33 INFO - Running setup.py (path:/tmp/pip-k43_eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:39:33 INFO - Running setup.py (path:/tmp/pip-zkflQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:39:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:39:33 INFO - Running setup.py install for manifestparser 23:39:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:39:33 INFO - Running setup.py install for mozcrash 23:39:33 INFO - Running setup.py install for mozdebug 23:39:33 INFO - Running setup.py install for mozdevice 23:39:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:39:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:39:33 INFO - Running setup.py install for mozfile 23:39:34 INFO - Running setup.py install for mozhttpd 23:39:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozinfo 23:39:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozInstall 23:39:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozleak 23:39:34 INFO - Running setup.py install for mozlog 23:39:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for moznetwork 23:39:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozprocess 23:39:34 INFO - Running setup.py install for mozprofile 23:39:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozrunner 23:39:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Running setup.py install for mozscreenshot 23:39:35 INFO - Running setup.py install for moztest 23:39:35 INFO - Running setup.py install for mozversion 23:39:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:39:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:39:35 INFO - Cleaning up... 23:39:35 INFO - Return code: 0 23:39:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:35 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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:35 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 23:39:35 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 23:39:35 INFO - Using env: {'DISPLAY': ':0', 23:39:35 INFO - 'HOME': '/home/cltbld', 23:39:35 INFO - 'LANG': 'en_US.UTF-8', 23:39:35 INFO - 'LANGUAGE': 'en_US:en', 23:39:35 INFO - 'LOGNAME': 'cltbld', 23:39:35 INFO - 'MAIL': '/var/mail/cltbld', 23:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:35 INFO - 'MOZ_NO_REMOTE': '1', 23:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:35 INFO - 'NO_EM_RESTART': '1', 23:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:35 INFO - 'PWD': '/builds/slave/test', 23:39:35 INFO - 'SHELL': '/bin/bash', 23:39:35 INFO - 'SHLVL': '1', 23:39:35 INFO - 'TERM': 'linux', 23:39:35 INFO - 'TMOUT': '86400', 23:39:35 INFO - 'USER': 'cltbld', 23:39:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:35 INFO - '_': '/tools/buildbot/bin/python'} 23:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:39:35 INFO - Running setup.py (path:/tmp/pip-s3ae2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:39:35 INFO - Running setup.py (path:/tmp/pip-kadch0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:39:35 INFO - Running setup.py (path:/tmp/pip-Psb2By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:39:35 INFO - Running setup.py (path:/tmp/pip-EivSjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:39:35 INFO - Running setup.py (path:/tmp/pip-Ls5Gr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:39:35 INFO - Running setup.py (path:/tmp/pip-0kwfHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:39:35 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)) 23:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:39:35 INFO - Running setup.py (path:/tmp/pip-ccGbwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:39:36 INFO - Running setup.py (path:/tmp/pip-kJlxOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:39:36 INFO - Running setup.py (path:/tmp/pip-_p_rtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:39:36 INFO - Running setup.py (path:/tmp/pip-Rm0cRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:39:36 INFO - Running setup.py (path:/tmp/pip-5_EeIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:39:36 INFO - Running setup.py (path:/tmp/pip-trhuIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:39:36 INFO - Running setup.py (path:/tmp/pip-TUyTYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:39:36 INFO - Running setup.py (path:/tmp/pip-AnxSIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:36 INFO - Running setup.py (path:/tmp/pip-3vweNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:39:36 INFO - Running setup.py (path:/tmp/pip-8oyG0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:39:36 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)) 23:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:39:36 INFO - Running setup.py (path:/tmp/pip-pI7JPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:39:36 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)) 23:39:36 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)) 23:39:36 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)) 23:39:36 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)) 23:39:36 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)) 23:39:36 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)) 23:39:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:39 INFO - Downloading blessings-1.6.tar.gz 23:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:39:39 INFO - Installing collected packages: blessings 23:39:39 INFO - Running setup.py install for blessings 23:39:39 INFO - Successfully installed blessings 23:39:39 INFO - Cleaning up... 23:39:39 INFO - Return code: 0 23:39:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:39:40 INFO - Reading from file tmpfile_stdout 23:39:40 INFO - Current package versions: 23:39:40 INFO - argparse == 1.2.1 23:39:40 INFO - blessings == 1.6 23:39:40 INFO - blobuploader == 1.2.4 23:39:40 INFO - docopt == 0.6.1 23:39:40 INFO - functools32 == 3.2.3-2 23:39:40 INFO - jsonschema == 2.5.1 23:39:40 INFO - manifestparser == 1.1 23:39:40 INFO - mozInstall == 1.12 23:39:40 INFO - mozcrash == 0.17 23:39:40 INFO - mozdebug == 0.1 23:39:40 INFO - mozdevice == 0.48 23:39:40 INFO - mozfile == 1.2 23:39:40 INFO - mozhttpd == 0.7 23:39:40 INFO - mozinfo == 0.9 23:39:40 INFO - mozleak == 0.1 23:39:40 INFO - mozlog == 3.3 23:39:40 INFO - moznetwork == 0.27 23:39:40 INFO - mozprocess == 0.23 23:39:40 INFO - mozprofile == 0.28 23:39:40 INFO - mozrunner == 6.12 23:39:40 INFO - mozscreenshot == 0.1 23:39:40 INFO - mozsystemmonitor == 0.3 23:39:40 INFO - moztest == 0.7 23:39:40 INFO - mozversion == 1.4 23:39:40 INFO - psutil == 3.1.1 23:39:40 INFO - requests == 1.2.3 23:39:40 INFO - wsgiref == 0.1.2 23:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:40 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')]} 23:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:40 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')]} 23:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:40 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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:40 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 23:39:40 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 23:39:40 INFO - Using env: {'DISPLAY': ':0', 23:39:40 INFO - 'HOME': '/home/cltbld', 23:39:40 INFO - 'LANG': 'en_US.UTF-8', 23:39:40 INFO - 'LANGUAGE': 'en_US:en', 23:39:40 INFO - 'LOGNAME': 'cltbld', 23:39:40 INFO - 'MAIL': '/var/mail/cltbld', 23:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:40 INFO - 'MOZ_NO_REMOTE': '1', 23:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:40 INFO - 'NO_EM_RESTART': '1', 23:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:40 INFO - 'PWD': '/builds/slave/test', 23:39:40 INFO - 'SHELL': '/bin/bash', 23:39:40 INFO - 'SHLVL': '1', 23:39:40 INFO - 'TERM': 'linux', 23:39:40 INFO - 'TMOUT': '86400', 23:39:40 INFO - 'USER': 'cltbld', 23:39:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:40 INFO - '_': '/tools/buildbot/bin/python'} 23:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 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)) 23:39:40 INFO - Cleaning up... 23:39:40 INFO - Return code: 0 23:39:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:39:40 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')]} 23:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:40 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')]} 23:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:40 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 0x167b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, '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': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', '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 23:39:40 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 23:39:40 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 23:39:40 INFO - Using env: {'DISPLAY': ':0', 23:39:40 INFO - 'HOME': '/home/cltbld', 23:39:40 INFO - 'LANG': 'en_US.UTF-8', 23:39:40 INFO - 'LANGUAGE': 'en_US:en', 23:39:40 INFO - 'LOGNAME': 'cltbld', 23:39:40 INFO - 'MAIL': '/var/mail/cltbld', 23:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:40 INFO - 'MOZ_NO_REMOTE': '1', 23:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:40 INFO - 'NO_EM_RESTART': '1', 23:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:40 INFO - 'PWD': '/builds/slave/test', 23:39:40 INFO - 'SHELL': '/bin/bash', 23:39:40 INFO - 'SHLVL': '1', 23:39:40 INFO - 'TERM': 'linux', 23:39:40 INFO - 'TMOUT': '86400', 23:39:40 INFO - 'USER': 'cltbld', 23:39:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:40 INFO - '_': '/tools/buildbot/bin/python'} 23:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:39:40 INFO - Cleaning up... 23:39:40 INFO - Return code: 0 23:39:40 INFO - Running post-action listener: _resource_record_post_action 23:39:40 INFO - Running post-action listener: _start_resource_monitoring 23:39:40 INFO - Starting resource monitoring. 23:39:40 INFO - [mozharness: 2016-07-25 06:39:40.577800Z] Finished create-virtualenv step (success) 23:39:40 INFO - [mozharness: 2016-07-25 06:39:40.578233Z] Running install step. 23:39:40 INFO - Running pre-action listener: _resource_record_pre_action 23:39:40 INFO - Running main action method: install 23:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:39:40 INFO - Reading from file tmpfile_stdout 23:39:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:39:40 INFO - Reading from file tmpfile_stdout 23:39:40 INFO - Output received: 23:39:40 INFO - Usage: mozinstall [options] installer 23:39:40 INFO - Options: 23:39:40 INFO - -h, --help show this help message and exit 23:39:40 INFO - -d DEST, --destination=DEST 23:39:40 INFO - Directory to install application into. [default: 23:39:40 INFO - "/builds/slave/test"] 23:39:40 INFO - --app=APP Application being installed. [default: firefox] 23:39:40 INFO - mkdir: /builds/slave/test/build/application 23:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:39:57 INFO - Reading from file tmpfile_stdout 23:39:57 INFO - Output received: 23:39:57 INFO - /builds/slave/test/build/application/firefox/firefox 23:39:57 INFO - Running post-action listener: _resource_record_post_action 23:39:57 INFO - [mozharness: 2016-07-25 06:39:57.245963Z] Finished install step (success) 23:39:57 INFO - [mozharness: 2016-07-25 06:39:57.246239Z] Running run-tests step. 23:39:57 INFO - Running pre-action listener: _resource_record_pre_action 23:39:57 INFO - Running main action method: run_tests 23:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:39:57 INFO - Python 2.7.3 23:39:57 INFO - Return code: 0 23:39:57 INFO - grabbing minidump binary from tooltool 23:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:57 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 0x193a3b0>, '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 0x193b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:39:57 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 23:39:57 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 23:39:57 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 23:39:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:39:57 INFO - Return code: 0 23:39:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:39:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:39:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:39:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:39:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 23:39:57 INFO - Using env: {'DISPLAY': ':0', 23:39:57 INFO - 'HOME': '/home/cltbld', 23:39:57 INFO - 'LANG': 'en_US.UTF-8', 23:39:57 INFO - 'LANGUAGE': 'en_US:en', 23:39:57 INFO - 'LOGNAME': 'cltbld', 23:39:57 INFO - 'MAIL': '/var/mail/cltbld', 23:39:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:39:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:57 INFO - 'MOZ_NO_REMOTE': '1', 23:39:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:57 INFO - 'NO_EM_RESTART': '1', 23:39:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:57 INFO - 'PWD': '/builds/slave/test', 23:39:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:39:57 INFO - 'SHELL': '/bin/bash', 23:39:57 INFO - 'SHLVL': '1', 23:39:57 INFO - 'TERM': 'linux', 23:39:57 INFO - 'TMOUT': '86400', 23:39:57 INFO - 'USER': 'cltbld', 23:39:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082', 23:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:57 INFO - '_': '/tools/buildbot/bin/python'} 23:39:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:39:57 INFO - mozversion application_buildid: 20160724221825 23:39:57 INFO - mozversion application_changeset: d5407d5642bf63eef799eedf52052fc9a6074d71 23:39:57 INFO - mozversion application_display_name: Nightly 23:39:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:39:57 INFO - mozversion application_name: Firefox 23:39:57 INFO - mozversion application_remotingname: firefox 23:39:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:39:57 INFO - mozversion application_vendor: Mozilla 23:39:57 INFO - mozversion application_version: 50.0a1 23:39:57 INFO - mozversion platform_buildid: 20160724221825 23:39:57 INFO - mozversion platform_changeset: d5407d5642bf63eef799eedf52052fc9a6074d71 23:39:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:39:57 INFO - mozversion platform_version: 50.0a1 23:39:57 INFO - using testdate: 1469428797 23:39:57 INFO - actual date: 1469428797 23:39:57 INFO - starting webserver on 'localhost:57479' 23:39:57 INFO - SUITE-START | Running 2 tests 23:39:57 INFO - TEST-START | dromaeo_css 23:39:57 INFO - operating with platform_type : linux_ 23:39:57 INFO - Initialising browser for dromaeo_css test... 23:39:57 INFO - TEST-INFO | started process 30080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCtYoBk/profile http://localhost:57479/getInfo.html) 23:40:01 INFO - PROCESS | 30080 | JavaScript error: , line 0: uncaught exception: undefined 23:40:01 INFO - PROCESS | 30080 | __metrics Screen width/height:1600/1200 23:40:01 INFO - PROCESS | 30080 | colorDepth:24 23:40:01 INFO - PROCESS | 30080 | Browser inner width/height: 1024/697 23:40:01 INFO - PROCESS | 30080 | __metrics 23:40:02 INFO - PROCESS | 30080 | 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" 23:40:02 INFO - PROCESS | 30080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:40:03 INFO - TEST-INFO | 30080: exit 0 23:40:03 INFO - Browser initialized. 23:40:03 INFO - Running cycle 1/1 for dromaeo_css test... 23:40:03 INFO - TEST-INFO | started process 30161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCtYoBk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:15 INFO - PROCESS | 30161 | RSS: Main: 158990336 23:40:15 INFO - PROCESS | 30161 | 23:41:07 INFO - PROCESS | 30161 | 1469428867037 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] 23:43:20 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57479/tests/dromaeo/cssquery-ext.html) 23:43:21 INFO - PROCESS | 30161 | RSS: Main: 248532992 23:43:21 INFO - PROCESS | 30161 | 23:46:24 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-ext.html (next: http://localhost:57479/tests/dromaeo/cssquery-jquery.html) 23:46:24 INFO - PROCESS | 30161 | RSS: Main: 244981760 23:46:24 INFO - PROCESS | 30161 | 23:49:26 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57479/tests/dromaeo/cssquery-mootools.html) 23:49:27 INFO - PROCESS | 30161 | RSS: Main: 190763008 23:49:27 INFO - PROCESS | 30161 | 23:52:29 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57479/tests/dromaeo/cssquery-prototype.html) 23:52:30 INFO - PROCESS | 30161 | RSS: Main: 196096000 23:52:30 INFO - PROCESS | 30161 | 23:55:33 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57479/tests/dromaeo/cssquery-yui.html) 23:55:34 INFO - PROCESS | 30161 | RSS: Main: 190611456 23:55:34 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | Cycle 1(1): loaded http://localhost:57479/tests/dromaeo/cssquery-yui.html (next: http://localhost:57479/tests/dromaeo/cssquery-dojo.html) 23:58:37 INFO - PROCESS | 30161 | RSS: Main: 283267072 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | __start_tp_report 23:58:37 INFO - PROCESS | 30161 | _x_x_mozilla_page_load 23:58:37 INFO - PROCESS | 30161 | _x_x_mozilla_page_load_details 23:58:37 INFO - PROCESS | 30161 | |i|pagename|runs| 23:58:37 INFO - PROCESS | 30161 | |0;dojo.html;2578.8194826362155;2593.1053786443695;2623.698274698409;2624.068455698227;2641.366072142685;4699.224627936395;4751.287306903966;4789.592884604808;4823.15594770915;4823.20417131173;4779.665423420353;4792.089502994429;4817.542333478314;4820.421549414066;4863.36776219091;4332.588404101605;4357.433533640622;4421.756803375813;4474.686771925966;4532.728036317815;4453.84411545596;4489.955100449003;4506;4520.163769702599;4525.637948964091;4336.1978034063795;4363.476382834048;4378.949052227475;4379.715318504287;4455.108978204372;4375.496817865955;4379.1679580879845;4384.671149663788;4392.407025051641;4479.8800299925015;4394.582514661134;4405.273129933557;4409.647228221735;4436.800343984496;4437.112577484516;4662.347271382009;4692.460367057798;4817.975910120427;4821.22860342347;4861.246506791453;5084.415292241402;5093.032323858455;5140.537351638333;5149.562287205592;5150.150225212836;5119.974400127976;5151.5106064923775;5158.38099428071;5178.17149256121;5179.741012949337;4706.788194531255;4786.473487916326;4804.663673542888;4826.879328016757;4868.902621947541;5346.705931173745;5392.272043274186;5400.972995134999;5409;5411.891762164734;5126.077306084866;5178;5190.558802501754;5191.6884986900905;5195.792168313225;4981.676191047571;5071.41678706946;5218.765155568009;5271.156614941668;5279.894402111936;5021.84934451967;5074.543291103819;5076;5083.186690129562;5131.230315452712;5055.545000949932;5065.620078494054;5070.087384270867;5070.873228169252;5110.642255042186;4324.71889327199;4348.956510434855;4363.3018717005125;4380.649548036149;4420.248557745191;3771.7548359356556;3797.3354662933875;3798.9620103798607;3821.9044523887123;3907.0427745202605;4399.054203346296;4407.823687052482;4409.647228221735;4412.735235885857;4456.77716114193;5135.820246291362;5164.2770012198325;5181.922271165936;5181.922271165936;5181.948180518222;4339.652827773771;4396.978015109904;4446;4447.510773814878;4509.210888094571;4690.108879312919;4721.834735784231;4722.693024953367;4724.976375118103;4771.832985845548;4873;4886.682365646222;4887.095887260797;4888.193448081027;4936.284238785428;5085.847424577269;5109.131447653834;5137.409197942285;5152.149895267239;5223.660462069954;4746.240601503743;4768.070226305976;4781.569658730731;4794.400699912511;4834.492378300228;5064.721440320818;5069.062223488666;5075.086484432837;5078.08594453002;5178.404483484297;5073.086844368049;5124.461931497139;5170.586353091669;5181.81863634771;5239.109351410346;5017.724025178504;5063.518965698253;5075.695458272516;5078.568321692697;5121.07820592282;4999.325091112653;5003.3495645565845;5013.348264725562;5017.347744793154;5019.3976722793495;4791.904161916673;4918.286848407032;4965.230389289666;4970.900581988412;5044.344235249394;5082.288479612931;5095.235714642833;5096.974515127401;5099.286099945936;5152.458991805806;4961.603071754179;4961.627877909099;4978.2034874419915;4996.60027197816;4999.77501012448 23:58:37 INFO - PROCESS | 30161 | |1;ext.html;571.4542611805726;571.7970120607184;575.4906907386963;591.4824528537531;594.4204400709309;27392.452150956968;39312.41031384528;40751.79624101883;40779;44270.557294427046;40700.18599628006;41133.38299925504;41144.38283425751;41149.794251028776;41150.382744258786;7404.629768511553;7625.809354766147;7760.495567788075;7763.068431788165;7764.456488045811;7323.670434830418;7547.094348678166;7549.773506794805;9563.091506306924;9838.360506567085;10158.949205253963;10189.388636681786;10198;10211;10219.48902554873;9872.210223182128;9921.851172232422;9935.8509622355;9942.751431214205;9943.701688949342;9980.201583873346;10026.9498652507;10048.44733539655;10056.245781566338;10070.69787906364;38940.22119557621;39031;39063.41404878929;39395.60604393977;39453.802730986165;3010.202296391458;3086.2592977685194;3233.143217047461;3303.8513266903046;3401.710854577364;29728.405431891457;30210.395792084255;30539;30656;30895.0731478056;3470.8958731238104;3486.7384946128886;3525.964740352615;3555.520004799345;3606.6393360663988;249141;249144.9999999982;249553;250171;250293;29159.416811663647;53553.732231338596;53875.73062134664;53918.73040634772;53950.46049539533;31037.534436983464;32412.35175296528;32570.674293257238;32578.022659320257;32603.51094733581;13349.799753003712;13393.129446585941;13407.128536645087;13421.731565368833;13457.663558411117;11938.462769175409;12017.278963262232;12029.097817663534;12048.156629035884;12048.87951120495;7309.159446663595;7516.210797866145;7531.3598344141365;7614.428917831185;7657.57883316423;2987.0142852858503;3055.572219889217;3058.9694103058687;3074.9231269218003;3080.3377273885776;787.322902304018;863.792689754467;881.1761003461784;939.2063706168277;1016.5527168046036;26762.464750704876;27954;28296.151115466568;28376.716232837407;28551.57172642412;970.6457143142702;990.5195979949718;997.7206382212992;1002.2382988928467;1030.7526193713454;14754.63113422173;15030.17334046616;15031;15036.473723419627;15117.486080966364;399738;404014;404536;404625;405916;46337;46440.07119857584;51028.23457648138;51366.48633513617;51635.48364516307;1112.9944350278197;1122.2256642916361;1123.5730422439422;1125.083057308291;1167.1071630202732;27969.720302797527;29783.851080744458;30073;30570.694293056786;30584.235394115327;43884.341734874644;44532.77733611311;44536.77731611451;44545;44562.77718611386;319419;322136;322507;323078;323400;23750.643740344254;24502;24519;25607.871960640077;25937.740622593534;39832;40284.59715402809;40377.79811100926;41060.58939410568;41067;34780.47829282512;34994.125146871535;35215.767448139195;35290.47064294089;35829.10427239235;33939.66060339365;34387;34661.65338346685;34895.82552087223;34918.7778427764;34509.482357765155;34662.480062798575;35238.295234094665;35380.823095884356;35694.28611427705;30645.693543064284;32290.83854580806;32454;32638.83680581582;32699.836500817342;24338.63492047656;24564.263072107864;24859.50280994406;25026.249212523653;25330.366740831625 23:58:37 INFO - PROCESS | 30161 | |2;jquery.html;341.7846756543377;357.737063258505;360.48270731500315;367.346123899459;380.1941670471917;12652.114351995364;16059.919700401497;16136.596585085379;16936.491905242863;16995.405160819373;16383.180840957964;16667;16761.497155085337;16812.32750689971;16824.66350672989;4982.601391888649;5084.44071152173;5115.59075273979;5122.948770512303;5136.280920671109;3736.551613806347;4899.314096026559;5086.415062267831;5088.567471764886;5664;5871.76512939484;5947.286325640929;5968.4031596840405;5969.224000879901;5975.073863551135;5834.241548598677;5897.764089436418;5962.403759624046;5987.311459182162;5999.76000959961;5254.238135470374;5254.842354729364;5256.421793602701;5261.7369131543655;5261.815836445706;19571.315003974792;20099.899500502404;20224.595508089755;20330.49173770653;20680.276190333418;1852.397970659541;1927.152053096633;2004.6992951057312;2014.5668681233458;2405.2663937499055;12420.192687475284;13092.672683182902;13308.935285177162;13500.189988600716;13603.86396136036;1675.8407951244612;1747.248683066281;1766.3199668127734;1773.9911300443416;1800.4328636479468;49544.752276238745;66982;67806.321936781;68340.97488537726;70476.29523704748;9104.31717621181;9154.588043537924;9387.483688397067;9513.143817056498;9728.756781080388;12569.245845249314;12588.244705317711;12592.559260425842;12595.181313214613;12598.937005314914;7105.111861017373;7147.857042859114;7159.498835081598;7368.300011498899;7374.741884034141;6974.321681620323;7103.822404439827;7226.387247667282;7278.126624805057;7368.59472729005;5859.2382990211;6001.1898393717165;6008.849778755566;6011.098335249748;6159.3224745277985;1703.2420572845213;1721.690095782771;1726.4216487476835;1743.076169630098;1758.3845654021245;817.6279792694429;845.0915266088979;929.665320484625;932.6036434515439;960.3949511807516;15947.681046379008;16566.254518546695;16753.497395078168;17290.740638890427;17363.47909562715;806.3186607316808;826.1862065865118;834.1825011488654;842.0905422144192;849.087231226434;9074.183323500916;9306;9311.161995420445;10004.099631033241;10374.27380083402;420558;423606;423886;430075.29322361137;431445;81918;82313.58843205746;84325.57837210897;86055.56972215099;86891;861.8060936289285;868.2880038368603;868.6699054359303;876.1895246896595;877.6752601537472;14548.781768273697;14586.54134586533;15508;15674.843251567338;15727.370905163665;33423.33153336968;36216.81891590525;38760.6123938757;38907.61092389153;39940;53534.196987046;54768.72615636896;55270;55699.72150139223;56021.159682603975;6025.096235564525;6174.722137503733;7170.211276759656;7295.817604559928;7420.6660700269695;9281.907180928105;11180.944095279472;11329.490172942073;12038.097142714507;12081.335526546125;9625.32622716431;9662;10494.108000820015;10626.52180651888;10661.733456663334;10018.198544116307;10233.590656373959;10285.84571231447;10388.532516036645;10444.268901176845;10226.948865255627;10285.588576457158;10352.378857268588;10413;10506.474676266003;7375.963120184365;7616.124145723091;7620.923790762022;7679.462437629312;7739.729109481141;9667.226621870093;10079.395236285847;10085.89914100879;10090.394576325443;10239.385636861813 23:58:37 INFO - PROCESS | 30161 | |3;mootools.html;1247.2080229054548;1332.8400591928967;1412.2444492196676;1451.9709605807884;1642.6632540329242;6671.666416679165;7407.740729074483;7601.391888648908;7615.657295421705;7811.92188078119;7703.075630924297;7720.266574675411;7765.844683106335;7767.417443691732;7770.883436748439;2176.7387913450407;2202.0971401725296;2202.3062735238427;2202.41635966469;2209;2105.589410065038;2148.3769706785015;2177.096504950444;2177.4882902517897;2177.618916689573;2104.4318034130774;2112.207922029239;2122.0556852200775;2125.936221913345;2169.967450488244;2095.6542170541843;2098.223657246821;2098.6222479953603;2102.6425507663735;2109.0193060226993;2015.3248661698349;2117.2166298469665;2118.3644906528134;2120.035383900337;2125.489882428206;7736.34241089508;7861;7867.6066196689935;7874.133845277015;7877.606119693993;4411.735295882258;4535.727856328598;4538.115067561826;4604.608608268301;4607;2726.086760935089;2869.4117705870453;2898.6231789867184;2905.796594238404;2906.593076969226;902.7291812456302;915.1031988651159;919.5678031325266;926.6339795780628;929.3401684803797;10625.46872656364;10803.297785643987;10819.783604327948;10820.08029317509;10831.241813073088;3867.3425517662067;4123.773192474443;4131.07050913542;4225.619694227473;4230.788460576959;8498.362622803315;8513.148685131437;8514.318854491627;8515.446495977742;8516.61675224604;4610.700304480198;4621.861344159681;4623.791929363187;4624.30635404692;4632.5830675239395;3691.90770230741;3774.6036666150208;4127.9174416511505;4295.763732994716;4301.07526881722;3326.5841769778776;3410.7782994105305;3485;3502.9124271893406;3504.3867323218333;966.8163049020804;1003.6537394598852;1011.7622358745689;1019.5615885169449;1019.6686077024997;700.4851434195862;835.5738573327646;850.2602735619927;858.5664239558982;864.4899509289423;5185.118529849935;5273.288106105703;5320.361556613231;5443.183522471581;5464.644798088111;883.6818745251704;893.7363477774072;906.664534122379;924.8658944453017;935.3779736475303;3513.5959364672876;3615.4215325547784;3625.9818700906326;3642.34437801193;3700.9259814803554;9198;9532.285078619132;9628.75928101789;9670.516474176264;9676.612935482643;9283.675071372469;9521.809563808685;9550;9574.186194173433;9580.473073980858;6792.354726300993;6915.377616014583;6926;6928.376446119873;6945.548539345027;5221.791128354823;5228.790848366023;5285.392179899361;5331.893362132813;5443.945560544344;8897.73306800797;8977.147171018743;8995.685151019683;9006.189442950166;9084.22784063362;8502.957485212535;8702.738917832476;8750.82498350042;8753.824923501621;9054;6070.0591408331775;6615;6778.627175505198;6998.285420072115;7005.859882802213;7343.669534870837;7526.962365188139;7533.1336896257635;7549.471536992358;7553.848923021619;6655.367740064686;6678.165229346332;6819.965900170666;6840.3501667341525;7054.435645148274;6531.804045878631;6688.598684078971;6794.796156115324;6798.796036118924;6852.417544508772;5787.594868359343;5981.730822112929;5991.7902873399225;6026.306974697965;6041.818745437644;4648.674592778609;4650.558196971282;4781.282807578891;4788.640851936049;4789.99410123864;4413.713108647928;4525.615322697476;4625.537446255347;4685.039566888711;4848.660593758545 23:58:37 INFO - PROCESS | 30161 | |4;prototype.html;282.89532872837043;288.29511843542537;291.9430711011354;295.8963067757266;303.3841302156623;4946.901061978759;4973.278874563195;4978.925316120261;4980.925286120707;5033;4643.16423043852;4777.498362671913;4785.61715062795;4866.780994855231;4939.901201975958;3874.6364717522288;3875.2830726315583;3886.31989401855;3889.649931506171;3899.844006239747;3859.20886218326;3870.1679138985114;3882.7476214045996;3890.2219556088753;3909.6676782473523;3629.3648611493013;3698.4267438547067;3837;3844.5386553613607;3867.9806600966954;3817.10298079951;3824.694024478035;3831.597682243352;3837.884863454101;3844.4233364995193;3388.5594872666643;3392.2367467319655;3394.6435624259593;3397.3013493253375;3400.880969166092;4629.444466663988;4769.666123371366;4769.856904292877;4778.546038126373;4782.832600858988;4337.284348082562;4337.590283157986;4342.1966936116605;4361.040571074359;4382.496012958519;5087.194046113614;5091.414487333967;5091.414487333967;5096.898062038776;5098.439171691111;3682.355587772156;3683.1712864605515;3685.4656074869263;3689.0632417980773;3694.6674799268194;5142.640015198937;5327.254184414146;5327.786888524454;5340.332458442734;5349.3045904032615;3776.2069965307046;3780.281746468162;3783.45139954705;3784.508013958168;3786.1670432504807;3828.2343531293855;3834.4440056191697;3835.4822099016274;3839.6928245740273;3850.634189751969;4233.121477395339;4303.376010478463;4338.978305108454;4354.259775838115;4358.259095953632;5104.617153713486;5105.259737338065;5107.284980102789;5114.974425127925;5115.846524604268;1320.3134370127673;1329.1958365189114;1333.973320533584;1337.9397927093305;1341.8456877459023;835.3651225068992;836.2056046755606;886.9911300886909;901.2654686430539;920.9363185520734;4423.911521769546;4427.380166776654;4444.555544445529;4444.577765112309;4453.842001079743;5226.268322434787;5227.163653815372;5227.843164705065;5232.136697444955;5246.635874672536;4282.571742825692;4448.73211134825;4450.488193857683;4458.843940462133;4519.118771839526;2808.974724225643;2823.037988597946;2826.477101736144;2832.5467925132293;2841.247069526577;4945.975270123627;4954.47977962316;4960.9907987265215;4962.478939711278;4974.980129073531;5163.97418012915;5402.162664786964;5416.83749487516;5432.75552600134;5476.58925580583;4989.226669866177;4994.325766021613;5005.424376196711;5028.270900719448;5035.420926593415;5371.5971302153275;5371.946280537145;5377.220303056113;5382.3003009610065;5383.542398895981;5138.5375316220225;5144.710603781281;5214.21786731978;5240.7641656126325;5249.396319423316;4973.47778483254;4982.202847544376;4985.825496107619;4995.450500444876;4998.350214472095;3656.46981187721;3662.1393972415926;3664.1022949377575;3667.2298817248675;3682.8526858925343;5115.616328775282;5315.654482458628;5337.146056630921;5338.599605029716;5353.4646535346155;5162.896742065062;5164.767585458589;5176.456472070378;5179.1454410021925;5184.381887146967;5157.742112894415;5180.7150606717;5189.948100518946;5210;5215.973920130375;4998.375203099613;5098.872528186825;5133.638526277954;5140.203268493389;5141.203113517411;4962.255661650781;5094.439611642642;5136.486351364833;5197.584193264454;5204.9739751301;5073.883745575968;5088.898222035613;5096.413912399973;5098.827269728057;5126.154184559655 23:58:37 INFO - PROCESS | 30161 | |5;yui.html;624.9562530622857;626.6647343671137;643.4209211709461;659.4691273524812;725.7677543186182;12719.809202861965;13180.868191318084;13789.793153102686;13810.309484525771;13816.240106794123;13135.868641313584;13174.407151678173;13288.335583220849;13347.59957201283;13363.198208107497;766.7508059880533;788.0897563314353;789.4513313247295;789.6643926331286;789.6683392974935;633.5565104426896;650.1028580558822;650.6909218121402;654.630133974303;784.19228194959;796.4424902568196;827.148037521354;827.2720006394364;832.4672209785742;834.6953362022879;817.5952903312868;823.2261674026456;824.0770337222319;824.2458150792048;824.7608193623842;487.16451286044605;602.5029350785619;602.6625089949642;602.8553147244673;603.0050416812251;10496.475176241158;11042.33745975244;11052.281601695864;11805.822912656231;12289.631311060682;12438.129330946836;12785.16896401731;12909.935450322782;13301.800472992913;13581.932090339486;10475.371477711362;10573.312734672221;10721.303115297558;10820.891791082146;10961.177911656578;3188.5854838871032;3196.4406228909847;3252.235724604716;3252.674732526752;3303.4219011672863;59560.40439595592;59989;60012;60248.39751602516;61174;10105.848412273675;10133.00438705574;10172.694819155437;10226.590936362461;10299.12457441111;19619.313324033592;19642.21431142767;19649.705254421195;19650.50873728168;19660.90169549143;6602.669866506655;6615.305392933769;6784.8303792404595;6831.658417079127;6832.521723479408;3723.0878434783654;3784.508013958223;3812.256609961031;3815.465834783133;3816.8282427290837;2862.355969906754;2968.7031296870573;2972.821630702165;2974.7322740952986;2983.284011837187;500.7070863544867;519.3715604118983;566.3147591414353;569.7920259105397;571.6827160925643;460.1808780370945;481.0955403840827;482.2525086116505;485.8032496838786;492.63544976717685;6738.427233685094;7043.190033146254;7048.471364647569;7219.458540609476;7435.553866768011;550.6723499517781;575.6948817126929;584.3367777572486;594.147398483178;615.7998650438625;3569.660882216185;3600.617077469148;3695.279420512974;3747.4940882980995;3856.4793752843566;99236;99883;101965.49017254866;102712;107020.46489767657;89484;90318.54840725886;91140.54429727809;91270;93381;77945;78996;81222.59388703019;81854;83882.16117838866;7389.593572353572;7456.552606843607;7553.811154720956;8127.471714338549;8251.381146413923;30353.544696830006;30740.077797666105;38979.61020389873;39250.62622808188;43156.352654709575;39717.80141099276;51031.97936041332;55291.72354138204;62720;63547;10276.434796086287;10604.416757078434;10939.398333091438;11201.60794372193;11233.71915702114;11948.163628545919;12003.219790713576;12436.253824770543;12639.93680031594;13086.738265234833;11414;11588.611295747518;11609.651710448363;12062.457189426672;12378.876211237772;11124.165687573626;11208.159388046091;11452.713682158013;11660.12549058807;11910.225835320676;11074.390908499787;11337.829932550854;11500.079993600659;11825.46785394642;11984.64046078619;9503.714888553355;9651.324407291422;9680.177184939359;9926.15627671656;10412.271141020055;8472.534010629228;9275.582598783207;9627.711168664951;10303.845442318221;10326.48367581633 23:58:37 INFO - PROCESS | 30161 | __end_tp_report 23:58:37 INFO - PROCESS | 30161 | __start_cc_report 23:58:37 INFO - PROCESS | 30161 | _x_x_mozilla_cycle_collect,1023 23:58:37 INFO - PROCESS | 30161 | __end_cc_report 23:58:37 INFO - PROCESS | 30161 | __startTimestamp1469429917424__endTimestamp 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | ------- Summary: start ------- 23:58:37 INFO - PROCESS | 30161 | Number of tests: 6 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#0] dojo.html Cycles:165 Average:4762.69 Median:4886.68 stddev:515.21 (10.5%) stddev-sans-first:487.47 23:58:37 INFO - PROCESS | 30161 | Values: 2578.8 2593.1 2623.7 2624.1 2641.4 4699.2 4751.3 4789.6 4823.2 4823.2 4779.7 4792.1 4817.5 4820.4 4863.4 4332.6 4357.4 4421.8 4474.7 4532.7 4453.8 4490.0 4506.0 4520.2 4525.6 4336.2 4363.5 4378.9 4379.7 4455.1 4375.5 4379.2 4384.7 4392.4 4479.9 4394.6 4405.3 4409.6 4436.8 4437.1 4662.3 4692.5 4818.0 4821.2 4861.2 5084.4 5093.0 5140.5 5149.6 5150.2 5120.0 5151.5 5158.4 5178.2 5179.7 4706.8 4786.5 4804.7 4826.9 4868.9 5346.7 5392.3 5401.0 5409.0 5411.9 5126.1 5178.0 5190.6 5191.7 5195.8 4981.7 5071.4 5218.8 5271.2 5279.9 5021.8 5074.5 5076.0 5083.2 5131.2 5055.5 5065.6 5070.1 5070.9 5110.6 4324.7 4349.0 4363.3 4380.6 4420.2 3771.8 3797.3 3799.0 3821.9 3907.0 4399.1 4407.8 4409.6 4412.7 4456.8 5135.8 5164.3 5181.9 5181.9 5181.9 4339.7 4397.0 4446.0 4447.5 4509.2 4690.1 4721.8 4722.7 4725.0 4771.8 4873.0 4886.7 4887.1 4888.2 4936.3 5085.8 5109.1 5137.4 5152.1 5223.7 4746.2 4768.1 4781.6 4794.4 4834.5 5064.7 5069.1 5075.1 5078.1 5178.4 5073.1 5124.5 5170.6 5181.8 5239.1 5017.7 5063.5 5075.7 5078.6 5121.1 4999.3 5003.3 5013.3 5017.3 5019.4 4791.9 4918.3 4965.2 4970.9 5044.3 5082.3 5095.2 5097.0 5099.3 5152.5 4961.6 4961.6 4978.2 4996.6 4999.8 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#1] ext.html Cycles:180 Average:47003.37 Median:34448.24 stddev:87406.96 (253.7%) stddev-sans-first:87582.64 23:58:37 INFO - PROCESS | 30161 | Values: 571.5 571.8 575.5 591.5 594.4 27392.5 39312.4 40751.8 40779.0 44270.6 40700.2 41133.4 41144.4 41149.8 41150.4 7404.6 7625.8 7760.5 7763.1 7764.5 7323.7 7547.1 7549.8 9563.1 9838.4 10158.9 10189.4 10198.0 10211.0 10219.5 9872.2 9921.9 9935.9 9942.8 9943.7 9980.2 10026.9 10048.4 10056.2 10070.7 38940.2 39031.0 39063.4 39395.6 39453.8 3010.2 3086.3 3233.1 3303.9 3401.7 29728.4 30210.4 30539.0 30656.0 30895.1 3470.9 3486.7 3526.0 3555.5 3606.6 249141.0 249145.0 249553.0 250171.0 250293.0 29159.4 53553.7 53875.7 53918.7 53950.5 31037.5 32412.4 32570.7 32578.0 32603.5 13349.8 13393.1 13407.1 13421.7 13457.7 11938.5 12017.3 12029.1 12048.2 12048.9 7309.2 7516.2 7531.4 7614.4 7657.6 2987.0 3055.6 3059.0 3074.9 3080.3 787.3 863.8 881.2 939.2 1016.6 26762.5 27954.0 28296.2 28376.7 28551.6 970.6 990.5 997.7 1002.2 1030.8 14754.6 15030.2 15031.0 15036.5 15117.5 399738.0 404014.0 404536.0 404625.0 405916.0 46337.0 46440.1 51028.2 51366.5 51635.5 1113.0 1122.2 1123.6 1125.1 1167.1 27969.7 29783.9 30073.0 30570.7 30584.2 43884.3 44532.8 44536.8 44545.0 44562.8 319419.0 322136.0 322507.0 323078.0 323400.0 23750.6 24502.0 24519.0 25607.9 25937.7 39832.0 40284.6 40377.8 41060.6 41067.0 34780.5 34994.1 35215.8 35290.5 35829.1 33939.7 34387.0 34661.7 34895.8 34918.8 34509.5 34662.5 35238.3 35380.8 35694.3 30645.7 32290.8 32454.0 32638.8 32699.8 24338.6 24564.3 24859.5 25026.2 25330.4 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#2] jquery.html Cycles:180 Average:25535.02 Median:27263.68 stddev:70244.26 (257.6%) stddev-sans-first:70415.85 23:58:37 INFO - PROCESS | 30161 | Values: 341.8 357.7 360.5 367.3 380.2 12652.1 16059.9 16136.6 16936.5 16995.4 16383.2 16667.0 16761.5 16812.3 16824.7 4982.6 5084.4 5115.6 5122.9 5136.3 3736.6 4899.3 5086.4 5088.6 5664.0 5871.8 5947.3 5968.4 5969.2 5975.1 5834.2 5897.8 5962.4 5987.3 5999.8 5254.2 5254.8 5256.4 5261.7 5261.8 19571.3 20099.9 20224.6 20330.5 20680.3 1852.4 1927.2 2004.7 2014.6 2405.3 12420.2 13092.7 13308.9 13500.2 13603.9 1675.8 1747.2 1766.3 1774.0 1800.4 49544.8 66982.0 67806.3 68341.0 70476.3 9104.3 9154.6 9387.5 9513.1 9728.8 12569.2 12588.2 12592.6 12595.2 12598.9 7105.1 7147.9 7159.5 7368.3 7374.7 6974.3 7103.8 7226.4 7278.1 7368.6 5859.2 6001.2 6008.8 6011.1 6159.3 1703.2 1721.7 1726.4 1743.1 1758.4 817.6 845.1 929.7 932.6 960.4 15947.7 16566.3 16753.5 17290.7 17363.5 806.3 826.2 834.2 842.1 849.1 9074.2 9306.0 9311.2 10004.1 10374.3 420558.0 423606.0 423886.0 430075.3 431445.0 81918.0 82313.6 84325.6 86055.6 86891.0 861.8 868.3 868.7 876.2 877.7 14548.8 14586.5 15508.0 15674.8 15727.4 33423.3 36216.8 38760.6 38907.6 39940.0 53534.2 54768.7 55270.0 55699.7 56021.2 6025.1 6174.7 7170.2 7295.8 7420.7 9281.9 11180.9 11329.5 12038.1 12081.3 9625.3 9662.0 10494.1 10626.5 10661.7 10018.2 10233.6 10285.8 10388.5 10444.3 10226.9 10285.6 10352.4 10413.0 10506.5 7376.0 7616.1 7620.9 7679.5 7739.7 9667.2 10079.4 10085.9 10090.4 10239.4 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#3] mootools.html Cycles:180 Average:5074.55 Median:5387.54 stddev:2848.66 (52.9%) stddev-sans-first:2842.13 23:58:37 INFO - PROCESS | 30161 | Values: 1247.2 1332.8 1412.2 1452.0 1642.7 6671.7 7407.7 7601.4 7615.7 7811.9 7703.1 7720.3 7765.8 7767.4 7770.9 2176.7 2202.1 2202.3 2202.4 2209.0 2105.6 2148.4 2177.1 2177.5 2177.6 2104.4 2112.2 2122.1 2125.9 2170.0 2095.7 2098.2 2098.6 2102.6 2109.0 2015.3 2117.2 2118.4 2120.0 2125.5 7736.3 7861.0 7867.6 7874.1 7877.6 4411.7 4535.7 4538.1 4604.6 4607.0 2726.1 2869.4 2898.6 2905.8 2906.6 902.7 915.1 919.6 926.6 929.3 10625.5 10803.3 10819.8 10820.1 10831.2 3867.3 4123.8 4131.1 4225.6 4230.8 8498.4 8513.1 8514.3 8515.4 8516.6 4610.7 4621.9 4623.8 4624.3 4632.6 3691.9 3774.6 4127.9 4295.8 4301.1 3326.6 3410.8 3485.0 3502.9 3504.4 966.8 1003.7 1011.8 1019.6 1019.7 700.5 835.6 850.3 858.6 864.5 5185.1 5273.3 5320.4 5443.2 5464.6 883.7 893.7 906.7 924.9 935.4 3513.6 3615.4 3626.0 3642.3 3700.9 9198.0 9532.3 9628.8 9670.5 9676.6 9283.7 9521.8 9550.0 9574.2 9580.5 6792.4 6915.4 6926.0 6928.4 6945.5 5221.8 5228.8 5285.4 5331.9 5443.9 8897.7 8977.1 8995.7 9006.2 9084.2 8503.0 8702.7 8750.8 8753.8 9054.0 6070.1 6615.0 6778.6 6998.3 7005.9 7343.7 7527.0 7533.1 7549.5 7553.8 6655.4 6678.2 6820.0 6840.4 7054.4 6531.8 6688.6 6794.8 6798.8 6852.4 5787.6 5981.7 5991.8 6026.3 6041.8 4648.7 4650.6 4781.3 4788.6 4790.0 4413.7 4525.6 4625.5 4685.0 4848.7 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#4] prototype.html Cycles:180 Average:4271.10 Median:4946.44 stddev:1237.92 (25.0%) stddev-sans-first:1204.65 23:58:37 INFO - PROCESS | 30161 | Values: 282.9 288.3 291.9 295.9 303.4 4946.9 4973.3 4978.9 4980.9 5033.0 4643.2 4777.5 4785.6 4866.8 4939.9 3874.6 3875.3 3886.3 3889.6 3899.8 3859.2 3870.2 3882.7 3890.2 3909.7 3629.4 3698.4 3837.0 3844.5 3868.0 3817.1 3824.7 3831.6 3837.9 3844.4 3388.6 3392.2 3394.6 3397.3 3400.9 4629.4 4769.7 4769.9 4778.5 4782.8 4337.3 4337.6 4342.2 4361.0 4382.5 5087.2 5091.4 5091.4 5096.9 5098.4 3682.4 3683.2 3685.5 3689.1 3694.7 5142.6 5327.3 5327.8 5340.3 5349.3 3776.2 3780.3 3783.5 3784.5 3786.2 3828.2 3834.4 3835.5 3839.7 3850.6 4233.1 4303.4 4339.0 4354.3 4358.3 5104.6 5105.3 5107.3 5115.0 5115.8 1320.3 1329.2 1334.0 1337.9 1341.8 835.4 836.2 887.0 901.3 920.9 4423.9 4427.4 4444.6 4444.6 4453.8 5226.3 5227.2 5227.8 5232.1 5246.6 4282.6 4448.7 4450.5 4458.8 4519.1 2809.0 2823.0 2826.5 2832.5 2841.2 4946.0 4954.5 4961.0 4962.5 4975.0 5164.0 5402.2 5416.8 5432.8 5476.6 4989.2 4994.3 5005.4 5028.3 5035.4 5371.6 5371.9 5377.2 5382.3 5383.5 5138.5 5144.7 5214.2 5240.8 5249.4 4973.5 4982.2 4985.8 4995.5 4998.4 3656.5 3662.1 3664.1 3667.2 3682.9 5115.6 5315.7 5337.1 5338.6 5353.5 5162.9 5164.8 5176.5 5179.1 5184.4 5157.7 5180.7 5189.9 5210.0 5216.0 4998.4 5098.9 5133.6 5140.2 5141.2 4962.3 5094.4 5136.5 5197.6 5205.0 5073.9 5088.9 5096.4 5098.8 5126.2 23:58:37 INFO - PROCESS | 30161 | 23:58:37 INFO - PROCESS | 30161 | [#5] yui.html Cycles:180 Average:17654.84 Median:41437.08 stddev:26115.27 (63.0%) stddev-sans-first:26157.22 23:58:37 INFO - PROCESS | 30161 | Values: 625.0 626.7 643.4 659.5 725.8 12719.8 13180.9 13789.8 13810.3 13816.2 13135.9 13174.4 13288.3 13347.6 13363.2 766.8 788.1 789.5 789.7 789.7 633.6 650.1 650.7 654.6 784.2 796.4 827.1 827.3 832.5 834.7 817.6 823.2 824.1 824.2 824.8 487.2 602.5 602.7 602.9 603.0 10496.5 11042.3 11052.3 11805.8 12289.6 12438.1 12785.2 12909.9 13301.8 13581.9 10475.4 10573.3 10721.3 10820.9 10961.2 3188.6 3196.4 3252.2 3252.7 3303.4 59560.4 59989.0 60012.0 60248.4 61174.0 10105.8 10133.0 10172.7 10226.6 10299.1 19619.3 19642.2 19649.7 19650.5 19660.9 6602.7 6615.3 6784.8 6831.7 6832.5 3723.1 3784.5 3812.3 3815.5 3816.8 2862.4 2968.7 2972.8 2974.7 2983.3 500.7 519.4 566.3 569.8 571.7 460.2 481.1 482.3 485.8 492.6 6738.4 7043.2 7048.5 7219.5 7435.6 550.7 575.7 584.3 594.1 615.8 3569.7 3600.6 3695.3 3747.5 3856.5 99236.0 99883.0 101965.5 102712.0 107020.5 89484.0 90318.5 91140.5 91270.0 93381.0 77945.0 78996.0 81222.6 81854.0 83882.2 7389.6 7456.6 7553.8 8127.5 8251.4 30353.5 30740.1 38979.6 39250.6 43156.4 39717.8 51032.0 55291.7 62720.0 63547.0 10276.4 10604.4 10939.4 11201.6 11233.7 11948.2 12003.2 12436.3 12639.9 13086.7 11414.0 11588.6 11609.7 12062.5 12378.9 11124.2 11208.2 11452.7 11660.1 11910.2 11074.4 11337.8 11500.1 11825.5 11984.6 9503.7 9651.3 9680.2 9926.2 10412.3 8472.5 9275.6 9627.7 10303.8 10326.5 23:58:37 INFO - PROCESS | 30161 | -------- Summary: end -------- 23:58:37 INFO - PROCESS | 30161 | 23:58:38 INFO - TEST-INFO | 30161: exit 0 23:58:38 INFO - TEST-OK | dromaeo_css | took 1120734ms 23:58:38 INFO - TEST-START | kraken 23:58:38 INFO - operating with platform_type : linux_ 23:58:38 INFO - Initialising browser for kraken test... 23:58:38 INFO - TEST-INFO | started process 30350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQq0pzw/profile http://localhost:57479/getInfo.html) 23:58:41 INFO - PROCESS | 30350 | JavaScript error: , line 0: uncaught exception: undefined 23:58:42 INFO - PROCESS | 30350 | __metrics Screen width/height:1600/1200 23:58:42 INFO - PROCESS | 30350 | colorDepth:24 23:58:42 INFO - PROCESS | 30350 | Browser inner width/height: 1024/697 23:58:42 INFO - PROCESS | 30350 | __metrics 23:58:43 INFO - PROCESS | 30350 | 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" 23:58:43 INFO - PROCESS | 30350 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:58:44 INFO - TEST-INFO | 30350: exit 0 23:58:44 INFO - Browser initialized. 23:58:44 INFO - Running cycle 1/1 for kraken test... 23:58:44 INFO - TEST-INFO | started process 30431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQq0pzw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:58:56 INFO - PROCESS | 30431 | RSS: Main: 158814208 23:58:56 INFO - PROCESS | 30431 | 23:58:59 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57479/tests/kraken/driver.html?testName=audio-beat-detection) 23:59:00 INFO - PROCESS | 30431 | RSS: Main: 214839296 23:59:00 INFO - PROCESS | 30431 | 23:59:03 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57479/tests/kraken/driver.html?testName=audio-dft) 23:59:03 INFO - PROCESS | 30431 | RSS: Main: 192630784 23:59:03 INFO - PROCESS | 30431 | 23:59:06 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57479/tests/kraken/driver.html?testName=audio-fft) 23:59:07 INFO - PROCESS | 30431 | RSS: Main: 272265216 23:59:07 INFO - PROCESS | 30431 | 23:59:09 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57479/tests/kraken/driver.html?testName=audio-oscillator) 23:59:10 INFO - PROCESS | 30431 | RSS: Main: 182267904 23:59:10 INFO - PROCESS | 30431 | 23:59:12 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:59:13 INFO - PROCESS | 30431 | RSS: Main: 186363904 23:59:13 INFO - PROCESS | 30431 | 23:59:16 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57479/tests/kraken/driver.html?testName=imaging-darkroom) 23:59:16 INFO - PROCESS | 30431 | RSS: Main: 223666176 23:59:16 INFO - PROCESS | 30431 | 23:59:20 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57479/tests/kraken/driver.html?testName=imaging-desaturate) 23:59:20 INFO - PROCESS | 30431 | RSS: Main: 216711168 23:59:20 INFO - PROCESS | 30431 | 23:59:23 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57479/tests/kraken/driver.html?testName=json-parse-financial) 23:59:24 INFO - PROCESS | 30431 | RSS: Main: 219287552 23:59:24 INFO - PROCESS | 30431 | 23:59:26 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:59:26 INFO - PROCESS | 30431 | RSS: Main: 185745408 23:59:26 INFO - PROCESS | 30431 | 23:59:28 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:59:29 INFO - PROCESS | 30431 | RSS: Main: 191430656 23:59:29 INFO - PROCESS | 30431 | 23:59:31 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:59:32 INFO - PROCESS | 30431 | RSS: Main: 195608576 23:59:32 INFO - PROCESS | 30431 | 23:59:34 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:59:35 INFO - PROCESS | 30431 | RSS: Main: 190910464 23:59:35 INFO - PROCESS | 30431 | 23:59:38 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:59:38 INFO - PROCESS | 30431 | RSS: Main: 193773568 23:59:38 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | Cycle 1(1): loaded http://localhost:57479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57479/tests/kraken/driver.html?testName=ai-astar) 23:59:40 INFO - PROCESS | 30431 | RSS: Main: 245039104 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | __start_tp_report 23:59:40 INFO - PROCESS | 30431 | _x_x_mozilla_page_load 23:59:40 INFO - PROCESS | 30431 | _x_x_mozilla_page_load_details 23:59:40 INFO - PROCESS | 30431 | |i|pagename|runs| 23:59:40 INFO - PROCESS | 30431 | |0;ai-astar;105;114;114;116;114;114;113;114;112;113 23:59:40 INFO - PROCESS | 30431 | |1;audio-beat-detection;165;123;125;181;127;128;148;123;172;125 23:59:40 INFO - PROCESS | 30431 | |2;audio-dft;161;159;159;161;160;162;161;162;160;161 23:59:40 INFO - PROCESS | 30431 | |3;audio-fft;75;77;77;105;76;76;75;76;100;76 23:59:40 INFO - PROCESS | 30431 | |4;audio-oscillator;85;85;124;85;85;86;120;84;85;125 23:59:40 INFO - PROCESS | 30431 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 23:59:40 INFO - PROCESS | 30431 | |6;imaging-darkroom;146;146;147;146;148;146;146;145;146;146 23:59:40 INFO - PROCESS | 30431 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 23:59:40 INFO - PROCESS | 30431 | |8;json-parse-financial;66;62;60;61;61;62;60;61;62;60 23:59:40 INFO - PROCESS | 30431 | |9;json-stringify-tinderbox;66;65;66;65;65;64;65;67;65;65 23:59:40 INFO - PROCESS | 30431 | |10;stanford-crypto-aes;79;80;79;79;79;79;78;80;79;83 23:59:40 INFO - PROCESS | 30431 | |11;stanford-crypto-ccm;130;138;134;136;133;135;128;136;177;130 23:59:40 INFO - PROCESS | 30431 | |12;stanford-crypto-pbkdf2;167;165;163;164;165;169;172;163;162;163 23:59:40 INFO - PROCESS | 30431 | |13;stanford-crypto-sha256-iterative;68;67;66;67;68;70;67;67;68;66 23:59:40 INFO - PROCESS | 30431 | __end_tp_report 23:59:40 INFO - PROCESS | 30431 | __start_cc_report 23:59:40 INFO - PROCESS | 30431 | _x_x_mozilla_cycle_collect,1901 23:59:40 INFO - PROCESS | 30431 | __end_cc_report 23:59:40 INFO - PROCESS | 30431 | __startTimestamp1469429980973__endTimestamp 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | ------- Summary: start ------- 23:59:40 INFO - PROCESS | 30431 | Number of tests: 14 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 23:59:40 INFO - PROCESS | 30431 | Values: 105.0 114.0 114.0 116.0 114.0 114.0 113.0 114.0 112.0 113.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:138.00 stddev:22.87 (16.6%) stddev-sans-first:22.65 23:59:40 INFO - PROCESS | 30431 | Values: 165.0 123.0 125.0 181.0 127.0 128.0 148.0 123.0 172.0 125.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 23:59:40 INFO - PROCESS | 30431 | Values: 161.0 159.0 159.0 161.0 160.0 162.0 161.0 162.0 160.0 161.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.26 (14.8%) stddev-sans-first:11.70 23:59:40 INFO - PROCESS | 30431 | Values: 75.0 77.0 77.0 105.0 76.0 76.0 75.0 76.0 100.0 76.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:18.40 (21.7%) stddev-sans-first:19.05 23:59:40 INFO - PROCESS | 30431 | Values: 85.0 85.0 124.0 85.0 85.0 86.0 120.0 84.0 85.0 125.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 23:59:40 INFO - PROCESS | 30431 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:59:40 INFO - PROCESS | 30431 | Values: 146.0 146.0 147.0 146.0 148.0 146.0 146.0 145.0 146.0 146.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:59:40 INFO - PROCESS | 30431 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.50 stddev:1.78 (2.9%) stddev-sans-first:0.87 23:59:40 INFO - PROCESS | 30431 | Values: 66.0 62.0 60.0 61.0 61.0 62.0 60.0 61.0 62.0 60.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 23:59:40 INFO - PROCESS | 30431 | Values: 66.0 65.0 66.0 65.0 65.0 64.0 65.0 67.0 65.0 65.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.35 (1.7%) stddev-sans-first:1.42 23:59:40 INFO - PROCESS | 30431 | Values: 79.0 80.0 79.0 79.0 79.0 79.0 78.0 80.0 79.0 83.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:135.50 stddev:14.17 (10.5%) stddev-sans-first:14.75 23:59:40 INFO - PROCESS | 30431 | Values: 130.0 138.0 134.0 136.0 133.0 135.0 128.0 136.0 177.0 130.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:3.16 (1.9%) stddev-sans-first:3.30 23:59:40 INFO - PROCESS | 30431 | Values: 167.0 165.0 163.0 164.0 165.0 169.0 172.0 163.0 162.0 163.0 23:59:40 INFO - PROCESS | 30431 | 23:59:40 INFO - PROCESS | 30431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 23:59:40 INFO - PROCESS | 30431 | Values: 68.0 67.0 66.0 67.0 68.0 70.0 67.0 67.0 68.0 66.0 23:59:40 INFO - PROCESS | 30431 | -------- Summary: end -------- 23:59:40 INFO - PROCESS | 30431 | 23:59:42 INFO - TEST-INFO | 30431: exit 0 23:59:42 INFO - TEST-OK | kraken | took 63838ms 23:59:42 INFO - SUITE-END | took 1184s 23:59:42 INFO - Completed test suite (00:19:44) 23:59:42 INFO - javascript benchmark 23:59:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.8194826362155, 2593.1053786443695, 2623.698274698409, 2624.068455698227, 2641.366072142685, 4699.224627936395, 4751.287306903966, 4789.592884604808, 4823.15594770915, 4823.20417131173, 4779.665423420353, 4792.089502994429, 4817.542333478314, 4820.421549414066, 4863.36776219091, 4332.588404101605, 4357.433533640622, 4421.756803375813, 4474.686771925966, 4532.728036317815, 4453.84411545596, 4489.955100449003, 4506.0, 4520.163769702599, 4525.637948964091, 4336.1978034063795, 4363.476382834048, 4378.949052227475, 4379.715318504287, 4455.108978204372, 4375.496817865955, 4379.1679580879845, 4384.671149663788, 4392.407025051641, 4479.8800299925015, 4394.582514661134, 4405.273129933557, 4409.647228221735, 4436.800343984496, 4437.112577484516, 4662.347271382009, 4692.460367057798, 4817.975910120427, 4821.22860342347, 4861.246506791453, 5084.415292241402, 5093.032323858455, 5140.537351638333, 5149.562287205592, 5150.150225212836, 5119.974400127976, 5151.5106064923775, 5158.38099428071, 5178.17149256121, 5179.741012949337, 4706.788194531255, 4786.473487916326, 4804.663673542888, 4826.879328016757, 4868.902621947541, 5346.705931173745, 5392.272043274186, 5400.972995134999, 5409.0, 5411.891762164734, 5126.077306084866, 5178.0, 5190.558802501754, 5191.6884986900905, 5195.792168313225, 4981.676191047571, 5071.41678706946, 5218.765155568009, 5271.156614941668, 5279.894402111936, 5021.84934451967, 5074.543291103819, 5076.0, 5083.186690129562, 5131.230315452712, 5055.545000949932, 5065.620078494054, 5070.087384270867, 5070.873228169252, 5110.642255042186, 4324.71889327199, 4348.956510434855, 4363.3018717005125, 4380.649548036149, 4420.248557745191, 3771.7548359356556, 3797.3354662933875, 3798.9620103798607, 3821.9044523887123, 3907.0427745202605, 4399.054203346296, 4407.823687052482, 4409.647228221735, 4412.735235885857, 4456.77716114193, 5135.820246291362, 5164.2770012198325, 5181.922271165936, 5181.922271165936, 5181.948180518222, 4339.652827773771, 4396.978015109904, 4446.0, 4447.510773814878, 4509.210888094571, 4690.108879312919, 4721.834735784231, 4722.693024953367, 4724.976375118103, 4771.832985845548, 4873.0, 4886.682365646222, 4887.095887260797, 4888.193448081027, 4936.284238785428, 5085.847424577269, 5109.131447653834, 5137.409197942285, 5152.149895267239, 5223.660462069954, 4746.240601503743, 4768.070226305976, 4781.569658730731, 4794.400699912511, 4834.492378300228, 5064.721440320818, 5069.062223488666, 5075.086484432837, 5078.08594453002, 5178.404483484297, 5073.086844368049, 5124.461931497139, 5170.586353091669, 5181.81863634771, 5239.109351410346, 5017.724025178504, 5063.518965698253, 5075.695458272516, 5078.568321692697, 5121.07820592282, 4999.325091112653, 5003.3495645565845, 5013.348264725562, 5017.347744793154, 5019.3976722793495, 4791.904161916673, 4918.286848407032, 4965.230389289666, 4970.900581988412, 5044.344235249394, 5082.288479612931, 5095.235714642833, 5096.974515127401, 5099.286099945936, 5152.458991805806, 4961.603071754179, 4961.627877909099, 4978.2034874419915, 4996.60027197816, 4999.77501012448], "value": 4728.296392130985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4542611805726, 571.7970120607184, 575.4906907386963, 591.4824528537531, 594.4204400709309, 27392.452150956968, 39312.41031384528, 40751.79624101883, 40779.0, 44270.557294427046, 40700.18599628006, 41133.38299925504, 41144.38283425751, 41149.794251028776, 41150.382744258786, 7404.629768511553, 7625.809354766147, 7760.495567788075, 7763.068431788165, 7764.456488045811, 7323.670434830418, 7547.094348678166, 7549.773506794805, 9563.091506306924, 9838.360506567085, 10158.949205253963, 10189.388636681786, 10198.0, 10211.0, 10219.48902554873, 9872.210223182128, 9921.851172232422, 9935.8509622355, 9942.751431214205, 9943.701688949342, 9980.201583873346, 10026.9498652507, 10048.44733539655, 10056.245781566338, 10070.69787906364, 38940.22119557621, 39031.0, 39063.41404878929, 39395.60604393977, 39453.802730986165, 3010.202296391458, 3086.2592977685194, 3233.143217047461, 3303.8513266903046, 3401.710854577364, 29728.405431891457, 30210.395792084255, 30539.0, 30656.0, 30895.0731478056, 3470.8958731238104, 3486.7384946128886, 3525.964740352615, 3555.520004799345, 3606.6393360663988, 249141.0, 249144.9999999982, 249553.0, 250171.0, 250293.0, 29159.416811663647, 53553.732231338596, 53875.73062134664, 53918.73040634772, 53950.46049539533, 31037.534436983464, 32412.35175296528, 32570.674293257238, 32578.022659320257, 32603.51094733581, 13349.799753003712, 13393.129446585941, 13407.128536645087, 13421.731565368833, 13457.663558411117, 11938.462769175409, 12017.278963262232, 12029.097817663534, 12048.156629035884, 12048.87951120495, 7309.159446663595, 7516.210797866145, 7531.3598344141365, 7614.428917831185, 7657.57883316423, 2987.0142852858503, 3055.572219889217, 3058.9694103058687, 3074.9231269218003, 3080.3377273885776, 787.322902304018, 863.792689754467, 881.1761003461784, 939.2063706168277, 1016.5527168046036, 26762.464750704876, 27954.0, 28296.151115466568, 28376.716232837407, 28551.57172642412, 970.6457143142702, 990.5195979949718, 997.7206382212992, 1002.2382988928467, 1030.7526193713454, 14754.63113422173, 15030.17334046616, 15031.0, 15036.473723419627, 15117.486080966364, 399738.0, 404014.0, 404536.0, 404625.0, 405916.0, 46337.0, 46440.07119857584, 51028.23457648138, 51366.48633513617, 51635.48364516307, 1112.9944350278197, 1122.2256642916361, 1123.5730422439422, 1125.083057308291, 1167.1071630202732, 27969.720302797527, 29783.851080744458, 30073.0, 30570.694293056786, 30584.235394115327, 43884.341734874644, 44532.77733611311, 44536.77731611451, 44545.0, 44562.77718611386, 319419.0, 322136.0, 322507.0, 323078.0, 323400.0, 23750.643740344254, 24502.0, 24519.0, 25607.871960640077, 25937.740622593534, 39832.0, 40284.59715402809, 40377.79811100926, 41060.58939410568, 41067.0, 34780.47829282512, 34994.125146871535, 35215.767448139195, 35290.47064294089, 35829.10427239235, 33939.66060339365, 34387.0, 34661.65338346685, 34895.82552087223, 34918.7778427764, 34509.482357765155, 34662.480062798575, 35238.295234094665, 35380.823095884356, 35694.28611427705, 30645.693543064284, 32290.83854580806, 32454.0, 32638.83680581582, 32699.836500817342, 24338.63492047656, 24564.263072107864, 24859.50280994406, 25026.249212523653, 25330.366740831625], "value": 16858.00633459674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.7846756543377, 357.737063258505, 360.48270731500315, 367.346123899459, 380.1941670471917, 12652.114351995364, 16059.919700401497, 16136.596585085379, 16936.491905242863, 16995.405160819373, 16383.180840957964, 16667.0, 16761.497155085337, 16812.32750689971, 16824.66350672989, 4982.601391888649, 5084.44071152173, 5115.59075273979, 5122.948770512303, 5136.280920671109, 3736.551613806347, 4899.314096026559, 5086.415062267831, 5088.567471764886, 5664.0, 5871.76512939484, 5947.286325640929, 5968.4031596840405, 5969.224000879901, 5975.073863551135, 5834.241548598677, 5897.764089436418, 5962.403759624046, 5987.311459182162, 5999.76000959961, 5254.238135470374, 5254.842354729364, 5256.421793602701, 5261.7369131543655, 5261.815836445706, 19571.315003974792, 20099.899500502404, 20224.595508089755, 20330.49173770653, 20680.276190333418, 1852.397970659541, 1927.152053096633, 2004.6992951057312, 2014.5668681233458, 2405.2663937499055, 12420.192687475284, 13092.672683182902, 13308.935285177162, 13500.189988600716, 13603.86396136036, 1675.8407951244612, 1747.248683066281, 1766.3199668127734, 1773.9911300443416, 1800.4328636479468, 49544.752276238745, 66982.0, 67806.321936781, 68340.97488537726, 70476.29523704748, 9104.31717621181, 9154.588043537924, 9387.483688397067, 9513.143817056498, 9728.756781080388, 12569.245845249314, 12588.244705317711, 12592.559260425842, 12595.181313214613, 12598.937005314914, 7105.111861017373, 7147.857042859114, 7159.498835081598, 7368.300011498899, 7374.741884034141, 6974.321681620323, 7103.822404439827, 7226.387247667282, 7278.126624805057, 7368.59472729005, 5859.2382990211, 6001.1898393717165, 6008.849778755566, 6011.098335249748, 6159.3224745277985, 1703.2420572845213, 1721.690095782771, 1726.4216487476835, 1743.076169630098, 1758.3845654021245, 817.6279792694429, 845.0915266088979, 929.665320484625, 932.6036434515439, 960.3949511807516, 15947.681046379008, 16566.254518546695, 16753.497395078168, 17290.740638890427, 17363.47909562715, 806.3186607316808, 826.1862065865118, 834.1825011488654, 842.0905422144192, 849.087231226434, 9074.183323500916, 9306.0, 9311.161995420445, 10004.099631033241, 10374.27380083402, 420558.0, 423606.0, 423886.0, 430075.29322361137, 431445.0, 81918.0, 82313.58843205746, 84325.57837210897, 86055.56972215099, 86891.0, 861.8060936289285, 868.2880038368603, 868.6699054359303, 876.1895246896595, 877.6752601537472, 14548.781768273697, 14586.54134586533, 15508.0, 15674.843251567338, 15727.370905163665, 33423.33153336968, 36216.81891590525, 38760.6123938757, 38907.61092389153, 39940.0, 53534.196987046, 54768.72615636896, 55270.0, 55699.72150139223, 56021.159682603975, 6025.096235564525, 6174.722137503733, 7170.211276759656, 7295.817604559928, 7420.6660700269695, 9281.907180928105, 11180.944095279472, 11329.490172942073, 12038.097142714507, 12081.335526546125, 9625.32622716431, 9662.0, 10494.108000820015, 10626.52180651888, 10661.733456663334, 10018.198544116307, 10233.590656373959, 10285.84571231447, 10388.532516036645, 10444.268901176845, 10226.948865255627, 10285.588576457158, 10352.378857268588, 10413.0, 10506.474676266003, 7375.963120184365, 7616.124145723091, 7620.923790762022, 7679.462437629312, 7739.729109481141, 9667.226621870093, 10079.395236285847, 10085.89914100879, 10090.394576325443, 10239.385636861813], "value": 8313.588240188541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.2080229054548, 1332.8400591928967, 1412.2444492196676, 1451.9709605807884, 1642.6632540329242, 6671.666416679165, 7407.740729074483, 7601.391888648908, 7615.657295421705, 7811.92188078119, 7703.075630924297, 7720.266574675411, 7765.844683106335, 7767.417443691732, 7770.883436748439, 2176.7387913450407, 2202.0971401725296, 2202.3062735238427, 2202.41635966469, 2209.0, 2105.589410065038, 2148.3769706785015, 2177.096504950444, 2177.4882902517897, 2177.618916689573, 2104.4318034130774, 2112.207922029239, 2122.0556852200775, 2125.936221913345, 2169.967450488244, 2095.6542170541843, 2098.223657246821, 2098.6222479953603, 2102.6425507663735, 2109.0193060226993, 2015.3248661698349, 2117.2166298469665, 2118.3644906528134, 2120.035383900337, 2125.489882428206, 7736.34241089508, 7861.0, 7867.6066196689935, 7874.133845277015, 7877.606119693993, 4411.735295882258, 4535.727856328598, 4538.115067561826, 4604.608608268301, 4607.0, 2726.086760935089, 2869.4117705870453, 2898.6231789867184, 2905.796594238404, 2906.593076969226, 902.7291812456302, 915.1031988651159, 919.5678031325266, 926.6339795780628, 929.3401684803797, 10625.46872656364, 10803.297785643987, 10819.783604327948, 10820.08029317509, 10831.241813073088, 3867.3425517662067, 4123.773192474443, 4131.07050913542, 4225.619694227473, 4230.788460576959, 8498.362622803315, 8513.148685131437, 8514.318854491627, 8515.446495977742, 8516.61675224604, 4610.700304480198, 4621.861344159681, 4623.791929363187, 4624.30635404692, 4632.5830675239395, 3691.90770230741, 3774.6036666150208, 4127.9174416511505, 4295.763732994716, 4301.07526881722, 3326.5841769778776, 3410.7782994105305, 3485.0, 3502.9124271893406, 3504.3867323218333, 966.8163049020804, 1003.6537394598852, 1011.7622358745689, 1019.5615885169449, 1019.6686077024997, 700.4851434195862, 835.5738573327646, 850.2602735619927, 858.5664239558982, 864.4899509289423, 5185.118529849935, 5273.288106105703, 5320.361556613231, 5443.183522471581, 5464.644798088111, 883.6818745251704, 893.7363477774072, 906.664534122379, 924.8658944453017, 935.3779736475303, 3513.5959364672876, 3615.4215325547784, 3625.9818700906326, 3642.34437801193, 3700.9259814803554, 9198.0, 9532.285078619132, 9628.75928101789, 9670.516474176264, 9676.612935482643, 9283.675071372469, 9521.809563808685, 9550.0, 9574.186194173433, 9580.473073980858, 6792.354726300993, 6915.377616014583, 6926.0, 6928.376446119873, 6945.548539345027, 5221.791128354823, 5228.790848366023, 5285.392179899361, 5331.893362132813, 5443.945560544344, 8897.73306800797, 8977.147171018743, 8995.685151019683, 9006.189442950166, 9084.22784063362, 8502.957485212535, 8702.738917832476, 8750.82498350042, 8753.824923501621, 9054.0, 6070.0591408331775, 6615.0, 6778.627175505198, 6998.285420072115, 7005.859882802213, 7343.669534870837, 7526.962365188139, 7533.1336896257635, 7549.471536992358, 7553.848923021619, 6655.367740064686, 6678.165229346332, 6819.965900170666, 6840.3501667341525, 7054.435645148274, 6531.804045878631, 6688.598684078971, 6794.796156115324, 6798.796036118924, 6852.417544508772, 5787.594868359343, 5981.730822112929, 5991.7902873399225, 6026.306974697965, 6041.818745437644, 4648.674592778609, 4650.558196971282, 4781.282807578891, 4788.640851936049, 4789.99410123864, 4413.713108647928, 4525.615322697476, 4625.537446255347, 4685.039566888711, 4848.660593758545], "value": 4077.1485748208975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.89532872837043, 288.29511843542537, 291.9430711011354, 295.8963067757266, 303.3841302156623, 4946.901061978759, 4973.278874563195, 4978.925316120261, 4980.925286120707, 5033.0, 4643.16423043852, 4777.498362671913, 4785.61715062795, 4866.780994855231, 4939.901201975958, 3874.6364717522288, 3875.2830726315583, 3886.31989401855, 3889.649931506171, 3899.844006239747, 3859.20886218326, 3870.1679138985114, 3882.7476214045996, 3890.2219556088753, 3909.6676782473523, 3629.3648611493013, 3698.4267438547067, 3837.0, 3844.5386553613607, 3867.9806600966954, 3817.10298079951, 3824.694024478035, 3831.597682243352, 3837.884863454101, 3844.4233364995193, 3388.5594872666643, 3392.2367467319655, 3394.6435624259593, 3397.3013493253375, 3400.880969166092, 4629.444466663988, 4769.666123371366, 4769.856904292877, 4778.546038126373, 4782.832600858988, 4337.284348082562, 4337.590283157986, 4342.1966936116605, 4361.040571074359, 4382.496012958519, 5087.194046113614, 5091.414487333967, 5091.414487333967, 5096.898062038776, 5098.439171691111, 3682.355587772156, 3683.1712864605515, 3685.4656074869263, 3689.0632417980773, 3694.6674799268194, 5142.640015198937, 5327.254184414146, 5327.786888524454, 5340.332458442734, 5349.3045904032615, 3776.2069965307046, 3780.281746468162, 3783.45139954705, 3784.508013958168, 3786.1670432504807, 3828.2343531293855, 3834.4440056191697, 3835.4822099016274, 3839.6928245740273, 3850.634189751969, 4233.121477395339, 4303.376010478463, 4338.978305108454, 4354.259775838115, 4358.259095953632, 5104.617153713486, 5105.259737338065, 5107.284980102789, 5114.974425127925, 5115.846524604268, 1320.3134370127673, 1329.1958365189114, 1333.973320533584, 1337.9397927093305, 1341.8456877459023, 835.3651225068992, 836.2056046755606, 886.9911300886909, 901.2654686430539, 920.9363185520734, 4423.911521769546, 4427.380166776654, 4444.555544445529, 4444.577765112309, 4453.842001079743, 5226.268322434787, 5227.163653815372, 5227.843164705065, 5232.136697444955, 5246.635874672536, 4282.571742825692, 4448.73211134825, 4450.488193857683, 4458.843940462133, 4519.118771839526, 2808.974724225643, 2823.037988597946, 2826.477101736144, 2832.5467925132293, 2841.247069526577, 4945.975270123627, 4954.47977962316, 4960.9907987265215, 4962.478939711278, 4974.980129073531, 5163.97418012915, 5402.162664786964, 5416.83749487516, 5432.75552600134, 5476.58925580583, 4989.226669866177, 4994.325766021613, 5005.424376196711, 5028.270900719448, 5035.420926593415, 5371.5971302153275, 5371.946280537145, 5377.220303056113, 5382.3003009610065, 5383.542398895981, 5138.5375316220225, 5144.710603781281, 5214.21786731978, 5240.7641656126325, 5249.396319423316, 4973.47778483254, 4982.202847544376, 4985.825496107619, 4995.450500444876, 4998.350214472095, 3656.46981187721, 3662.1393972415926, 3664.1022949377575, 3667.2298817248675, 3682.8526858925343, 5115.616328775282, 5315.654482458628, 5337.146056630921, 5338.599605029716, 5353.4646535346155, 5162.896742065062, 5164.767585458589, 5176.456472070378, 5179.1454410021925, 5184.381887146967, 5157.742112894415, 5180.7150606717, 5189.948100518946, 5210.0, 5215.973920130375, 4998.375203099613, 5098.872528186825, 5133.638526277954, 5140.203268493389, 5141.203113517411, 4962.255661650781, 5094.439611642642, 5136.486351364833, 5197.584193264454, 5204.9739751301, 5073.883745575968, 5088.898222035613, 5096.413912399973, 5098.827269728057, 5126.154184559655], "value": 3874.7527853168135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.9562530622857, 626.6647343671137, 643.4209211709461, 659.4691273524812, 725.7677543186182, 12719.809202861965, 13180.868191318084, 13789.793153102686, 13810.309484525771, 13816.240106794123, 13135.868641313584, 13174.407151678173, 13288.335583220849, 13347.59957201283, 13363.198208107497, 766.7508059880533, 788.0897563314353, 789.4513313247295, 789.6643926331286, 789.6683392974935, 633.5565104426896, 650.1028580558822, 650.6909218121402, 654.630133974303, 784.19228194959, 796.4424902568196, 827.148037521354, 827.2720006394364, 832.4672209785742, 834.6953362022879, 817.5952903312868, 823.2261674026456, 824.0770337222319, 824.2458150792048, 824.7608193623842, 487.16451286044605, 602.5029350785619, 602.6625089949642, 602.8553147244673, 603.0050416812251, 10496.475176241158, 11042.33745975244, 11052.281601695864, 11805.822912656231, 12289.631311060682, 12438.129330946836, 12785.16896401731, 12909.935450322782, 13301.800472992913, 13581.932090339486, 10475.371477711362, 10573.312734672221, 10721.303115297558, 10820.891791082146, 10961.177911656578, 3188.5854838871032, 3196.4406228909847, 3252.235724604716, 3252.674732526752, 3303.4219011672863, 59560.40439595592, 59989.0, 60012.0, 60248.39751602516, 61174.0, 10105.848412273675, 10133.00438705574, 10172.694819155437, 10226.590936362461, 10299.12457441111, 19619.313324033592, 19642.21431142767, 19649.705254421195, 19650.50873728168, 19660.90169549143, 6602.669866506655, 6615.305392933769, 6784.8303792404595, 6831.658417079127, 6832.521723479408, 3723.0878434783654, 3784.508013958223, 3812.256609961031, 3815.465834783133, 3816.8282427290837, 2862.355969906754, 2968.7031296870573, 2972.821630702165, 2974.7322740952986, 2983.284011837187, 500.7070863544867, 519.3715604118983, 566.3147591414353, 569.7920259105397, 571.6827160925643, 460.1808780370945, 481.0955403840827, 482.2525086116505, 485.8032496838786, 492.63544976717685, 6738.427233685094, 7043.190033146254, 7048.471364647569, 7219.458540609476, 7435.553866768011, 550.6723499517781, 575.6948817126929, 584.3367777572486, 594.147398483178, 615.7998650438625, 3569.660882216185, 3600.617077469148, 3695.279420512974, 3747.4940882980995, 3856.4793752843566, 99236.0, 99883.0, 101965.49017254866, 102712.0, 107020.46489767657, 89484.0, 90318.54840725886, 91140.54429727809, 91270.0, 93381.0, 77945.0, 78996.0, 81222.59388703019, 81854.0, 83882.16117838866, 7389.593572353572, 7456.552606843607, 7553.811154720956, 8127.471714338549, 8251.381146413923, 30353.544696830006, 30740.077797666105, 38979.61020389873, 39250.62622808188, 43156.352654709575, 39717.80141099276, 51031.97936041332, 55291.72354138204, 62720.0, 63547.0, 10276.434796086287, 10604.416757078434, 10939.398333091438, 11201.60794372193, 11233.71915702114, 11948.163628545919, 12003.219790713576, 12436.253824770543, 12639.93680031594, 13086.738265234833, 11414.0, 11588.611295747518, 11609.651710448363, 12062.457189426672, 12378.876211237772, 11124.165687573626, 11208.159388046091, 11452.713682158013, 11660.12549058807, 11910.225835320676, 11074.390908499787, 11337.829932550854, 11500.079993600659, 11825.46785394642, 11984.64046078619, 9503.714888553355, 9651.324407291422, 9680.177184939359, 9926.15627671656, 10412.271141020055, 8472.534010629228, 9275.582598783207, 9627.711168664951, 10303.845442318221, 10326.48367581633], "value": 6401.0351816225375, "unit": "score"}], "name": "dromaeo_css", "value": 6373.327950563877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 116.0, 114.0, 114.0, 113.0, 114.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 123.0, 125.0, 181.0, 127.0, 128.0, 148.0, 123.0, 172.0, 125.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 161.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 105.0, 76.0, 76.0, 75.0, 76.0, 100.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 85.0, 85.0, 86.0, 120.0, 84.0, 85.0, 125.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 60.0, 61.0, 61.0, 62.0, 60.0, 61.0, 62.0, 60.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 67.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 83.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 134.0, 136.0, 133.0, 135.0, 128.0, 136.0, 177.0, 130.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 163.0, 164.0, 165.0, 169.0, 172.0, 163.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 70.0, 67.0, 67.0, 68.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1527.9, "alertThreshold": 2.0}]} 23:59:42 INFO - Return code: 0 23:59:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:59:42 INFO - # TBPL SUCCESS # 23:59:42 INFO - Running post-action listener: _resource_record_post_action 23:59:42 INFO - [mozharness: 2016-07-25 06:59:42.291294Z] Finished run-tests step (success) 23:59:42 INFO - Running post-run listener: _resource_record_post_run 23:59:42 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546283520; Read time: 12; Write time: 529136 23:59:42 INFO - TinderboxPrint: CPU usage
13.0% 23:59:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:59:42 INFO - TinderboxPrint: I/O write bytes / time
546,283,520 / 529,136 23:59:42 INFO - TinderboxPrint: CPU idle
8,342.2 (87.0%) 23:59:42 INFO - TinderboxPrint: CPU user
1,199.2 (12.5%) 23:59:42 INFO - TinderboxPrint: Swap in / out
0 / 0 23:59:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258347008; Read time: 0; Write time: 287880 23:59:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 287936512; Read time: 0; Write time: 241256 23:59:42 INFO - Running post-run listener: _upload_blobber_files 23:59:42 INFO - Blob upload gear active. 23:59:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:59:42 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 23:59:42 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:59:42 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:59:43 INFO - (blobuploader) - INFO - Open directory for files ... 23:59:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:59:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:59:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:59:44 INFO - (blobuploader) - INFO - Done attempting. 23:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:00:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:01 INFO - (blobuploader) - INFO - Done attempting. 00:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:02 INFO - (blobuploader) - INFO - Done attempting. 00:00:02 INFO - (blobuploader) - INFO - Iteration through files over. 00:00:02 INFO - Return code: 0 00:00:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:00:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:00:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23aaf162712b5e10ee216fe83bdade147c6f99a14a7aaaf9d965b5dd66c7595076f9153ecc005d08b4872ebe5f190c9e6e8e1a0c25107111191199078a388c9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6801241b7d0519bbed2cd7d6fe7de75003dbd8f440d2c61bab04eff11f873f6bb5f71e51add7c9342c13adade404eec7dfb1787dfa7a02c14433bc4da62dc09f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c4f777e2db7af905b72c46c77ac349fb49e49fb9341caf714ce6ea2746441afb36845404104e2aa385301b705ee5007d151836cf4feeb55b2f58b8827695c3b"} 00:00:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:00:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:00:02 INFO - Contents: 00:00:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23aaf162712b5e10ee216fe83bdade147c6f99a14a7aaaf9d965b5dd66c7595076f9153ecc005d08b4872ebe5f190c9e6e8e1a0c25107111191199078a388c9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6801241b7d0519bbed2cd7d6fe7de75003dbd8f440d2c61bab04eff11f873f6bb5f71e51add7c9342c13adade404eec7dfb1787dfa7a02c14433bc4da62dc09f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c4f777e2db7af905b72c46c77ac349fb49e49fb9341caf714ce6ea2746441afb36845404104e2aa385301b705ee5007d151836cf4feeb55b2f58b8827695c3b"} 00:00:02 INFO - Running post-run listener: copy_logs_to_upload_dir 00:00:02 INFO - Copying logs to upload dir... 00:00:02 INFO - mkdir: /builds/slave/test/build/upload/logs 00:00:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.455750 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-25 00:00:01.734915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 00:00:01.738834) ========= 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=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 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-Non-PGO/sha512/23aaf162712b5e10ee216fe83bdade147c6f99a14a7aaaf9d965b5dd66c7595076f9153ecc005d08b4872ebe5f190c9e6e8e1a0c25107111191199078a388c9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6801241b7d0519bbed2cd7d6fe7de75003dbd8f440d2c61bab04eff11f873f6bb5f71e51add7c9342c13adade404eec7dfb1787dfa7a02c14433bc4da62dc09f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c4f777e2db7af905b72c46c77ac349fb49e49fb9341caf714ce6ea2746441afb36845404104e2aa385301b705ee5007d151836cf4feeb55b2f58b8827695c3b"} build_url:https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/Ac-ofN-9S7ir9tNwOhzwXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23aaf162712b5e10ee216fe83bdade147c6f99a14a7aaaf9d965b5dd66c7595076f9153ecc005d08b4872ebe5f190c9e6e8e1a0c25107111191199078a388c9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6801241b7d0519bbed2cd7d6fe7de75003dbd8f440d2c61bab04eff11f873f6bb5f71e51add7c9342c13adade404eec7dfb1787dfa7a02c14433bc4da62dc09f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c4f777e2db7af905b72c46c77ac349fb49e49fb9341caf714ce6ea2746441afb36845404104e2aa385301b705ee5007d151836cf4feeb55b2f58b8827695c3b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 00:00:01.763988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 00:00:01.764318) ========= 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=836cfdc75598d54cb747368e000001a9-1469428726.668541-365114082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 00:00:01.814145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 00:00:01.814474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 00:00:01.814781) ========= ========= Total master_lag: 0.34 =========