builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1469852573.56 results: success (0) buildid: 20160729183003 builduid: 201a4a8055cd4c2782ea52de5c612f94 revision: f60ec9e34d4d34958ff64d573862474dac8c0a6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:53.563530) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:53.564480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:53.564844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:53.925753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:53.926040) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 21:22:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.3M=0s 2016-07-29 21:22:54 (90.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092409 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:54.043723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:54.044025) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:54.093043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 21:22:54.096431) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f60ec9e34d4d34958ff64d573862474dac8c0a6f --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 f60ec9e34d4d34958ff64d573862474dac8c0a6f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 21:22:55,000 truncating revision to first 12 chars 2016-07-29 21:22:55,000 Setting DEBUG logging. 2016-07-29 21:22:55,000 attempt 1/10 2016-07-29 21:22:55,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f60ec9e34d4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 21:22:56,396 unpacking tar archive at: autoland-f60ec9e34d4d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.743853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 21:22:55.853535) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:55.853843) ========= script_repo_revision: f60ec9e34d4d34958ff64d573862474dac8c0a6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:55.854225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:55.854488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 21:22:55.864254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-29 21:22:55.864531) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:22:56 INFO - MultiFileLogger online at 20160729 21:22:56 in /builds/slave/test 21:22:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:22:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:56 INFO - {'append_to_log': False, 21:22:56 INFO - 'base_work_dir': '/builds/slave/test', 21:22:56 INFO - 'blob_upload_branch': 'Autoland', 21:22:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:56 INFO - 'branch': 'Autoland', 21:22:56 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:56 INFO - 'config_files': ('talos/linux_config.py',), 21:22:56 INFO - 'default_actions': ('clobber', 21:22:56 INFO - 'read-buildbot-config', 21:22:56 INFO - 'download-and-extract', 21:22:56 INFO - 'populate-webroot', 21:22:56 INFO - 'create-virtualenv', 21:22:56 INFO - 'install', 21:22:56 INFO - 'run-tests'), 21:22:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:56 INFO - 'download_minidump_stackwalk': True, 21:22:56 INFO - 'download_symbols': 'ondemand', 21:22:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:56 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:56 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:56 INFO - 'installer_path': 'installer.exe', 21:22:56 INFO - 'log_level': 'info', 21:22:56 INFO - 'log_name': 'talos', 21:22:56 INFO - 'log_to_console': True, 21:22:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:22:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:22:56 INFO - 'opt_config_files': (), 21:22:56 INFO - 'pip_index': False, 21:22:56 INFO - 'sps_profile': False, 21:22:56 INFO - 'sps_profile_interval': 0, 21:22:56 INFO - 'suite': 'dromaeojs-e10s', 21:22:56 INFO - 'system_bits': '32', 21:22:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:56 INFO - 'title': 'talos-linux64-ix-066', 21:22:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:56 INFO - 'use_talos_json': True, 21:22:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:56 INFO - 'work_dir': 'build'} 21:22:56 INFO - [mozharness: 2016-07-30 04:22:56.862103Z] Running clobber step. 21:22:56 INFO - Running pre-action listener: _resource_record_pre_action 21:22:56 INFO - Running main action method: clobber 21:22:56 INFO - rmtree: /builds/slave/test/build 21:22:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:57 INFO - Running post-action listener: _resource_record_post_action 21:22:57 INFO - [mozharness: 2016-07-30 04:22:57.337553Z] Finished clobber step (success) 21:22:57 INFO - [mozharness: 2016-07-30 04:22:57.337656Z] Running read-buildbot-config step. 21:22:57 INFO - Running pre-action listener: _resource_record_pre_action 21:22:57 INFO - Running main action method: read_buildbot_config 21:22:57 INFO - Using buildbot properties: 21:22:57 INFO - { 21:22:57 INFO - "project": "", 21:22:57 INFO - "product": "firefox", 21:22:57 INFO - "script_repo_revision": "production", 21:22:57 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:22:57 INFO - "repository": "", 21:22:57 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:22:57 INFO - "buildid": "20160729183003", 21:22:57 INFO - "pgo_build": "True", 21:22:57 INFO - "basedir": "/builds/slave/test", 21:22:57 INFO - "buildnumber": 66, 21:22:57 INFO - "slavename": "talos-linux64-ix-066", 21:22:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:22:57 INFO - "platform": "ubuntu64_hw", 21:22:57 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:22:57 INFO - "branch": "autoland", 21:22:57 INFO - "repo_path": "integration/autoland", 21:22:57 INFO - "revision": "f60ec9e34d4d34958ff64d573862474dac8c0a6f", 21:22:57 INFO - "stage_platform": "linux64-pgo", 21:22:57 INFO - "builduid": "201a4a8055cd4c2782ea52de5c612f94", 21:22:57 INFO - "slavebuilddir": "test" 21:22:57 INFO - } 21:22:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:22:57 INFO - Running post-action listener: _resource_record_post_action 21:22:57 INFO - [mozharness: 2016-07-30 04:22:57.340131Z] Finished read-buildbot-config step (success) 21:22:57 INFO - [mozharness: 2016-07-30 04:22:57.340222Z] Running download-and-extract step. 21:22:57 INFO - Running pre-action listener: _resource_record_pre_action 21:22:57 INFO - Running main action method: download_and_extract 21:22:57 INFO - mkdir: /builds/slave/test/build/tests 21:22: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')]} 21:22:57 INFO - https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:04 INFO - Downloaded 1361 bytes. 21:23:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:23:04 INFO - Using the following test package requirements: 21:23:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:23:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:23:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:23:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'jsshell-linux-x86_64.zip'], 21:23:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:23:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:23:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:23:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:23:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:23:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:23:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:04 INFO - https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:14 INFO - Downloaded 24332114 bytes. 21:23:14 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'] 21:23:14 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 21:23:16 INFO - Return code: 0 21:23:16 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 21:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:16 INFO - https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:17 INFO - Downloaded 24332114 bytes. 21:23:17 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'] 21:23:17 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 21:23:18 INFO - Return code: 0 21:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:18 INFO - https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:19 INFO - Downloaded 14413725 bytes. 21:23:19 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'] 21:23:19 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 21:23:19 INFO - Return code: 0 21:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:19 INFO - https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nco6ihx4QhKmthBQCY5S9A/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 21:23:21 INFO - Downloaded 61035539 bytes. 21:23:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:23:21 INFO - mkdir: /builds/slave/test/properties 21:23:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:23:21 INFO - Writing to file /builds/slave/test/properties/build_url 21:23:21 INFO - Contents: 21:23:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:23:21 INFO - Running post-action listener: _resource_record_post_action 21:23:21 INFO - Running post-action listener: set_extra_try_arguments 21:23:21 INFO - [mozharness: 2016-07-30 04:23:21.718372Z] Finished download-and-extract step (success) 21:23:21 INFO - [mozharness: 2016-07-30 04:23:21.718608Z] Running populate-webroot step. 21:23:21 INFO - Running pre-action listener: _resource_record_pre_action 21:23:21 INFO - Running main action method: populate_webroot 21:23:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:21 INFO - '--tppagecycles', 21:23:21 INFO - '7'], 21:23:21 INFO - 'tests': ['tsvgm']}}, 21:23:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:23:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:23:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:23:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['damp', 'tps']}, 21:23:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'tests': ['damp', 'tps']}, 21:23:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['dromaeo_dom']}, 21:23:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['basic_compositor_video']}, 21:23:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:23:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'other-e10s': {'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['a11yr', 21:23:21 INFO - 'ts_paint', 21:23:21 INFO - 'tpaint', 21:23:21 INFO - 'sessionrestore', 21:23:21 INFO - 'sessionrestore_no_auto_restore', 21:23:21 INFO - 'tabpaint']}, 21:23:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['tsvgx', 21:23:21 INFO - 'tsvgr_opacity', 21:23:21 INFO - 'tart', 21:23:21 INFO - 'tscrollx', 21:23:21 INFO - 'cart']}, 21:23:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:23:21 INFO - 'tsvgr_opacity', 21:23:21 INFO - 'tart', 21:23:21 INFO - 'tscrollx', 21:23:21 INFO - 'cart']}, 21:23:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'talos_options': ['--disable-e10s'], 21:23:21 INFO - 'tests': ['tp5o']}, 21:23:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'tests': ['tp5o']}, 21:23:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'talos_options': ['--disable-e10s', 21:23:21 INFO - '--xperf_path', 21:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:21 INFO - 'tests': ['tp5n']}, 21:23:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:21 INFO - 'talos_options': ['--xperf_path', 21:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:21 INFO - 'tests': ['tp5n']}}, 21:23:21 INFO - 'talos.zip': {'path': '', 21:23:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:21 INFO - Running post-action listener: _resource_record_post_action 21:23:21 INFO - [mozharness: 2016-07-30 04:23:21.736130Z] Finished populate-webroot step (success) 21:23:21 INFO - [mozharness: 2016-07-30 04:23:21.736221Z] Running create-virtualenv step. 21:23:21 INFO - Running pre-action listener: _resource_record_pre_action 21:23:21 INFO - Running main action method: create_virtualenv 21:23:21 INFO - Creating virtualenv /builds/slave/test/build/venv 21:23:21 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 21:23:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:23:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:21 INFO - Using real prefix '/usr' 21:23:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:23:22 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:24 INFO - Installing pip.................done. 21:23:24 INFO - Return code: 0 21:23:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:24 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:24 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 21:23:24 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 21:23:24 INFO - Using env: {'DISPLAY': ':0', 21:23:24 INFO - 'HOME': '/home/cltbld', 21:23:24 INFO - 'LANG': 'en_US.UTF-8', 21:23:24 INFO - 'LANGUAGE': 'en_US:en', 21:23:24 INFO - 'LOGNAME': 'cltbld', 21:23:24 INFO - 'MAIL': '/var/mail/cltbld', 21:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:24 INFO - 'MOZ_NO_REMOTE': '1', 21:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:24 INFO - 'NO_EM_RESTART': '1', 21:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:24 INFO - 'PWD': '/builds/slave/test', 21:23:24 INFO - 'SHELL': '/bin/bash', 21:23:24 INFO - 'SHLVL': '1', 21:23:24 INFO - 'TERM': 'linux', 21:23:24 INFO - 'TMOUT': '86400', 21:23:24 INFO - 'USER': 'cltbld', 21:23:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:24 INFO - '_': '/tools/buildbot/bin/python'} 21:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:24 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 21:23:24 INFO - Cleaning up... 21:23:24 INFO - Return code: 0 21:23:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:24 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:24 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 21:23:24 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 21:23:24 INFO - Using env: {'DISPLAY': ':0', 21:23:24 INFO - 'HOME': '/home/cltbld', 21:23:24 INFO - 'LANG': 'en_US.UTF-8', 21:23:24 INFO - 'LANGUAGE': 'en_US:en', 21:23:24 INFO - 'LOGNAME': 'cltbld', 21:23:24 INFO - 'MAIL': '/var/mail/cltbld', 21:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:24 INFO - 'MOZ_NO_REMOTE': '1', 21:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:24 INFO - 'NO_EM_RESTART': '1', 21:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:24 INFO - 'PWD': '/builds/slave/test', 21:23:24 INFO - 'SHELL': '/bin/bash', 21:23:24 INFO - 'SHLVL': '1', 21:23:24 INFO - 'TERM': 'linux', 21:23:24 INFO - 'TMOUT': '86400', 21:23:24 INFO - 'USER': 'cltbld', 21:23:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:24 INFO - '_': '/tools/buildbot/bin/python'} 21:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:24 INFO - Downloading/unpacking psutil>=3.1.1 21:23:24 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 21:23:24 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 21:23:24 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 21:23:24 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 21:23:24 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 21:23:24 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 21:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:26 INFO - Installing collected packages: psutil 21:23:26 INFO - Running setup.py install for psutil 21:23:26 INFO - building 'psutil._psutil_linux' extension 21:23:26 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 21:23:26 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 21:23:26 INFO - building 'psutil._psutil_posix' extension 21:23:26 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 21:23:27 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 21:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:27 INFO - Successfully installed psutil 21:23:27 INFO - Cleaning up... 21:23:27 INFO - Return code: 0 21:23:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:27 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 21:23:27 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 21:23:27 INFO - Using env: {'DISPLAY': ':0', 21:23:27 INFO - 'HOME': '/home/cltbld', 21:23:27 INFO - 'LANG': 'en_US.UTF-8', 21:23:27 INFO - 'LANGUAGE': 'en_US:en', 21:23:27 INFO - 'LOGNAME': 'cltbld', 21:23:27 INFO - 'MAIL': '/var/mail/cltbld', 21:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:27 INFO - 'MOZ_NO_REMOTE': '1', 21:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:27 INFO - 'NO_EM_RESTART': '1', 21:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:27 INFO - 'PWD': '/builds/slave/test', 21:23:27 INFO - 'SHELL': '/bin/bash', 21:23:27 INFO - 'SHLVL': '1', 21:23:27 INFO - 'TERM': 'linux', 21:23:27 INFO - 'TMOUT': '86400', 21:23:27 INFO - 'USER': 'cltbld', 21:23:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:27 INFO - '_': '/tools/buildbot/bin/python'} 21:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:29 INFO - Installing collected packages: mozsystemmonitor 21:23:29 INFO - Running setup.py install for mozsystemmonitor 21:23:29 INFO - Successfully installed mozsystemmonitor 21:23:29 INFO - Cleaning up... 21:23:29 INFO - Return code: 0 21:23:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:29 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 21:23:29 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 21:23:29 INFO - Using env: {'DISPLAY': ':0', 21:23:29 INFO - 'HOME': '/home/cltbld', 21:23:29 INFO - 'LANG': 'en_US.UTF-8', 21:23:29 INFO - 'LANGUAGE': 'en_US:en', 21:23:29 INFO - 'LOGNAME': 'cltbld', 21:23:29 INFO - 'MAIL': '/var/mail/cltbld', 21:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:29 INFO - 'MOZ_NO_REMOTE': '1', 21:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:29 INFO - 'NO_EM_RESTART': '1', 21:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:29 INFO - 'PWD': '/builds/slave/test', 21:23:29 INFO - 'SHELL': '/bin/bash', 21:23:29 INFO - 'SHLVL': '1', 21:23:29 INFO - 'TERM': 'linux', 21:23:29 INFO - 'TMOUT': '86400', 21:23:29 INFO - 'USER': 'cltbld', 21:23:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:29 INFO - '_': '/tools/buildbot/bin/python'} 21:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:29 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:31 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:32 INFO - warning: no files found matching '*.txt' 21:23:32 INFO - no previously-included directories found matching 'build' 21:23:32 INFO - no previously-included directories found matching 'dist' 21:23:32 INFO - no previously-included directories found matching '.git*' 21:23:32 INFO - Installing collected packages: jsonschema, functools32 21:23:32 INFO - Running setup.py install for functools32 21:23:32 INFO - warning: no files found matching '*.txt' 21:23:32 INFO - no previously-included directories found matching 'build' 21:23:32 INFO - no previously-included directories found matching 'dist' 21:23:32 INFO - no previously-included directories found matching '.git*' 21:23:32 INFO - Successfully installed jsonschema functools32 21:23:32 INFO - Cleaning up... 21:23:32 INFO - Return code: 0 21:23:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:32 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:32 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 21:23:32 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 21:23:32 INFO - Using env: {'DISPLAY': ':0', 21:23:32 INFO - 'HOME': '/home/cltbld', 21:23:32 INFO - 'LANG': 'en_US.UTF-8', 21:23:32 INFO - 'LANGUAGE': 'en_US:en', 21:23:32 INFO - 'LOGNAME': 'cltbld', 21:23:32 INFO - 'MAIL': '/var/mail/cltbld', 21:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:32 INFO - 'MOZ_NO_REMOTE': '1', 21:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:32 INFO - 'NO_EM_RESTART': '1', 21:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:32 INFO - 'PWD': '/builds/slave/test', 21:23:32 INFO - 'SHELL': '/bin/bash', 21:23:32 INFO - 'SHLVL': '1', 21:23:32 INFO - 'TERM': 'linux', 21:23:32 INFO - 'TMOUT': '86400', 21:23:32 INFO - 'USER': 'cltbld', 21:23:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:32 INFO - '_': '/tools/buildbot/bin/python'} 21:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:32 INFO - Cleaning up... 21:23:32 INFO - Return code: 0 21:23:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:32 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:32 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 21:23:32 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 21:23:32 INFO - Using env: {'DISPLAY': ':0', 21:23:32 INFO - 'HOME': '/home/cltbld', 21:23:32 INFO - 'LANG': 'en_US.UTF-8', 21:23:32 INFO - 'LANGUAGE': 'en_US:en', 21:23:32 INFO - 'LOGNAME': 'cltbld', 21:23:32 INFO - 'MAIL': '/var/mail/cltbld', 21:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:32 INFO - 'MOZ_NO_REMOTE': '1', 21:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:32 INFO - 'NO_EM_RESTART': '1', 21:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:32 INFO - 'PWD': '/builds/slave/test', 21:23:32 INFO - 'SHELL': '/bin/bash', 21:23:32 INFO - 'SHLVL': '1', 21:23:32 INFO - 'TERM': 'linux', 21:23:32 INFO - 'TMOUT': '86400', 21:23:32 INFO - 'USER': 'cltbld', 21:23:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:32 INFO - '_': '/tools/buildbot/bin/python'} 21:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:32 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:34 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:35 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 21:23:35 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 21:23:35 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 21:23:35 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 21:23:35 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 21:23:35 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 21:23:35 INFO - Downloading docopt-0.6.1.tar.gz 21:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:35 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:35 INFO - Running setup.py install for blobuploader 21:23:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:35 INFO - Running setup.py install for requests 21:23:35 INFO - Running setup.py install for docopt 21:23:35 INFO - Successfully installed blobuploader requests docopt 21:23:35 INFO - Cleaning up... 21:23:35 INFO - Return code: 0 21:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:35 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:35 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 21:23:35 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 21:23:35 INFO - Using env: {'DISPLAY': ':0', 21:23:35 INFO - 'HOME': '/home/cltbld', 21:23:35 INFO - 'LANG': 'en_US.UTF-8', 21:23:35 INFO - 'LANGUAGE': 'en_US:en', 21:23:35 INFO - 'LOGNAME': 'cltbld', 21:23:35 INFO - 'MAIL': '/var/mail/cltbld', 21:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:35 INFO - 'MOZ_NO_REMOTE': '1', 21:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:35 INFO - 'NO_EM_RESTART': '1', 21:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:35 INFO - 'PWD': '/builds/slave/test', 21:23:35 INFO - 'SHELL': '/bin/bash', 21:23:35 INFO - 'SHLVL': '1', 21:23:35 INFO - 'TERM': 'linux', 21:23:35 INFO - 'TMOUT': '86400', 21:23:35 INFO - 'USER': 'cltbld', 21:23:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:35 INFO - '_': '/tools/buildbot/bin/python'} 21:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:36 INFO - Running setup.py (path:/tmp/pip-kEUDDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:36 INFO - Running setup.py (path:/tmp/pip-C8TMRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 INFO - Running setup.py (path:/tmp/pip-L9ROZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 INFO - Running setup.py (path:/tmp/pip-01fnJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:36 INFO - Running setup.py (path:/tmp/pip-UBJqwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:36 INFO - Running setup.py (path:/tmp/pip-PMLcOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:36 INFO - Running setup.py (path:/tmp/pip-X4DcJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:36 INFO - Running setup.py (path:/tmp/pip-Bp_Fgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:36 INFO - Running setup.py (path:/tmp/pip-P6PWRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:36 INFO - Running setup.py (path:/tmp/pip-IYCRvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:36 INFO - Running setup.py (path:/tmp/pip-cszi6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:36 INFO - Running setup.py (path:/tmp/pip-nSVp4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:36 INFO - Running setup.py (path:/tmp/pip-VyMQJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 INFO - Running setup.py (path:/tmp/pip-LgtAeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 INFO - Running setup.py (path:/tmp/pip-pSXrDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:37 INFO - Running setup.py (path:/tmp/pip-IVDyEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:37 INFO - Running setup.py (path:/tmp/pip-CyuQAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:37 INFO - Running setup.py install for manifestparser 21:23:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:37 INFO - Running setup.py install for mozcrash 21:23:37 INFO - Running setup.py install for mozdebug 21:23:37 INFO - Running setup.py install for mozdevice 21:23:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:37 INFO - Running setup.py install for mozfile 21:23:37 INFO - Running setup.py install for mozhttpd 21:23:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:37 INFO - Running setup.py install for mozinfo 21:23:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for mozInstall 21:23:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for mozleak 21:23:38 INFO - Running setup.py install for mozlog 21:23:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for moznetwork 21:23:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for mozprocess 21:23:38 INFO - Running setup.py install for mozprofile 21:23:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for mozrunner 21:23:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:38 INFO - Running setup.py install for mozscreenshot 21:23:38 INFO - Running setup.py install for moztest 21:23:39 INFO - Running setup.py install for mozversion 21:23:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:39 INFO - Cleaning up... 21:23:39 INFO - Return code: 0 21:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:39 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')]} 21:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 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')]} 21:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:39 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 21:23:39 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 21:23:39 INFO - Using env: {'DISPLAY': ':0', 21:23:39 INFO - 'HOME': '/home/cltbld', 21:23:39 INFO - 'LANG': 'en_US.UTF-8', 21:23:39 INFO - 'LANGUAGE': 'en_US:en', 21:23:39 INFO - 'LOGNAME': 'cltbld', 21:23:39 INFO - 'MAIL': '/var/mail/cltbld', 21:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:39 INFO - 'MOZ_NO_REMOTE': '1', 21:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:39 INFO - 'NO_EM_RESTART': '1', 21:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:39 INFO - 'PWD': '/builds/slave/test', 21:23:39 INFO - 'SHELL': '/bin/bash', 21:23:39 INFO - 'SHLVL': '1', 21:23:39 INFO - 'TERM': 'linux', 21:23:39 INFO - 'TMOUT': '86400', 21:23:39 INFO - 'USER': 'cltbld', 21:23:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:39 INFO - '_': '/tools/buildbot/bin/python'} 21:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:39 INFO - Running setup.py (path:/tmp/pip-n4MeMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:39 INFO - Running setup.py (path:/tmp/pip-CSgX2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:39 INFO - Running setup.py (path:/tmp/pip-SDDRt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:39 INFO - Running setup.py (path:/tmp/pip-QMXTON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:39 INFO - Running setup.py (path:/tmp/pip-2AzTBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:39 INFO - Running setup.py (path:/tmp/pip-qJZOOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:39 INFO - Running setup.py (path:/tmp/pip-wdI_W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:39 INFO - Running setup.py (path:/tmp/pip-Skvy0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:39 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)) 21:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:39 INFO - Running setup.py (path:/tmp/pip-ZSPHIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:40 INFO - Running setup.py (path:/tmp/pip-NZi06n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:40 INFO - Running setup.py (path:/tmp/pip-8vdLpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:40 INFO - Running setup.py (path:/tmp/pip-4fsC55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:40 INFO - Running setup.py (path:/tmp/pip-RVTaoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:40 INFO - Running setup.py (path:/tmp/pip-dgyvQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:40 INFO - Running setup.py (path:/tmp/pip-5ALOIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:40 INFO - Running setup.py (path:/tmp/pip-hk_yE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:40 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)) 21:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:40 INFO - Running setup.py (path:/tmp/pip-phOHfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:40 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 21:23:40 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 21:23:40 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 21:23:40 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 21:23:40 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 21:23:40 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 21:23:42 INFO - Downloading blessings-1.6.tar.gz 21:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:42 INFO - Installing collected packages: blessings 21:23:42 INFO - Running setup.py install for blessings 21:23:42 INFO - Successfully installed blessings 21:23:42 INFO - Cleaning up... 21:23:42 INFO - Return code: 0 21:23:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:42 INFO - Reading from file tmpfile_stdout 21:23:42 INFO - Current package versions: 21:23:42 INFO - argparse == 1.2.1 21:23:42 INFO - blessings == 1.6 21:23:42 INFO - blobuploader == 1.2.4 21:23:42 INFO - docopt == 0.6.1 21:23:42 INFO - functools32 == 3.2.3-2 21:23:42 INFO - jsonschema == 2.5.1 21:23:42 INFO - manifestparser == 1.1 21:23:42 INFO - mozInstall == 1.12 21:23:42 INFO - mozcrash == 0.17 21:23:42 INFO - mozdebug == 0.1 21:23:42 INFO - mozdevice == 0.48 21:23:42 INFO - mozfile == 1.2 21:23:42 INFO - mozhttpd == 0.7 21:23:42 INFO - mozinfo == 0.9 21:23:42 INFO - mozleak == 0.1 21:23:42 INFO - mozlog == 3.3 21:23:42 INFO - moznetwork == 0.27 21:23:42 INFO - mozprocess == 0.23 21:23:42 INFO - mozprofile == 0.28 21:23:42 INFO - mozrunner == 6.12 21:23:42 INFO - mozscreenshot == 0.1 21:23:42 INFO - mozsystemmonitor == 0.3 21:23:42 INFO - moztest == 0.7 21:23:42 INFO - mozversion == 1.4 21:23:42 INFO - psutil == 3.1.1 21:23:42 INFO - requests == 1.2.3 21:23:42 INFO - wsgiref == 0.1.2 21:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:42 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:42 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 21:23:42 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 21:23:42 INFO - Using env: {'DISPLAY': ':0', 21:23:42 INFO - 'HOME': '/home/cltbld', 21:23:42 INFO - 'LANG': 'en_US.UTF-8', 21:23:42 INFO - 'LANGUAGE': 'en_US:en', 21:23:42 INFO - 'LOGNAME': 'cltbld', 21:23:42 INFO - 'MAIL': '/var/mail/cltbld', 21:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:42 INFO - 'MOZ_NO_REMOTE': '1', 21:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:42 INFO - 'NO_EM_RESTART': '1', 21:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:42 INFO - 'PWD': '/builds/slave/test', 21:23:42 INFO - 'SHELL': '/bin/bash', 21:23:42 INFO - 'SHLVL': '1', 21:23:42 INFO - 'TERM': 'linux', 21:23:42 INFO - 'TMOUT': '86400', 21:23:42 INFO - 'USER': 'cltbld', 21:23:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:42 INFO - '_': '/tools/buildbot/bin/python'} 21:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 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)) 21:23:43 INFO - Cleaning up... 21:23:43 INFO - Return code: 0 21:23:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:43 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')]} 21:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:43 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')]} 21:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:43 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 0x24ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', '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 21:23:43 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 21:23:43 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 21:23:43 INFO - Using env: {'DISPLAY': ':0', 21:23:43 INFO - 'HOME': '/home/cltbld', 21:23:43 INFO - 'LANG': 'en_US.UTF-8', 21:23:43 INFO - 'LANGUAGE': 'en_US:en', 21:23:43 INFO - 'LOGNAME': 'cltbld', 21:23:43 INFO - 'MAIL': '/var/mail/cltbld', 21:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:43 INFO - 'MOZ_NO_REMOTE': '1', 21:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:43 INFO - 'NO_EM_RESTART': '1', 21:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:43 INFO - 'PWD': '/builds/slave/test', 21:23:43 INFO - 'SHELL': '/bin/bash', 21:23:43 INFO - 'SHLVL': '1', 21:23:43 INFO - 'TERM': 'linux', 21:23:43 INFO - 'TMOUT': '86400', 21:23:43 INFO - 'USER': 'cltbld', 21:23:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:43 INFO - '_': '/tools/buildbot/bin/python'} 21:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:43 INFO - Cleaning up... 21:23:43 INFO - Return code: 0 21:23:43 INFO - Running post-action listener: _resource_record_post_action 21:23:43 INFO - Running post-action listener: _start_resource_monitoring 21:23:43 INFO - Starting resource monitoring. 21:23:43 INFO - [mozharness: 2016-07-30 04:23:43.422317Z] Finished create-virtualenv step (success) 21:23:43 INFO - [mozharness: 2016-07-30 04:23:43.422839Z] Running install step. 21:23:43 INFO - Running pre-action listener: _resource_record_pre_action 21:23:43 INFO - Running main action method: install 21:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:43 INFO - Reading from file tmpfile_stdout 21:23:43 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:43 INFO - Reading from file tmpfile_stdout 21:23:43 INFO - Output received: 21:23:43 INFO - Usage: mozinstall [options] installer 21:23:43 INFO - Options: 21:23:43 INFO - -h, --help show this help message and exit 21:23:43 INFO - -d DEST, --destination=DEST 21:23:43 INFO - Directory to install application into. [default: 21:23:43 INFO - "/builds/slave/test"] 21:23:43 INFO - --app=APP Application being installed. [default: firefox] 21:23:43 INFO - mkdir: /builds/slave/test/build/application 21:23:43 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'] 21:23:43 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 21:24:01 INFO - Reading from file tmpfile_stdout 21:24:01 INFO - Output received: 21:24:01 INFO - /builds/slave/test/build/application/firefox/firefox 21:24:01 INFO - Running post-action listener: _resource_record_post_action 21:24:01 INFO - [mozharness: 2016-07-30 04:24:01.053800Z] Finished install step (success) 21:24:01 INFO - [mozharness: 2016-07-30 04:24:01.054075Z] Running run-tests step. 21:24:01 INFO - Running pre-action listener: _resource_record_pre_action 21:24:01 INFO - Running main action method: run_tests 21:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:24:01 INFO - Python 2.7.3 21:24:01 INFO - Return code: 0 21:24:01 INFO - grabbing minidump binary from tooltool 21:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:24:01 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 0x276c3b0>, '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 0x276d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:24:01 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 21:24:01 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 21:24:01 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 21:24:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:24:01 INFO - Return code: 0 21:24:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:24:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:24:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:24:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:24:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:24:01 INFO - Using env: {'DISPLAY': ':0', 21:24:01 INFO - 'HOME': '/home/cltbld', 21:24:01 INFO - 'LANG': 'en_US.UTF-8', 21:24:01 INFO - 'LANGUAGE': 'en_US:en', 21:24:01 INFO - 'LOGNAME': 'cltbld', 21:24:01 INFO - 'MAIL': '/var/mail/cltbld', 21:24:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:24:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:24:01 INFO - 'MOZ_NO_REMOTE': '1', 21:24:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:24:01 INFO - 'NO_EM_RESTART': '1', 21:24:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:24:01 INFO - 'PWD': '/builds/slave/test', 21:24:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:24:01 INFO - 'SHELL': '/bin/bash', 21:24:01 INFO - 'SHLVL': '1', 21:24:01 INFO - 'TERM': 'linux', 21:24:01 INFO - 'TMOUT': '86400', 21:24:01 INFO - 'USER': 'cltbld', 21:24:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198', 21:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:24:01 INFO - '_': '/tools/buildbot/bin/python'} 21:24:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:24:01 INFO - mozversion application_buildid: 20160729183003 21:24:01 INFO - mozversion application_changeset: f60ec9e34d4d34958ff64d573862474dac8c0a6f 21:24:01 INFO - mozversion application_display_name: Nightly 21:24:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:24:01 INFO - mozversion application_name: Firefox 21:24:01 INFO - mozversion application_remotingname: firefox 21:24:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:24:01 INFO - mozversion application_vendor: Mozilla 21:24:01 INFO - mozversion application_version: 50.0a1 21:24:01 INFO - mozversion platform_buildid: 20160729183003 21:24:01 INFO - mozversion platform_changeset: f60ec9e34d4d34958ff64d573862474dac8c0a6f 21:24:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:24:01 INFO - mozversion platform_version: 50.0a1 21:24:01 INFO - using testdate: 1469852641 21:24:01 INFO - actual date: 1469852641 21:24:01 INFO - starting webserver on 'localhost:41037' 21:24:01 INFO - SUITE-START | Running 2 tests 21:24:01 INFO - TEST-START | dromaeo_css 21:24:01 INFO - operating with platform_type : linux_ 21:24:01 INFO - Initialising browser for dromaeo_css test... 21:24:01 INFO - TEST-INFO | started process 19884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJtV0p/profile http://localhost:41037/getInfo.html) 21:24:04 INFO - PROCESS | 19884 | JavaScript error: , line 0: uncaught exception: undefined 21:24:05 INFO - PROCESS | 19884 | __metrics Screen width/height:1600/1200 21:24:05 INFO - PROCESS | 19884 | colorDepth:24 21:24:05 INFO - PROCESS | 19884 | Browser inner width/height: 1024/697 21:24:05 INFO - PROCESS | 19884 | __metrics 21:24:07 ERROR - PROCESS | 19884 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:24:07 INFO - TEST-INFO | 19884: exit 0 21:24:07 INFO - Browser initialized. 21:24:07 INFO - Running cycle 1/1 for dromaeo_css test... 21:24:07 INFO - TEST-INFO | started process 20003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJtV0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:19 INFO - PROCESS | 20003 | RSS: Main: 164671488 21:24:19 INFO - PROCESS | 20003 | 21:25:09 INFO - PROCESS | 20003 | 1469852709385 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] 21:27:18 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41037/tests/dromaeo/cssquery-ext.html) 21:27:19 INFO - PROCESS | 20003 | RSS: Main: 169431040 21:27:19 INFO - PROCESS | 20003 | 21:30:21 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-ext.html (next: http://localhost:41037/tests/dromaeo/cssquery-jquery.html) 21:30:21 INFO - PROCESS | 20003 | RSS: Main: 167600128 21:30:21 INFO - PROCESS | 20003 | 21:33:23 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41037/tests/dromaeo/cssquery-mootools.html) 21:33:24 INFO - PROCESS | 20003 | RSS: Main: 171098112 21:33:24 INFO - PROCESS | 20003 | 21:36:26 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41037/tests/dromaeo/cssquery-prototype.html) 21:36:26 INFO - PROCESS | 20003 | RSS: Main: 165916672 21:36:26 INFO - PROCESS | 20003 | 21:39:29 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41037/tests/dromaeo/cssquery-yui.html) 21:39:29 INFO - PROCESS | 20003 | RSS: Main: 167780352 21:39:29 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | Cycle 1(1): loaded http://localhost:41037/tests/dromaeo/cssquery-yui.html (next: http://localhost:41037/tests/dromaeo/cssquery-dojo.html) 21:42:32 INFO - PROCESS | 20003 | RSS: Main: 171048960 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | __start_tp_report 21:42:32 INFO - PROCESS | 20003 | _x_x_mozilla_page_load 21:42:32 INFO - PROCESS | 20003 | _x_x_mozilla_page_load_details 21:42:32 INFO - PROCESS | 20003 | |i|pagename|runs| 21:42:32 INFO - PROCESS | 20003 | |0;dojo.html;3115.984420077902;3121.1884909923415;3159.0680749178996;3160.051984404678;3160.8261545614996;5448;5476;5482.945170548293;5533.6403133796275;5567.2762540869735;5494.642848214863;5569.331680198372;5587.832365029046;5592.4407559244155;5644.435556444353;5018.222175562784;5100.693958362492;5113.1307677694695;5177.094008548489;5227.686338819664;5186.040582492232;5186.429492755794;5209.426963034063;5242.6330156889035;5246.213068039787;5003.199488081926;5007.424146223195;5068.695878247317;5077.035363280983;5121.9487805122035;5061.924071138936;5079.2127220280545;5089.872753181163;5142.717150556718;5160.354955630546;5006.199008158714;5053.1157047516535;5055.292259083732;5064.721440320781;5084.720340381277;5324.494173053554;5477.068898287301;5541.085720856054;5545.085060964936;5568.276124103881;6011.75952961881;6015.09773533969;6015.548833837436;6041.758329666808;6054.515638748933;6043.848903777397;6049.727762250665;6051.425114614105;6058.939410605925;6067.635941843503;5389.461053894618;5495.862603434906;5532;5599.748011339459;5607.635503692247;6122.764110201795;6141.447269745655;6145.4161854623735;6158.261008678987;6161.661108639068;5850.736716847752;5870.911936320958;5883.558733094949;5883.735231914488;5886.23478947734;5778.393268706809;5841.299044114733;5848.9707551462825;5965.284165900033;5977;5718.085106383042;5877.676727779927;5890.793822216202;5905.704714764244;5910.940890591039;5889.352171261158;5900.704964751745;5914.970425147847;5916.556258280646;5921;4425.822967081281;4486.573775491323;4490.820367185342;4505.05393867285;4575.954240457553;3974.2250261198787;3987.980060099739;4007.6393124618926;4027.0536423940353;4046.7167298288837;5706.3722990471015;5731.254936858265;5738.655680659173;5740.282464691913;5740.368559458456;5814;5995.850103747442;6004.8799024020145;6006.969965150233;6014;5565.0817615093865;5662.2639056922335;5670.829875103754;5727.05503591911;5768.913466298009;5027.924581131286;5064;5067.037262920034;5079.085764562415;5082.872928176751;5995.2206213192;6147.907781383283;6168.573779074044;6195.566310358232;6200.410960958701;5833.562482813891;5864;5874.17761513397;5913.852153696192;5961.105834124916;5999.670018149044;6066.272047354346;6081.118237855398;6091.208142941389;6100.481459076028;5671.206031155559;5763.7982670606325;5768.394318596655;5786.913196302143;5797.2173756542325;5906.822795316148;5921.674307912934;5971.0744834550715;5988.37122102173;6006.639601623917;5823.679697616672;5824.446677565625;5824.796132135355;5831.212786273799;5838.065909454467;5662.886742265214;5769.932562475956;5815.389384114607;5825.2135961644635;5836.270466191726;5678.233438485751;5754.309482861916;5759.164921086335;5793.3337666167245;5796.333421656564;5812.418758124154;5823.650580965155;5856.297244330707;5867.677277749594;5878.559108066826;5580.888382232414;5653.293338332708;5680.403557626555;5695.373508914099;5725.398833122462 21:42:32 INFO - PROCESS | 20003 | |1;ext.html;578.2136294639292;602.8071017274474;603.471962033221;617.7559863853777;624.7251209467831;38470.807645961766;41508.16983660325;41672.37491437623;41739.37390939138;41773.58226417735;42733;43083.138337233235;43389;43528.347074793906;43537;8914;9053.185213330831;9055.094490550926;9059.864102038475;9082.091790820898;8880.200781929625;8911.465312081264;8960.462372257653;8989.595468203914;8996.325275604324;8914.955425222897;8952.194302512773;8955.95522022389;8959.686410975617;9013.639454421815;8918.464892106495;8978.910210897873;8996.865047024234;9019.368644194908;9023.413478123934;8873.778155546099;8921.375503714742;8937.106289371075;8950;8958.46249225042;39231;39401.60598394008;39479;39562.20875582501;39638.60361396407;3527.4708793680898;3537.610862805115;3564.9643503564894;3736.57029441615;3968.6311787072314;31125.37749245025;31818.840905795554;32071;32363.352732945445;32502;4132.586741325843;4342.435483387171;4393.428854248959;4411.647068234533;4490.708103973231;348635;349503.25248373847;349610;350219;351136;54353.1847022295;55146.72426637841;55173;55422.72288638531;55504.72247638817;35065.824670876995;35466.29067418637;35545.578176873154;36798.44802327967;57980.71009644925;14471.348789304506;14604.780928286084;14728.189949552878;14731;14738.336774845158;10749.83875241872;10903.672889813319;10909.34543927367;10910.563577456971;10918.235723499438;18715.625687486176;18731.90634046821;18750.406215471838;18896.622067558572;18899.433017009513;7130.393916517154;7376.852462950818;7421.480496365202;7421.666025028887;7495.725726626487;886.4636894678755;980.0060814212649;1028.3367228137809;1036.1658864614058;1039.365986748083;31480.37039259202;31720.206994824854;31912.840435798138;32161.839190804363;32334.35331293361;926.1571969507715;1024.1141412678128;1054.2778196935124;1126.4030064066058;1132.17351333527;15814.841851581567;16522.42171523991;16560.6687866242;16641.41755038568;16769.32922683079;616955;618788;619393;620525;620851;56780.71609641925;57395.26930749488;57611.71194144002;57699.71150144222;57723.26830195101;1282.6536835054483;1300.6618279247275;1325.0989327257364;1339.6918708697053;1339.6985678222518;29036.822238331788;30892.382152357277;31033.37933241368;31159.376812464077;31551.684483155794;48053.279200812714;48349.27476087791;48415.78960526015;48436.757816210695;48463;366393;367729;466280;467427;467638;27606.309842254104;27659.723402766518;27858.16425507238;27963.440731184855;28107.57838632463;44778.77610611926;46771.29843052425;47092;47143.292850607955;47869;39698.206035878546;40353.79823100983;40428.79785601053;40967;42039;40137;41302;41424;41453.58546414618;41465;38981;41000.384994224514;41282;41429;43591;35057;36047.27905441929;36426.27147457089;37361.62638373581;37500.43749343707;28450;28548.85725571359;28653.856730717045;28660.85669571639;28739.712602873704 21:42:32 INFO - PROCESS | 20003 | |2;jquery.html;376.1893120325699;383.9288385404721;396;397.6361629109365;411.6315897271942;13817.585472435818;18115.818841811593;19012.14445349959;19973.800261997374;20010.49973750655;19017.809821901777;19089.23643054276;19167.520811979706;19471.123799429024;19855.503612409662;5687.886242275152;5708.543316534688;5730.2837145356625;5801.332846722617;5853.443922827346;5361.115415956362;5724.513416359594;5727.799527016556;5758.913616295759;5766.0486019806685;5595.636283641571;5727.284089488814;5728.856778580527;5736.6558006519535;5737.856553586173;5651.858703532424;5697.658140511562;5723.742431590546;5727.742251598646;5741.282339707536;5025.296458495814;5285.233641122054;5836.212111364996;5977.073553599155;6004.249468816398;13642.386092625855;13794.103383280055;14035.368408421646;14054.508092216825;14062.578122656336;2225.710657614516;2265.4676151104477;2411.3127758588894;2678.08944958715;2983.1199796060214;9794.706158815246;10086.09225169731;10140.594376224943;10154.593816247341;10160.933102024255;1879.6616609010373;1896.2794138227384;1926.6820974539185;1935.5161209697576;2004.5990801839691;77036.61481692556;77733;79076;79621.60189199075;79772.60113699452;10762.569497220024;10902.546926941375;11259.268147570381;11323;11398.202125851276;15085.849141508665;15098.471553495576;15150.393984240507;15204.315805788767;15268.465603703817;7481.251874812475;7581.810454738676;7624.771256862303;7806.570638614817;7837.725679601187;7006.4394848412;7060.858782824314;7252.5648461092505;7265.309795569412;7281.5631062136445;4655.813767449264;4732.313814496879;4739.3601863748645;4774.904501909942;4825.831095911696;1911.9713204301947;1961.9411417657493;1975.8122978317037;1991.3428568572335;1992.0935974131735;881.8236352729351;926.7266156483853;931.771715929588;997.2819569909653;1068.6580294305747;17900.46298611018;19377.61244775125;19471.610567788564;19930.90034549818;20191.899040505;991.177322822056;992.6426486464867;994.229472159068;1002.8997100289913;1058.0266155137138;10629.946850265855;10951.45242737876;11009.449527523591;11017.228793984345;11139.498722557342;497672;517574;545557;556443;559904.0071994617;90442.54778726195;92009.5399522998;93690;93904;95284.52357738167;980.132582664333;996.9252306076928;1042.760165162017;1059.9152067834555;1061.9592799056968;16318.347266109222;16736.246868890685;16842.831571684615;17069.805113641927;17248.051357175475;41565;42302.36546451744;42635;42814;43325.35011974886;55023.72488137534;59356;59695;60414.39585604263;61245;8296.70961516344;8300.958495207486;8439.07170211264;8473.576321183793;8480.915190848013;11583;12877.291748953523;12985.480580776662;13013.21920684762;13173.27546984925;10930.234883558074;11092.445377731243;11345.48945297447;11704.297742135499;12224.266544007389;10933.890661093605;11152.275102118336;11419.828702569303;11437.142214333791;11493.31040137561;11082.279651822606;11232.382218978035;11574.305541667527;11713.824292635447;11828.526858925547;8238.340932725248;8340.791480213044;8385.53879536607;8470.110638383128;8500.192481714228;10720.517576709222;10833.620823271147;11101.777964440827;11275.548978040786;11317.490712918103 21:42:32 INFO - PROCESS | 20003 | |3;mootools.html;1501.5120085972057;1516.355548891721;1675.3968571314324;1770.0884044716981;1785.4465115814091;7982.880256796138;8637.870431943526;8717.12828717128;9375.624975000992;9384.296177786668;8684.218420342168;9059.320550958671;9063.72808815735;9065.682701105463;9098.22665073468;2128.2551107112504;2154.870707757532;2155.245664017597;2163;2164.037003533428;2343.8828058597;2371.4545654499475;2392.270357540949;2402.9158979435724;2409.5301416223842;2142.6678864775986;2166.306781829815;2179.553191595719;2181.160253302482;2226.4322597737637;1956.5499935015025;1958.1090603775249;1960.1669290551458;1967.4491142480128;1973.1811298311256;2165.393689766852;2187.8359123065675;2196.736391632998;2197.2748992832326;2221.589006033889;8945.01604823469;8986.326025548111;9142.1772040516;9173.633054677804;9177.724668259963;5281.023010743025;5423.674579525241;5428.891422171534;5433.809816656398;5449.1826226066405;3271;3321.800691958466;3373.274745929637;3374.240795820945;3472.75690701651;1007.3452256033563;1038.3873514626332;1071.3197119828887;1073.1682945717055;1120.2494328799723;12565.120441569094;12584.930280926132;12594;12611.432485538173;12682.239065655998;4522.25382811839;4756.7859446325;4772.117158325721;4796.544328288807;4797.616190704735;10688.51901664427;10741.83887241692;10754.40850753216;10759.515821788038;10770.730731731614;5465.699386533779;5482.2873026506295;5485.835424937259;5491.807786727445;5494.09347457665;4917.262410638361;4923.679960802537;4935.037667654845;5005.424376196784;5051.090803655377;3915.5497117831246;3939.5469521005452;3989.800509974548;4098.590140985878;4123.134141830249;1222.7676741419102;1223.565634199864;1229.827824104626;1247.9688007799696;1273.6497463197509;980.4705459052175;1002.2633364477103;1007.0885848307294;1022.156720705421;1032.7314898126542;6175.2589689237575;6293.244810622663;6315.147455093595;6335.524835637346;6342.651154186564;438.0800319329446;441.1661958897686;443.3792690233634;444.5954181694642;953.7234202081319;4305.74165550068;4436.889077773081;4439.98370283512;4482.462104547475;4518.8418405356315;11275.379854108103;11597;11607.883921160848;11615.941920290514;11664.94167529157;11451;11458.828117578243;11514.424278786195;11526.942365288287;11535.942320288344;7947.642356093989;8281.668733250723;8288.254057134765;8474.491530508067;8551.01663308715;6277.466415354746;6279.340669229665;6360.713767880549;6464.741410343534;6508.284088750328;9966.700998970042;10360.274780765274;10423.530941107516;10477;10610.734731631772;9543.570539325608;10002.799944001225;10584.682459526226;10631.096356809448;10813.56745730162;7622.390208783395;7864.0563132422185;8026.117127116129;8037.839243214986;8078.19218078211;8674.696385626472;8697.608607612547;8699.13008699125;8706.695265665672;8749.91250087491;7697.153313135439;7776.144624091458;7814.960925195338;7924.4056695749205;7960.4825686330205;7873.842523149619;7944.602769861599;7985.480943738638;8058.919410805817;8123.8781418277595;7183.568985860865;7282.198958114497;7290.1251849776245;7302.817429564303;7319.74380896666;5092.388913330424;5390.757415916215;5399.865003374947;5407.675539467645;5637.802676906453;5367.463253674601;5372.462753724596;5374.113271310346;5424.945750542602;5442.619016668795 21:42:32 INFO - PROCESS | 20003 | |4;prototype.html;323.454978361461;334.9949750753738;338.70363431997004;342.13781271196586;344.71216534193945;5356.91964620531;5493.780248790049;5534.889302213954;5603.747831347594;5625.943740562593;5499.752511136999;5524.8342549723575;5532.225488431623;5536.422119695888;5537.418571050032;4317.495852405597;4331.826726930919;4345.978270108645;4358.716683415568;4362.541933097011;4085.53016403113;4264.594863487963;4304.622520793348;4336;4336.59060805238;4261;4274;4280.122574872144;4282.164977829325;4291.275040349369;4272.551382104881;4280.657547396201;4283.378910058024;4284.472161424743;4294.248506511348;3565.554305711786;3764.480211002694;3768.0956570423177;3771.321761815993;3775.5091838060875;5335.799445124816;5380.973095134499;5387.892242155135;5391.865203369908;5400.675959442446;4818.807247710122;4887.6070319959;4895.437024742165;4904.656674032819;4916.50834916509;5562.499375056264;5681.784104199365;5731.512821410185;5745.253117094792;5755.65466072037;4091.2022155679656;4099.1596722672075;4101.2207680540605;4104.938425923614;4108.897277568055;5875.265591801025;5952.58331916766;6001.819945401645;6018.6689732064715;6022.337542870281;3966.8214930328204;4156.646685031746;4158.126793373425;4175;4180.28935081037;4273.508546517128;4276.508201556799;4277.165952639268;4287;4302.892427689333;4868.683535570177;4893.7063776173545;4909.772556860785;4919.2867034279825;4919.557239848431;5613.382527921925;5767.818331709477;5819.039858423313;5829.708514574254;5843.24037875082;1453.8151406603795;1471.9852801472061;1477.4164205139125;1481.1335368809152;1484.46559238674;891.4428482198626;935.4901578639658;939.2532936315646;939.7172859047351;952.1573407534382;4944.208926571731;4962.776675049631;4968;4972.453030166679;4985.426675932242;5129.640925135204;5213.869653258623;5217.895642087213;5223.52988231061;5271.288376069258;4629.236176030917;4886.242632391985;4936.40838559759;4992.675476094042;4994.350734404504;2778.8749506272266;2780.569011803174;2782.624345713303;2792;2798.846063466529;5397.8110766123;5400.378956419983;5410.458954104558;5453.754581043862;5464.398916119224;5248.868778280574;5297.7880884764945;5708.71456427177;6098.878022439526;6141.969290153521;6199.132121502993;6201.930044627848;6204.627722336674;6214.875702485925;6220.782272620527;5643.661380317194;5908.5568582357355;5975.760969561169;5981.671008094597;6003.459688628044;5909.8227053188475;5953.2735506702575;5953.345132035559;5960.5231581474245;5965.373635768182;6172.592688851262;6195.4424101831055;6200.255969283535;6229.2524897012645;6230.252369715482;3969.861054863066;4231.174920890397;4330.285502892114;4370.147821174841;4374.321980093091;5901.232839730979;5917.289925209003;5934.9406505934385;5964.956132676677;5968.134620480093;5685.630434021776;5769.1634712967225;5813.651180929158;5828.271466066742;5842.328132264844;5710.143478478261;5717.599768016199;5766.913496297475;5820;5826.388229236039;5689.203511508309;5737.655740655574;5764.740586673526;5771.307443106854;5777.24895763548;5634.633748806478;5783.334916484489;5815.883682326245;5822.155787410887;5831.35855055935;5660.264165658438;5661.943380566307;5663.575231857545;5680.77276908919;5716.657000579979 21:42:32 INFO - PROCESS | 20003 | |5;yui.html;762.5805806806256;778.4473024152848;796.8286818334057;837.4054421360834;879.5953861223836;14033.929830350846;15158.772618410705;15445.84554154458;15756.424357564252;16140.43508477202;14747.188904610242;14898.40406383746;14929.626759330995;14989;15001.099934003967;672.6972862212024;802.6227672993683;809.1382677448528;831.7047448155909;835.2524490580927;787.2049230277404;803.1727320859524;807.2250639386197;808.0586117173515;809.1382677448498;859.9054104048549;861.4917198852708;863.5984267315697;864.8140649760301;867.1631875240423;849.647396330522;855.1064137975831;859.6045818923334;862.348926560446;863.7667829686012;629.9275583307887;630.0863747566048;630.7540059376847;632.5414074795782;632.7943418389042;16268.75596866048;16314.184290785413;16325.755113673304;16503.17484125801;16509.83490165107;13796.931015344959;13843.930780346134;13913.791293130509;13953.232572208524;14363.856361436356;12331.630051098482;12451.315177665225;12458.43937022827;12508.249505029637;12623.431945562472;4004.139110091315;4021.81934222858;4040.1313717550574;4080.6123418275215;4092.9795351023054;83634;83643.16356836475;86518.5674071632;86964.56517717434;87531.56234218788;12002.1598488105;12198.695032624255;12265.69335766613;12318.384080795924;12553.560625378068;22909.541809163722;22987.770122298563;23016.769832301798;23128.4217894554;23151;8368.958155209186;8497.872531912026;8546.743597692079;8772.122787721177;8779.648814047367;4497.415336006298;4555.931661025087;4558.361829343895;4630.722156670543;4655.86032419028;3609;3727.9440808387894;3730.1420673245307;3730.8880733578035;3735.122246272124;621.7409745265873;624.3132554190445;639.6513899924553;643.829385212919;647.6276141218818;584.5002522842908;584.6871923520896;650.4731167754135;718.9748358807417;731.3600599475459;9456.385334953206;9792.363496372713;9942.80114397708;10112.696619101438;10524.31591946521;667.2626747444101;701.1796198447828;744.1256523584766;769.5459678789541;787.4055088408215;4894.241392584155;4947.480514545993;4985.4266759323145;5027.371578552681;5099.286099946011;122461.38769306274;126758.36620816837;130143;131407.34296328647;133919;83889.16110838813;87962.48150073926;110458;112397.4380128094;112460.437697811;77063.8440423394;86464;86534;87053;90306.09693903108;9621.230301575997;9810.306198655713;9985.350952188084;10006.649767258112;10082.143017843273;51876.22185667142;51881.7405912968;52725;53462.73268633632;54555.454445455034;64944.35055649383;73498.26501735128;74330;76085;77889.2211077882;12553.435095420546;13306.800397993844;13498.797518037434;13680.521181758591;13846.238456884968;14400.20798856031;14709.92645036768;14790.926045369704;14901;15567.844321557093;14770.556883293519;14815;15272;15547.922260388626;15576.766348504554;14517.274136293354;14817.957651568815;15110.622234444227;15154.575267957074;15259.542213733606;14401.207933563755;14633;14926.402943882124;15526.767098493307;15551.611209719847;11004.614838480615;11206.719832004264;11242.94378528102;11276.9436152822;11329.470521479494;11651.242669226473;11806.350650714294;11901.166918315635;11981.580644677395;12215.938920305342 21:42:32 INFO - PROCESS | 20003 | __end_tp_report 21:42:32 INFO - PROCESS | 20003 | __start_cc_report 21:42:32 INFO - PROCESS | 20003 | _x_x_mozilla_cycle_collect,334 21:42:32 INFO - PROCESS | 20003 | __end_cc_report 21:42:32 INFO - PROCESS | 20003 | __startTimestamp1469853752819__endTimestamp 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | ------- Summary: start ------- 21:42:32 INFO - PROCESS | 20003 | Number of tests: 6 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#0] dojo.html Cycles:165 Average:5521.02 Median:5740.37 stddev:636.04 (11.1%) stddev-sans-first:609.37 21:42:32 INFO - PROCESS | 20003 | Values: 3116.0 3121.2 3159.1 3160.1 3160.8 5448.0 5476.0 5482.9 5533.6 5567.3 5494.6 5569.3 5587.8 5592.4 5644.4 5018.2 5100.7 5113.1 5177.1 5227.7 5186.0 5186.4 5209.4 5242.6 5246.2 5003.2 5007.4 5068.7 5077.0 5121.9 5061.9 5079.2 5089.9 5142.7 5160.4 5006.2 5053.1 5055.3 5064.7 5084.7 5324.5 5477.1 5541.1 5545.1 5568.3 6011.8 6015.1 6015.5 6041.8 6054.5 6043.8 6049.7 6051.4 6058.9 6067.6 5389.5 5495.9 5532.0 5599.7 5607.6 6122.8 6141.4 6145.4 6158.3 6161.7 5850.7 5870.9 5883.6 5883.7 5886.2 5778.4 5841.3 5849.0 5965.3 5977.0 5718.1 5877.7 5890.8 5905.7 5910.9 5889.4 5900.7 5915.0 5916.6 5921.0 4425.8 4486.6 4490.8 4505.1 4576.0 3974.2 3988.0 4007.6 4027.1 4046.7 5706.4 5731.3 5738.7 5740.3 5740.4 5814.0 5995.9 6004.9 6007.0 6014.0 5565.1 5662.3 5670.8 5727.1 5768.9 5027.9 5064.0 5067.0 5079.1 5082.9 5995.2 6147.9 6168.6 6195.6 6200.4 5833.6 5864.0 5874.2 5913.9 5961.1 5999.7 6066.3 6081.1 6091.2 6100.5 5671.2 5763.8 5768.4 5786.9 5797.2 5906.8 5921.7 5971.1 5988.4 6006.6 5823.7 5824.4 5824.8 5831.2 5838.1 5662.9 5769.9 5815.4 5825.2 5836.3 5678.2 5754.3 5759.2 5793.3 5796.3 5812.4 5823.7 5856.3 5867.7 5878.6 5580.9 5653.3 5680.4 5695.4 5725.4 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#1] ext.html Cycles:180 Average:61207.06 Median:41141.19 stddev:127934.06 (311.0%) stddev-sans-first:128211.97 21:42:32 INFO - PROCESS | 20003 | Values: 578.2 602.8 603.5 617.8 624.7 38470.8 41508.2 41672.4 41739.4 41773.6 42733.0 43083.1 43389.0 43528.3 43537.0 8914.0 9053.2 9055.1 9059.9 9082.1 8880.2 8911.5 8960.5 8989.6 8996.3 8915.0 8952.2 8956.0 8959.7 9013.6 8918.5 8978.9 8996.9 9019.4 9023.4 8873.8 8921.4 8937.1 8950.0 8958.5 39231.0 39401.6 39479.0 39562.2 39638.6 3527.5 3537.6 3565.0 3736.6 3968.6 31125.4 31818.8 32071.0 32363.4 32502.0 4132.6 4342.4 4393.4 4411.6 4490.7 348635.0 349503.3 349610.0 350219.0 351136.0 54353.2 55146.7 55173.0 55422.7 55504.7 35065.8 35466.3 35545.6 36798.4 57980.7 14471.3 14604.8 14728.2 14731.0 14738.3 10749.8 10903.7 10909.3 10910.6 10918.2 18715.6 18731.9 18750.4 18896.6 18899.4 7130.4 7376.9 7421.5 7421.7 7495.7 886.5 980.0 1028.3 1036.2 1039.4 31480.4 31720.2 31912.8 32161.8 32334.4 926.2 1024.1 1054.3 1126.4 1132.2 15814.8 16522.4 16560.7 16641.4 16769.3 616955.0 618788.0 619393.0 620525.0 620851.0 56780.7 57395.3 57611.7 57699.7 57723.3 1282.7 1300.7 1325.1 1339.7 1339.7 29036.8 30892.4 31033.4 31159.4 31551.7 48053.3 48349.3 48415.8 48436.8 48463.0 366393.0 367729.0 466280.0 467427.0 467638.0 27606.3 27659.7 27858.2 27963.4 28107.6 44778.8 46771.3 47092.0 47143.3 47869.0 39698.2 40353.8 40428.8 40967.0 42039.0 40137.0 41302.0 41424.0 41453.6 41465.0 38981.0 41000.4 41282.0 41429.0 43591.0 35057.0 36047.3 36426.3 37361.6 37500.4 28450.0 28548.9 28653.9 28660.9 28739.7 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#2] jquery.html Cycles:180 Average:29900.27 Median:380.06 stddev:88201.63 (23207.3%) stddev-sans-first:88421.20 21:42:32 INFO - PROCESS | 20003 | Values: 376.2 383.9 396.0 397.6 411.6 13817.6 18115.8 19012.1 19973.8 20010.5 19017.8 19089.2 19167.5 19471.1 19855.5 5687.9 5708.5 5730.3 5801.3 5853.4 5361.1 5724.5 5727.8 5758.9 5766.0 5595.6 5727.3 5728.9 5736.7 5737.9 5651.9 5697.7 5723.7 5727.7 5741.3 5025.3 5285.2 5836.2 5977.1 6004.2 13642.4 13794.1 14035.4 14054.5 14062.6 2225.7 2265.5 2411.3 2678.1 2983.1 9794.7 10086.1 10140.6 10154.6 10160.9 1879.7 1896.3 1926.7 1935.5 2004.6 77036.6 77733.0 79076.0 79621.6 79772.6 10762.6 10902.5 11259.3 11323.0 11398.2 15085.8 15098.5 15150.4 15204.3 15268.5 7481.3 7581.8 7624.8 7806.6 7837.7 7006.4 7060.9 7252.6 7265.3 7281.6 4655.8 4732.3 4739.4 4774.9 4825.8 1912.0 1961.9 1975.8 1991.3 1992.1 881.8 926.7 931.8 997.3 1068.7 17900.5 19377.6 19471.6 19930.9 20191.9 991.2 992.6 994.2 1002.9 1058.0 10629.9 10951.5 11009.4 11017.2 11139.5 497672.0 517574.0 545557.0 556443.0 559904.0 90442.5 92009.5 93690.0 93904.0 95284.5 980.1 996.9 1042.8 1059.9 1062.0 16318.3 16736.2 16842.8 17069.8 17248.1 41565.0 42302.4 42635.0 42814.0 43325.4 55023.7 59356.0 59695.0 60414.4 61245.0 8296.7 8301.0 8439.1 8473.6 8480.9 11583.0 12877.3 12985.5 13013.2 13173.3 10930.2 11092.4 11345.5 11704.3 12224.3 10933.9 11152.3 11419.8 11437.1 11493.3 11082.3 11232.4 11574.3 11713.8 11828.5 8238.3 8340.8 8385.5 8470.1 8500.2 10720.5 10833.6 11101.8 11275.5 11317.5 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#3] mootools.html Cycles:180 Average:5951.53 Median:4520.55 stddev:3461.47 (76.6%) stddev-sans-first:3455.02 21:42:32 INFO - PROCESS | 20003 | Values: 1501.5 1516.4 1675.4 1770.1 1785.4 7982.9 8637.9 8717.1 9375.6 9384.3 8684.2 9059.3 9063.7 9065.7 9098.2 2128.3 2154.9 2155.2 2163.0 2164.0 2343.9 2371.5 2392.3 2402.9 2409.5 2142.7 2166.3 2179.6 2181.2 2226.4 1956.5 1958.1 1960.2 1967.4 1973.2 2165.4 2187.8 2196.7 2197.3 2221.6 8945.0 8986.3 9142.2 9173.6 9177.7 5281.0 5423.7 5428.9 5433.8 5449.2 3271.0 3321.8 3373.3 3374.2 3472.8 1007.3 1038.4 1071.3 1073.2 1120.2 12565.1 12584.9 12594.0 12611.4 12682.2 4522.3 4756.8 4772.1 4796.5 4797.6 10688.5 10741.8 10754.4 10759.5 10770.7 5465.7 5482.3 5485.8 5491.8 5494.1 4917.3 4923.7 4935.0 5005.4 5051.1 3915.5 3939.5 3989.8 4098.6 4123.1 1222.8 1223.6 1229.8 1248.0 1273.6 980.5 1002.3 1007.1 1022.2 1032.7 6175.3 6293.2 6315.1 6335.5 6342.7 438.1 441.2 443.4 444.6 953.7 4305.7 4436.9 4440.0 4482.5 4518.8 11275.4 11597.0 11607.9 11615.9 11664.9 11451.0 11458.8 11514.4 11526.9 11535.9 7947.6 8281.7 8288.3 8474.5 8551.0 6277.5 6279.3 6360.7 6464.7 6508.3 9966.7 10360.3 10423.5 10477.0 10610.7 9543.6 10002.8 10584.7 10631.1 10813.6 7622.4 7864.1 8026.1 8037.8 8078.2 8674.7 8697.6 8699.1 8706.7 8749.9 7697.2 7776.1 7815.0 7924.4 7960.5 7873.8 7944.6 7985.5 8058.9 8123.9 7183.6 7282.2 7290.1 7302.8 7319.7 5092.4 5390.8 5399.9 5407.7 5637.8 5367.5 5372.5 5374.1 5424.9 5442.6 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#4] prototype.html Cycles:180 Average:4777.90 Median:5389.88 stddev:1420.14 (26.3%) stddev-sans-first:1384.21 21:42:32 INFO - PROCESS | 20003 | Values: 323.5 335.0 338.7 342.1 344.7 5356.9 5493.8 5534.9 5603.7 5625.9 5499.8 5524.8 5532.2 5536.4 5537.4 4317.5 4331.8 4346.0 4358.7 4362.5 4085.5 4264.6 4304.6 4336.0 4336.6 4261.0 4274.0 4280.1 4282.2 4291.3 4272.6 4280.7 4283.4 4284.5 4294.2 3565.6 3764.5 3768.1 3771.3 3775.5 5335.8 5381.0 5387.9 5391.9 5400.7 4818.8 4887.6 4895.4 4904.7 4916.5 5562.5 5681.8 5731.5 5745.3 5755.7 4091.2 4099.2 4101.2 4104.9 4108.9 5875.3 5952.6 6001.8 6018.7 6022.3 3966.8 4156.6 4158.1 4175.0 4180.3 4273.5 4276.5 4277.2 4287.0 4302.9 4868.7 4893.7 4909.8 4919.3 4919.6 5613.4 5767.8 5819.0 5829.7 5843.2 1453.8 1472.0 1477.4 1481.1 1484.5 891.4 935.5 939.3 939.7 952.2 4944.2 4962.8 4968.0 4972.5 4985.4 5129.6 5213.9 5217.9 5223.5 5271.3 4629.2 4886.2 4936.4 4992.7 4994.4 2778.9 2780.6 2782.6 2792.0 2798.8 5397.8 5400.4 5410.5 5453.8 5464.4 5248.9 5297.8 5708.7 6098.9 6142.0 6199.1 6201.9 6204.6 6214.9 6220.8 5643.7 5908.6 5975.8 5981.7 6003.5 5909.8 5953.3 5953.3 5960.5 5965.4 6172.6 6195.4 6200.3 6229.3 6230.3 3969.9 4231.2 4330.3 4370.1 4374.3 5901.2 5917.3 5934.9 5965.0 5968.1 5685.6 5769.2 5813.7 5828.3 5842.3 5710.1 5717.6 5766.9 5820.0 5826.4 5689.2 5737.7 5764.7 5771.3 5777.2 5634.6 5783.3 5815.9 5822.2 5831.4 5660.3 5661.9 5663.6 5680.8 5716.7 21:42:32 INFO - PROCESS | 20003 | 21:42:32 INFO - PROCESS | 20003 | [#5] yui.html Cycles:180 Average:21812.20 Median:4086.80 stddev:31838.75 (779.1%) stddev-sans-first:31888.83 21:42:32 INFO - PROCESS | 20003 | Values: 762.6 778.4 796.8 837.4 879.6 14033.9 15158.8 15445.8 15756.4 16140.4 14747.2 14898.4 14929.6 14989.0 15001.1 672.7 802.6 809.1 831.7 835.3 787.2 803.2 807.2 808.1 809.1 859.9 861.5 863.6 864.8 867.2 849.6 855.1 859.6 862.3 863.8 629.9 630.1 630.8 632.5 632.8 16268.8 16314.2 16325.8 16503.2 16509.8 13796.9 13843.9 13913.8 13953.2 14363.9 12331.6 12451.3 12458.4 12508.2 12623.4 4004.1 4021.8 4040.1 4080.6 4093.0 83634.0 83643.2 86518.6 86964.6 87531.6 12002.2 12198.7 12265.7 12318.4 12553.6 22909.5 22987.8 23016.8 23128.4 23151.0 8369.0 8497.9 8546.7 8772.1 8779.6 4497.4 4555.9 4558.4 4630.7 4655.9 3609.0 3727.9 3730.1 3730.9 3735.1 621.7 624.3 639.7 643.8 647.6 584.5 584.7 650.5 719.0 731.4 9456.4 9792.4 9942.8 10112.7 10524.3 667.3 701.2 744.1 769.5 787.4 4894.2 4947.5 4985.4 5027.4 5099.3 122461.4 126758.4 130143.0 131407.3 133919.0 83889.2 87962.5 110458.0 112397.4 112460.4 77063.8 86464.0 86534.0 87053.0 90306.1 9621.2 9810.3 9985.4 10006.6 10082.1 51876.2 51881.7 52725.0 53462.7 54555.5 64944.4 73498.3 74330.0 76085.0 77889.2 12553.4 13306.8 13498.8 13680.5 13846.2 14400.2 14709.9 14790.9 14901.0 15567.8 14770.6 14815.0 15272.0 15547.9 15576.8 14517.3 14818.0 15110.6 15154.6 15259.5 14401.2 14633.0 14926.4 15526.8 15551.6 11004.6 11206.7 11242.9 11276.9 11329.5 11651.2 11806.4 11901.2 11981.6 12215.9 21:42:32 INFO - PROCESS | 20003 | -------- Summary: end -------- 21:42:32 INFO - PROCESS | 20003 | 21:42:33 INFO - TEST-INFO | 20003: exit 0 21:42:33 INFO - TEST-OK | dromaeo_css | took 1112367ms 21:42:33 INFO - TEST-START | kraken 21:42:33 INFO - operating with platform_type : linux_ 21:42:33 INFO - Initialising browser for kraken test... 21:42:33 INFO - TEST-INFO | started process 20248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ6VHwQ/profile http://localhost:41037/getInfo.html) 21:42:37 INFO - PROCESS | 20248 | JavaScript error: , line 0: uncaught exception: undefined 21:42:38 INFO - PROCESS | 20248 | __metrics Screen width/height:1600/1200 21:42:38 INFO - PROCESS | 20248 | colorDepth:24 21:42:38 INFO - PROCESS | 20248 | Browser inner width/height: 1024/697 21:42:38 INFO - PROCESS | 20248 | __metrics 21:42:39 ERROR - PROCESS | 20248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:42:40 INFO - TEST-INFO | 20248: exit 0 21:42:40 INFO - Browser initialized. 21:42:40 INFO - Running cycle 1/1 for kraken test... 21:42:40 INFO - TEST-INFO | started process 20365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ6VHwQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:51 INFO - PROCESS | 20365 | RSS: Main: 165208064 21:42:51 INFO - PROCESS | 20365 | 21:42:54 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41037/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:55 INFO - PROCESS | 20365 | RSS: Main: 170332160 21:42:55 INFO - PROCESS | 20365 | 21:42:58 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41037/tests/kraken/driver.html?testName=audio-dft) 21:42:58 INFO - PROCESS | 20365 | RSS: Main: 169721856 21:42:58 INFO - PROCESS | 20365 | 21:43:01 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41037/tests/kraken/driver.html?testName=audio-fft) 21:43:02 INFO - PROCESS | 20365 | RSS: Main: 165752832 21:43:02 INFO - PROCESS | 20365 | 21:43:04 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41037/tests/kraken/driver.html?testName=audio-oscillator) 21:43:04 INFO - PROCESS | 20365 | RSS: Main: 166776832 21:43:04 INFO - PROCESS | 20365 | 21:43:07 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:43:07 INFO - PROCESS | 20365 | RSS: Main: 167649280 21:43:07 INFO - PROCESS | 20365 | 21:43:10 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41037/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:11 INFO - PROCESS | 20365 | RSS: Main: 166629376 21:43:11 INFO - PROCESS | 20365 | 21:43:14 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41037/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:15 INFO - PROCESS | 20365 | RSS: Main: 167985152 21:43:15 INFO - PROCESS | 20365 | 21:43:18 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41037/tests/kraken/driver.html?testName=json-parse-financial) 21:43:18 INFO - PROCESS | 20365 | RSS: Main: 167829504 21:43:18 INFO - PROCESS | 20365 | 21:43:20 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:21 INFO - PROCESS | 20365 | RSS: Main: 167317504 21:43:21 INFO - PROCESS | 20365 | 21:43:22 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:23 INFO - PROCESS | 20365 | RSS: Main: 167718912 21:43:23 INFO - PROCESS | 20365 | 21:43:25 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:26 INFO - PROCESS | 20365 | RSS: Main: 168013824 21:43:26 INFO - PROCESS | 20365 | 21:43:28 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:29 INFO - PROCESS | 20365 | RSS: Main: 168202240 21:43:29 INFO - PROCESS | 20365 | 21:43:32 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:32 INFO - PROCESS | 20365 | RSS: Main: 168337408 21:43:32 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | Cycle 1(1): loaded http://localhost:41037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41037/tests/kraken/driver.html?testName=ai-astar) 21:43:34 INFO - PROCESS | 20365 | RSS: Main: 169115648 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | __start_tp_report 21:43:34 INFO - PROCESS | 20365 | _x_x_mozilla_page_load 21:43:34 INFO - PROCESS | 20365 | _x_x_mozilla_page_load_details 21:43:34 INFO - PROCESS | 20365 | |i|pagename|runs| 21:43:34 INFO - PROCESS | 20365 | |0;ai-astar;102;113;106;113;113;112;112;114;112;112 21:43:34 INFO - PROCESS | 20365 | |1;audio-beat-detection;151;120;151;175;120;149;145;123;185;122 21:43:34 INFO - PROCESS | 20365 | |2;audio-dft;164;161;161;161;162;166;167;162;162;162 21:43:34 INFO - PROCESS | 20365 | |3;audio-fft;75;76;75;181;77;76;75;75;192;76 21:43:34 INFO - PROCESS | 20365 | |4;audio-oscillator;85;85;150;84;84;85;128;84;85;140 21:43:34 INFO - PROCESS | 20365 | |5;imaging-gaussian-blur;118;119;118;117;117;117;118;117;117;117 21:43:34 INFO - PROCESS | 20365 | |6;imaging-darkroom;148;148;147;148;147;147;147;147;148;146 21:43:34 INFO - PROCESS | 20365 | |7;imaging-desaturate;96;97;95;95;96;95;97;95;96;96 21:43:34 INFO - PROCESS | 20365 | |8;json-parse-financial;55;53;55;53;56;53;52;55;52;60 21:43:34 INFO - PROCESS | 20365 | |9;json-stringify-tinderbox;64;64;64;63;64;63;63;71;64;64 21:43:34 INFO - PROCESS | 20365 | |10;stanford-crypto-aes;82;77;77;76;77;77;77;82;84;82 21:43:34 INFO - PROCESS | 20365 | |11;stanford-crypto-ccm;124;121;123;123;127;121;133;137;169;132 21:43:34 INFO - PROCESS | 20365 | |12;stanford-crypto-pbkdf2;161;164;163;163;167;161;162;163;162;161 21:43:34 INFO - PROCESS | 20365 | |13;stanford-crypto-sha256-iterative;66;65;67;67;66;64;65;64;66;66 21:43:34 INFO - PROCESS | 20365 | __end_tp_report 21:43:34 INFO - PROCESS | 20365 | __start_cc_report 21:43:34 INFO - PROCESS | 20365 | _x_x_mozilla_cycle_collect,865 21:43:34 INFO - PROCESS | 20365 | __end_cc_report 21:43:34 INFO - PROCESS | 20365 | __startTimestamp1469853814835__endTimestamp 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | ------- Summary: start ------- 21:43:34 INFO - PROCESS | 20365 | Number of tests: 14 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:2.32 21:43:34 INFO - PROCESS | 20365 | Values: 102.0 113.0 106.0 113.0 113.0 112.0 112.0 114.0 112.0 112.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.00 stddev:23.20 (15.5%) stddev-sans-first:24.47 21:43:34 INFO - PROCESS | 20365 | Values: 151.0 120.0 151.0 175.0 120.0 149.0 145.0 123.0 185.0 122.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.15 (1.3%) stddev-sans-first:2.24 21:43:34 INFO - PROCESS | 20365 | Values: 164.0 161.0 161.0 161.0 162.0 166.0 167.0 162.0 162.0 162.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#3] audio-fft Cycles:10 Average:97.80 Median:75.50 stddev:46.83 (62.0%) stddev-sans-first:48.93 21:43:34 INFO - PROCESS | 20365 | Values: 75.0 76.0 75.0 181.0 77.0 76.0 75.0 75.0 192.0 76.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:84.50 stddev:26.96 (31.9%) stddev-sans-first:27.97 21:43:34 INFO - PROCESS | 20365 | Values: 85.0 85.0 150.0 84.0 84.0 85.0 128.0 84.0 85.0 140.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 21:43:34 INFO - PROCESS | 20365 | Values: 118.0 119.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 21:43:34 INFO - PROCESS | 20365 | Values: 148.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 146.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 21:43:34 INFO - PROCESS | 20365 | Values: 96.0 97.0 95.0 95.0 96.0 95.0 97.0 95.0 96.0 96.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:2.41 (4.4%) stddev-sans-first:2.55 21:43:34 INFO - PROCESS | 20365 | Values: 55.0 53.0 55.0 53.0 56.0 53.0 52.0 55.0 52.0 60.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:2.37 (3.7%) stddev-sans-first:2.51 21:43:34 INFO - PROCESS | 20365 | Values: 64.0 64.0 64.0 63.0 64.0 63.0 63.0 71.0 64.0 64.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:3.00 (3.8%) stddev-sans-first:2.99 21:43:34 INFO - PROCESS | 20365 | Values: 82.0 77.0 77.0 76.0 77.0 77.0 77.0 82.0 84.0 82.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:129.50 stddev:14.45 (11.2%) stddev-sans-first:15.10 21:43:34 INFO - PROCESS | 20365 | Values: 124.0 121.0 123.0 123.0 127.0 121.0 133.0 137.0 169.0 132.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:163.00 stddev:1.83 (1.1%) stddev-sans-first:1.83 21:43:34 INFO - PROCESS | 20365 | Values: 161.0 164.0 163.0 163.0 167.0 161.0 162.0 163.0 162.0 161.0 21:43:34 INFO - PROCESS | 20365 | 21:43:34 INFO - PROCESS | 20365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 21:43:34 INFO - PROCESS | 20365 | Values: 66.0 65.0 67.0 67.0 66.0 64.0 65.0 64.0 66.0 66.0 21:43:34 INFO - PROCESS | 20365 | -------- Summary: end -------- 21:43:34 INFO - PROCESS | 20365 | 21:43:35 INFO - TEST-INFO | 20365: exit 0 21:43:35 INFO - TEST-OK | kraken | took 62146ms 21:43:35 INFO - SUITE-END | took 1174s 21:43:35 INFO - Completed test suite (00:19:34) 21:43:36 INFO - javascript benchmark 21:43:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7304.152452418958, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.984420077902, 3121.1884909923415, 3159.0680749178996, 3160.051984404678, 3160.8261545614996, 5448.0, 5476.0, 5482.945170548293, 5533.6403133796275, 5567.2762540869735, 5494.642848214863, 5569.331680198372, 5587.832365029046, 5592.4407559244155, 5644.435556444353, 5018.222175562784, 5100.693958362492, 5113.1307677694695, 5177.094008548489, 5227.686338819664, 5186.040582492232, 5186.429492755794, 5209.426963034063, 5242.6330156889035, 5246.213068039787, 5003.199488081926, 5007.424146223195, 5068.695878247317, 5077.035363280983, 5121.9487805122035, 5061.924071138936, 5079.2127220280545, 5089.872753181163, 5142.717150556718, 5160.354955630546, 5006.199008158714, 5053.1157047516535, 5055.292259083732, 5064.721440320781, 5084.720340381277, 5324.494173053554, 5477.068898287301, 5541.085720856054, 5545.085060964936, 5568.276124103881, 6011.75952961881, 6015.09773533969, 6015.548833837436, 6041.758329666808, 6054.515638748933, 6043.848903777397, 6049.727762250665, 6051.425114614105, 6058.939410605925, 6067.635941843503, 5389.461053894618, 5495.862603434906, 5532.0, 5599.748011339459, 5607.635503692247, 6122.764110201795, 6141.447269745655, 6145.4161854623735, 6158.261008678987, 6161.661108639068, 5850.736716847752, 5870.911936320958, 5883.558733094949, 5883.735231914488, 5886.23478947734, 5778.393268706809, 5841.299044114733, 5848.9707551462825, 5965.284165900033, 5977.0, 5718.085106383042, 5877.676727779927, 5890.793822216202, 5905.704714764244, 5910.940890591039, 5889.352171261158, 5900.704964751745, 5914.970425147847, 5916.556258280646, 5921.0, 4425.822967081281, 4486.573775491323, 4490.820367185342, 4505.05393867285, 4575.954240457553, 3974.2250261198787, 3987.980060099739, 4007.6393124618926, 4027.0536423940353, 4046.7167298288837, 5706.3722990471015, 5731.254936858265, 5738.655680659173, 5740.282464691913, 5740.368559458456, 5814.0, 5995.850103747442, 6004.8799024020145, 6006.969965150233, 6014.0, 5565.0817615093865, 5662.2639056922335, 5670.829875103754, 5727.05503591911, 5768.913466298009, 5027.924581131286, 5064.0, 5067.037262920034, 5079.085764562415, 5082.872928176751, 5995.2206213192, 6147.907781383283, 6168.573779074044, 6195.566310358232, 6200.410960958701, 5833.562482813891, 5864.0, 5874.17761513397, 5913.852153696192, 5961.105834124916, 5999.670018149044, 6066.272047354346, 6081.118237855398, 6091.208142941389, 6100.481459076028, 5671.206031155559, 5763.7982670606325, 5768.394318596655, 5786.913196302143, 5797.2173756542325, 5906.822795316148, 5921.674307912934, 5971.0744834550715, 5988.37122102173, 6006.639601623917, 5823.679697616672, 5824.446677565625, 5824.796132135355, 5831.212786273799, 5838.065909454467, 5662.886742265214, 5769.932562475956, 5815.389384114607, 5825.2135961644635, 5836.270466191726, 5678.233438485751, 5754.309482861916, 5759.164921086335, 5793.3337666167245, 5796.333421656564, 5812.418758124154, 5823.650580965155, 5856.297244330707, 5867.677277749594, 5878.559108066826, 5580.888382232414, 5653.293338332708, 5680.403557626555, 5695.373508914099, 5725.398833122462], "value": 5476.759258956841, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.2136294639292, 602.8071017274474, 603.471962033221, 617.7559863853777, 624.7251209467831, 38470.807645961766, 41508.16983660325, 41672.37491437623, 41739.37390939138, 41773.58226417735, 42733.0, 43083.138337233235, 43389.0, 43528.347074793906, 43537.0, 8914.0, 9053.185213330831, 9055.094490550926, 9059.864102038475, 9082.091790820898, 8880.200781929625, 8911.465312081264, 8960.462372257653, 8989.595468203914, 8996.325275604324, 8914.955425222897, 8952.194302512773, 8955.95522022389, 8959.686410975617, 9013.639454421815, 8918.464892106495, 8978.910210897873, 8996.865047024234, 9019.368644194908, 9023.413478123934, 8873.778155546099, 8921.375503714742, 8937.106289371075, 8950.0, 8958.46249225042, 39231.0, 39401.60598394008, 39479.0, 39562.20875582501, 39638.60361396407, 3527.4708793680898, 3537.610862805115, 3564.9643503564894, 3736.57029441615, 3968.6311787072314, 31125.37749245025, 31818.840905795554, 32071.0, 32363.352732945445, 32502.0, 4132.586741325843, 4342.435483387171, 4393.428854248959, 4411.647068234533, 4490.708103973231, 348635.0, 349503.25248373847, 349610.0, 350219.0, 351136.0, 54353.1847022295, 55146.72426637841, 55173.0, 55422.72288638531, 55504.72247638817, 35065.824670876995, 35466.29067418637, 35545.578176873154, 36798.44802327967, 57980.71009644925, 14471.348789304506, 14604.780928286084, 14728.189949552878, 14731.0, 14738.336774845158, 10749.83875241872, 10903.672889813319, 10909.34543927367, 10910.563577456971, 10918.235723499438, 18715.625687486176, 18731.90634046821, 18750.406215471838, 18896.622067558572, 18899.433017009513, 7130.393916517154, 7376.852462950818, 7421.480496365202, 7421.666025028887, 7495.725726626487, 886.4636894678755, 980.0060814212649, 1028.3367228137809, 1036.1658864614058, 1039.365986748083, 31480.37039259202, 31720.206994824854, 31912.840435798138, 32161.839190804363, 32334.35331293361, 926.1571969507715, 1024.1141412678128, 1054.2778196935124, 1126.4030064066058, 1132.17351333527, 15814.841851581567, 16522.42171523991, 16560.6687866242, 16641.41755038568, 16769.32922683079, 616955.0, 618788.0, 619393.0, 620525.0, 620851.0, 56780.71609641925, 57395.26930749488, 57611.71194144002, 57699.71150144222, 57723.26830195101, 1282.6536835054483, 1300.6618279247275, 1325.0989327257364, 1339.6918708697053, 1339.6985678222518, 29036.822238331788, 30892.382152357277, 31033.37933241368, 31159.376812464077, 31551.684483155794, 48053.279200812714, 48349.27476087791, 48415.78960526015, 48436.757816210695, 48463.0, 366393.0, 367729.0, 466280.0, 467427.0, 467638.0, 27606.309842254104, 27659.723402766518, 27858.16425507238, 27963.440731184855, 28107.57838632463, 44778.77610611926, 46771.29843052425, 47092.0, 47143.292850607955, 47869.0, 39698.206035878546, 40353.79823100983, 40428.79785601053, 40967.0, 42039.0, 40137.0, 41302.0, 41424.0, 41453.58546414618, 41465.0, 38981.0, 41000.384994224514, 41282.0, 41429.0, 43591.0, 35057.0, 36047.27905441929, 36426.27147457089, 37361.62638373581, 37500.43749343707, 28450.0, 28548.85725571359, 28653.856730717045, 28660.85669571639, 28739.712602873704], "value": 19599.342771126725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.1893120325699, 383.9288385404721, 396.0, 397.6361629109365, 411.6315897271942, 13817.585472435818, 18115.818841811593, 19012.14445349959, 19973.800261997374, 20010.49973750655, 19017.809821901777, 19089.23643054276, 19167.520811979706, 19471.123799429024, 19855.503612409662, 5687.886242275152, 5708.543316534688, 5730.2837145356625, 5801.332846722617, 5853.443922827346, 5361.115415956362, 5724.513416359594, 5727.799527016556, 5758.913616295759, 5766.0486019806685, 5595.636283641571, 5727.284089488814, 5728.856778580527, 5736.6558006519535, 5737.856553586173, 5651.858703532424, 5697.658140511562, 5723.742431590546, 5727.742251598646, 5741.282339707536, 5025.296458495814, 5285.233641122054, 5836.212111364996, 5977.073553599155, 6004.249468816398, 13642.386092625855, 13794.103383280055, 14035.368408421646, 14054.508092216825, 14062.578122656336, 2225.710657614516, 2265.4676151104477, 2411.3127758588894, 2678.08944958715, 2983.1199796060214, 9794.706158815246, 10086.09225169731, 10140.594376224943, 10154.593816247341, 10160.933102024255, 1879.6616609010373, 1896.2794138227384, 1926.6820974539185, 1935.5161209697576, 2004.5990801839691, 77036.61481692556, 77733.0, 79076.0, 79621.60189199075, 79772.60113699452, 10762.569497220024, 10902.546926941375, 11259.268147570381, 11323.0, 11398.202125851276, 15085.849141508665, 15098.471553495576, 15150.393984240507, 15204.315805788767, 15268.465603703817, 7481.251874812475, 7581.810454738676, 7624.771256862303, 7806.570638614817, 7837.725679601187, 7006.4394848412, 7060.858782824314, 7252.5648461092505, 7265.309795569412, 7281.5631062136445, 4655.813767449264, 4732.313814496879, 4739.3601863748645, 4774.904501909942, 4825.831095911696, 1911.9713204301947, 1961.9411417657493, 1975.8122978317037, 1991.3428568572335, 1992.0935974131735, 881.8236352729351, 926.7266156483853, 931.771715929588, 997.2819569909653, 1068.6580294305747, 17900.46298611018, 19377.61244775125, 19471.610567788564, 19930.90034549818, 20191.899040505, 991.177322822056, 992.6426486464867, 994.229472159068, 1002.8997100289913, 1058.0266155137138, 10629.946850265855, 10951.45242737876, 11009.449527523591, 11017.228793984345, 11139.498722557342, 497672.0, 517574.0, 545557.0, 556443.0, 559904.0071994617, 90442.54778726195, 92009.5399522998, 93690.0, 93904.0, 95284.52357738167, 980.132582664333, 996.9252306076928, 1042.760165162017, 1059.9152067834555, 1061.9592799056968, 16318.347266109222, 16736.246868890685, 16842.831571684615, 17069.805113641927, 17248.051357175475, 41565.0, 42302.36546451744, 42635.0, 42814.0, 43325.35011974886, 55023.72488137534, 59356.0, 59695.0, 60414.39585604263, 61245.0, 8296.70961516344, 8300.958495207486, 8439.07170211264, 8473.576321183793, 8480.915190848013, 11583.0, 12877.291748953523, 12985.480580776662, 13013.21920684762, 13173.27546984925, 10930.234883558074, 11092.445377731243, 11345.48945297447, 11704.297742135499, 12224.266544007389, 10933.890661093605, 11152.275102118336, 11419.828702569303, 11437.142214333791, 11493.31040137561, 11082.279651822606, 11232.382218978035, 11574.305541667527, 11713.824292635447, 11828.526858925547, 8238.340932725248, 8340.791480213044, 8385.53879536607, 8470.110638383128, 8500.192481714228, 10720.517576709222, 10833.620823271147, 11101.777964440827, 11275.548978040786, 11317.490712918103], "value": 9028.169496817958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.5120085972057, 1516.355548891721, 1675.3968571314324, 1770.0884044716981, 1785.4465115814091, 7982.880256796138, 8637.870431943526, 8717.12828717128, 9375.624975000992, 9384.296177786668, 8684.218420342168, 9059.320550958671, 9063.72808815735, 9065.682701105463, 9098.22665073468, 2128.2551107112504, 2154.870707757532, 2155.245664017597, 2163.0, 2164.037003533428, 2343.8828058597, 2371.4545654499475, 2392.270357540949, 2402.9158979435724, 2409.5301416223842, 2142.6678864775986, 2166.306781829815, 2179.553191595719, 2181.160253302482, 2226.4322597737637, 1956.5499935015025, 1958.1090603775249, 1960.1669290551458, 1967.4491142480128, 1973.1811298311256, 2165.393689766852, 2187.8359123065675, 2196.736391632998, 2197.2748992832326, 2221.589006033889, 8945.01604823469, 8986.326025548111, 9142.1772040516, 9173.633054677804, 9177.724668259963, 5281.023010743025, 5423.674579525241, 5428.891422171534, 5433.809816656398, 5449.1826226066405, 3271.0, 3321.800691958466, 3373.274745929637, 3374.240795820945, 3472.75690701651, 1007.3452256033563, 1038.3873514626332, 1071.3197119828887, 1073.1682945717055, 1120.2494328799723, 12565.120441569094, 12584.930280926132, 12594.0, 12611.432485538173, 12682.239065655998, 4522.25382811839, 4756.7859446325, 4772.117158325721, 4796.544328288807, 4797.616190704735, 10688.51901664427, 10741.83887241692, 10754.40850753216, 10759.515821788038, 10770.730731731614, 5465.699386533779, 5482.2873026506295, 5485.835424937259, 5491.807786727445, 5494.09347457665, 4917.262410638361, 4923.679960802537, 4935.037667654845, 5005.424376196784, 5051.090803655377, 3915.5497117831246, 3939.5469521005452, 3989.800509974548, 4098.590140985878, 4123.134141830249, 1222.7676741419102, 1223.565634199864, 1229.827824104626, 1247.9688007799696, 1273.6497463197509, 980.4705459052175, 1002.2633364477103, 1007.0885848307294, 1022.156720705421, 1032.7314898126542, 6175.2589689237575, 6293.244810622663, 6315.147455093595, 6335.524835637346, 6342.651154186564, 438.0800319329446, 441.1661958897686, 443.3792690233634, 444.5954181694642, 953.7234202081319, 4305.74165550068, 4436.889077773081, 4439.98370283512, 4482.462104547475, 4518.8418405356315, 11275.379854108103, 11597.0, 11607.883921160848, 11615.941920290514, 11664.94167529157, 11451.0, 11458.828117578243, 11514.424278786195, 11526.942365288287, 11535.942320288344, 7947.642356093989, 8281.668733250723, 8288.254057134765, 8474.491530508067, 8551.01663308715, 6277.466415354746, 6279.340669229665, 6360.713767880549, 6464.741410343534, 6508.284088750328, 9966.700998970042, 10360.274780765274, 10423.530941107516, 10477.0, 10610.734731631772, 9543.570539325608, 10002.799944001225, 10584.682459526226, 10631.096356809448, 10813.56745730162, 7622.390208783395, 7864.0563132422185, 8026.117127116129, 8037.839243214986, 8078.19218078211, 8674.696385626472, 8697.608607612547, 8699.13008699125, 8706.695265665672, 8749.91250087491, 7697.153313135439, 7776.144624091458, 7814.960925195338, 7924.4056695749205, 7960.4825686330205, 7873.842523149619, 7944.602769861599, 7985.480943738638, 8058.919410805817, 8123.8781418277595, 7183.568985860865, 7282.198958114497, 7290.1251849776245, 7302.817429564303, 7319.74380896666, 5092.388913330424, 5390.757415916215, 5399.865003374947, 5407.675539467645, 5637.802676906453, 5367.463253674601, 5372.462753724596, 5374.113271310346, 5424.945750542602, 5442.619016668795], "value": 4643.555400255437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.454978361461, 334.9949750753738, 338.70363431997004, 342.13781271196586, 344.71216534193945, 5356.91964620531, 5493.780248790049, 5534.889302213954, 5603.747831347594, 5625.943740562593, 5499.752511136999, 5524.8342549723575, 5532.225488431623, 5536.422119695888, 5537.418571050032, 4317.495852405597, 4331.826726930919, 4345.978270108645, 4358.716683415568, 4362.541933097011, 4085.53016403113, 4264.594863487963, 4304.622520793348, 4336.0, 4336.59060805238, 4261.0, 4274.0, 4280.122574872144, 4282.164977829325, 4291.275040349369, 4272.551382104881, 4280.657547396201, 4283.378910058024, 4284.472161424743, 4294.248506511348, 3565.554305711786, 3764.480211002694, 3768.0956570423177, 3771.321761815993, 3775.5091838060875, 5335.799445124816, 5380.973095134499, 5387.892242155135, 5391.865203369908, 5400.675959442446, 4818.807247710122, 4887.6070319959, 4895.437024742165, 4904.656674032819, 4916.50834916509, 5562.499375056264, 5681.784104199365, 5731.512821410185, 5745.253117094792, 5755.65466072037, 4091.2022155679656, 4099.1596722672075, 4101.2207680540605, 4104.938425923614, 4108.897277568055, 5875.265591801025, 5952.58331916766, 6001.819945401645, 6018.6689732064715, 6022.337542870281, 3966.8214930328204, 4156.646685031746, 4158.126793373425, 4175.0, 4180.28935081037, 4273.508546517128, 4276.508201556799, 4277.165952639268, 4287.0, 4302.892427689333, 4868.683535570177, 4893.7063776173545, 4909.772556860785, 4919.2867034279825, 4919.557239848431, 5613.382527921925, 5767.818331709477, 5819.039858423313, 5829.708514574254, 5843.24037875082, 1453.8151406603795, 1471.9852801472061, 1477.4164205139125, 1481.1335368809152, 1484.46559238674, 891.4428482198626, 935.4901578639658, 939.2532936315646, 939.7172859047351, 952.1573407534382, 4944.208926571731, 4962.776675049631, 4968.0, 4972.453030166679, 4985.426675932242, 5129.640925135204, 5213.869653258623, 5217.895642087213, 5223.52988231061, 5271.288376069258, 4629.236176030917, 4886.242632391985, 4936.40838559759, 4992.675476094042, 4994.350734404504, 2778.8749506272266, 2780.569011803174, 2782.624345713303, 2792.0, 2798.846063466529, 5397.8110766123, 5400.378956419983, 5410.458954104558, 5453.754581043862, 5464.398916119224, 5248.868778280574, 5297.7880884764945, 5708.71456427177, 6098.878022439526, 6141.969290153521, 6199.132121502993, 6201.930044627848, 6204.627722336674, 6214.875702485925, 6220.782272620527, 5643.661380317194, 5908.5568582357355, 5975.760969561169, 5981.671008094597, 6003.459688628044, 5909.8227053188475, 5953.2735506702575, 5953.345132035559, 5960.5231581474245, 5965.373635768182, 6172.592688851262, 6195.4424101831055, 6200.255969283535, 6229.2524897012645, 6230.252369715482, 3969.861054863066, 4231.174920890397, 4330.285502892114, 4370.147821174841, 4374.321980093091, 5901.232839730979, 5917.289925209003, 5934.9406505934385, 5964.956132676677, 5968.134620480093, 5685.630434021776, 5769.1634712967225, 5813.651180929158, 5828.271466066742, 5842.328132264844, 5710.143478478261, 5717.599768016199, 5766.913496297475, 5820.0, 5826.388229236039, 5689.203511508309, 5737.655740655574, 5764.740586673526, 5771.307443106854, 5777.24895763548, 5634.633748806478, 5783.334916484489, 5815.883682326245, 5822.155787410887, 5831.35855055935, 5660.264165658438, 5661.943380566307, 5663.575231857545, 5680.77276908919, 5716.657000579979], "value": 4322.642653720678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.5805806806256, 778.4473024152848, 796.8286818334057, 837.4054421360834, 879.5953861223836, 14033.929830350846, 15158.772618410705, 15445.84554154458, 15756.424357564252, 16140.43508477202, 14747.188904610242, 14898.40406383746, 14929.626759330995, 14989.0, 15001.099934003967, 672.6972862212024, 802.6227672993683, 809.1382677448528, 831.7047448155909, 835.2524490580927, 787.2049230277404, 803.1727320859524, 807.2250639386197, 808.0586117173515, 809.1382677448498, 859.9054104048549, 861.4917198852708, 863.5984267315697, 864.8140649760301, 867.1631875240423, 849.647396330522, 855.1064137975831, 859.6045818923334, 862.348926560446, 863.7667829686012, 629.9275583307887, 630.0863747566048, 630.7540059376847, 632.5414074795782, 632.7943418389042, 16268.75596866048, 16314.184290785413, 16325.755113673304, 16503.17484125801, 16509.83490165107, 13796.931015344959, 13843.930780346134, 13913.791293130509, 13953.232572208524, 14363.856361436356, 12331.630051098482, 12451.315177665225, 12458.43937022827, 12508.249505029637, 12623.431945562472, 4004.139110091315, 4021.81934222858, 4040.1313717550574, 4080.6123418275215, 4092.9795351023054, 83634.0, 83643.16356836475, 86518.5674071632, 86964.56517717434, 87531.56234218788, 12002.1598488105, 12198.695032624255, 12265.69335766613, 12318.384080795924, 12553.560625378068, 22909.541809163722, 22987.770122298563, 23016.769832301798, 23128.4217894554, 23151.0, 8368.958155209186, 8497.872531912026, 8546.743597692079, 8772.122787721177, 8779.648814047367, 4497.415336006298, 4555.931661025087, 4558.361829343895, 4630.722156670543, 4655.86032419028, 3609.0, 3727.9440808387894, 3730.1420673245307, 3730.8880733578035, 3735.122246272124, 621.7409745265873, 624.3132554190445, 639.6513899924553, 643.829385212919, 647.6276141218818, 584.5002522842908, 584.6871923520896, 650.4731167754135, 718.9748358807417, 731.3600599475459, 9456.385334953206, 9792.363496372713, 9942.80114397708, 10112.696619101438, 10524.31591946521, 667.2626747444101, 701.1796198447828, 744.1256523584766, 769.5459678789541, 787.4055088408215, 4894.241392584155, 4947.480514545993, 4985.4266759323145, 5027.371578552681, 5099.286099946011, 122461.38769306274, 126758.36620816837, 130143.0, 131407.34296328647, 133919.0, 83889.16110838813, 87962.48150073926, 110458.0, 112397.4380128094, 112460.437697811, 77063.8440423394, 86464.0, 86534.0, 87053.0, 90306.09693903108, 9621.230301575997, 9810.306198655713, 9985.350952188084, 10006.649767258112, 10082.143017843273, 51876.22185667142, 51881.7405912968, 52725.0, 53462.73268633632, 54555.454445455034, 64944.35055649383, 73498.26501735128, 74330.0, 76085.0, 77889.2211077882, 12553.435095420546, 13306.800397993844, 13498.797518037434, 13680.521181758591, 13846.238456884968, 14400.20798856031, 14709.92645036768, 14790.926045369704, 14901.0, 15567.844321557093, 14770.556883293519, 14815.0, 15272.0, 15547.922260388626, 15576.766348504554, 14517.274136293354, 14817.957651568815, 15110.622234444227, 15154.575267957074, 15259.542213733606, 14401.207933563755, 14633.0, 14926.402943882124, 15526.767098493307, 15551.611209719847, 11004.614838480615, 11206.719832004264, 11242.94378528102, 11276.9436152822, 11329.470521479494, 11651.242669226473, 11806.350650714294, 11901.166918315635, 11981.580644677395, 12215.938920305342], "value": 7805.697450073652, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 113.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 151.0, 175.0, 120.0, 149.0, 145.0, 123.0, 185.0, 122.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 161.0, 162.0, 166.0, 167.0, 162.0, 162.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 181.0, 77.0, 76.0, 75.0, 75.0, 192.0, 76.0], "value": 97.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 150.0, 84.0, 84.0, 85.0, 128.0, 84.0, 85.0, 140.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 53.0, 56.0, 53.0, 52.0, 55.0, 52.0, 60.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 71.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 77.0, 76.0, 77.0, 77.0, 77.0, 82.0, 84.0, 82.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 123.0, 123.0, 127.0, 121.0, 133.0, 137.0, 169.0, 132.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 163.0, 167.0, 161.0, 162.0, 163.0, 162.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 67.0, 66.0, 64.0, 65.0, 64.0, 66.0, 66.0], "value": 65.6, "unit": "score"}]}]} 21:43:36 INFO - Return code: 0 21:43:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:36 ERROR - # TBPL SUCCESS # 21:43:36 INFO - Running post-action listener: _resource_record_post_action 21:43:36 INFO - [mozharness: 2016-07-30 04:43:36.132065Z] Finished run-tests step (success) 21:43:36 INFO - Running post-run listener: _resource_record_post_run 21:43:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553373696; Read time: 8; Write time: 660640 21:43:36 INFO - TinderboxPrint: CPU usage
13.3% 21:43:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:43:36 INFO - TinderboxPrint: I/O write bytes / time
553,373,696 / 660,640 21:43:36 INFO - TinderboxPrint: CPU idle
8,240.7 (86.6%) 21:43:36 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 21:43:36 INFO - TinderboxPrint: Swap in / out
0 / 0 21:43:36 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257077248; Read time: 0; Write time: 352792 21:43:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295792640; Read time: 0; Write time: 307848 21:43:36 INFO - Running post-run listener: _upload_blobber_files 21:43:36 INFO - Blob upload gear active. 21:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:36 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 21:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:43:37 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:38 INFO - (blobuploader) - INFO - Done attempting. 21:43:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:41 INFO - (blobuploader) - INFO - Done attempting. 21:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:43:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:42 INFO - (blobuploader) - INFO - Done attempting. 21:43:42 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:42 INFO - Return code: 0 21:43:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf85d853a04806dfac01af6682ce0493f2ac9ed1ffac8446f15cc651a1ca98e21c9e09e21ca301d8fe5dacf0c9c3ea22c9221354be8ea3674a392ee5c8bea8c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94351843b418779067eed2b546759dc638d91337a3a2447f273d7d8f95cd1657ea084d57e44c341e9cb0c361fec977be57ba1e29730d870429ba45f7280e28d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23dd0c91cc423eb44a5286d165e3c90ef7da95a152d2efe2921188d93aaacc64c748407198670882f311d2e88f3506565e62e76103be0527e7bd28e561b2e9d1"} 21:43:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:42 INFO - Contents: 21:43:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf85d853a04806dfac01af6682ce0493f2ac9ed1ffac8446f15cc651a1ca98e21c9e09e21ca301d8fe5dacf0c9c3ea22c9221354be8ea3674a392ee5c8bea8c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94351843b418779067eed2b546759dc638d91337a3a2447f273d7d8f95cd1657ea084d57e44c341e9cb0c361fec977be57ba1e29730d870429ba45f7280e28d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23dd0c91cc423eb44a5286d165e3c90ef7da95a152d2efe2921188d93aaacc64c748407198670882f311d2e88f3506565e62e76103be0527e7bd28e561b2e9d1"} 21:43:42 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:42 INFO - Copying logs to upload dir... 21:43:42 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.769404 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-29 21:43:41.629407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 21:43:41.632750) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf85d853a04806dfac01af6682ce0493f2ac9ed1ffac8446f15cc651a1ca98e21c9e09e21ca301d8fe5dacf0c9c3ea22c9221354be8ea3674a392ee5c8bea8c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94351843b418779067eed2b546759dc638d91337a3a2447f273d7d8f95cd1657ea084d57e44c341e9cb0c361fec977be57ba1e29730d870429ba45f7280e28d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23dd0c91cc423eb44a5286d165e3c90ef7da95a152d2efe2921188d93aaacc64c748407198670882f311d2e88f3506565e62e76103be0527e7bd28e561b2e9d1"} build_url:https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/Nco6ihx4QhKmthBQCY5S9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf85d853a04806dfac01af6682ce0493f2ac9ed1ffac8446f15cc651a1ca98e21c9e09e21ca301d8fe5dacf0c9c3ea22c9221354be8ea3674a392ee5c8bea8c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94351843b418779067eed2b546759dc638d91337a3a2447f273d7d8f95cd1657ea084d57e44c341e9cb0c361fec977be57ba1e29730d870429ba45f7280e28d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23dd0c91cc423eb44a5286d165e3c90ef7da95a152d2efe2921188d93aaacc64c748407198670882f311d2e88f3506565e62e76103be0527e7bd28e561b2e9d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 21:43:41.658375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:43:41.658726) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469852309.352988-147681198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 21:43:41.741020) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 21:43:41.741379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 21:43:41.741706) ========= ========= Total master_lag: 0.15 =========