builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1470219494.34 results: success (0) buildid: 20160803003003 builduid: 7290ea626db545448230f44d81aa8eeb revision: 6849935c81c669e32c93e88d061635648cc94049 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.338549) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.339053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.339337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.356182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.356478) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 03:18:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3M=0s 2016-08-03 03:18:15 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.558740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.559148) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.610637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:14.611018) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6849935c81c669e32c93e88d061635648cc94049 --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 6849935c81c669e32c93e88d061635648cc94049 --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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 03:18:15,750 truncating revision to first 12 chars 2016-08-03 03:18:15,750 Setting DEBUG logging. 2016-08-03 03:18:15,750 attempt 1/10 2016-08-03 03:18:15,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6849935c81c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 03:18:16,054 unpacking tar archive at: autoland-6849935c81c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:15.253611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:15.254166) ========= script_repo_revision: 6849935c81c669e32c93e88d061635648cc94049 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:15.254817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:15.255254) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 03:18:15.273208) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-03 03:18:15.273831) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:16 INFO - MultiFileLogger online at 20160803 03:18:16 in /builds/slave/test 03:18:16 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 03:18:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:16 INFO - {'append_to_log': False, 03:18:16 INFO - 'base_work_dir': '/builds/slave/test', 03:18:16 INFO - 'blob_upload_branch': 'Autoland', 03:18:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:16 INFO - 'branch': 'Autoland', 03:18:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:16 INFO - 'config_files': ('talos/linux_config.py',), 03:18:16 INFO - 'default_actions': ('clobber', 03:18:16 INFO - 'read-buildbot-config', 03:18:16 INFO - 'download-and-extract', 03:18:16 INFO - 'populate-webroot', 03:18:16 INFO - 'create-virtualenv', 03:18:16 INFO - 'install', 03:18:16 INFO - 'run-tests'), 03:18:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:16 INFO - 'download_minidump_stackwalk': True, 03:18:16 INFO - 'download_symbols': 'ondemand', 03:18:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:16 INFO - 'installer_path': 'installer.exe', 03:18:16 INFO - 'log_level': 'info', 03:18:16 INFO - 'log_name': 'talos', 03:18:16 INFO - 'log_to_console': True, 03:18:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:16 INFO - 'opt_config_files': (), 03:18:16 INFO - 'pip_index': False, 03:18:16 INFO - 'sps_profile': False, 03:18:16 INFO - 'sps_profile_interval': 0, 03:18:16 INFO - 'suite': 'dromaeojs-e10s', 03:18:16 INFO - 'system_bits': '32', 03:18:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:16 INFO - 'title': 'talos-linux64-ix-061', 03:18:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:16 INFO - 'use_talos_json': True, 03:18:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:16 INFO - 'work_dir': 'build'} 03:18:16 INFO - [mozharness: 2016-08-03 10:18:16.509763Z] Running clobber step. 03:18:16 INFO - Running pre-action listener: _resource_record_pre_action 03:18:16 INFO - Running main action method: clobber 03:18:16 INFO - rmtree: /builds/slave/test/build 03:18:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:16 INFO - Running post-action listener: _resource_record_post_action 03:18:16 INFO - [mozharness: 2016-08-03 10:18:16.989998Z] Finished clobber step (success) 03:18:16 INFO - [mozharness: 2016-08-03 10:18:16.990099Z] Running read-buildbot-config step. 03:18:16 INFO - Running pre-action listener: _resource_record_pre_action 03:18:16 INFO - Running main action method: read_buildbot_config 03:18:16 INFO - Using buildbot properties: 03:18:16 INFO - { 03:18:16 INFO - "project": "", 03:18:16 INFO - "product": "firefox", 03:18:16 INFO - "script_repo_revision": "production", 03:18:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 03:18:16 INFO - "repository": "", 03:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 03:18:16 INFO - "buildid": "20160803003003", 03:18:16 INFO - "pgo_build": "True", 03:18:16 INFO - "basedir": "/builds/slave/test", 03:18:16 INFO - "buildnumber": 84, 03:18:16 INFO - "slavename": "talos-linux64-ix-061", 03:18:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:16 INFO - "platform": "ubuntu64_hw", 03:18:16 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:18:16 INFO - "branch": "autoland", 03:18:16 INFO - "repo_path": "integration/autoland", 03:18:16 INFO - "revision": "6849935c81c669e32c93e88d061635648cc94049", 03:18:16 INFO - "stage_platform": "linux64-pgo", 03:18:16 INFO - "builduid": "7290ea626db545448230f44d81aa8eeb", 03:18:16 INFO - "slavebuilddir": "test" 03:18:16 INFO - } 03:18:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:18:16 INFO - Running post-action listener: _resource_record_post_action 03:18:16 INFO - [mozharness: 2016-08-03 10:18:16.992550Z] Finished read-buildbot-config step (success) 03:18:16 INFO - [mozharness: 2016-08-03 10:18:16.992640Z] Running download-and-extract step. 03:18:16 INFO - Running pre-action listener: _resource_record_pre_action 03:18:16 INFO - Running main action method: download_and_extract 03:18:16 INFO - mkdir: /builds/slave/test/build/tests 03:18: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')]} 03:18:16 INFO - https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:18:17 INFO - Downloaded 1361 bytes. 03:18:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:18:17 INFO - Using the following test package requirements: 03:18:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:18:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'jsshell-linux-x86_64.zip'], 03:18:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:18:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:18:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:17 INFO - https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:18 INFO - Downloaded 21810734 bytes. 03:18:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:19 INFO - Return code: 0 03:18:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:18: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')]} 03:18:19 INFO - https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:20 INFO - Downloaded 21810734 bytes. 03:18:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:22 INFO - Return code: 0 03:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:22 INFO - https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:18:22 INFO - Downloaded 14413723 bytes. 03:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:18:23 INFO - Return code: 0 03:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:23 INFO - https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:18:26 INFO - Downloaded 59359074 bytes. 03:18:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:26 INFO - mkdir: /builds/slave/test/properties 03:18:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:26 INFO - Contents: 03:18:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:18:27 INFO - Running post-action listener: _resource_record_post_action 03:18:27 INFO - Running post-action listener: set_extra_try_arguments 03:18:27 INFO - [mozharness: 2016-08-03 10:18:27.586004Z] Finished download-and-extract step (success) 03:18:27 INFO - [mozharness: 2016-08-03 10:18:27.586237Z] Running populate-webroot step. 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: populate_webroot 03:18:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:27 INFO - '--tppagecycles', 03:18:27 INFO - '7'], 03:18:27 INFO - 'tests': ['tsvgm']}}, 03:18:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['damp', 'tps']}, 03:18:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'tests': ['damp', 'tps']}, 03:18:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['dromaeo_dom']}, 03:18:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['basic_compositor_video']}, 03:18:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:18:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['a11yr', 03:18:27 INFO - 'ts_paint', 03:18:27 INFO - 'tpaint', 03:18:27 INFO - 'sessionrestore', 03:18:27 INFO - 'sessionrestore_no_auto_restore', 03:18:27 INFO - 'tabpaint']}, 03:18:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['tsvgx', 03:18:27 INFO - 'tsvgr_opacity', 03:18:27 INFO - 'tart', 03:18:27 INFO - 'tscrollx', 03:18:27 INFO - 'cart']}, 03:18:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:27 INFO - 'tsvgr_opacity', 03:18:27 INFO - 'tart', 03:18:27 INFO - 'tscrollx', 03:18:27 INFO - 'cart']}, 03:18:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'talos_options': ['--disable-e10s'], 03:18:27 INFO - 'tests': ['tp5o']}, 03:18:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'tests': ['tp5o']}, 03:18:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'talos_options': ['--disable-e10s', 03:18:27 INFO - '--xperf_path', 03:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:27 INFO - 'tests': ['tp5n']}, 03:18:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:27 INFO - 'talos_options': ['--xperf_path', 03:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:27 INFO - 'tests': ['tp5n']}}, 03:18:27 INFO - 'talos.zip': {'path': '', 03:18:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:27 INFO - Running post-action listener: _resource_record_post_action 03:18:27 INFO - [mozharness: 2016-08-03 10:18:27.604089Z] Finished populate-webroot step (success) 03:18:27 INFO - [mozharness: 2016-08-03 10:18:27.604179Z] Running create-virtualenv step. 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: create_virtualenv 03:18:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:27 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 03:18:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:27 INFO - Using real prefix '/usr' 03:18:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:30 INFO - Installing pip.................done. 03:18:30 INFO - Return code: 0 03:18:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:30 INFO - Using env: {'DISPLAY': ':0', 03:18:30 INFO - 'HOME': '/home/cltbld', 03:18:30 INFO - 'LANG': 'en_US.UTF-8', 03:18:30 INFO - 'LANGUAGE': 'en_US:en', 03:18:30 INFO - 'LOGNAME': 'cltbld', 03:18:30 INFO - 'MAIL': '/var/mail/cltbld', 03:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:30 INFO - 'MOZ_NO_REMOTE': '1', 03:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:30 INFO - 'NO_EM_RESTART': '1', 03:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:30 INFO - 'PWD': '/builds/slave/test', 03:18:30 INFO - 'SHELL': '/bin/bash', 03:18:30 INFO - 'SHLVL': '1', 03:18:30 INFO - 'TERM': 'linux', 03:18:30 INFO - 'TMOUT': '86400', 03:18:30 INFO - 'USER': 'cltbld', 03:18:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:30 INFO - '_': '/tools/buildbot/bin/python'} 03:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:30 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 03:18:30 INFO - Cleaning up... 03:18:30 INFO - Return code: 0 03:18:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:30 INFO - Using env: {'DISPLAY': ':0', 03:18:30 INFO - 'HOME': '/home/cltbld', 03:18:30 INFO - 'LANG': 'en_US.UTF-8', 03:18:30 INFO - 'LANGUAGE': 'en_US:en', 03:18:30 INFO - 'LOGNAME': 'cltbld', 03:18:30 INFO - 'MAIL': '/var/mail/cltbld', 03:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:30 INFO - 'MOZ_NO_REMOTE': '1', 03:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:30 INFO - 'NO_EM_RESTART': '1', 03:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:30 INFO - 'PWD': '/builds/slave/test', 03:18:30 INFO - 'SHELL': '/bin/bash', 03:18:30 INFO - 'SHLVL': '1', 03:18:30 INFO - 'TERM': 'linux', 03:18:30 INFO - 'TMOUT': '86400', 03:18:30 INFO - 'USER': 'cltbld', 03:18:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:30 INFO - '_': '/tools/buildbot/bin/python'} 03:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:30 INFO - Downloading/unpacking psutil>=3.1.1 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:32 INFO - Installing collected packages: psutil 03:18:32 INFO - Running setup.py install for psutil 03:18:32 INFO - building 'psutil._psutil_linux' extension 03:18:32 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 03:18:32 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 03:18:32 INFO - building 'psutil._psutil_posix' extension 03:18:32 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 03:18:32 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 03:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:33 INFO - Successfully installed psutil 03:18:33 INFO - Cleaning up... 03:18:33 INFO - Return code: 0 03:18:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:33 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:33 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 03:18:33 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 03:18:33 INFO - Using env: {'DISPLAY': ':0', 03:18:33 INFO - 'HOME': '/home/cltbld', 03:18:33 INFO - 'LANG': 'en_US.UTF-8', 03:18:33 INFO - 'LANGUAGE': 'en_US:en', 03:18:33 INFO - 'LOGNAME': 'cltbld', 03:18:33 INFO - 'MAIL': '/var/mail/cltbld', 03:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:33 INFO - 'MOZ_NO_REMOTE': '1', 03:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:33 INFO - 'NO_EM_RESTART': '1', 03:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:33 INFO - 'PWD': '/builds/slave/test', 03:18:33 INFO - 'SHELL': '/bin/bash', 03:18:33 INFO - 'SHLVL': '1', 03:18:33 INFO - 'TERM': 'linux', 03:18:33 INFO - 'TMOUT': '86400', 03:18:33 INFO - 'USER': 'cltbld', 03:18:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:33 INFO - '_': '/tools/buildbot/bin/python'} 03:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:35 INFO - Installing collected packages: mozsystemmonitor 03:18:35 INFO - Running setup.py install for mozsystemmonitor 03:18:35 INFO - Successfully installed mozsystemmonitor 03:18:35 INFO - Cleaning up... 03:18:35 INFO - Return code: 0 03:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:35 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:35 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 03:18:35 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 03:18:35 INFO - Using env: {'DISPLAY': ':0', 03:18:35 INFO - 'HOME': '/home/cltbld', 03:18:35 INFO - 'LANG': 'en_US.UTF-8', 03:18:35 INFO - 'LANGUAGE': 'en_US:en', 03:18:35 INFO - 'LOGNAME': 'cltbld', 03:18:35 INFO - 'MAIL': '/var/mail/cltbld', 03:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:35 INFO - 'MOZ_NO_REMOTE': '1', 03:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:35 INFO - 'NO_EM_RESTART': '1', 03:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:35 INFO - 'PWD': '/builds/slave/test', 03:18:35 INFO - 'SHELL': '/bin/bash', 03:18:35 INFO - 'SHLVL': '1', 03:18:35 INFO - 'TERM': 'linux', 03:18:35 INFO - 'TMOUT': '86400', 03:18:35 INFO - 'USER': 'cltbld', 03:18:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:35 INFO - '_': '/tools/buildbot/bin/python'} 03:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:37 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 03:18:37 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 03:18:37 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 03:18:37 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 03:18:37 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 03:18:37 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 03:18:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:37 INFO - warning: no files found matching '*.txt' 03:18:37 INFO - no previously-included directories found matching 'build' 03:18:37 INFO - no previously-included directories found matching 'dist' 03:18:37 INFO - no previously-included directories found matching '.git*' 03:18:37 INFO - Installing collected packages: jsonschema, functools32 03:18:37 INFO - Running setup.py install for functools32 03:18:37 INFO - warning: no files found matching '*.txt' 03:18:37 INFO - no previously-included directories found matching 'build' 03:18:37 INFO - no previously-included directories found matching 'dist' 03:18:37 INFO - no previously-included directories found matching '.git*' 03:18:37 INFO - Successfully installed jsonschema functools32 03:18:37 INFO - Cleaning up... 03:18:37 INFO - Return code: 0 03:18:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:37 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:37 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 03:18:37 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 03:18:37 INFO - Using env: {'DISPLAY': ':0', 03:18:37 INFO - 'HOME': '/home/cltbld', 03:18:37 INFO - 'LANG': 'en_US.UTF-8', 03:18:37 INFO - 'LANGUAGE': 'en_US:en', 03:18:37 INFO - 'LOGNAME': 'cltbld', 03:18:37 INFO - 'MAIL': '/var/mail/cltbld', 03:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:37 INFO - 'MOZ_NO_REMOTE': '1', 03:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:37 INFO - 'NO_EM_RESTART': '1', 03:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:37 INFO - 'PWD': '/builds/slave/test', 03:18:37 INFO - 'SHELL': '/bin/bash', 03:18:37 INFO - 'SHLVL': '1', 03:18:37 INFO - 'TERM': 'linux', 03:18:37 INFO - 'TMOUT': '86400', 03:18:37 INFO - 'USER': 'cltbld', 03:18:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:37 INFO - '_': '/tools/buildbot/bin/python'} 03:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:38 INFO - Cleaning up... 03:18:38 INFO - Return code: 0 03:18:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:38 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')]} 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:38 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')]} 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:38 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:38 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 03:18:38 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 03:18:38 INFO - Using env: {'DISPLAY': ':0', 03:18:38 INFO - 'HOME': '/home/cltbld', 03:18:38 INFO - 'LANG': 'en_US.UTF-8', 03:18:38 INFO - 'LANGUAGE': 'en_US:en', 03:18:38 INFO - 'LOGNAME': 'cltbld', 03:18:38 INFO - 'MAIL': '/var/mail/cltbld', 03:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:38 INFO - 'MOZ_NO_REMOTE': '1', 03:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:38 INFO - 'NO_EM_RESTART': '1', 03:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:38 INFO - 'PWD': '/builds/slave/test', 03:18:38 INFO - 'SHELL': '/bin/bash', 03:18:38 INFO - 'SHLVL': '1', 03:18:38 INFO - 'TERM': 'linux', 03:18:38 INFO - 'TMOUT': '86400', 03:18:38 INFO - 'USER': 'cltbld', 03:18:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:38 INFO - '_': '/tools/buildbot/bin/python'} 03:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:40 INFO - Downloading docopt-0.6.1.tar.gz 03:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:41 INFO - Running setup.py install for blobuploader 03:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:41 INFO - Running setup.py install for requests 03:18:41 INFO - Running setup.py install for docopt 03:18:41 INFO - Successfully installed blobuploader requests docopt 03:18:41 INFO - Cleaning up... 03:18:41 INFO - Return code: 0 03:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:41 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:41 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 03:18:41 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 03:18:41 INFO - Using env: {'DISPLAY': ':0', 03:18:41 INFO - 'HOME': '/home/cltbld', 03:18:41 INFO - 'LANG': 'en_US.UTF-8', 03:18:41 INFO - 'LANGUAGE': 'en_US:en', 03:18:41 INFO - 'LOGNAME': 'cltbld', 03:18:41 INFO - 'MAIL': '/var/mail/cltbld', 03:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:41 INFO - 'MOZ_NO_REMOTE': '1', 03:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:41 INFO - 'NO_EM_RESTART': '1', 03:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:41 INFO - 'PWD': '/builds/slave/test', 03:18:41 INFO - 'SHELL': '/bin/bash', 03:18:41 INFO - 'SHLVL': '1', 03:18:41 INFO - 'TERM': 'linux', 03:18:41 INFO - 'TMOUT': '86400', 03:18:41 INFO - 'USER': 'cltbld', 03:18:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:41 INFO - '_': '/tools/buildbot/bin/python'} 03:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:41 INFO - Running setup.py (path:/tmp/pip-shxwOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:41 INFO - Running setup.py (path:/tmp/pip-gbqvAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:41 INFO - Running setup.py (path:/tmp/pip-IHgQhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:42 INFO - Running setup.py (path:/tmp/pip-8TFcUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:42 INFO - Running setup.py (path:/tmp/pip-DRLBl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:42 INFO - Running setup.py (path:/tmp/pip-0QsqJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:42 INFO - Running setup.py (path:/tmp/pip-c3rGrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:42 INFO - Running setup.py (path:/tmp/pip-9UeiQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:42 INFO - Running setup.py (path:/tmp/pip-LAnC_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:42 INFO - Running setup.py (path:/tmp/pip-gPautW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:42 INFO - Running setup.py (path:/tmp/pip-7CSw3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:42 INFO - Running setup.py (path:/tmp/pip-937MLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:42 INFO - Running setup.py (path:/tmp/pip-X8s1Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:42 INFO - Running setup.py (path:/tmp/pip-Q7tT3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:42 INFO - Running setup.py (path:/tmp/pip-fPmkd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:42 INFO - Running setup.py (path:/tmp/pip-IsKNnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:42 INFO - Running setup.py (path:/tmp/pip-DPvb_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:43 INFO - Running setup.py install for manifestparser 03:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozcrash 03:18:43 INFO - Running setup.py install for mozdebug 03:18:43 INFO - Running setup.py install for mozdevice 03:18:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozfile 03:18:43 INFO - Running setup.py install for mozhttpd 03:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozinfo 03:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozInstall 03:18:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozleak 03:18:43 INFO - Running setup.py install for mozlog 03:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for moznetwork 03:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozprocess 03:18:44 INFO - Running setup.py install for mozprofile 03:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozrunner 03:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozscreenshot 03:18:44 INFO - Running setup.py install for moztest 03:18:44 INFO - Running setup.py install for mozversion 03:18:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:44 INFO - Cleaning up... 03:18:44 INFO - Return code: 0 03:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:44 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:44 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 03:18:44 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 03:18:44 INFO - Using env: {'DISPLAY': ':0', 03:18:44 INFO - 'HOME': '/home/cltbld', 03:18:44 INFO - 'LANG': 'en_US.UTF-8', 03:18:44 INFO - 'LANGUAGE': 'en_US:en', 03:18:44 INFO - 'LOGNAME': 'cltbld', 03:18:44 INFO - 'MAIL': '/var/mail/cltbld', 03:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:44 INFO - 'MOZ_NO_REMOTE': '1', 03:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:44 INFO - 'NO_EM_RESTART': '1', 03:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:44 INFO - 'PWD': '/builds/slave/test', 03:18:44 INFO - 'SHELL': '/bin/bash', 03:18:44 INFO - 'SHLVL': '1', 03:18:44 INFO - 'TERM': 'linux', 03:18:44 INFO - 'TMOUT': '86400', 03:18:44 INFO - 'USER': 'cltbld', 03:18:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:44 INFO - '_': '/tools/buildbot/bin/python'} 03:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:45 INFO - Running setup.py (path:/tmp/pip-qT3zNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:45 INFO - Running setup.py (path:/tmp/pip-Tr5pzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:45 INFO - Running setup.py (path:/tmp/pip-Jw8yBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:45 INFO - Running setup.py (path:/tmp/pip-CsRM0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:45 INFO - Running setup.py (path:/tmp/pip-NpoZk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:45 INFO - Running setup.py (path:/tmp/pip-uSnSs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:45 INFO - Running setup.py (path:/tmp/pip-wMhXex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:45 INFO - Running setup.py (path:/tmp/pip-JvGV0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:45 INFO - Running setup.py (path:/tmp/pip-CX0zve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:45 INFO - Running setup.py (path:/tmp/pip-0epAQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:45 INFO - Running setup.py (path:/tmp/pip-U6RBE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:45 INFO - Running setup.py (path:/tmp/pip-xY3NGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:45 INFO - Running setup.py (path:/tmp/pip-JWI4h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:46 INFO - Running setup.py (path:/tmp/pip-JWxGXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:46 INFO - Running setup.py (path:/tmp/pip-FTew1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:46 INFO - Running setup.py (path:/tmp/pip-Girlja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:46 INFO - Running setup.py (path:/tmp/pip-uh3hki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:48 INFO - Downloading blessings-1.6.tar.gz 03:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:48 INFO - Installing collected packages: blessings 03:18:48 INFO - Running setup.py install for blessings 03:18:48 INFO - Successfully installed blessings 03:18:48 INFO - Cleaning up... 03:18:48 INFO - Return code: 0 03:18:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:48 INFO - Reading from file tmpfile_stdout 03:18:48 INFO - Current package versions: 03:18:48 INFO - argparse == 1.2.1 03:18:48 INFO - blessings == 1.6 03:18:48 INFO - blobuploader == 1.2.4 03:18:48 INFO - docopt == 0.6.1 03:18:48 INFO - functools32 == 3.2.3-2 03:18:48 INFO - jsonschema == 2.5.1 03:18:48 INFO - manifestparser == 1.1 03:18:48 INFO - mozInstall == 1.12 03:18:48 INFO - mozcrash == 0.17 03:18:48 INFO - mozdebug == 0.1 03:18:48 INFO - mozdevice == 0.48 03:18:48 INFO - mozfile == 1.2 03:18:48 INFO - mozhttpd == 0.7 03:18:48 INFO - mozinfo == 0.9 03:18:48 INFO - mozleak == 0.1 03:18:48 INFO - mozlog == 3.3 03:18:48 INFO - moznetwork == 0.27 03:18:48 INFO - mozprocess == 0.23 03:18:48 INFO - mozprofile == 0.28 03:18:48 INFO - mozrunner == 6.12 03:18:48 INFO - mozscreenshot == 0.1 03:18:48 INFO - mozsystemmonitor == 0.3 03:18:48 INFO - moztest == 0.7 03:18:48 INFO - mozversion == 1.4 03:18:48 INFO - psutil == 3.1.1 03:18:48 INFO - requests == 1.2.3 03:18:48 INFO - wsgiref == 0.1.2 03:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:48 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')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 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')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:48 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 03:18:48 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 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 INFO - Cleaning up... 03:18:48 INFO - Return code: 0 03:18:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18:48 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')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 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')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 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 0x2581030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2842180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', '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 03:18:48 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 03:18:48 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 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:49 INFO - Cleaning up... 03:18:49 INFO - Return code: 0 03:18:49 INFO - Running post-action listener: _resource_record_post_action 03:18:49 INFO - Running post-action listener: _start_resource_monitoring 03:18:49 INFO - Starting resource monitoring. 03:18:49 INFO - [mozharness: 2016-08-03 10:18:49.114093Z] Finished create-virtualenv step (success) 03:18:49 INFO - [mozharness: 2016-08-03 10:18:49.114531Z] Running install step. 03:18:49 INFO - Running pre-action listener: _resource_record_pre_action 03:18:49 INFO - Running main action method: install 03:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:49 INFO - Reading from file tmpfile_stdout 03:18:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:49 INFO - Reading from file tmpfile_stdout 03:18:49 INFO - Output received: 03:18:49 INFO - Usage: mozinstall [options] installer 03:18:49 INFO - Options: 03:18:49 INFO - -h, --help show this help message and exit 03:18:49 INFO - -d DEST, --destination=DEST 03:18:49 INFO - Directory to install application into. [default: 03:18:49 INFO - "/builds/slave/test"] 03:18:49 INFO - --app=APP Application being installed. [default: firefox] 03:18:49 INFO - mkdir: /builds/slave/test/build/application 03:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:19:06 INFO - Reading from file tmpfile_stdout 03:19:06 INFO - Output received: 03:19:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:06 INFO - Running post-action listener: _resource_record_post_action 03:19:06 INFO - [mozharness: 2016-08-03 10:19:06.424927Z] Finished install step (success) 03:19:06 INFO - [mozharness: 2016-08-03 10:19:06.425309Z] Running run-tests step. 03:19:06 INFO - Running pre-action listener: _resource_record_pre_action 03:19:06 INFO - Running main action method: run_tests 03:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:06 INFO - Python 2.7.3 03:19:06 INFO - Return code: 0 03:19:06 INFO - grabbing minidump binary from tooltool 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:06 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 0x28403b0>, '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 0x28412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:06 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 03:19:06 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 03:19:06 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 03:19:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:06 INFO - Return code: 0 03:19:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:06 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/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:19:06 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/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 03:19:06 INFO - Using env: {'DISPLAY': ':0', 03:19:06 INFO - 'HOME': '/home/cltbld', 03:19:06 INFO - 'LANG': 'en_US.UTF-8', 03:19:06 INFO - 'LANGUAGE': 'en_US:en', 03:19:06 INFO - 'LOGNAME': 'cltbld', 03:19:06 INFO - 'MAIL': '/var/mail/cltbld', 03:19:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:06 INFO - 'MOZ_NO_REMOTE': '1', 03:19:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:06 INFO - 'NO_EM_RESTART': '1', 03:19:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:06 INFO - 'PWD': '/builds/slave/test', 03:19:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:06 INFO - 'SHELL': '/bin/bash', 03:19:06 INFO - 'SHLVL': '1', 03:19:06 INFO - 'TERM': 'linux', 03:19:06 INFO - 'TMOUT': '86400', 03:19:06 INFO - 'USER': 'cltbld', 03:19:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767', 03:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:06 INFO - '_': '/tools/buildbot/bin/python'} 03:19:06 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/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:19:06 INFO - mozversion application_buildid: 20160803003003 03:19:06 INFO - mozversion application_changeset: 6849935c81c669e32c93e88d061635648cc94049 03:19:06 INFO - mozversion application_display_name: Nightly 03:19:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:06 INFO - mozversion application_name: Firefox 03:19:06 INFO - mozversion application_remotingname: firefox 03:19:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:19:06 INFO - mozversion application_vendor: Mozilla 03:19:06 INFO - mozversion application_version: 51.0a1 03:19:06 INFO - mozversion platform_buildid: 20160803003003 03:19:06 INFO - mozversion platform_changeset: 6849935c81c669e32c93e88d061635648cc94049 03:19:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:19:06 INFO - mozversion platform_version: 51.0a1 03:19:06 INFO - using testdate: 1470219546 03:19:06 INFO - actual date: 1470219546 03:19:06 INFO - starting webserver on 'localhost:55518' 03:19:06 INFO - SUITE-START | Running 2 tests 03:19:06 INFO - TEST-START | dromaeo_css 03:19:06 INFO - operating with platform_type : linux_ 03:19:06 INFO - Initialising browser for dromaeo_css test... 03:19:06 INFO - TEST-INFO | started process 9849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvtpSQI/profile http://localhost:55518/getInfo.html) 03:19:11 INFO - PROCESS | 9849 | __metrics Screen width/height:1600/1200 03:19:11 INFO - PROCESS | 9849 | colorDepth:24 03:19:11 INFO - PROCESS | 9849 | Browser inner width/height: 1024/697 03:19:11 INFO - PROCESS | 9849 | __metrics 03:19:12 ERROR - PROCESS | 9849 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:19:13 INFO - TEST-INFO | 9849: exit 0 03:19:13 INFO - Browser initialized. 03:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:13 INFO - TEST-INFO | started process 9966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvtpSQI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:24 INFO - PROCESS | 9966 | RSS: Main: 163254272 03:19:24 INFO - PROCESS | 9966 | 03:20:14 INFO - PROCESS | 9966 | 1470219614553 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] 03:22:23 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55518/tests/dromaeo/cssquery-ext.html) 03:22:24 INFO - PROCESS | 9966 | RSS: Main: 168759296 03:22:24 INFO - PROCESS | 9966 | 03:25:26 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-ext.html (next: http://localhost:55518/tests/dromaeo/cssquery-jquery.html) 03:25:27 INFO - PROCESS | 9966 | RSS: Main: 165765120 03:25:27 INFO - PROCESS | 9966 | 03:28:29 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55518/tests/dromaeo/cssquery-mootools.html) 03:28:29 INFO - PROCESS | 9966 | RSS: Main: 169480192 03:28:29 INFO - PROCESS | 9966 | 03:31:31 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55518/tests/dromaeo/cssquery-prototype.html) 03:31:32 INFO - PROCESS | 9966 | RSS: Main: 163762176 03:31:32 INFO - PROCESS | 9966 | 03:34:34 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55518/tests/dromaeo/cssquery-yui.html) 03:34:35 INFO - PROCESS | 9966 | RSS: Main: 166199296 03:34:35 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | Cycle 1(1): loaded http://localhost:55518/tests/dromaeo/cssquery-yui.html (next: http://localhost:55518/tests/dromaeo/cssquery-dojo.html) 03:37:38 INFO - PROCESS | 9966 | RSS: Main: 169394176 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | __start_tp_report 03:37:38 INFO - PROCESS | 9966 | _x_x_mozilla_page_load 03:37:38 INFO - PROCESS | 9966 | _x_x_mozilla_page_load_details 03:37:38 INFO - PROCESS | 9966 | |i|pagename|runs| 03:37:38 INFO - PROCESS | 9966 | |0;dojo.html;3062.096681478964;3085.9074227773176;3109.3004074083333;3113.564101025857;3116.298832762627;5211.400688920775;5342.198670199472;5364.088105022146;5376.220448035037;5465.508104270615;5330.200469929512;5363.168708850135;5381.139017757159;5412.242286079952;5433.755481003354;4879.560839524442;4926.827561035373;4929.457759646436;4962.082014827269;5024;4915.139850526161;4940.08608407444;5007.0486607544635;5009.474005229453;5047.49525047496;5086.79652813887;5113.590912726973;5116.820911268106;5126.051680439112;5132.332796736419;4872;4900.264960255954;4908.582770464514;4986.750662466899;4991.251312303148;4901.436334821506;4905.337779399807;4910.975445122787;4924.384451943507;4961.610748990289;5398.8920221595345;5401.3248343957;5451.427600102012;5454.372747134091;5482.2873026506695;5551.028570000234;5693.459121383462;5710.086386178192;5746.540276777848;5832.270966129234;5824.184614154022;5829.300483941912;5841.824745257649;5843.678597677126;5851.210086638292;5393.5954803389905;5416.837494875121;5417.322834645669;5422.620416570881;5425.782968681208;5678.914816277759;5879.52963762898;5907.49786268172;5907.734151963172;5926.4666180044005;5741.971290143606;5746.9712651436475;5757.769689212385;5774.740136693859;5787.450192231731;5813.709314534256;5828.067509198592;5833.445822646841;5855.180274761537;5855.502282305966;5517.69652669107;5618.381977982419;5641.887162256732;5673.574481913791;5770.567207459458;5533.170024496358;5666.575006874501;5727.2268243787385;5764.538836893039;5768.7692492300675;4458.77706114693;4472.8210871565425;4477.350784136282;4479.641628669699;4504.031633198878;3879.573246942834;3982.2234664240773;3982.2433737589763;4002.2795896738285;4034.3141665916864;5520.779168833202;5564.666120032811;5574;5596.636218645856;5624.493795558337;5781.335146458211;5846.766129354778;5889.087191485327;5909.6158749681135;5909.881802363929;5351.732413379315;5605.943940560624;5614.29821272341;5617.21359009739;5619.269494965628;4906.58294045003;4942.975285123552;4943.060818444484;4985.925211121836;5020.849374518771;6038.305594856648;6043.093535969552;6043.123747056652;6055.606385584835;6056.606320589148;5568;5817.970910145422;5830.067189249699;5837.0368889132815;5838.357780644211;5939.792107276225;5955.8213253600725;5986.970065149646;6028.4272994065495;6072.180255665428;5680.517156041617;5710.828675139586;5723.656580605177;5726.4273572642405;5749.885002299847;5624.971875140598;5770.163326317745;5790.131480277992;5827.912581311199;5836.912446313394;5632.070708333243;5650.378458369494;5664.603477756682;5723.6851973141875;5755.942440575541;5677.829665110054;5691.089425691869;5694.032014557618;5705.600607957404;5717.313922329347;5460.2355670207;5621.775128994795;5622.465865742748;5627.52166065889;5646.491815736604;5584.134459158837;5656.717164141859;5686.800961966312;5718.857028574319;5725.799597014085;5557.305336832896;5590.413006634408;5593.161025846156;5597.804076857454;5618.859528511656 03:37:38 INFO - PROCESS | 9966 | |1;ext.html;572.5276646766417;581.1167026120297;592.1532208941213;607.6080927801565;628.776784241594;40843;41986.37020444692;44787.77606111965;44800.3279950801;44862.32706509405;45299.320510192294;45402;45406;45509.77245113778;45570.54429455705;8691.521966291868;8857.070007649201;8943.731688049369;8955.462672239686;8971.730848074536;8816.471011739317;8855.380123391365;8929.732108036736;8963.641454341818;8968.417052891542;8925.821483570324;8929.821403571925;8943.821123577525;8970.551472426385;8977.46135231885;8875.06811784763;8897.77755556113;8900.287976961827;8913.688020919237;8973.282137429023;8758.343124265706;8851.690190843354;8878.600462979182;8915.46507209563;8920.063393343671;42205.366919496235;42384;42588.57411425877;42842.35736463955;43064.56935430637;3446.879359222415;3512.7541072124964;3522.982385088084;3562.5546806649168;4311;33552.328953420794;33631.15922101943;33680.663193368;33804.32391352159;35889.64110358915;4374.4094547236355;4430.623397011258;4460.576245256728;4481.08137831747;4579.198640237945;350344.7448288278;350856;353113;353861;354890;35583.11042223914;61043.38956610377;61352.38647613556;61365.69317153386;61415.692921535105;36556.817215914285;38084.619153808664;38234.80882595569;38305.80847095747;38319.23361532754;15009.399624014917;15111.924440377728;15157.848421515864;15159.469418570297;15240.542783716506;12448.75102497945;12588.496460141674;12658.430370633343;12691.682707932376;12753.553625623059;8629.956850215709;8680.435771674822;8718;8744.431611945203;8779.122087791298;3264.7224985876464;3327.983360083184;3332.3168750406107;3350.748693847971;3355.261842394669;1030.2376241581176;1040.730309023006;1068.2201992545486;1074.693712291993;1102.922795404314;32884.83557582197;33561.32877342439;33627;33820.49269260963;33884.32231355359;1119.5969450997634;1147.5926046253626;1161.4599211366756;1196.4496331687521;1217.3608855350835;17299.308027679002;17613.471595852145;17680.55798605045;17761;17787.644247114986;535629;538586;539661;539911;546293;59739;60171;60294;60362.39637603656;60444.39555604476;1331.2411925202734;1340.3097404836517;1352.8241328627412;1365.3992243412868;1379.1380387257964;31548.053558393283;32936.34127317392;33454.49818252777;33613.15967100842;33626;53234.4676553245;53309.46690533045;53374.199387010005;53456.73271633773;53571;445129;447427;447654;448136;448905;29220.26949326199;29493.852530738066;29842.403151937273;29883;29997.4000519984;48968.75515622399;49673.75163124306;49874.75062624809;49921.75039124781;50296.497035029184;40100.18598884067;42216;42447.787761060994;42869;43879.24438305582;43075;43458.78270608627;43729.125417492105;43858.34212486879;44029.33955990599;42454;42646.14707705891;43484;43581.564184357754;45252.77373613111;32571.674283256863;38010.8099459512;38513.80743096267;38703.22593548169;38831;29618.851905741194;29626.851865741395;29651.555226671186;29716.559814215812;29847.403051938407 03:37:38 INFO - PROCESS | 9966 | |2;jquery.html;359.48952487467795;383.0939827308416;387.26999605743174;391.125833761543;407.96124368185014;17952.91023544882;20265.797342026613;20532.178712851488;20767.169313227492;20877.060532276028;19511.317103901365;19687.409377718657;20122.9938503075;20209.39371818848;20271.189152433886;5832.096025116114;5911.88176236475;5917.20117784098;5974.8805023899495;6032.366601506845;5777.046787280094;5862.560307976897;5876.911846322288;5923.614965027281;5930.525557955353;5545.972270138664;5843.094320380348;5896.086106653475;5951.791687290945;5967.04527275636;5862.765489380419;5865.237519122508;6141.969290153543;6403.423691867708;6419;5855.736491857877;5874.823755287305;5970.253718285215;5983.850403739942;6003.189569408118;23221.7677823223;23480.060797568076;23615.527689446288;23709.17017904365;23757.689542222564;2229.721284839395;2287.3824067501846;2376.2277259890434;2439.621858611918;2821.3228825082037;10217.518459823359;10329.638462653846;10372.636957706443;10521.842172367344;10583.894161058368;1989.0651393844869;2158.6977823104776;2192.254633424643;2247.1123906057014;2276.8520046196945;98982.50508747483;99777;101065.4946725269;104002.47998760034;106498;17965.281388744566;18211.72682409765;18265.45718288326;18399;18949.43151705451;33313.833430833176;33333.3333333332;33472.3305533888;33539;33655.32689346199;10048.79902401948;10151.898481015243;10193.388396696222;10324.277300589038;10544.209184311054;8438.620262088221;8582.227599516074;8588.141185881486;8772.429792063496;8863.689770857989;8958.596863141174;8974.596143173572;9074.092590741006;9173.312001599774;9196.12636799503;3186;3221.4362486564755;3333.8999830005137;3388.102152929476;3596.9100772480374;950.6007476859736;962.7737481691797;991.5389343955095;1036.9948150259352;1047.7328281288223;20514;20897.477563061046;21039.910481163744;21197.36407907765;21284.78715212828;1005.7334806276342;1025.7435641089728;1027.8766548014287;1042.6246551241547;1071.994640026795;10828.365468559092;11674.533018679327;11738.76522469563;11769.52921883115;11822.763544729058;359621;371295;372369;460391;512699;89154.55422722975;89861;90323.54838225766;90470.54764726266;90931;970.2529052629436;1002.0680766886719;1011.6661501704419;1023.0690072034413;1034.1674951663983;17853.553661158574;18012.909935450763;18526.536836579195;18654.85469171063;18758.343457978906;41421;42029.52896648725;42697.78651106849;42867.142657147306;43935.56064439315;57560.84878302494;58440.123398148215;60502;60576.707027836725;61265.69367153136;8336.708215212439;8384;8563.229309362187;8596.828063438821;8598.65605375803;12737;12947.5468358607;13353.198808071547;13885.305734713022;13972.371243293874;6234.75060997555;11991.340476273888;12356.876431235572;12443.191192572454;12445.937770311091;12167.513299467922;12250.509979600716;12276.877231227574;12314.261144331369;12739.171953822972;12206.070543069776;12216.26702397859;12550.560730374393;12635.74728505443;12764.702943087068;7209.197700574856;7554.924450755642;8811.162939520735;8817.823643527221;8912.688055918012;11088.279261847954;12020.33888136161;12035.338056406632;12121.27272363661;12768.106232564003 03:37:38 INFO - PROCESS | 9966 | |3;mootools.html;1506.6158129676935;1513.7729340598912;1667.2747354900619;1753.1935309757503;1789.946301610952;7308.415326773858;8418.410711250215;8625.611847466864;9064.456132632038;9077.092290770928;8725.563721813916;8756.474611523314;8821.603027863746;8838.425502342343;8860.955695221515;2330.8368414211013;2348.3072493614427;2357.6227803551437;2375.714914210297;2377.2749311459997;2365.124903785602;2382.6664267002634;2383.392234980078;2400.3519049856527;2404.5671779079757;2370.7273663528745;2378.3459548624096;2390.4143484846236;2439.609662454008;2446.425090103824;2376.6910301660846;2395.568797616428;2399.748026457223;2402.37538240058;2404.8677322747244;2151.440625437382;2205.9889700551553;2210.5799898019327;2211.5687440949023;2216.1910902520463;8273.875891861628;8338.958305208434;8344.791380215544;8379.916200837975;8400.075991640915;4944.33251511045;5072;5162.586993040585;5168.870778230536;5177.999999999963;3351.798892066484;3529.2412131391875;3543.5039094526787;3544.3620148373284;3579.516765236686;1138.772245550885;1185.5494911933497;1187.6555798818333;1196.3958201108385;2050.815426611612;12213.084018698633;12357.567485137977;12539.811902821464;12563.874361256454;12626.810597840948;4128.236276288896;4489.753063581469;4637.350770892078;4719.528047195322;4727.361806156194;8873.334499912404;8949.060348663426;8957;8965.372423930263;8978.147076027766;4989.800407983713;5007.324011258506;5025.296458495814;5028.798848046037;5046.62150338726;3977.2244412339314;4600.263957766741;4626.028534007896;4740.45484769249;4790.520947905182;3570.3751843427294;3636.818159092035;3764.5482542095124;3785.545734511876;3837.520309961255;1113.1929351220301;1121.3944469986116;1133.6769020829024;1175.0716933622343;1178.0693252330564;1000.3847633705219;1006.8540061691014;1031.9845202321972;1042.3276986343917;1051.695008447557;6039.939600604026;6193.318734939153;6260.311365749764;6275.937240627627;6283.685815709287;474.46859517340107;484.4840245138916;485.5654189500377;497.102729573124;499.0592732698889;4246.4691913510815;4246.7027308088755;4296.3555466680245;4346.500152482505;4367.650587952956;10279.17766578672;10557.894421055844;10650.786984260272;10671.306365086244;10679.679609611723;10332;10526.789464210826;10581.470926453647;10590.57637694499;10961.177911656658;8191.836163276701;8431.40980131385;8432.325413966868;8434.493930364199;8443.915560844558;6345.365463453618;6372.904406434;6437.645929473737;6462.095306657166;6483.708233129426;10189.541470633987;10344;10438.791224175626;10464.529096190841;10511.211659125443;9816.460094694574;10261.281710280507;10395.94802025985;10504.369737815756;10545.789084218426;6619;7620.80947976305;7638.427117966064;7780.88328675059;7872.055353357634;8744.213020828156;8764.56177191125;8783.5169065702;8839.867401989104;8855.070217627057;7374.815629609088;7401.111866576045;7469.215732348025;7498.512596681198;7662.080550333995;7032.437405007689;7057.294270572902;7112.146542414944;7271.8909216360735;7294.088238970129;7057.823554411181;7074.575525468488;7123.038389817309;7132.322429369202;7143.714251429885;5226.724973289844;5342.412334643263;5386.192071189353;5404.8108316208745;5525.889482210414;5334.51989320963;5401.756920938488;5424.972875135599;5432.402435731988;5496.697681627549 03:37:38 INFO - PROCESS | 9966 | |4;prototype.html;313.0374099643596;316.6643358040477;317.1895806215121;322.9015150379133;323.90282915125454;5506.889862202754;5563.554915606752;5569.721513924303;5583.832485025446;5605.411431799664;5455.208994695777;5462.426445223254;5471.562275017999;5478.205660179272;5495.230667706524;4083.693218170187;4174.22776786294;4240.173166232586;4268.231718290706;4305.26810442224;4266.445362102922;4268.807903644343;4288.177524552053;4305.375720520523;4328.761918094504;4256.893577660552;4273.786310684469;4273.807678654468;4276.294411422112;4282.100758840632;3995.6803455723616;4204.894877628053;4222.324428091521;4235.512916014667;4287.635550978171;3676.7977761223124;3689.6494832991093;3697.4638677391895;3698.0569954661387;3698.7410881238325;5310.92033619496;5326.227696983916;5351;5360.2227676987;5364.91952620711;4557.954420455786;4791.185498465269;4803.495632958524;4846.830360937351;4852.539008794159;5673.631213971079;5675.382515982967;5702.6293290935955;5711.571632127566;5720.971395143039;3996.840126394941;3998.7400818946676;4025.597440255951;4028.516578010628;4033.556308806029;5869.677167755772;5891.8527036824;5896.469317761379;5945.524358051389;6037.788677396314;4145.585441455891;4158.91682166355;4172.332426811696;4173.603507666767;4182.602652747984;4218.367244913287;4235.407043013981;4237.78811059452;4243.045314804206;4248.660107191417;4748.905021899612;4800.831970881002;4814;4859.598281203172;4870.512948705172;5684.857878552986;5687.658740475585;5723.59934804568;5749.9712501437225;5769.941930776695;1423.59427563144;1450.173401161328;1450.3835869755312;1452.4190323870537;1461.4373466215584;880.1154839386376;898.2230370729403;909.7407238936871;916.3310783128354;951.2009911674088;5505.476979686923;5506.779728810883;5522.530584900329;5532.723363831792;5581.888362232733;5846.386129456346;5863.970680146572;5878.911816322759;5879.970600146972;5883.352831188566;5396.244525766396;5476.452354764491;5491.258680078138;5516.3380394352935;5566.471185237396;3087.336222712128;3093.6751641077813;3098.3578703287294;3101.65881753007;3105.6117985251844;5910.497607703393;5926.4666180044005;6018.789342372996;6067.211262535842;6067.484263837535;5855.795047173328;5932.347441781487;5932.982785852831;5948.185803330026;6003.699815009232;6028.819135425944;6041.486473649701;6054.909176362358;6063.454289114001;6080.635161890213;5639.802606908738;5879.1779945625485;5934.9406505934385;5993.041113421831;6008;5924.4667979882015;5940.405959404025;5959.344472108151;5963.880722385441;6007.759689612367;5901;6133.141360209664;6215.906761398673;6231.22109736283;6282.931901576834;4168.499780026416;4177.352510360899;4189.622933935961;4228.281192197395;4228.936565951575;6042.667653279112;6069.180660610938;6072.635641861502;6077.361877003028;6099.725512352044;5611.214429979887;5751.539876809761;5754.741036653444;5786.797462088806;5916.645001299936;5759.280089988752;5761;5827.388124246893;5836.678982655994;5849.912251316148;5078.441371449211;5749.885002300014;5775.537956963349;5780.855478613068;5786.913196302143;5750.453706897838;5817.94182058174;5830.7959221427045;5830.82507524775;5837.591368604157;5704.3725190228215;5706.229658995982;5708.172315014383;5772.249607550992;5791.739371728367 03:37:38 INFO - PROCESS | 9966 | |5;yui.html;692.4218277738089;739.6819367671902;745.5973774161953;787.2481779900196;834.4826207751194;15228.543143705692;16011.359545618176;16057.197140143004;16104.355825766956;16126.354945802153;14910.25448727562;15199.240037998112;15204.391824327042;15268.923655381735;15285;652.8531080506872;782.792559971608;810.8662070758318;824.5506199121463;829.713748756678;799.7081065411112;811.8254575266317;814.8696208606624;815.6085079162006;817.1175130858659;873.3973558244791;875.9737207883742;877.5524482513932;879.0857508191473;880.1506546182932;872.7250915961451;872.8647059705755;873.4846440600045;875.7941883657336;876.6361959786681;644.2108417188953;644.3073695777058;644.4908522267403;644.8806970710434;646.2051676438008;14937.701245975128;14940.925295373454;15067.4726384576;15082.170480623561;15230.695386092217;15397.923010384988;15402.3839046438;15551.377944882192;15690.450834220861;15693;11933;12030.939845300805;12128.45421956014;12416.379181040911;12506.062045346636;3850.1144736710435;3925.0972276376306;4012.799360031987;4016.0361513236903;4092.8158232879296;82749;84039.5798021006;85333;85714;87290;11311.83032254517;11474.196806223652;11570.59502917394;11589.130815188895;12093.939530302292;22908;22913.19803806859;22967.425814354774;22973;22979.195728149436;8712.651493940299;8850.911490885137;8972.41679290844;9054.456732596065;9069.818603627891;4611.584957353854;4753.9049219016115;4922.852314430573;4970.950290497121;5069.949300507022;3536.717062634983;3593.7484376093944;3622.5290712207243;3646.908827279339;3653.6346365363784;601.9879602408015;614.6281499692622;619.9380061993854;639.1052526462896;639.7153266796231;610.1122866229625;634.5563842258898;670.8356452669127;718.741253148866;737.3363972424753;9807.656732014346;10036.548355324028;10088;10111.191104711605;10129.341592796445;596.7821745063108;715.4026387966003;722.7940037089404;725.3109545931386;725.3145777240458;4618.815247390066;4893.119238537098;4900.855229674539;4974.751262436864;4982.128127577659;75274.6236268826;87231;121887.78112218942;127575;130398;109680;111166;111734;112202;113102;94897.52551237338;96969;98410.99999999857;98704.50647746859;102037.48981255046;9179.26565874715;9292.349535532448;9361.204297634777;9439.150476457151;9451.527423628928;37221.813890930374;44975.550244497135;45117;56545.43454565566;57909.13136302875;70222.29777702158;71506.28493714996;72298;73938.63030685027;75942;12332.876671233173;12479;12607.243565386107;12855.871441285468;13211.471541138248;14108;14295.142291462545;14327.856721432652;14601.70796584041;15085.47200847965;13060.738785224052;13539.323033848072;13552.661183470493;13630.250336231602;13717.245551494763;13474.056816022785;13951.790723138958;14017.439302428196;14048.438062477386;14484.130952142905;12108.394580270775;12368.134230603771;12516.31160286193;12582.748345033231;12613.936930315289;10248.755231993006;10276.280660353703;10595.841062384225;10624.628138015132;10859.891401085888;9914.355566888129;10164.867986141508;11632.185746997968;11686.824697629712;11720.531178753095 03:37:38 INFO - PROCESS | 9966 | __end_tp_report 03:37:38 INFO - PROCESS | 9966 | __start_cc_report 03:37:38 INFO - PROCESS | 9966 | _x_x_mozilla_cycle_collect,348 03:37:38 INFO - PROCESS | 9966 | __end_cc_report 03:37:38 INFO - PROCESS | 9966 | __startTimestamp1470220658663__endTimestamp 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | ------- Summary: start ------- 03:37:38 INFO - PROCESS | 9966 | Number of tests: 6 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#0] dojo.html Cycles:165 Average:5390.81 Median:5617.21 stddev:607.35 (10.8%) stddev-sans-first:581.09 03:37:38 INFO - PROCESS | 9966 | Values: 3062.1 3085.9 3109.3 3113.6 3116.3 5211.4 5342.2 5364.1 5376.2 5465.5 5330.2 5363.2 5381.1 5412.2 5433.8 4879.6 4926.8 4929.5 4962.1 5024.0 4915.1 4940.1 5007.0 5009.5 5047.5 5086.8 5113.6 5116.8 5126.1 5132.3 4872.0 4900.3 4908.6 4986.8 4991.3 4901.4 4905.3 4911.0 4924.4 4961.6 5398.9 5401.3 5451.4 5454.4 5482.3 5551.0 5693.5 5710.1 5746.5 5832.3 5824.2 5829.3 5841.8 5843.7 5851.2 5393.6 5416.8 5417.3 5422.6 5425.8 5678.9 5879.5 5907.5 5907.7 5926.5 5742.0 5747.0 5757.8 5774.7 5787.5 5813.7 5828.1 5833.4 5855.2 5855.5 5517.7 5618.4 5641.9 5673.6 5770.6 5533.2 5666.6 5727.2 5764.5 5768.8 4458.8 4472.8 4477.4 4479.6 4504.0 3879.6 3982.2 3982.2 4002.3 4034.3 5520.8 5564.7 5574.0 5596.6 5624.5 5781.3 5846.8 5889.1 5909.6 5909.9 5351.7 5605.9 5614.3 5617.2 5619.3 4906.6 4943.0 4943.1 4985.9 5020.8 6038.3 6043.1 6043.1 6055.6 6056.6 5568.0 5818.0 5830.1 5837.0 5838.4 5939.8 5955.8 5987.0 6028.4 6072.2 5680.5 5710.8 5723.7 5726.4 5749.9 5625.0 5770.2 5790.1 5827.9 5836.9 5632.1 5650.4 5664.6 5723.7 5755.9 5677.8 5691.1 5694.0 5705.6 5717.3 5460.2 5621.8 5622.5 5627.5 5646.5 5584.1 5656.7 5686.8 5718.9 5725.8 5557.3 5590.4 5593.2 5597.8 5618.9 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#1] ext.html Cycles:180 Average:60279.71 Median:42855.68 stddev:120304.56 (280.7%) stddev-sans-first:120558.53 03:37:38 INFO - PROCESS | 9966 | Values: 572.5 581.1 592.2 607.6 628.8 40843.0 41986.4 44787.8 44800.3 44862.3 45299.3 45402.0 45406.0 45509.8 45570.5 8691.5 8857.1 8943.7 8955.5 8971.7 8816.5 8855.4 8929.7 8963.6 8968.4 8925.8 8929.8 8943.8 8970.6 8977.5 8875.1 8897.8 8900.3 8913.7 8973.3 8758.3 8851.7 8878.6 8915.5 8920.1 42205.4 42384.0 42588.6 42842.4 43064.6 3446.9 3512.8 3523.0 3562.6 4311.0 33552.3 33631.2 33680.7 33804.3 35889.6 4374.4 4430.6 4460.6 4481.1 4579.2 350344.7 350856.0 353113.0 353861.0 354890.0 35583.1 61043.4 61352.4 61365.7 61415.7 36556.8 38084.6 38234.8 38305.8 38319.2 15009.4 15111.9 15157.8 15159.5 15240.5 12448.8 12588.5 12658.4 12691.7 12753.6 8630.0 8680.4 8718.0 8744.4 8779.1 3264.7 3328.0 3332.3 3350.7 3355.3 1030.2 1040.7 1068.2 1074.7 1102.9 32884.8 33561.3 33627.0 33820.5 33884.3 1119.6 1147.6 1161.5 1196.4 1217.4 17299.3 17613.5 17680.6 17761.0 17787.6 535629.0 538586.0 539661.0 539911.0 546293.0 59739.0 60171.0 60294.0 60362.4 60444.4 1331.2 1340.3 1352.8 1365.4 1379.1 31548.1 32936.3 33454.5 33613.2 33626.0 53234.5 53309.5 53374.2 53456.7 53571.0 445129.0 447427.0 447654.0 448136.0 448905.0 29220.3 29493.9 29842.4 29883.0 29997.4 48968.8 49673.8 49874.8 49921.8 50296.5 40100.2 42216.0 42447.8 42869.0 43879.2 43075.0 43458.8 43729.1 43858.3 44029.3 42454.0 42646.1 43484.0 43581.6 45252.8 32571.7 38010.8 38513.8 38703.2 38831.0 29618.9 29626.9 29651.6 29716.6 29847.4 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#2] jquery.html Cycles:180 Average:28711.76 Median:2407.92 stddev:70033.15 (2908.4%) stddev-sans-first:70197.26 03:37:38 INFO - PROCESS | 9966 | Values: 359.5 383.1 387.3 391.1 408.0 17952.9 20265.8 20532.2 20767.2 20877.1 19511.3 19687.4 20123.0 20209.4 20271.2 5832.1 5911.9 5917.2 5974.9 6032.4 5777.0 5862.6 5876.9 5923.6 5930.5 5546.0 5843.1 5896.1 5951.8 5967.0 5862.8 5865.2 6142.0 6403.4 6419.0 5855.7 5874.8 5970.3 5983.9 6003.2 23221.8 23480.1 23615.5 23709.2 23757.7 2229.7 2287.4 2376.2 2439.6 2821.3 10217.5 10329.6 10372.6 10521.8 10583.9 1989.1 2158.7 2192.3 2247.1 2276.9 98982.5 99777.0 101065.5 104002.5 106498.0 17965.3 18211.7 18265.5 18399.0 18949.4 33313.8 33333.3 33472.3 33539.0 33655.3 10048.8 10151.9 10193.4 10324.3 10544.2 8438.6 8582.2 8588.1 8772.4 8863.7 8958.6 8974.6 9074.1 9173.3 9196.1 3186.0 3221.4 3333.9 3388.1 3596.9 950.6 962.8 991.5 1037.0 1047.7 20514.0 20897.5 21039.9 21197.4 21284.8 1005.7 1025.7 1027.9 1042.6 1072.0 10828.4 11674.5 11738.8 11769.5 11822.8 359621.0 371295.0 372369.0 460391.0 512699.0 89154.6 89861.0 90323.5 90470.5 90931.0 970.3 1002.1 1011.7 1023.1 1034.2 17853.6 18012.9 18526.5 18654.9 18758.3 41421.0 42029.5 42697.8 42867.1 43935.6 57560.8 58440.1 60502.0 60576.7 61265.7 8336.7 8384.0 8563.2 8596.8 8598.7 12737.0 12947.5 13353.2 13885.3 13972.4 6234.8 11991.3 12356.9 12443.2 12445.9 12167.5 12250.5 12276.9 12314.3 12739.2 12206.1 12216.3 12550.6 12635.7 12764.7 7209.2 7554.9 8811.2 8817.8 8912.7 11088.3 12020.3 12035.3 12121.3 12768.1 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#3] mootools.html Cycles:180 Average:5747.61 Median:4723.44 stddev:3242.50 (68.6%) stddev-sans-first:3235.93 03:37:38 INFO - PROCESS | 9966 | Values: 1506.6 1513.8 1667.3 1753.2 1789.9 7308.4 8418.4 8625.6 9064.5 9077.1 8725.6 8756.5 8821.6 8838.4 8861.0 2330.8 2348.3 2357.6 2375.7 2377.3 2365.1 2382.7 2383.4 2400.4 2404.6 2370.7 2378.3 2390.4 2439.6 2446.4 2376.7 2395.6 2399.7 2402.4 2404.9 2151.4 2206.0 2210.6 2211.6 2216.2 8273.9 8339.0 8344.8 8379.9 8400.1 4944.3 5072.0 5162.6 5168.9 5178.0 3351.8 3529.2 3543.5 3544.4 3579.5 1138.8 1185.5 1187.7 1196.4 2050.8 12213.1 12357.6 12539.8 12563.9 12626.8 4128.2 4489.8 4637.4 4719.5 4727.4 8873.3 8949.1 8957.0 8965.4 8978.1 4989.8 5007.3 5025.3 5028.8 5046.6 3977.2 4600.3 4626.0 4740.5 4790.5 3570.4 3636.8 3764.5 3785.5 3837.5 1113.2 1121.4 1133.7 1175.1 1178.1 1000.4 1006.9 1032.0 1042.3 1051.7 6039.9 6193.3 6260.3 6275.9 6283.7 474.5 484.5 485.6 497.1 499.1 4246.5 4246.7 4296.4 4346.5 4367.7 10279.2 10557.9 10650.8 10671.3 10679.7 10332.0 10526.8 10581.5 10590.6 10961.2 8191.8 8431.4 8432.3 8434.5 8443.9 6345.4 6372.9 6437.6 6462.1 6483.7 10189.5 10344.0 10438.8 10464.5 10511.2 9816.5 10261.3 10395.9 10504.4 10545.8 6619.0 7620.8 7638.4 7780.9 7872.1 8744.2 8764.6 8783.5 8839.9 8855.1 7374.8 7401.1 7469.2 7498.5 7662.1 7032.4 7057.3 7112.1 7271.9 7294.1 7057.8 7074.6 7123.0 7132.3 7143.7 5226.7 5342.4 5386.2 5404.8 5525.9 5334.5 5401.8 5425.0 5432.4 5496.7 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#4] prototype.html Cycles:180 Average:4835.52 Median:5565.01 stddev:1446.34 (26.0%) stddev-sans-first:1410.00 03:37:38 INFO - PROCESS | 9966 | Values: 313.0 316.7 317.2 322.9 323.9 5506.9 5563.6 5569.7 5583.8 5605.4 5455.2 5462.4 5471.6 5478.2 5495.2 4083.7 4174.2 4240.2 4268.2 4305.3 4266.4 4268.8 4288.2 4305.4 4328.8 4256.9 4273.8 4273.8 4276.3 4282.1 3995.7 4204.9 4222.3 4235.5 4287.6 3676.8 3689.6 3697.5 3698.1 3698.7 5310.9 5326.2 5351.0 5360.2 5364.9 4558.0 4791.2 4803.5 4846.8 4852.5 5673.6 5675.4 5702.6 5711.6 5721.0 3996.8 3998.7 4025.6 4028.5 4033.6 5869.7 5891.9 5896.5 5945.5 6037.8 4145.6 4158.9 4172.3 4173.6 4182.6 4218.4 4235.4 4237.8 4243.0 4248.7 4748.9 4800.8 4814.0 4859.6 4870.5 5684.9 5687.7 5723.6 5750.0 5769.9 1423.6 1450.2 1450.4 1452.4 1461.4 880.1 898.2 909.7 916.3 951.2 5505.5 5506.8 5522.5 5532.7 5581.9 5846.4 5864.0 5878.9 5880.0 5883.4 5396.2 5476.5 5491.3 5516.3 5566.5 3087.3 3093.7 3098.4 3101.7 3105.6 5910.5 5926.5 6018.8 6067.2 6067.5 5855.8 5932.3 5933.0 5948.2 6003.7 6028.8 6041.5 6054.9 6063.5 6080.6 5639.8 5879.2 5934.9 5993.0 6008.0 5924.5 5940.4 5959.3 5963.9 6007.8 5901.0 6133.1 6215.9 6231.2 6282.9 4168.5 4177.4 4189.6 4228.3 4228.9 6042.7 6069.2 6072.6 6077.4 6099.7 5611.2 5751.5 5754.7 5786.8 5916.6 5759.3 5761.0 5827.4 5836.7 5849.9 5078.4 5749.9 5775.5 5780.9 5786.9 5750.5 5817.9 5830.8 5830.8 5837.6 5704.4 5706.2 5708.2 5772.2 5791.7 03:37:38 INFO - PROCESS | 9966 | 03:37:38 INFO - PROCESS | 9966 | [#5] yui.html Cycles:180 Average:21497.06 Median:4014.42 stddev:31678.44 (789.1%) stddev-sans-first:31728.79 03:37:38 INFO - PROCESS | 9966 | Values: 692.4 739.7 745.6 787.2 834.5 15228.5 16011.4 16057.2 16104.4 16126.4 14910.3 15199.2 15204.4 15268.9 15285.0 652.9 782.8 810.9 824.6 829.7 799.7 811.8 814.9 815.6 817.1 873.4 876.0 877.6 879.1 880.2 872.7 872.9 873.5 875.8 876.6 644.2 644.3 644.5 644.9 646.2 14937.7 14940.9 15067.5 15082.2 15230.7 15397.9 15402.4 15551.4 15690.5 15693.0 11933.0 12030.9 12128.5 12416.4 12506.1 3850.1 3925.1 4012.8 4016.0 4092.8 82749.0 84039.6 85333.0 85714.0 87290.0 11311.8 11474.2 11570.6 11589.1 12093.9 22908.0 22913.2 22967.4 22973.0 22979.2 8712.7 8850.9 8972.4 9054.5 9069.8 4611.6 4753.9 4922.9 4971.0 5069.9 3536.7 3593.7 3622.5 3646.9 3653.6 602.0 614.6 619.9 639.1 639.7 610.1 634.6 670.8 718.7 737.3 9807.7 10036.5 10088.0 10111.2 10129.3 596.8 715.4 722.8 725.3 725.3 4618.8 4893.1 4900.9 4974.8 4982.1 75274.6 87231.0 121887.8 127575.0 130398.0 109680.0 111166.0 111734.0 112202.0 113102.0 94897.5 96969.0 98411.0 98704.5 102037.5 9179.3 9292.3 9361.2 9439.2 9451.5 37221.8 44975.6 45117.0 56545.4 57909.1 70222.3 71506.3 72298.0 73938.6 75942.0 12332.9 12479.0 12607.2 12855.9 13211.5 14108.0 14295.1 14327.9 14601.7 15085.5 13060.7 13539.3 13552.7 13630.3 13717.2 13474.1 13951.8 14017.4 14048.4 14484.1 12108.4 12368.1 12516.3 12582.7 12613.9 10248.8 10276.3 10595.8 10624.6 10859.9 9914.4 10164.9 11632.2 11686.8 11720.5 03:37:38 INFO - PROCESS | 9966 | -------- Summary: end -------- 03:37:38 INFO - PROCESS | 9966 | 03:37:39 INFO - TEST-INFO | 9966: exit 0 03:37:39 INFO - TEST-OK | dromaeo_css | took 1112747ms 03:37:39 INFO - TEST-START | kraken 03:37:39 INFO - operating with platform_type : linux_ 03:37:39 INFO - Initialising browser for kraken test... 03:37:39 INFO - TEST-INFO | started process 10209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCIqYL/profile http://localhost:55518/getInfo.html) 03:37:43 INFO - PROCESS | 10209 | __metrics Screen width/height:1600/1200 03:37:43 INFO - PROCESS | 10209 | colorDepth:24 03:37:43 INFO - PROCESS | 10209 | Browser inner width/height: 1024/697 03:37:43 INFO - PROCESS | 10209 | __metrics 03:37:44 ERROR - PROCESS | 10209 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:37:45 INFO - TEST-INFO | 10209: exit 0 03:37:45 INFO - Browser initialized. 03:37:45 INFO - Running cycle 1/1 for kraken test... 03:37:45 INFO - TEST-INFO | started process 10327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCIqYL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:57 INFO - PROCESS | 10327 | RSS: Main: 163340288 03:37:57 INFO - PROCESS | 10327 | 03:37:59 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:00 INFO - PROCESS | 10327 | RSS: Main: 168697856 03:38:00 INFO - PROCESS | 10327 | 03:38:03 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-dft) 03:38:04 INFO - PROCESS | 10327 | RSS: Main: 168083456 03:38:04 INFO - PROCESS | 10327 | 03:38:06 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-fft) 03:38:07 INFO - PROCESS | 10327 | RSS: Main: 163672064 03:38:07 INFO - PROCESS | 10327 | 03:38:09 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator) 03:38:10 INFO - PROCESS | 10327 | RSS: Main: 164888576 03:38:10 INFO - PROCESS | 10327 | 03:38:12 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:13 INFO - PROCESS | 10327 | RSS: Main: 165126144 03:38:13 INFO - PROCESS | 10327 | 03:38:16 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:16 INFO - PROCESS | 10327 | RSS: Main: 164847616 03:38:16 INFO - PROCESS | 10327 | 03:38:20 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:20 INFO - PROCESS | 10327 | RSS: Main: 166260736 03:38:20 INFO - PROCESS | 10327 | 03:38:23 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial) 03:38:24 INFO - PROCESS | 10327 | RSS: Main: 165548032 03:38:24 INFO - PROCESS | 10327 | 03:38:25 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:26 INFO - PROCESS | 10327 | RSS: Main: 165543936 03:38:26 INFO - PROCESS | 10327 | 03:38:28 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:29 INFO - PROCESS | 10327 | RSS: Main: 165740544 03:38:29 INFO - PROCESS | 10327 | 03:38:31 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:31 INFO - PROCESS | 10327 | RSS: Main: 166211584 03:38:31 INFO - PROCESS | 10327 | 03:38:34 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:35 INFO - PROCESS | 10327 | RSS: Main: 166359040 03:38:35 INFO - PROCESS | 10327 | 03:38:37 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:38 INFO - PROCESS | 10327 | RSS: Main: 166670336 03:38:38 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | Cycle 1(1): loaded http://localhost:55518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55518/tests/kraken/driver.html?testName=ai-astar) 03:38:40 INFO - PROCESS | 10327 | RSS: Main: 167182336 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | __start_tp_report 03:38:40 INFO - PROCESS | 10327 | _x_x_mozilla_page_load 03:38:40 INFO - PROCESS | 10327 | _x_x_mozilla_page_load_details 03:38:40 INFO - PROCESS | 10327 | |i|pagename|runs| 03:38:40 INFO - PROCESS | 10327 | |0;ai-astar;105;113;110;113;112;114;116;114;114;112 03:38:40 INFO - PROCESS | 10327 | |1;audio-beat-detection;148;119;147;183;120;152;155;119;192;118 03:38:40 INFO - PROCESS | 10327 | |2;audio-dft;165;162;164;160;162;164;177;162;162;162 03:38:40 INFO - PROCESS | 10327 | |3;audio-fft;76;76;76;184;78;76;75;76;169;77 03:38:40 INFO - PROCESS | 10327 | |4;audio-oscillator;85;86;143;85;84;86;147;84;84;146 03:38:40 INFO - PROCESS | 10327 | |5;imaging-gaussian-blur;117;117;118;118;118;122;119;119;117;120 03:38:40 INFO - PROCESS | 10327 | |6;imaging-darkroom;147;147;147;153;147;149;147;147;147;146 03:38:40 INFO - PROCESS | 10327 | |7;imaging-desaturate;96;96;95;95;96;96;96;95;95;95 03:38:40 INFO - PROCESS | 10327 | |8;json-parse-financial;50;51;53;51;51;54;51;51;51;51 03:38:40 INFO - PROCESS | 10327 | |9;json-stringify-tinderbox;60;60;60;60;65;59;60;60;60;60 03:38:40 INFO - PROCESS | 10327 | |10;stanford-crypto-aes;86;77;77;77;79;77;81;77;83;85 03:38:40 INFO - PROCESS | 10327 | |11;stanford-crypto-ccm;128;132;126;131;131;122;125;125;166;141 03:38:40 INFO - PROCESS | 10327 | |12;stanford-crypto-pbkdf2;160;162;161;159;159;168;159;157;159;158 03:38:40 INFO - PROCESS | 10327 | |13;stanford-crypto-sha256-iterative;64;64;65;65;68;70;63;66;63;61 03:38:40 INFO - PROCESS | 10327 | __end_tp_report 03:38:40 INFO - PROCESS | 10327 | __start_cc_report 03:38:40 INFO - PROCESS | 10327 | _x_x_mozilla_cycle_collect,862 03:38:40 INFO - PROCESS | 10327 | __end_cc_report 03:38:40 INFO - PROCESS | 10327 | __startTimestamp1470220720280__endTimestamp 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | ------- Summary: start ------- 03:38:40 INFO - PROCESS | 10327 | Number of tests: 14 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.02 (2.7%) stddev-sans-first:1.69 03:38:40 INFO - PROCESS | 10327 | Values: 105.0 113.0 110.0 113.0 112.0 114.0 116.0 114.0 114.0 112.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.00 stddev:26.92 (17.9%) stddev-sans-first:28.53 03:38:40 INFO - PROCESS | 10327 | Values: 148.0 119.0 147.0 183.0 120.0 152.0 155.0 119.0 192.0 118.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.78 (2.9%) stddev-sans-first:5.06 03:38:40 INFO - PROCESS | 10327 | Values: 165.0 162.0 164.0 160.0 162.0 164.0 177.0 162.0 162.0 162.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:42.42 (55.8%) stddev-sans-first:44.36 03:38:40 INFO - PROCESS | 10327 | Values: 76.0 76.0 76.0 184.0 78.0 76.0 75.0 76.0 169.0 77.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:84.50 stddev:29.24 (34.6%) stddev-sans-first:30.28 03:38:40 INFO - PROCESS | 10327 | Values: 85.0 86.0 143.0 85.0 84.0 86.0 147.0 84.0 84.0 146.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.58 (1.3%) stddev-sans-first:1.58 03:38:40 INFO - PROCESS | 10327 | Values: 117.0 117.0 118.0 118.0 118.0 122.0 119.0 119.0 117.0 120.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:2.00 (1.4%) stddev-sans-first:2.11 03:38:40 INFO - PROCESS | 10327 | Values: 147.0 147.0 147.0 153.0 147.0 149.0 147.0 147.0 147.0 146.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:38:40 INFO - PROCESS | 10327 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:1.17 (2.3%) stddev-sans-first:1.13 03:38:40 INFO - PROCESS | 10327 | Values: 50.0 51.0 53.0 51.0 51.0 54.0 51.0 51.0 51.0 51.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 03:38:40 INFO - PROCESS | 10327 | Values: 60.0 60.0 60.0 60.0 65.0 59.0 60.0 60.0 60.0 60.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:3.60 (4.5%) stddev-sans-first:3.07 03:38:40 INFO - PROCESS | 10327 | Values: 86.0 77.0 77.0 77.0 79.0 77.0 81.0 77.0 83.0 85.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:131.00 stddev:12.84 (9.8%) stddev-sans-first:13.51 03:38:40 INFO - PROCESS | 10327 | Values: 128.0 132.0 126.0 131.0 131.0 122.0 125.0 125.0 166.0 141.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:159.50 stddev:3.08 (1.9%) stddev-sans-first:3.27 03:38:40 INFO - PROCESS | 10327 | Values: 160.0 162.0 161.0 159.0 159.0 168.0 159.0 157.0 159.0 158.0 03:38:40 INFO - PROCESS | 10327 | 03:38:40 INFO - PROCESS | 10327 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.60 (4.0%) stddev-sans-first:2.74 03:38:40 INFO - PROCESS | 10327 | Values: 64.0 64.0 65.0 65.0 68.0 70.0 63.0 66.0 63.0 61.0 03:38:40 INFO - PROCESS | 10327 | -------- Summary: end -------- 03:38:40 INFO - PROCESS | 10327 | 03:38:41 INFO - TEST-INFO | 10327: exit 0 03:38:41 INFO - TEST-OK | kraken | took 61857ms 03:38:41 INFO - SUITE-END | took 1174s 03:38:41 INFO - Completed test suite (00:19:34) 03:38:41 INFO - javascript benchmark 03:38:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7378.686546399745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.096681478964, 3085.9074227773176, 3109.3004074083333, 3113.564101025857, 3116.298832762627, 5211.400688920775, 5342.198670199472, 5364.088105022146, 5376.220448035037, 5465.508104270615, 5330.200469929512, 5363.168708850135, 5381.139017757159, 5412.242286079952, 5433.755481003354, 4879.560839524442, 4926.827561035373, 4929.457759646436, 4962.082014827269, 5024.0, 4915.139850526161, 4940.08608407444, 5007.0486607544635, 5009.474005229453, 5047.49525047496, 5086.79652813887, 5113.590912726973, 5116.820911268106, 5126.051680439112, 5132.332796736419, 4872.0, 4900.264960255954, 4908.582770464514, 4986.750662466899, 4991.251312303148, 4901.436334821506, 4905.337779399807, 4910.975445122787, 4924.384451943507, 4961.610748990289, 5398.8920221595345, 5401.3248343957, 5451.427600102012, 5454.372747134091, 5482.2873026506695, 5551.028570000234, 5693.459121383462, 5710.086386178192, 5746.540276777848, 5832.270966129234, 5824.184614154022, 5829.300483941912, 5841.824745257649, 5843.678597677126, 5851.210086638292, 5393.5954803389905, 5416.837494875121, 5417.322834645669, 5422.620416570881, 5425.782968681208, 5678.914816277759, 5879.52963762898, 5907.49786268172, 5907.734151963172, 5926.4666180044005, 5741.971290143606, 5746.9712651436475, 5757.769689212385, 5774.740136693859, 5787.450192231731, 5813.709314534256, 5828.067509198592, 5833.445822646841, 5855.180274761537, 5855.502282305966, 5517.69652669107, 5618.381977982419, 5641.887162256732, 5673.574481913791, 5770.567207459458, 5533.170024496358, 5666.575006874501, 5727.2268243787385, 5764.538836893039, 5768.7692492300675, 4458.77706114693, 4472.8210871565425, 4477.350784136282, 4479.641628669699, 4504.031633198878, 3879.573246942834, 3982.2234664240773, 3982.2433737589763, 4002.2795896738285, 4034.3141665916864, 5520.779168833202, 5564.666120032811, 5574.0, 5596.636218645856, 5624.493795558337, 5781.335146458211, 5846.766129354778, 5889.087191485327, 5909.6158749681135, 5909.881802363929, 5351.732413379315, 5605.943940560624, 5614.29821272341, 5617.21359009739, 5619.269494965628, 4906.58294045003, 4942.975285123552, 4943.060818444484, 4985.925211121836, 5020.849374518771, 6038.305594856648, 6043.093535969552, 6043.123747056652, 6055.606385584835, 6056.606320589148, 5568.0, 5817.970910145422, 5830.067189249699, 5837.0368889132815, 5838.357780644211, 5939.792107276225, 5955.8213253600725, 5986.970065149646, 6028.4272994065495, 6072.180255665428, 5680.517156041617, 5710.828675139586, 5723.656580605177, 5726.4273572642405, 5749.885002299847, 5624.971875140598, 5770.163326317745, 5790.131480277992, 5827.912581311199, 5836.912446313394, 5632.070708333243, 5650.378458369494, 5664.603477756682, 5723.6851973141875, 5755.942440575541, 5677.829665110054, 5691.089425691869, 5694.032014557618, 5705.600607957404, 5717.313922329347, 5460.2355670207, 5621.775128994795, 5622.465865742748, 5627.52166065889, 5646.491815736604, 5584.134459158837, 5656.717164141859, 5686.800961966312, 5718.857028574319, 5725.799597014085, 5557.305336832896, 5590.413006634408, 5593.161025846156, 5597.804076857454, 5618.859528511656], "value": 5349.720011154781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5276646766417, 581.1167026120297, 592.1532208941213, 607.6080927801565, 628.776784241594, 40843.0, 41986.37020444692, 44787.77606111965, 44800.3279950801, 44862.32706509405, 45299.320510192294, 45402.0, 45406.0, 45509.77245113778, 45570.54429455705, 8691.521966291868, 8857.070007649201, 8943.731688049369, 8955.462672239686, 8971.730848074536, 8816.471011739317, 8855.380123391365, 8929.732108036736, 8963.641454341818, 8968.417052891542, 8925.821483570324, 8929.821403571925, 8943.821123577525, 8970.551472426385, 8977.46135231885, 8875.06811784763, 8897.77755556113, 8900.287976961827, 8913.688020919237, 8973.282137429023, 8758.343124265706, 8851.690190843354, 8878.600462979182, 8915.46507209563, 8920.063393343671, 42205.366919496235, 42384.0, 42588.57411425877, 42842.35736463955, 43064.56935430637, 3446.879359222415, 3512.7541072124964, 3522.982385088084, 3562.5546806649168, 4311.0, 33552.328953420794, 33631.15922101943, 33680.663193368, 33804.32391352159, 35889.64110358915, 4374.4094547236355, 4430.623397011258, 4460.576245256728, 4481.08137831747, 4579.198640237945, 350344.7448288278, 350856.0, 353113.0, 353861.0, 354890.0, 35583.11042223914, 61043.38956610377, 61352.38647613556, 61365.69317153386, 61415.692921535105, 36556.817215914285, 38084.619153808664, 38234.80882595569, 38305.80847095747, 38319.23361532754, 15009.399624014917, 15111.924440377728, 15157.848421515864, 15159.469418570297, 15240.542783716506, 12448.75102497945, 12588.496460141674, 12658.430370633343, 12691.682707932376, 12753.553625623059, 8629.956850215709, 8680.435771674822, 8718.0, 8744.431611945203, 8779.122087791298, 3264.7224985876464, 3327.983360083184, 3332.3168750406107, 3350.748693847971, 3355.261842394669, 1030.2376241581176, 1040.730309023006, 1068.2201992545486, 1074.693712291993, 1102.922795404314, 32884.83557582197, 33561.32877342439, 33627.0, 33820.49269260963, 33884.32231355359, 1119.5969450997634, 1147.5926046253626, 1161.4599211366756, 1196.4496331687521, 1217.3608855350835, 17299.308027679002, 17613.471595852145, 17680.55798605045, 17761.0, 17787.644247114986, 535629.0, 538586.0, 539661.0, 539911.0, 546293.0, 59739.0, 60171.0, 60294.0, 60362.39637603656, 60444.39555604476, 1331.2411925202734, 1340.3097404836517, 1352.8241328627412, 1365.3992243412868, 1379.1380387257964, 31548.053558393283, 32936.34127317392, 33454.49818252777, 33613.15967100842, 33626.0, 53234.4676553245, 53309.46690533045, 53374.199387010005, 53456.73271633773, 53571.0, 445129.0, 447427.0, 447654.0, 448136.0, 448905.0, 29220.26949326199, 29493.852530738066, 29842.403151937273, 29883.0, 29997.4000519984, 48968.75515622399, 49673.75163124306, 49874.75062624809, 49921.75039124781, 50296.497035029184, 40100.18598884067, 42216.0, 42447.787761060994, 42869.0, 43879.24438305582, 43075.0, 43458.78270608627, 43729.125417492105, 43858.34212486879, 44029.33955990599, 42454.0, 42646.14707705891, 43484.0, 43581.564184357754, 45252.77373613111, 32571.674283256863, 38010.8099459512, 38513.80743096267, 38703.22593548169, 38831.0, 29618.851905741194, 29626.851865741395, 29651.555226671186, 29716.559814215812, 29847.403051938407], "value": 19376.623770497124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.48952487467795, 383.0939827308416, 387.26999605743174, 391.125833761543, 407.96124368185014, 17952.91023544882, 20265.797342026613, 20532.178712851488, 20767.169313227492, 20877.060532276028, 19511.317103901365, 19687.409377718657, 20122.9938503075, 20209.39371818848, 20271.189152433886, 5832.096025116114, 5911.88176236475, 5917.20117784098, 5974.8805023899495, 6032.366601506845, 5777.046787280094, 5862.560307976897, 5876.911846322288, 5923.614965027281, 5930.525557955353, 5545.972270138664, 5843.094320380348, 5896.086106653475, 5951.791687290945, 5967.04527275636, 5862.765489380419, 5865.237519122508, 6141.969290153543, 6403.423691867708, 6419.0, 5855.736491857877, 5874.823755287305, 5970.253718285215, 5983.850403739942, 6003.189569408118, 23221.7677823223, 23480.060797568076, 23615.527689446288, 23709.17017904365, 23757.689542222564, 2229.721284839395, 2287.3824067501846, 2376.2277259890434, 2439.621858611918, 2821.3228825082037, 10217.518459823359, 10329.638462653846, 10372.636957706443, 10521.842172367344, 10583.894161058368, 1989.0651393844869, 2158.6977823104776, 2192.254633424643, 2247.1123906057014, 2276.8520046196945, 98982.50508747483, 99777.0, 101065.4946725269, 104002.47998760034, 106498.0, 17965.281388744566, 18211.72682409765, 18265.45718288326, 18399.0, 18949.43151705451, 33313.833430833176, 33333.3333333332, 33472.3305533888, 33539.0, 33655.32689346199, 10048.79902401948, 10151.898481015243, 10193.388396696222, 10324.277300589038, 10544.209184311054, 8438.620262088221, 8582.227599516074, 8588.141185881486, 8772.429792063496, 8863.689770857989, 8958.596863141174, 8974.596143173572, 9074.092590741006, 9173.312001599774, 9196.12636799503, 3186.0, 3221.4362486564755, 3333.8999830005137, 3388.102152929476, 3596.9100772480374, 950.6007476859736, 962.7737481691797, 991.5389343955095, 1036.9948150259352, 1047.7328281288223, 20514.0, 20897.477563061046, 21039.910481163744, 21197.36407907765, 21284.78715212828, 1005.7334806276342, 1025.7435641089728, 1027.8766548014287, 1042.6246551241547, 1071.994640026795, 10828.365468559092, 11674.533018679327, 11738.76522469563, 11769.52921883115, 11822.763544729058, 359621.0, 371295.0, 372369.0, 460391.0, 512699.0, 89154.55422722975, 89861.0, 90323.54838225766, 90470.54764726266, 90931.0, 970.2529052629436, 1002.0680766886719, 1011.6661501704419, 1023.0690072034413, 1034.1674951663983, 17853.553661158574, 18012.909935450763, 18526.536836579195, 18654.85469171063, 18758.343457978906, 41421.0, 42029.52896648725, 42697.78651106849, 42867.142657147306, 43935.56064439315, 57560.84878302494, 58440.123398148215, 60502.0, 60576.707027836725, 61265.69367153136, 8336.708215212439, 8384.0, 8563.229309362187, 8596.828063438821, 8598.65605375803, 12737.0, 12947.5468358607, 13353.198808071547, 13885.305734713022, 13972.371243293874, 6234.75060997555, 11991.340476273888, 12356.876431235572, 12443.191192572454, 12445.937770311091, 12167.513299467922, 12250.509979600716, 12276.877231227574, 12314.261144331369, 12739.171953822972, 12206.070543069776, 12216.26702397859, 12550.560730374393, 12635.74728505443, 12764.702943087068, 7209.197700574856, 7554.924450755642, 8811.162939520735, 8817.823643527221, 8912.688055918012, 11088.279261847954, 12020.33888136161, 12035.338056406632, 12121.27272363661, 12768.106232564003], "value": 10214.238180207602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.6158129676935, 1513.7729340598912, 1667.2747354900619, 1753.1935309757503, 1789.946301610952, 7308.415326773858, 8418.410711250215, 8625.611847466864, 9064.456132632038, 9077.092290770928, 8725.563721813916, 8756.474611523314, 8821.603027863746, 8838.425502342343, 8860.955695221515, 2330.8368414211013, 2348.3072493614427, 2357.6227803551437, 2375.714914210297, 2377.2749311459997, 2365.124903785602, 2382.6664267002634, 2383.392234980078, 2400.3519049856527, 2404.5671779079757, 2370.7273663528745, 2378.3459548624096, 2390.4143484846236, 2439.609662454008, 2446.425090103824, 2376.6910301660846, 2395.568797616428, 2399.748026457223, 2402.37538240058, 2404.8677322747244, 2151.440625437382, 2205.9889700551553, 2210.5799898019327, 2211.5687440949023, 2216.1910902520463, 8273.875891861628, 8338.958305208434, 8344.791380215544, 8379.916200837975, 8400.075991640915, 4944.33251511045, 5072.0, 5162.586993040585, 5168.870778230536, 5177.999999999963, 3351.798892066484, 3529.2412131391875, 3543.5039094526787, 3544.3620148373284, 3579.516765236686, 1138.772245550885, 1185.5494911933497, 1187.6555798818333, 1196.3958201108385, 2050.815426611612, 12213.084018698633, 12357.567485137977, 12539.811902821464, 12563.874361256454, 12626.810597840948, 4128.236276288896, 4489.753063581469, 4637.350770892078, 4719.528047195322, 4727.361806156194, 8873.334499912404, 8949.060348663426, 8957.0, 8965.372423930263, 8978.147076027766, 4989.800407983713, 5007.324011258506, 5025.296458495814, 5028.798848046037, 5046.62150338726, 3977.2244412339314, 4600.263957766741, 4626.028534007896, 4740.45484769249, 4790.520947905182, 3570.3751843427294, 3636.818159092035, 3764.5482542095124, 3785.545734511876, 3837.520309961255, 1113.1929351220301, 1121.3944469986116, 1133.6769020829024, 1175.0716933622343, 1178.0693252330564, 1000.3847633705219, 1006.8540061691014, 1031.9845202321972, 1042.3276986343917, 1051.695008447557, 6039.939600604026, 6193.318734939153, 6260.311365749764, 6275.937240627627, 6283.685815709287, 474.46859517340107, 484.4840245138916, 485.5654189500377, 497.102729573124, 499.0592732698889, 4246.4691913510815, 4246.7027308088755, 4296.3555466680245, 4346.500152482505, 4367.650587952956, 10279.17766578672, 10557.894421055844, 10650.786984260272, 10671.306365086244, 10679.679609611723, 10332.0, 10526.789464210826, 10581.470926453647, 10590.57637694499, 10961.177911656658, 8191.836163276701, 8431.40980131385, 8432.325413966868, 8434.493930364199, 8443.915560844558, 6345.365463453618, 6372.904406434, 6437.645929473737, 6462.095306657166, 6483.708233129426, 10189.541470633987, 10344.0, 10438.791224175626, 10464.529096190841, 10511.211659125443, 9816.460094694574, 10261.281710280507, 10395.94802025985, 10504.369737815756, 10545.789084218426, 6619.0, 7620.80947976305, 7638.427117966064, 7780.88328675059, 7872.055353357634, 8744.213020828156, 8764.56177191125, 8783.5169065702, 8839.867401989104, 8855.070217627057, 7374.815629609088, 7401.111866576045, 7469.215732348025, 7498.512596681198, 7662.080550333995, 7032.437405007689, 7057.294270572902, 7112.146542414944, 7271.8909216360735, 7294.088238970129, 7057.823554411181, 7074.575525468488, 7123.038389817309, 7132.322429369202, 7143.714251429885, 5226.724973289844, 5342.412334643263, 5386.192071189353, 5404.8108316208745, 5525.889482210414, 5334.51989320963, 5401.756920938488, 5424.972875135599, 5432.402435731988, 5496.697681627549], "value": 4566.02897280613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.0374099643596, 316.6643358040477, 317.1895806215121, 322.9015150379133, 323.90282915125454, 5506.889862202754, 5563.554915606752, 5569.721513924303, 5583.832485025446, 5605.411431799664, 5455.208994695777, 5462.426445223254, 5471.562275017999, 5478.205660179272, 5495.230667706524, 4083.693218170187, 4174.22776786294, 4240.173166232586, 4268.231718290706, 4305.26810442224, 4266.445362102922, 4268.807903644343, 4288.177524552053, 4305.375720520523, 4328.761918094504, 4256.893577660552, 4273.786310684469, 4273.807678654468, 4276.294411422112, 4282.100758840632, 3995.6803455723616, 4204.894877628053, 4222.324428091521, 4235.512916014667, 4287.635550978171, 3676.7977761223124, 3689.6494832991093, 3697.4638677391895, 3698.0569954661387, 3698.7410881238325, 5310.92033619496, 5326.227696983916, 5351.0, 5360.2227676987, 5364.91952620711, 4557.954420455786, 4791.185498465269, 4803.495632958524, 4846.830360937351, 4852.539008794159, 5673.631213971079, 5675.382515982967, 5702.6293290935955, 5711.571632127566, 5720.971395143039, 3996.840126394941, 3998.7400818946676, 4025.597440255951, 4028.516578010628, 4033.556308806029, 5869.677167755772, 5891.8527036824, 5896.469317761379, 5945.524358051389, 6037.788677396314, 4145.585441455891, 4158.91682166355, 4172.332426811696, 4173.603507666767, 4182.602652747984, 4218.367244913287, 4235.407043013981, 4237.78811059452, 4243.045314804206, 4248.660107191417, 4748.905021899612, 4800.831970881002, 4814.0, 4859.598281203172, 4870.512948705172, 5684.857878552986, 5687.658740475585, 5723.59934804568, 5749.9712501437225, 5769.941930776695, 1423.59427563144, 1450.173401161328, 1450.3835869755312, 1452.4190323870537, 1461.4373466215584, 880.1154839386376, 898.2230370729403, 909.7407238936871, 916.3310783128354, 951.2009911674088, 5505.476979686923, 5506.779728810883, 5522.530584900329, 5532.723363831792, 5581.888362232733, 5846.386129456346, 5863.970680146572, 5878.911816322759, 5879.970600146972, 5883.352831188566, 5396.244525766396, 5476.452354764491, 5491.258680078138, 5516.3380394352935, 5566.471185237396, 3087.336222712128, 3093.6751641077813, 3098.3578703287294, 3101.65881753007, 3105.6117985251844, 5910.497607703393, 5926.4666180044005, 6018.789342372996, 6067.211262535842, 6067.484263837535, 5855.795047173328, 5932.347441781487, 5932.982785852831, 5948.185803330026, 6003.699815009232, 6028.819135425944, 6041.486473649701, 6054.909176362358, 6063.454289114001, 6080.635161890213, 5639.802606908738, 5879.1779945625485, 5934.9406505934385, 5993.041113421831, 6008.0, 5924.4667979882015, 5940.405959404025, 5959.344472108151, 5963.880722385441, 6007.759689612367, 5901.0, 6133.141360209664, 6215.906761398673, 6231.22109736283, 6282.931901576834, 4168.499780026416, 4177.352510360899, 4189.622933935961, 4228.281192197395, 4228.936565951575, 6042.667653279112, 6069.180660610938, 6072.635641861502, 6077.361877003028, 6099.725512352044, 5611.214429979887, 5751.539876809761, 5754.741036653444, 5786.797462088806, 5916.645001299936, 5759.280089988752, 5761.0, 5827.388124246893, 5836.678982655994, 5849.912251316148, 5078.441371449211, 5749.885002300014, 5775.537956963349, 5780.855478613068, 5786.913196302143, 5750.453706897838, 5817.94182058174, 5830.7959221427045, 5830.82507524775, 5837.591368604157, 5704.3725190228215, 5706.229658995982, 5708.172315014383, 5772.249607550992, 5791.739371728367], "value": 4361.583055489606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.4218277738089, 739.6819367671902, 745.5973774161953, 787.2481779900196, 834.4826207751194, 15228.543143705692, 16011.359545618176, 16057.197140143004, 16104.355825766956, 16126.354945802153, 14910.25448727562, 15199.240037998112, 15204.391824327042, 15268.923655381735, 15285.0, 652.8531080506872, 782.792559971608, 810.8662070758318, 824.5506199121463, 829.713748756678, 799.7081065411112, 811.8254575266317, 814.8696208606624, 815.6085079162006, 817.1175130858659, 873.3973558244791, 875.9737207883742, 877.5524482513932, 879.0857508191473, 880.1506546182932, 872.7250915961451, 872.8647059705755, 873.4846440600045, 875.7941883657336, 876.6361959786681, 644.2108417188953, 644.3073695777058, 644.4908522267403, 644.8806970710434, 646.2051676438008, 14937.701245975128, 14940.925295373454, 15067.4726384576, 15082.170480623561, 15230.695386092217, 15397.923010384988, 15402.3839046438, 15551.377944882192, 15690.450834220861, 15693.0, 11933.0, 12030.939845300805, 12128.45421956014, 12416.379181040911, 12506.062045346636, 3850.1144736710435, 3925.0972276376306, 4012.799360031987, 4016.0361513236903, 4092.8158232879296, 82749.0, 84039.5798021006, 85333.0, 85714.0, 87290.0, 11311.83032254517, 11474.196806223652, 11570.59502917394, 11589.130815188895, 12093.939530302292, 22908.0, 22913.19803806859, 22967.425814354774, 22973.0, 22979.195728149436, 8712.651493940299, 8850.911490885137, 8972.41679290844, 9054.456732596065, 9069.818603627891, 4611.584957353854, 4753.9049219016115, 4922.852314430573, 4970.950290497121, 5069.949300507022, 3536.717062634983, 3593.7484376093944, 3622.5290712207243, 3646.908827279339, 3653.6346365363784, 601.9879602408015, 614.6281499692622, 619.9380061993854, 639.1052526462896, 639.7153266796231, 610.1122866229625, 634.5563842258898, 670.8356452669127, 718.741253148866, 737.3363972424753, 9807.656732014346, 10036.548355324028, 10088.0, 10111.191104711605, 10129.341592796445, 596.7821745063108, 715.4026387966003, 722.7940037089404, 725.3109545931386, 725.3145777240458, 4618.815247390066, 4893.119238537098, 4900.855229674539, 4974.751262436864, 4982.128127577659, 75274.6236268826, 87231.0, 121887.78112218942, 127575.0, 130398.0, 109680.0, 111166.0, 111734.0, 112202.0, 113102.0, 94897.52551237338, 96969.0, 98410.99999999857, 98704.50647746859, 102037.48981255046, 9179.26565874715, 9292.349535532448, 9361.204297634777, 9439.150476457151, 9451.527423628928, 37221.813890930374, 44975.550244497135, 45117.0, 56545.43454565566, 57909.13136302875, 70222.29777702158, 71506.28493714996, 72298.0, 73938.63030685027, 75942.0, 12332.876671233173, 12479.0, 12607.243565386107, 12855.871441285468, 13211.471541138248, 14108.0, 14295.142291462545, 14327.856721432652, 14601.70796584041, 15085.47200847965, 13060.738785224052, 13539.323033848072, 13552.661183470493, 13630.250336231602, 13717.245551494763, 13474.056816022785, 13951.790723138958, 14017.439302428196, 14048.438062477386, 14484.130952142905, 12108.394580270775, 12368.134230603771, 12516.31160286193, 12582.748345033231, 12613.936930315289, 10248.755231993006, 10276.280660353703, 10595.841062384225, 10624.628138015132, 10859.891401085888, 9914.355566888129, 10164.867986141508, 11632.185746997968, 11686.824697629712, 11720.531178753095], "value": 7653.005590320904, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 110.0, 113.0, 112.0, 114.0, 116.0, 114.0, 114.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 147.0, 183.0, 120.0, 152.0, 155.0, 119.0, 192.0, 118.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 160.0, 162.0, 164.0, 177.0, 162.0, 162.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 184.0, 78.0, 76.0, 75.0, 76.0, 169.0, 77.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 143.0, 85.0, 84.0, 86.0, 147.0, 84.0, 84.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 122.0, 119.0, 119.0, 117.0, 120.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 153.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 53.0, 51.0, 51.0, 54.0, 51.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 65.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 77.0, 77.0, 79.0, 77.0, 81.0, 77.0, 83.0, 85.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 126.0, 131.0, 131.0, 122.0, 125.0, 125.0, 166.0, 141.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 159.0, 159.0, 168.0, 159.0, 157.0, 159.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 68.0, 70.0, 63.0, 66.0, 63.0, 61.0], "value": 64.9, "unit": "score"}]}]} 03:38:41 INFO - Return code: 0 03:38:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:41 ERROR - # TBPL SUCCESS # 03:38:41 INFO - Running post-action listener: _resource_record_post_action 03:38:41 INFO - [mozharness: 2016-08-03 10:38:41.608878Z] Finished run-tests step (success) 03:38:41 INFO - Running post-run listener: _resource_record_post_run 03:38:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553570304; Read time: 8; Write time: 685732 03:38:41 INFO - TinderboxPrint: CPU usage
13.4% 03:38:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:38:41 INFO - TinderboxPrint: I/O write bytes / time
553,570,304 / 685,732 03:38:41 INFO - TinderboxPrint: CPU idle
8,239.9 (86.6%) 03:38:41 INFO - TinderboxPrint: CPU user
1,211.3 (12.7%) 03:38:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260493312; Read time: 0; Write time: 336248 03:38:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293076992; Read time: 0; Write time: 349484 03:38:42 INFO - Running post-run listener: _upload_blobber_files 03:38:42 INFO - Blob upload gear active. 03:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:38:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:43 INFO - (blobuploader) - INFO - Done attempting. 03:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:46 INFO - (blobuploader) - INFO - Done attempting. 03:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:47 INFO - (blobuploader) - INFO - Done attempting. 03:38:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:47 INFO - Return code: 0 03:38:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/730756f8c5742afe116dc78570df77a4287a29f5651c60cfcee7b98cec7240346ac328b2a01e313dd2ade055a77287fae65adc6ea20da14548a4309bbe7af535", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/60652bfee0c1eca964f4d96d99c23692dfdc30a5ba5aad5a36290341becc2a7425eadc23c281765d90508945627b97fcf734d6cb2037dda78841ce353045457e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0d55b92e657765fc7737e7dc66ff4d829c6978a174c8f92a45d24fad2115e50b74c6c44297b7677d5171f1dbd30254a87932ea49290a8420db672cd83daf4a19"} 03:38:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:47 INFO - Contents: 03:38:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/730756f8c5742afe116dc78570df77a4287a29f5651c60cfcee7b98cec7240346ac328b2a01e313dd2ade055a77287fae65adc6ea20da14548a4309bbe7af535", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/60652bfee0c1eca964f4d96d99c23692dfdc30a5ba5aad5a36290341becc2a7425eadc23c281765d90508945627b97fcf734d6cb2037dda78841ce353045457e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0d55b92e657765fc7737e7dc66ff4d829c6978a174c8f92a45d24fad2115e50b74c6c44297b7677d5171f1dbd30254a87932ea49290a8420db672cd83daf4a19"} 03:38:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:47 INFO - Copying logs to upload dir... 03:38:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.836910 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-03 03:38:46.122679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 03:38:46.126473) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 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/730756f8c5742afe116dc78570df77a4287a29f5651c60cfcee7b98cec7240346ac328b2a01e313dd2ade055a77287fae65adc6ea20da14548a4309bbe7af535", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/60652bfee0c1eca964f4d96d99c23692dfdc30a5ba5aad5a36290341becc2a7425eadc23c281765d90508945627b97fcf734d6cb2037dda78841ce353045457e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0d55b92e657765fc7737e7dc66ff4d829c6978a174c8f92a45d24fad2115e50b74c6c44297b7677d5171f1dbd30254a87932ea49290a8420db672cd83daf4a19"} build_url:https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/BU07S-FLRO2zFpJBQHwaPw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/730756f8c5742afe116dc78570df77a4287a29f5651c60cfcee7b98cec7240346ac328b2a01e313dd2ade055a77287fae65adc6ea20da14548a4309bbe7af535", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/60652bfee0c1eca964f4d96d99c23692dfdc30a5ba5aad5a36290341becc2a7425eadc23c281765d90508945627b97fcf734d6cb2037dda78841ce353045457e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0d55b92e657765fc7737e7dc66ff4d829c6978a174c8f92a45d24fad2115e50b74c6c44297b7677d5171f1dbd30254a87932ea49290a8420db672cd83daf4a19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 03:38:46.152972) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:38:46.153426) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470211286.34505-2123039767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:38:46.239689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 03:38:46.240070) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 03:38:46.240378) ========= ========= Total master_lag: 0.17 =========