builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1469712470.1 results: success (0) buildid: 20160728045829 builduid: db109830860d47f4968a8c8928ceb022 revision: 0aa0956567fc0178126434c013070332eb3a6fd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.104452) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.104862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.105129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.738890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.739220) ========= 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=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 06:27:50-- 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% 37.0M=0s 2016-07-28 06:27:50 (37.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.872495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.872807) ========= 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=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013546 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.922012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:50.922371) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0aa0956567fc0178126434c013070332eb3a6fd7 --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 0aa0956567fc0178126434c013070332eb3a6fd7 --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=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 06:27:50,984 truncating revision to first 12 chars 2016-07-28 06:27:50,984 Setting DEBUG logging. 2016-07-28 06:27:50,984 attempt 1/10 2016-07-28 06:27:50,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0aa0956567fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 06:27:51,497 unpacking tar archive at: autoland-0aa0956567fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:51.785356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:51.785669) ========= script_repo_revision: 0aa0956567fc0178126434c013070332eb3a6fd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:51.786053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:51.786423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 06:27:51.794645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-28 06:27:51.794907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:27:51 INFO - MultiFileLogger online at 20160728 06:27:51 in /builds/slave/test 06:27:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 06:27:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:51 INFO - {'append_to_log': False, 06:27:51 INFO - 'base_work_dir': '/builds/slave/test', 06:27:51 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:27:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:51 INFO - 'branch': 'Autoland-Non-PGO', 06:27:51 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:51 INFO - 'config_files': ('talos/linux_config.py',), 06:27:51 INFO - 'default_actions': ('clobber', 06:27:51 INFO - 'read-buildbot-config', 06:27:51 INFO - 'download-and-extract', 06:27:51 INFO - 'populate-webroot', 06:27:51 INFO - 'create-virtualenv', 06:27:51 INFO - 'install', 06:27:51 INFO - 'run-tests'), 06:27:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:51 INFO - 'download_minidump_stackwalk': True, 06:27:51 INFO - 'download_symbols': 'ondemand', 06:27:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:51 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:51 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:51 INFO - 'installer_path': 'installer.exe', 06:27:51 INFO - 'log_level': 'info', 06:27:51 INFO - 'log_name': 'talos', 06:27:51 INFO - 'log_to_console': True, 06:27:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:27:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:27:51 INFO - 'opt_config_files': (), 06:27:51 INFO - 'pip_index': False, 06:27:51 INFO - 'sps_profile': False, 06:27:51 INFO - 'sps_profile_interval': 0, 06:27:51 INFO - 'suite': 'dromaeojs-e10s', 06:27:51 INFO - 'system_bits': '32', 06:27:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:51 INFO - 'title': 'talos-linux64-ix-007', 06:27:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:51 INFO - 'use_talos_json': True, 06:27:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:51 INFO - 'work_dir': 'build'} 06:27:51 INFO - [mozharness: 2016-07-28 13:27:51.947056Z] Running clobber step. 06:27:51 INFO - Running pre-action listener: _resource_record_pre_action 06:27:51 INFO - Running main action method: clobber 06:27:51 INFO - rmtree: /builds/slave/test/build 06:27:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:52 INFO - Running post-action listener: _resource_record_post_action 06:27:52 INFO - [mozharness: 2016-07-28 13:27:52.418302Z] Finished clobber step (success) 06:27:52 INFO - [mozharness: 2016-07-28 13:27:52.418403Z] Running read-buildbot-config step. 06:27:52 INFO - Running pre-action listener: _resource_record_pre_action 06:27:52 INFO - Running main action method: read_buildbot_config 06:27:52 INFO - Using buildbot properties: 06:27:52 INFO - { 06:27:52 INFO - "project": "", 06:27:52 INFO - "product": "firefox", 06:27:52 INFO - "script_repo_revision": "production", 06:27:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 06:27:52 INFO - "repository": "", 06:27:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 06:27:52 INFO - "buildid": "20160728045829", 06:27:52 INFO - "pgo_build": "False", 06:27:52 INFO - "basedir": "/builds/slave/test", 06:27:52 INFO - "buildnumber": 139, 06:27:52 INFO - "slavename": "talos-linux64-ix-007", 06:27:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:27:52 INFO - "platform": "ubuntu64_hw", 06:27:52 INFO - "scheduler": "tests-autoland-linux64-talos", 06:27:52 INFO - "branch": "autoland", 06:27:52 INFO - "repo_path": "integration/autoland", 06:27:52 INFO - "revision": "0aa0956567fc0178126434c013070332eb3a6fd7", 06:27:52 INFO - "stage_platform": "linux64", 06:27:52 INFO - "builduid": "db109830860d47f4968a8c8928ceb022", 06:27:52 INFO - "slavebuilddir": "test" 06:27:52 INFO - } 06:27:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:27:52 INFO - Running post-action listener: _resource_record_post_action 06:27:52 INFO - [mozharness: 2016-07-28 13:27:52.420831Z] Finished read-buildbot-config step (success) 06:27:52 INFO - [mozharness: 2016-07-28 13:27:52.420921Z] Running download-and-extract step. 06:27:52 INFO - Running pre-action listener: _resource_record_pre_action 06:27:52 INFO - Running main action method: download_and_extract 06:27:52 INFO - mkdir: /builds/slave/test/build/tests 06:27:52 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')]} 06:27:52 INFO - https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:27:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:27:53 INFO - Downloaded 1361 bytes. 06:27:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:53 INFO - Using the following test package requirements: 06:27:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:27:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:27:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'jsshell-linux-x86_64.zip'], 06:27:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:27:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:27:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:27:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:27:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:27:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:53 INFO - https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:27:53 INFO - Downloaded 22746794 bytes. 06:27:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:27:55 INFO - Return code: 0 06:27:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:27:55 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')]} 06:27:55 INFO - https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:27:56 INFO - Downloaded 22746794 bytes. 06:27:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:27:57 INFO - Return code: 0 06:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:57 INFO - https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:27:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:27:58 INFO - Downloaded 14413725 bytes. 06:27:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:27:58 INFO - Return code: 0 06:27:58 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')]} 06:27:58 INFO - https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:27:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:27:59 INFO - Downloaded 57165422 bytes. 06:27:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:59 INFO - mkdir: /builds/slave/test/properties 06:27:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:59 INFO - Contents: 06:27:59 INFO - build_url:https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:00 INFO - Running post-action listener: _resource_record_post_action 06:28:00 INFO - Running post-action listener: set_extra_try_arguments 06:28:00 INFO - [mozharness: 2016-07-28 13:28:00.621445Z] Finished download-and-extract step (success) 06:28:00 INFO - [mozharness: 2016-07-28 13:28:00.621685Z] Running populate-webroot step. 06:28:00 INFO - Running pre-action listener: _resource_record_pre_action 06:28:00 INFO - Running main action method: populate_webroot 06:28:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:00 INFO - '--tppagecycles', 06:28:00 INFO - '7'], 06:28:00 INFO - 'tests': ['tsvgm']}}, 06:28:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['damp', 'tps']}, 06:28:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'tests': ['damp', 'tps']}, 06:28:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['dromaeo_dom']}, 06:28:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['basic_compositor_video']}, 06:28:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:28:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['a11yr', 06:28:00 INFO - 'ts_paint', 06:28:00 INFO - 'tpaint', 06:28:00 INFO - 'sessionrestore', 06:28:00 INFO - 'sessionrestore_no_auto_restore', 06:28:00 INFO - 'tabpaint']}, 06:28:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['tsvgx', 06:28:00 INFO - 'tsvgr_opacity', 06:28:00 INFO - 'tart', 06:28:00 INFO - 'tscrollx', 06:28:00 INFO - 'cart']}, 06:28:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:00 INFO - 'tsvgr_opacity', 06:28:00 INFO - 'tart', 06:28:00 INFO - 'tscrollx', 06:28:00 INFO - 'cart']}, 06:28:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'talos_options': ['--disable-e10s'], 06:28:00 INFO - 'tests': ['tp5o']}, 06:28:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'tests': ['tp5o']}, 06:28:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'talos_options': ['--disable-e10s', 06:28:00 INFO - '--xperf_path', 06:28:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:00 INFO - 'tests': ['tp5n']}, 06:28:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:00 INFO - 'talos_options': ['--xperf_path', 06:28:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:00 INFO - 'tests': ['tp5n']}}, 06:28:00 INFO - 'talos.zip': {'path': '', 06:28:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:00 INFO - Running post-action listener: _resource_record_post_action 06:28:00 INFO - [mozharness: 2016-07-28 13:28:00.642584Z] Finished populate-webroot step (success) 06:28:00 INFO - [mozharness: 2016-07-28 13:28:00.642673Z] Running create-virtualenv step. 06:28:00 INFO - Running pre-action listener: _resource_record_pre_action 06:28:00 INFO - Running main action method: create_virtualenv 06:28:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:00 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 06:28:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:00 INFO - Using real prefix '/usr' 06:28:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:03 INFO - Installing pip.................done. 06:28:03 INFO - Return code: 0 06:28:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:03 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')]} 06:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:03 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')]} 06:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:03 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:03 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 06:28:03 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 06:28:03 INFO - Using env: {'DISPLAY': ':0', 06:28:03 INFO - 'HOME': '/home/cltbld', 06:28:03 INFO - 'LANG': 'en_US.UTF-8', 06:28:03 INFO - 'LANGUAGE': 'en_US:en', 06:28:03 INFO - 'LOGNAME': 'cltbld', 06:28:03 INFO - 'MAIL': '/var/mail/cltbld', 06:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:03 INFO - 'MOZ_NO_REMOTE': '1', 06:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:03 INFO - 'NO_EM_RESTART': '1', 06:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:03 INFO - 'PWD': '/builds/slave/test', 06:28:03 INFO - 'SHELL': '/bin/bash', 06:28:03 INFO - 'SHLVL': '1', 06:28:03 INFO - 'TERM': 'linux', 06:28:03 INFO - 'TMOUT': '86400', 06:28:03 INFO - 'USER': 'cltbld', 06:28:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:03 INFO - '_': '/tools/buildbot/bin/python'} 06:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:03 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 06:28:03 INFO - Cleaning up... 06:28:03 INFO - Return code: 0 06:28:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:28:03 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')]} 06:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:03 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')]} 06:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:03 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:03 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 06:28:03 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 06:28:03 INFO - Using env: {'DISPLAY': ':0', 06:28:03 INFO - 'HOME': '/home/cltbld', 06:28:03 INFO - 'LANG': 'en_US.UTF-8', 06:28:03 INFO - 'LANGUAGE': 'en_US:en', 06:28:03 INFO - 'LOGNAME': 'cltbld', 06:28:03 INFO - 'MAIL': '/var/mail/cltbld', 06:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:03 INFO - 'MOZ_NO_REMOTE': '1', 06:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:03 INFO - 'NO_EM_RESTART': '1', 06:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:03 INFO - 'PWD': '/builds/slave/test', 06:28:03 INFO - 'SHELL': '/bin/bash', 06:28:03 INFO - 'SHLVL': '1', 06:28:03 INFO - 'TERM': 'linux', 06:28:03 INFO - 'TMOUT': '86400', 06:28:03 INFO - 'USER': 'cltbld', 06:28:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:03 INFO - '_': '/tools/buildbot/bin/python'} 06:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:03 INFO - Downloading/unpacking psutil>=3.1.1 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:05 INFO - Installing collected packages: psutil 06:28:05 INFO - Running setup.py install for psutil 06:28:05 INFO - building 'psutil._psutil_linux' extension 06:28:05 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 06:28:05 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 06:28:06 INFO - building 'psutil._psutil_posix' extension 06:28:06 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 06:28:06 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 06:28:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:06 INFO - Successfully installed psutil 06:28:06 INFO - Cleaning up... 06:28:06 INFO - Return code: 0 06:28:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:06 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:06 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 06:28:06 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 06:28:06 INFO - Using env: {'DISPLAY': ':0', 06:28:06 INFO - 'HOME': '/home/cltbld', 06:28:06 INFO - 'LANG': 'en_US.UTF-8', 06:28:06 INFO - 'LANGUAGE': 'en_US:en', 06:28:06 INFO - 'LOGNAME': 'cltbld', 06:28:06 INFO - 'MAIL': '/var/mail/cltbld', 06:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:06 INFO - 'MOZ_NO_REMOTE': '1', 06:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:06 INFO - 'NO_EM_RESTART': '1', 06:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:06 INFO - 'PWD': '/builds/slave/test', 06:28:06 INFO - 'SHELL': '/bin/bash', 06:28:06 INFO - 'SHLVL': '1', 06:28:06 INFO - 'TERM': 'linux', 06:28:06 INFO - 'TMOUT': '86400', 06:28:06 INFO - 'USER': 'cltbld', 06:28:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:06 INFO - '_': '/tools/buildbot/bin/python'} 06:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:28:08 INFO - Installing collected packages: mozsystemmonitor 06:28:08 INFO - Running setup.py install for mozsystemmonitor 06:28:08 INFO - Successfully installed mozsystemmonitor 06:28:08 INFO - Cleaning up... 06:28:08 INFO - Return code: 0 06:28:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:28:08 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')]} 06:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:08 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')]} 06:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:08 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:08 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 06:28:08 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 06:28:08 INFO - Using env: {'DISPLAY': ':0', 06:28:08 INFO - 'HOME': '/home/cltbld', 06:28:08 INFO - 'LANG': 'en_US.UTF-8', 06:28:08 INFO - 'LANGUAGE': 'en_US:en', 06:28:08 INFO - 'LOGNAME': 'cltbld', 06:28:08 INFO - 'MAIL': '/var/mail/cltbld', 06:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:08 INFO - 'MOZ_NO_REMOTE': '1', 06:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:08 INFO - 'NO_EM_RESTART': '1', 06:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:08 INFO - 'PWD': '/builds/slave/test', 06:28:08 INFO - 'SHELL': '/bin/bash', 06:28:08 INFO - 'SHLVL': '1', 06:28:08 INFO - 'TERM': 'linux', 06:28:08 INFO - 'TMOUT': '86400', 06:28:08 INFO - 'USER': 'cltbld', 06:28:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:08 INFO - '_': '/tools/buildbot/bin/python'} 06:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:08 INFO - Downloading/unpacking jsonschema==2.5.1 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:10 INFO - warning: no files found matching '*.txt' 06:28:10 INFO - no previously-included directories found matching 'build' 06:28:10 INFO - no previously-included directories found matching 'dist' 06:28:10 INFO - no previously-included directories found matching '.git*' 06:28:10 INFO - Installing collected packages: jsonschema, functools32 06:28:11 INFO - Running setup.py install for functools32 06:28:11 INFO - warning: no files found matching '*.txt' 06:28:11 INFO - no previously-included directories found matching 'build' 06:28:11 INFO - no previously-included directories found matching 'dist' 06:28:11 INFO - no previously-included directories found matching '.git*' 06:28:11 INFO - Successfully installed jsonschema functools32 06:28:11 INFO - Cleaning up... 06:28:11 INFO - Return code: 0 06:28:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:28:11 INFO - Using env: {'DISPLAY': ':0', 06:28:11 INFO - 'HOME': '/home/cltbld', 06:28:11 INFO - 'LANG': 'en_US.UTF-8', 06:28:11 INFO - 'LANGUAGE': 'en_US:en', 06:28:11 INFO - 'LOGNAME': 'cltbld', 06:28:11 INFO - 'MAIL': '/var/mail/cltbld', 06:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:11 INFO - 'MOZ_NO_REMOTE': '1', 06:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:11 INFO - 'NO_EM_RESTART': '1', 06:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:11 INFO - 'PWD': '/builds/slave/test', 06:28:11 INFO - 'SHELL': '/bin/bash', 06:28:11 INFO - 'SHLVL': '1', 06:28:11 INFO - 'TERM': 'linux', 06:28:11 INFO - 'TMOUT': '86400', 06:28:11 INFO - 'USER': 'cltbld', 06:28:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:11 INFO - '_': '/tools/buildbot/bin/python'} 06:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:28:11 INFO - Cleaning up... 06:28:11 INFO - Return code: 0 06:28:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:28:11 INFO - Using env: {'DISPLAY': ':0', 06:28:11 INFO - 'HOME': '/home/cltbld', 06:28:11 INFO - 'LANG': 'en_US.UTF-8', 06:28:11 INFO - 'LANGUAGE': 'en_US:en', 06:28:11 INFO - 'LOGNAME': 'cltbld', 06:28:11 INFO - 'MAIL': '/var/mail/cltbld', 06:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:11 INFO - 'MOZ_NO_REMOTE': '1', 06:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:11 INFO - 'NO_EM_RESTART': '1', 06:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:11 INFO - 'PWD': '/builds/slave/test', 06:28:11 INFO - 'SHELL': '/bin/bash', 06:28:11 INFO - 'SHLVL': '1', 06:28:11 INFO - 'TERM': 'linux', 06:28:11 INFO - 'TMOUT': '86400', 06:28:11 INFO - 'USER': 'cltbld', 06:28:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:11 INFO - '_': '/tools/buildbot/bin/python'} 06:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28:13 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 06:28:13 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 06:28:13 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 06:28:13 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 06:28:13 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 06:28:13 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 06:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:13 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 06:28:13 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 06:28:13 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 06:28:13 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 06:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:14 INFO - Downloading docopt-0.6.1.tar.gz 06:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:14 INFO - Running setup.py install for blobuploader 06:28:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:14 INFO - Running setup.py install for requests 06:28:14 INFO - Running setup.py install for docopt 06:28:14 INFO - Successfully installed blobuploader requests docopt 06:28:14 INFO - Cleaning up... 06:28:14 INFO - Return code: 0 06:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:14 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:14 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 06:28:14 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 06:28:14 INFO - Using env: {'DISPLAY': ':0', 06:28:14 INFO - 'HOME': '/home/cltbld', 06:28:14 INFO - 'LANG': 'en_US.UTF-8', 06:28:14 INFO - 'LANGUAGE': 'en_US:en', 06:28:14 INFO - 'LOGNAME': 'cltbld', 06:28:14 INFO - 'MAIL': '/var/mail/cltbld', 06:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:14 INFO - 'MOZ_NO_REMOTE': '1', 06:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:14 INFO - 'NO_EM_RESTART': '1', 06:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:14 INFO - 'PWD': '/builds/slave/test', 06:28:14 INFO - 'SHELL': '/bin/bash', 06:28:14 INFO - 'SHLVL': '1', 06:28:14 INFO - 'TERM': 'linux', 06:28:14 INFO - 'TMOUT': '86400', 06:28:14 INFO - 'USER': 'cltbld', 06:28:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:14 INFO - '_': '/tools/buildbot/bin/python'} 06:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:15 INFO - Running setup.py (path:/tmp/pip-Z5_FQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:15 INFO - Running setup.py (path:/tmp/pip-0WzLB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:15 INFO - Running setup.py (path:/tmp/pip-mfmAdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:15 INFO - Running setup.py (path:/tmp/pip-m_09Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:15 INFO - Running setup.py (path:/tmp/pip-QbCthP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:15 INFO - Running setup.py (path:/tmp/pip-wcpkan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:15 INFO - Running setup.py (path:/tmp/pip-ctMS0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:15 INFO - Running setup.py (path:/tmp/pip-vEt4dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:15 INFO - Running setup.py (path:/tmp/pip-EHI7uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:15 INFO - Running setup.py (path:/tmp/pip-NcNDjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:15 INFO - Running setup.py (path:/tmp/pip-hqCE9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:15 INFO - Running setup.py (path:/tmp/pip-ni2j9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:15 INFO - Running setup.py (path:/tmp/pip-ljgCFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:16 INFO - Running setup.py (path:/tmp/pip-47oF3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:16 INFO - Running setup.py (path:/tmp/pip-1lmkeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:16 INFO - Running setup.py (path:/tmp/pip-jXGi_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:16 INFO - Running setup.py (path:/tmp/pip-LhiTXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:16 INFO - Running setup.py install for manifestparser 06:28:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:16 INFO - Running setup.py install for mozcrash 06:28:16 INFO - Running setup.py install for mozdebug 06:28:16 INFO - Running setup.py install for mozdevice 06:28:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:16 INFO - Running setup.py install for mozfile 06:28:16 INFO - Running setup.py install for mozhttpd 06:28:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:16 INFO - Running setup.py install for mozinfo 06:28:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for mozInstall 06:28:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for mozleak 06:28:17 INFO - Running setup.py install for mozlog 06:28:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for moznetwork 06:28:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for mozprocess 06:28:17 INFO - Running setup.py install for mozprofile 06:28:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for mozrunner 06:28:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:17 INFO - Running setup.py install for mozscreenshot 06:28:17 INFO - Running setup.py install for moztest 06:28:18 INFO - Running setup.py install for mozversion 06:28:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:18 INFO - Cleaning up... 06:28:18 INFO - Return code: 0 06:28:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:18 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:18 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 06:28:18 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 06:28:18 INFO - Using env: {'DISPLAY': ':0', 06:28:18 INFO - 'HOME': '/home/cltbld', 06:28:18 INFO - 'LANG': 'en_US.UTF-8', 06:28:18 INFO - 'LANGUAGE': 'en_US:en', 06:28:18 INFO - 'LOGNAME': 'cltbld', 06:28:18 INFO - 'MAIL': '/var/mail/cltbld', 06:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:18 INFO - 'MOZ_NO_REMOTE': '1', 06:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:18 INFO - 'NO_EM_RESTART': '1', 06:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:18 INFO - 'PWD': '/builds/slave/test', 06:28:18 INFO - 'SHELL': '/bin/bash', 06:28:18 INFO - 'SHLVL': '1', 06:28:18 INFO - 'TERM': 'linux', 06:28:18 INFO - 'TMOUT': '86400', 06:28:18 INFO - 'USER': 'cltbld', 06:28:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:18 INFO - '_': '/tools/buildbot/bin/python'} 06:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:18 INFO - Running setup.py (path:/tmp/pip-VOBRkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:18 INFO - Running setup.py (path:/tmp/pip-ogDhKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:18 INFO - Running setup.py (path:/tmp/pip-QJloDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:18 INFO - Running setup.py (path:/tmp/pip-hSxFcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:18 INFO - Running setup.py (path:/tmp/pip-xobFD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:18 INFO - Running setup.py (path:/tmp/pip-or0NiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:18 INFO - Running setup.py (path:/tmp/pip-SQiwF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:18 INFO - Running setup.py (path:/tmp/pip-5VIUIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:18 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)) 06:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:18 INFO - Running setup.py (path:/tmp/pip-r5tczD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:19 INFO - Running setup.py (path:/tmp/pip-qBcsfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:19 INFO - Running setup.py (path:/tmp/pip-NLwyO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:19 INFO - Running setup.py (path:/tmp/pip-pi_JH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:19 INFO - Running setup.py (path:/tmp/pip-TiTKU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:19 INFO - Running setup.py (path:/tmp/pip-90RrZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:19 INFO - Running setup.py (path:/tmp/pip-bSQx7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:19 INFO - Running setup.py (path:/tmp/pip-5GESYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:19 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)) 06:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:19 INFO - Running setup.py (path:/tmp/pip-4xtdFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:19 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)) 06:28:19 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)) 06:28:19 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)) 06:28:19 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)) 06:28:19 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)) 06:28:19 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)) 06:28:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:21 INFO - Downloading blessings-1.6.tar.gz 06:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:21 INFO - Installing collected packages: blessings 06:28:21 INFO - Running setup.py install for blessings 06:28:21 INFO - Successfully installed blessings 06:28:21 INFO - Cleaning up... 06:28:21 INFO - Return code: 0 06:28:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:22 INFO - Reading from file tmpfile_stdout 06:28:22 INFO - Current package versions: 06:28:22 INFO - argparse == 1.2.1 06:28:22 INFO - blessings == 1.6 06:28:22 INFO - blobuploader == 1.2.4 06:28:22 INFO - docopt == 0.6.1 06:28:22 INFO - functools32 == 3.2.3-2 06:28:22 INFO - jsonschema == 2.5.1 06:28:22 INFO - manifestparser == 1.1 06:28:22 INFO - mozInstall == 1.12 06:28:22 INFO - mozcrash == 0.17 06:28:22 INFO - mozdebug == 0.1 06:28:22 INFO - mozdevice == 0.48 06:28:22 INFO - mozfile == 1.2 06:28:22 INFO - mozhttpd == 0.7 06:28:22 INFO - mozinfo == 0.9 06:28:22 INFO - mozleak == 0.1 06:28:22 INFO - mozlog == 3.3 06:28:22 INFO - moznetwork == 0.27 06:28:22 INFO - mozprocess == 0.23 06:28:22 INFO - mozprofile == 0.28 06:28:22 INFO - mozrunner == 6.12 06:28:22 INFO - mozscreenshot == 0.1 06:28:22 INFO - mozsystemmonitor == 0.3 06:28:22 INFO - moztest == 0.7 06:28:22 INFO - mozversion == 1.4 06:28:22 INFO - psutil == 3.1.1 06:28:22 INFO - requests == 1.2.3 06:28:22 INFO - wsgiref == 0.1.2 06:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:22 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:22 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 06:28:22 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 06:28:22 INFO - Using env: {'DISPLAY': ':0', 06:28:22 INFO - 'HOME': '/home/cltbld', 06:28:22 INFO - 'LANG': 'en_US.UTF-8', 06:28:22 INFO - 'LANGUAGE': 'en_US:en', 06:28:22 INFO - 'LOGNAME': 'cltbld', 06:28:22 INFO - 'MAIL': '/var/mail/cltbld', 06:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:22 INFO - 'MOZ_NO_REMOTE': '1', 06:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:22 INFO - 'NO_EM_RESTART': '1', 06:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:22 INFO - 'PWD': '/builds/slave/test', 06:28:22 INFO - 'SHELL': '/bin/bash', 06:28:22 INFO - 'SHLVL': '1', 06:28:22 INFO - 'TERM': 'linux', 06:28:22 INFO - 'TMOUT': '86400', 06:28:22 INFO - 'USER': 'cltbld', 06:28:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:22 INFO - '_': '/tools/buildbot/bin/python'} 06:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 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)) 06:28:22 INFO - Cleaning up... 06:28:22 INFO - Return code: 0 06:28:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:22 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 0xf99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, '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': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', '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 06:28:22 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 06:28:22 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 06:28:22 INFO - Using env: {'DISPLAY': ':0', 06:28:22 INFO - 'HOME': '/home/cltbld', 06:28:22 INFO - 'LANG': 'en_US.UTF-8', 06:28:22 INFO - 'LANGUAGE': 'en_US:en', 06:28:22 INFO - 'LOGNAME': 'cltbld', 06:28:22 INFO - 'MAIL': '/var/mail/cltbld', 06:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:22 INFO - 'MOZ_NO_REMOTE': '1', 06:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:22 INFO - 'NO_EM_RESTART': '1', 06:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:22 INFO - 'PWD': '/builds/slave/test', 06:28:22 INFO - 'SHELL': '/bin/bash', 06:28:22 INFO - 'SHLVL': '1', 06:28:22 INFO - 'TERM': 'linux', 06:28:22 INFO - 'TMOUT': '86400', 06:28:22 INFO - 'USER': 'cltbld', 06:28:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:22 INFO - '_': '/tools/buildbot/bin/python'} 06:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:28:22 INFO - Cleaning up... 06:28:22 INFO - Return code: 0 06:28:22 INFO - Running post-action listener: _resource_record_post_action 06:28:22 INFO - Running post-action listener: _start_resource_monitoring 06:28:22 INFO - Starting resource monitoring. 06:28:22 INFO - [mozharness: 2016-07-28 13:28:22.477978Z] Finished create-virtualenv step (success) 06:28:22 INFO - [mozharness: 2016-07-28 13:28:22.478451Z] Running install step. 06:28:22 INFO - Running pre-action listener: _resource_record_pre_action 06:28:22 INFO - Running main action method: install 06:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:22 INFO - Reading from file tmpfile_stdout 06:28:22 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:22 INFO - Reading from file tmpfile_stdout 06:28:22 INFO - Output received: 06:28:22 INFO - Usage: mozinstall [options] installer 06:28:22 INFO - Options: 06:28:22 INFO - -h, --help show this help message and exit 06:28:22 INFO - -d DEST, --destination=DEST 06:28:22 INFO - Directory to install application into. [default: 06:28:22 INFO - "/builds/slave/test"] 06:28:22 INFO - --app=APP Application being installed. [default: firefox] 06:28:22 INFO - mkdir: /builds/slave/test/build/application 06:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:28:39 INFO - Reading from file tmpfile_stdout 06:28:39 INFO - Output received: 06:28:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:28:39 INFO - Running post-action listener: _resource_record_post_action 06:28:39 INFO - [mozharness: 2016-07-28 13:28:39.202651Z] Finished install step (success) 06:28:39 INFO - [mozharness: 2016-07-28 13:28:39.202933Z] Running run-tests step. 06:28:39 INFO - Running pre-action listener: _resource_record_pre_action 06:28:39 INFO - Running main action method: run_tests 06:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:39 INFO - Python 2.7.3 06:28:39 INFO - Return code: 0 06:28:39 INFO - grabbing minidump binary from tooltool 06:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:39 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 0x1257570>, '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 0x1258470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1258900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:39 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 06:28:39 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 06:28:39 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 06:28:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:39 INFO - Return code: 0 06:28:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:28:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:28:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 06:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 06:28:39 INFO - Using env: {'DISPLAY': ':0', 06:28:39 INFO - 'HOME': '/home/cltbld', 06:28:39 INFO - 'LANG': 'en_US.UTF-8', 06:28:39 INFO - 'LANGUAGE': 'en_US:en', 06:28:39 INFO - 'LOGNAME': 'cltbld', 06:28:39 INFO - 'MAIL': '/var/mail/cltbld', 06:28:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:39 INFO - 'MOZ_NO_REMOTE': '1', 06:28:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:39 INFO - 'NO_EM_RESTART': '1', 06:28:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:39 INFO - 'PWD': '/builds/slave/test', 06:28:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:39 INFO - 'SHELL': '/bin/bash', 06:28:39 INFO - 'SHLVL': '1', 06:28:39 INFO - 'TERM': 'linux', 06:28:39 INFO - 'TMOUT': '86400', 06:28:39 INFO - 'USER': 'cltbld', 06:28:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741', 06:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:39 INFO - '_': '/tools/buildbot/bin/python'} 06:28:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 06:28:39 INFO - mozversion application_buildid: 20160728045829 06:28:39 INFO - mozversion application_changeset: 0aa0956567fc0178126434c013070332eb3a6fd7 06:28:39 INFO - mozversion application_display_name: Nightly 06:28:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:39 INFO - mozversion application_name: Firefox 06:28:39 INFO - mozversion application_remotingname: firefox 06:28:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:28:39 INFO - mozversion application_vendor: Mozilla 06:28:39 INFO - mozversion application_version: 50.0a1 06:28:39 INFO - mozversion platform_buildid: 20160728045829 06:28:39 INFO - mozversion platform_changeset: 0aa0956567fc0178126434c013070332eb3a6fd7 06:28:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:28:39 INFO - mozversion platform_version: 50.0a1 06:28:39 INFO - using testdate: 1469712519 06:28:39 INFO - actual date: 1469712519 06:28:39 INFO - starting webserver on 'localhost:34960' 06:28:39 INFO - SUITE-START | Running 2 tests 06:28:39 INFO - TEST-START | dromaeo_css 06:28:39 INFO - operating with platform_type : linux_ 06:28:39 INFO - Initialising browser for dromaeo_css test... 06:28:39 INFO - TEST-INFO | started process 25067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DqmVt/profile http://localhost:34960/getInfo.html) 06:28:42 INFO - PROCESS | 25067 | JavaScript error: , line 0: uncaught exception: undefined 06:28:43 INFO - PROCESS | 25067 | __metrics Screen width/height:1600/1200 06:28:43 INFO - PROCESS | 25067 | colorDepth:24 06:28:43 INFO - PROCESS | 25067 | Browser inner width/height: 1024/697 06:28:43 INFO - PROCESS | 25067 | __metrics 06:28:44 ERROR - PROCESS | 25067 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:28:45 INFO - TEST-INFO | 25067: exit 0 06:28:45 INFO - Browser initialized. 06:28:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:45 INFO - TEST-INFO | started process 25185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DqmVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:57 INFO - PROCESS | 25185 | RSS: Main: 166035456 06:28:57 INFO - PROCESS | 25185 | 06:29:46 INFO - PROCESS | 25185 | 1469712586849 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] 06:31:59 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34960/tests/dromaeo/cssquery-ext.html) 06:32:00 INFO - PROCESS | 25185 | RSS: Main: 167927808 06:32:00 INFO - PROCESS | 25185 | 06:35:02 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-ext.html (next: http://localhost:34960/tests/dromaeo/cssquery-jquery.html) 06:35:03 INFO - PROCESS | 25185 | RSS: Main: 167608320 06:35:03 INFO - PROCESS | 25185 | 06:38:05 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34960/tests/dromaeo/cssquery-mootools.html) 06:38:06 INFO - PROCESS | 25185 | RSS: Main: 171458560 06:38:06 INFO - PROCESS | 25185 | 06:41:07 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34960/tests/dromaeo/cssquery-prototype.html) 06:41:08 INFO - PROCESS | 25185 | RSS: Main: 165892096 06:41:08 INFO - PROCESS | 25185 | 06:44:11 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34960/tests/dromaeo/cssquery-yui.html) 06:44:12 INFO - PROCESS | 25185 | RSS: Main: 168538112 06:44:12 INFO - PROCESS | 25185 | 06:47:14 INFO - PROCESS | 25185 | Cycle 1(1): loaded http://localhost:34960/tests/dromaeo/cssquery-yui.html (next: http://localhost:34960/tests/dromaeo/cssquery-dojo.html) 06:47:15 INFO - PROCESS | 25185 | RSS: Main: 171409408 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | __start_tp_report 06:47:15 INFO - PROCESS | 25185 | _x_x_mozilla_page_load 06:47:15 INFO - PROCESS | 25185 | _x_x_mozilla_page_load_details 06:47:15 INFO - PROCESS | 25185 | |i|pagename|runs| 06:47:15 INFO - PROCESS | 25185 | |0;dojo.html;2642.973570264297;2648.6821581410227;2667.199840047985;2680.758731714145;2695.8786854591553;4703.200455922492;4715.834945776903;4771.451283102444;4775.928361074587;4819.951800481994;4774.928376074362;4797.448293446255;4800.303955926389;4805.1831188697915;4874.317595536619;4384.824607015716;4451.821927122911;4476.529964353745;4495.820167193308;4572.314152877078;4417.88955276119;4472.955270447286;4488.304312831517;4517.751523666197;4529.501754806968;4312;4365.476142862877;4383.561643835623;4406.845760398387;4411.316245981878;4369.366441865912;4397.450318710161;4402.515723270438;4413.955860441387;4441.356003379524;4398.64810815134;4416.205083085043;4461.754603496806;4464.866054018385;4508.008238187626;4745.715257084551;4747.8575642730775;4764.166270902613;4780.737059461728;4854.635902307341;5140.537351638333;5172.2241663750365;5211.270422140866;5211.7915283389;5256.159014557652;5075.441701412841;5197.766100525486;5220.947790522084;5221.843344699665;5238.633295669305;4777.092352453023;4813.542713442217;4825.034993001414;4841.15279826029;4887.0714564232685;5283.418823929364;5314.388845282765;5319.1223448131395;5323.733813309319;5367.624266301399;4960.578350840219;5049.368828896388;5051.924221136685;5055.115354812893;5066.9746651266505;5142.948570514322;5144.7942082316285;5174.120399532088;5199.168133098686;5239.947600524022;5135.2553879687985;5145.9485405146215;5149.2276158576515;5163.974180129076;5208.9739551302;4905.288733133676;5087.923681144785;5129.256257842592;5135.101357262464;5149.304843846107;4334.0248444099825;4334.739915605074;4359.847405340798;4383.298672212494;4405.31717583775;3755.4179102239195;3777.131259810259;3799.7340186186702;3824.3116239077235;3829.7702137871815;4308.9353659695125;4374.321980093091;4419.1824512464655;4428.977855110768;4446.221911165598;5074.771635276422;5164.974175129176;5168.7415629218385;5177.068127736969;5225.216217567396;4466.798994045275;4494.07871386365;4494.415725955605;4498.887527811766;4540.432445944257;4513.616342610849;4633.7683115844075;4691.507391723888;4692.061587682409;4726.409198850144;4813.855584332476;4846.588040016638;4849.903001940012;4857.125717370907;4912.92630610534;5180.093483640423;5184.7926082957765;5185.974070129625;5203.323567936144;5245.186996015624;4727.267273572602;4796.37647105874;4843.491433399583;4849;4886.022795440855;5077.92383114261;5093.286939828353;5117.2068329409;5144.871378215575;5170.663906846043;5211.114110601283;5211.765470553758;5222.764975576184;5235.952809438051;5269.841904742864;4950.801967921243;5062.493750624908;5076.441591425014;5078.695278283167;5079.72061536619;4965.627577931742;5038.571721403721;5053.039922414877;5082.415522214993;5123.743812809419;4914.680545764514;4945.4807245238735;4952.380952380952;4958.355413796184;4983.576396006235;4906.460289368238;5092;5093.286939828501;5099.51554602327;5104.081265372269;4905.681130726492;4909.3372394727685;4930.186519224288;4973.900521989468;4999.775010124626 06:47:15 INFO - PROCESS | 25185 | |1;ext.html;551.7903196785221;566.2779955556665;573.0945106731364;576.8327185116317;581.8923499152654;36125;37100;37156.44265336022;37187.62812371879;37223;39378.40932386016;39808.60191398092;39844.800775996155;39947.20105597886;40060.59484943776;7559.962200188991;7676.1939996300425;7687.115981662097;7697.653605587762;7699.461037727361;7645;7756.495827771177;7762.922370776277;7771.184025677308;7775.1447340792465;7681.7695469136015;7762.45662803604;7790.259925307087;7791.415643826707;7795.14253432122;7702.07575090987;7771.766846994543;7808.960955195216;7809.531428114331;7821.21787821219;7614.809629759245;7665;7678.347340476011;7679.539227646359;7686.461947663665;36255.637443625754;36520.817395913116;36550.817245913866;36555;36597.085072873124;2849.6580410350684;3224.3228921926425;3252;3527.7001454876367;3566.8751593694356;28724.8563757182;29150.562741558893;29207.269818254503;29277.70722292771;29558.852205739047;3272.132884785534;3292.703656670911;3311.9668803311897;3321.8671253149846;3435.158386195373;267441;269328;270434;270533;270568.999999998;31369.37261254808;32769.344613107605;55013;55287.447125529034;55292;33899.830500847835;33963.490547641806;33985;34067.14832129217;34082.73965754281;13601.251931143883;13734.107283026571;13787.931060344634;13793.517226897011;13837.515686950908;10935.398553079498;10950.507227174796;10977.341359518454;11017.83473247902;11025.393603351893;7820.960895195488;7827.295543401121;7836.882446763303;7953.443258971932;7963.641636126388;3092.969070309313;3131.6242050954033;3136.8588413521447;3148.1185268124964;3172.952405713916;766.7738017284914;828.3207769628847;861.3927181337142;895.6551727584797;1008.7730260691433;25396.238112856645;26824.865875670497;26899.86550067237;26959.326016849343;27560.03539876095;795.5544894858898;866.6056944090424;891.5675897189858;971.4656938683696;1074.5164675895878;14194.148351098967;14400.567982960529;14583.41666333356;14624.122552646875;14626.683598476187;415160;419084;419227;420331;420793;48227.276590851165;48653.540393788244;48734.26898596524;48806;48849;1165.5337864854125;1180.533689192764;1191.4221602522769;1194.904407647386;1203.6148432501516;25055.248342549752;25614.87192564025;26070;26191.214263572125;26244.343891402867;41800.581994179665;41854.372184417865;41943.580564193966;42071;42130;363140;364523;365228;365500;366472;24747.752522474544;24962.251132466055;25199.11803086883;25239.495210095327;25289.367765806;40489.392659109544;40916.18167636571;41065;41147.7942610285;42742.358864616435;35537;36466.8176659115;36557.26885462329;36632.633673662924;36772.44841327436;35934.101647457974;36003.099922502144;36409;36591.81704091569;36928.63071369252;29763.55354669725;34622.975532832534;34828.82585587056;34955.65044349524;35034.29931401409;29489;30856.537151943186;30977;31103.84448077745;31241.37517249597;24839.627405589294;25317;25583.744162558138;25818.22545323643;26181 06:47:15 INFO - PROCESS | 25185 | |2;jquery.html;341.54574416026685;349.45136136266063;351.94720791881224;352.99220724830593;372.37255224945966;15389.07665540067;16165.757513637305;16943.322267109303;16991.57521061974;17122.743158852627;14553.289742135186;14676.266186690676;14867.851321486782;14932.253387330617;14940.178290194062;4848.6363522735755;4980.501949805009;5042.268871013701;5070.619703522232;5094.083065048289;3650.671439570438;4906.705597664151;5048.899022019557;5088.465711100337;5632.464915832989;5799.884002319951;5959.493443057346;5967.731452084667;5968.612040217394;5976.671283079429;5871.060630299153;5887.322957859858;5932.733027013774;5959;5960.195373624549;5216.347956505437;5226.660267082628;5228.8692782680355;5229.477052294778;5240.030594340021;20079.598408031758;21165.8941705292;21168.470788230265;21189.576208475744;21314.786852131434;1903.1245627011454;1933.9903300483547;1955.4915721912264;2088.697138914864;2563.641090247348;9130.680426185118;9272.211861991738;9400.670976515858;11829.99445047172;12420.56528021524;1680.2103011584659;1772.087375001875;1775.9289628414847;1778.1109445277361;1781.3498073203189;69903;71238;71624.6418767908;72455.27544724538;73324.63337683331;9669.70990870275;9829;9849.852252216222;10077.69766906994;10088.74778130538;13343.532976345781;13369.398377072861;13382.531611393555;13389.732205356033;13444.058915875794;6948.583085014915;7167.534110282815;7211.819704507429;7407.2592740725495;7411.444141689395;6593.142891424084;6709.429698475684;6866.690998905061;7021.29787021304;7093.716251349992;3989.7606143631474;4113.547509773923;4154.397612346193;4238.766867822299;4275.123599662062;1662.609286817597;1778.2709089273594;1784.9821501785075;1789.4878827390835;1803.801581825998;741.8775901976113;843.5065486690355;884.920357167858;894.695803426825;967.6371360739722;16651.583710407096;17534.386296479563;17596.91201543984;17729.846104776356;17858.821411785975;823.8228780812154;838.6351936907465;869.0483920107472;883.6244596046654;898.6944438890678;9055.456672599665;9839.458829764431;9872.60509579623;9925.454100024424;9968.700938971842;374637;376975;377864;381397;384378;71373;79252.81120783192;80509;80881.59559202167;81128.59435702901;862.7799911022774;879.8020445399734;889.621910687955;902.5126431726925;907.4600612635603;14482.927585362006;14734.336954836843;15788.21058947025;15788.842111579197;16930.291153415394;27432.17703468899;31269.218269542533;36474.35865386011;39908;40390;50397;52425;57381.71309143428;58332.70833645974;60204.39795601988;7386.96306518464;7414.962925185339;7507.286807753255;7611.010568626043;7792.259735325135;8803.823923521622;11514.827277590675;12210.206336588093;12636.684082898;12851.871481285067;10035.949820250851;10188.949055254676;10272.126869216201;10633.787324253317;11088.112950963743;10682.8397574038;11015.669529914116;11086.113110950942;11089.88910110921;11332.263402878787;9372.156505914229;9635.710928672152;9708.75728106803;10431.895681043396;10695.893041069801;7943.6822527100585;7970.083440404428;8063.516189028443;8121.187881211831;8227.876581851157;9730.36752611078;10128;10390.584376625153;10448;10599.940005999339 06:47:15 INFO - PROCESS | 25185 | |3;mootools.html;1327.077681011697;1401.8598140185982;1424.3376829774154;1619.9919000404996;1637.7625244339572;6580.4406625436895;7465.738699145524;7558;7986.760397188086;8025.398095142866;7630.5421674699555;7891.4081443891655;7949.880751788728;7967.243111904374;7990.360771138309;2176.749673787515;2208.216083290433;2211.524522227721;2212.4800671842186;2216.92240771573;2147.2699282244034;2180.1279488204686;2219.0236296029775;2223.0885337011828;2224.210405306117;2162.7080344153496;2172.228858755143;2187.442202238427;2194.47332640166;2203.6694495825595;2111.6093522698275;2115.8201552868027;2121.734783152106;2123.4054464749893;2133.4986278224605;2072.4611600983703;2106.3365040012345;2107.3783233946024;2113.904874280646;2143;7865.095514015847;7911.050673919109;7936.880946785803;7970.322522585587;8022.398320125955;4486.394336764528;4545.590896819269;4570.017446249072;4599.724016559017;4603.953960460386;2799.5520716685232;2841.4459180459817;2889.4943384907556;2898.116074597247;2932.6627437844495;874.7550685807984;900.6487469886683;904.9321300902393;925.7176561148914;930.6975233049286;10330.018648228406;10404;10419.687409377731;10471.581136754521;10490.370577765358;3943.684505239574;4026.8187931543152;4183.205191013698;4186.330187170038;4260.190563792869;8896.644134234688;9035.864462033074;9045.231155351737;9049.049849765812;9078.909210907806;4547.067851090518;4558.2251017327135;4558.384618076583;4566.493057291086;4630.236011058138;3345.0801029716536;3958.604139586076;4065.2276067547073;4193.1404062167185;4202.033532287591;3510.472459828919;3544.6455354464347;3654.104744337601;3676.6507181817683;3679.043448703303;1122.5229277557005;1165.7785020846181;1183.2782002978176;1186.6262127429832;1190.499990004183;749.8162950077157;787.2993036197788;788.2550989315042;792.0890975378246;803.9659661057417;5267.078261304257;5283.9471605284225;5295.364556253197;5370.624056316098;5395.649282796606;387.96702280305925;392.34478421036937;407.6901554818359;421.37425922505054;423.3924318602815;3498.7900725956524;3524.136586536315;3533.5759708835103;3553.147244661263;3611.4178362470434;9365.765855853659;9650.517474126265;9704.902950970541;9705.854412183822;9744.07431294026;9553.61785528571;9665.275104367201;9730.708078757649;9741.951290243504;9773.706788796348;7287.890681639779;7313.195548489662;7354.411647068222;7395.482316237812;7423.331900129015;5003.799848006039;5081.72050537224;5110.003549307849;5244.737763111752;5383.16560933056;8735.737927862174;8811.383203175716;8882.022977472343;8885.91114088851;8930.732078037669;8502.107278735644;8672.826543469222;8740.519271440131;9019.098090190928;9111.17999380059;5718.428157184248;6324.841878953063;6424.839379015375;6450.387213214737;6612.140421745143;7197.064381630355;7251.927480725336;7264.527805692613;7265.818354541178;7303.890441643486;6221.2845522763655;6255.343188965093;6311.2426508819235;6413.326600706859;6427.646479443675;6353.7140828661895;6425.164728585254;6440.742370305135;6441.67791610427;6473.611583305017;5967.91048134287;6064.757409703739;6068.968275393106;6096.8780624388155;6106.877862442815;4274.27337352657;4429.047754732748;4455.086707224947;4472.498826443558;4498.415206023196;4377.912441751084;4444.8444304449185;4497.617702495194;4504.256797628485;4545.477270113979 06:47:15 INFO - PROCESS | 25185 | |4;prototype.html;290.22509898570814;296.2490087627864;302.2564491351276;306.6167290886392;311.4083241840501;5113.948860511394;5141.794328226866;5144.511271429213;5151.784732565;5163.32876726026;5008.146985615327;5020.673656212343;5047.435295058525;5097.745112744357;5125.8988312071215;3774.7168962327796;3784.924301513968;3907.4138879168067;3941.6401341537126;3945.2109578084355;3928.5678575356833;3957.5250969883655;3962.742421742592;3983.760974341534;3987.262356464049;3934.2131573685233;3957.7031722620773;3965.048388386795;3965.385365268374;3969.622885825842;3806.619338066171;3898.67445068678;3926.293267211901;3965.484487016684;3979.8806035818825;3380.239446124602;3383.629629999854;3386.5766779152605;3394.6096198937194;3420.5201229108698;4960.975195124001;4976.35307410038;5001.524855138756;5013.849584512434;5015.799368025311;4416.955830441687;4472.351509031172;4484.170428470743;4508.323751437278;4534.6825722199455;5255.5532779713385;5276.630635855492;5337.146056630921;5360.812371567015;5366.329208848894;3783.129880127586;3787.8484860605545;3803.562590302123;3803.7337386382965;3815.084379748868;5398.757055932531;5591.189277554732;5627.549796016309;5652.265205523297;5658.151277308396;3761.4733937248807;3812.3328417526823;3822.6559609635265;3823.5220597425323;3824.571397162766;3867.7679339239735;3876.8836934891997;3878.9612103879163;3887.7278590498395;3888.51393575803;4463.977680111579;4468.329750537446;4485.820567177341;4493.1013797240685;4501.839117223751;5243.659162154448;5282.260483532308;5357;5382.596305277041;5431.864203394868;1363.2706502021372;1374.8144000559996;1383.2323060701206;1383.979240311396;1388.1879100725987;833.5290560833109;867.913208679127;878.2315473960285;879.5311829245176;885.1944730295529;4481.731096134243;4569.520200378979;4746.786394612251;4749.430068391815;4755.595774359149;5519.834404967857;5532.1425179097305;5544.750486228048;5603.327600687943;5642.887142257214;4615.192341340319;4745.14587374269;4760.857174284777;4773.76131193439;4792.137415265286;2939.5149800282716;2963.866626001835;2965.3328001199557;2969.1834745444744;2972.7175918287726;5203.765830537635;5205.895882082337;5209.270702101709;5223.347081614798;5246.108161612535;5507.366652834895;5649.446402239417;5657.811859509549;5690.4025077367105;5694.4590263924865;5146.147386940624;5187.118189907725;5202.895942081137;5205.427402985669;5217.530422262014;5505.972470137784;5523.4200408956485;5565.888682226414;5574.414686457863;5584.357798853021;5258.447862974333;5378.01520156317;5401.6218864679095;5402.540784033401;5423;5156.4070131935305;5157.7679004444135;5159.355080614923;5168.508991645787;5179.45615710345;3953.0710283084027;3972.5630180679523;3975.1453437511072;3979.0303799619373;3985.342418500915;5361.490658387447;5504;5507.862303442446;5525.502704756591;5529.115341545334;5376;5382.3003009610065;5391.75737091824;5406.621311565683;5426.810061647823;5233.215017747369;5357.437469065848;5369.140937450145;5392.272043274108;5406.972965135306;5270.472952704698;5296.470352964827;5308.654937429054;5322.361316642027;5323.787048518016;5143.537081662668;5249.2651028855225;5412.134058550613;5425.159100339453;5436.211749296409;5261.395274441332;5273.551748101454;5286.920696189637;5287.312649355559;5301.3373328333955 06:47:15 INFO - PROCESS | 25185 | |5;yui.html;596.2606368103553;616.4821549898086;617.6942413505315;626.8808926304005;660.3132741948374;12302.200356976802;12628.305443200621;12814.103012789084;13269.40287687054;13308;12864.163829351086;13178.143420677674;13198;13245.271510066967;13292.534761283358;629.8393909553057;752.289086812962;775.0196002057373;778.4823092643385;780.254856611937;755;778.9805254868617;779.0417786123072;782.4913806026071;782.8903953446522;820.4379999700195;823.7405217356544;824.1552408780988;825.335604838105;825.4263287015526;809.6397103289039;812.6749300279877;812.8496228197803;814.6415577146037;815.6085079162006;595.0508938243495;595.235122867118;595.4700316718124;598.8981873081586;599.3766482857823;12859.807102893465;12948.676283092998;12968.80546791799;12975.221486710732;13000.479980800757;12653.430595623218;12764.680882977907;12860.356982150855;13158.07893447459;13434.731305373936;9746.427521903102;10367.688969330931;10448.947755261252;10555.261131720783;10823.296485728402;3294.4234758917096;3322.4684050551796;3391.253924136686;3679.8344074516713;3727.254549090193;47417;47773.04453910937;47959;48127.03745925062;48148.27777583339;9810.607575696893;9913.65302214419;9915.256355773347;10082.647107351208;10098.192144628412;17742.822571774374;17878.642427151382;17936.282548697905;17947.910260448876;18000.639987200182;6073.908891366633;6108.450239478469;6257.09272155544;6340.365963403623;6407.391297826793;3452.533907922398;3491.6159222485508;3501.089716673632;3515.7011654009184;3576.2311103112434;2846.331112188634;2919.1242627212177;2919.7810164237767;2921;2939.720726530976;489.4036690444705;500.92986981821844;511.2561223419915;516.5222169493204;518.1657531374484;575.6258432019138;602.9397060294024;606.9969650151721;617.561531312764;619.3404024713666;7386.778396648109;7672.42456815741;7690.346320562703;7891.092524359772;8260.8347833043;474.70093840880713;514.1465167821399;569.407815871489;587.7619564076556;607.9179310793074;3602.171500554887;3779.5842457329672;3809.1810260794064;3859.459675645412;3890.144168282973;94955;95982.52008739911;96845.51577242068;97010;100946;84923;86068.56965715131;89858;91073;91808.54095729612;62178;76140.23859761443;76866.99999999888;77508;77819.22180778233;7399.852002960019;7471;7471.439642026979;7491.10106787189;7602.581857997863;32370.514442283857;32545.511817323233;44465.33302000408;45290.773546132055;45383.773081134386;61039;61951.380486196365;62232.68883655553;65246.67376663086;70217.64891175511;9517.191038761783;9654.903450965401;9708.271879608916;10494.52774625159;10832.945835270773;12562.748745024866;12704.491820327083;13125.60623181306;13128.934355328161;13419.932900335436;11334.319940803578;12189.878101218874;12584.685382865502;12589.93705031469;12591.559295424617;12127.575534856238;12495.93752031234;12687.175333603287;12791.36043197855;12985.091043626855;11288.322700637988;11450.541978320774;11451.25566838153;11735.882641173821;11751.177417580688;10122.696319110439;10221.386716797017;10475.109615682752;10525.842112368473;10660.307080039773;9161.49611771359;9460.574274157541;10183.694489165337;10293.125084367912;10328.122109620766 06:47:15 INFO - PROCESS | 25185 | __end_tp_report 06:47:15 INFO - PROCESS | 25185 | __start_cc_report 06:47:15 INFO - PROCESS | 25185 | _x_x_mozilla_cycle_collect,377 06:47:15 INFO - PROCESS | 25185 | __end_cc_report 06:47:15 INFO - PROCESS | 25185 | __startTimestamp1469713635071__endTimestamp 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | ------- Summary: start ------- 06:47:15 INFO - PROCESS | 25185 | Number of tests: 6 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#0] dojo.html Cycles:165 Average:4768.39 Median:4886.02 stddev:510.00 (10.4%) stddev-sans-first:483.54 06:47:15 INFO - PROCESS | 25185 | Values: 2643.0 2648.7 2667.2 2680.8 2695.9 4703.2 4715.8 4771.5 4775.9 4820.0 4774.9 4797.4 4800.3 4805.2 4874.3 4384.8 4451.8 4476.5 4495.8 4572.3 4417.9 4473.0 4488.3 4517.8 4529.5 4312.0 4365.5 4383.6 4406.8 4411.3 4369.4 4397.5 4402.5 4414.0 4441.4 4398.6 4416.2 4461.8 4464.9 4508.0 4745.7 4747.9 4764.2 4780.7 4854.6 5140.5 5172.2 5211.3 5211.8 5256.2 5075.4 5197.8 5220.9 5221.8 5238.6 4777.1 4813.5 4825.0 4841.2 4887.1 5283.4 5314.4 5319.1 5323.7 5367.6 4960.6 5049.4 5051.9 5055.1 5067.0 5142.9 5144.8 5174.1 5199.2 5239.9 5135.3 5145.9 5149.2 5164.0 5209.0 4905.3 5087.9 5129.3 5135.1 5149.3 4334.0 4334.7 4359.8 4383.3 4405.3 3755.4 3777.1 3799.7 3824.3 3829.8 4308.9 4374.3 4419.2 4429.0 4446.2 5074.8 5165.0 5168.7 5177.1 5225.2 4466.8 4494.1 4494.4 4498.9 4540.4 4513.6 4633.8 4691.5 4692.1 4726.4 4813.9 4846.6 4849.9 4857.1 4912.9 5180.1 5184.8 5186.0 5203.3 5245.2 4727.3 4796.4 4843.5 4849.0 4886.0 5077.9 5093.3 5117.2 5144.9 5170.7 5211.1 5211.8 5222.8 5236.0 5269.8 4950.8 5062.5 5076.4 5078.7 5079.7 4965.6 5038.6 5053.0 5082.4 5123.7 4914.7 4945.5 4952.4 4958.4 4983.6 4906.5 5092.0 5093.3 5099.5 5104.1 4905.7 4909.3 4930.2 4973.9 4999.8 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#1] ext.html Cycles:180 Average:48538.43 Median:200466.00 stddev:94439.06 (47.1%) stddev-sans-first:94635.26 06:47:15 INFO - PROCESS | 25185 | Values: 551.8 566.3 573.1 576.8 581.9 36125.0 37100.0 37156.4 37187.6 37223.0 39378.4 39808.6 39844.8 39947.2 40060.6 7560.0 7676.2 7687.1 7697.7 7699.5 7645.0 7756.5 7762.9 7771.2 7775.1 7681.8 7762.5 7790.3 7791.4 7795.1 7702.1 7771.8 7809.0 7809.5 7821.2 7614.8 7665.0 7678.3 7679.5 7686.5 36255.6 36520.8 36550.8 36555.0 36597.1 2849.7 3224.3 3252.0 3527.7 3566.9 28724.9 29150.6 29207.3 29277.7 29558.9 3272.1 3292.7 3312.0 3321.9 3435.2 267441.0 269328.0 270434.0 270533.0 270569.0 31369.4 32769.3 55013.0 55287.4 55292.0 33899.8 33963.5 33985.0 34067.1 34082.7 13601.3 13734.1 13787.9 13793.5 13837.5 10935.4 10950.5 10977.3 11017.8 11025.4 7821.0 7827.3 7836.9 7953.4 7963.6 3093.0 3131.6 3136.9 3148.1 3173.0 766.8 828.3 861.4 895.7 1008.8 25396.2 26824.9 26899.9 26959.3 27560.0 795.6 866.6 891.6 971.5 1074.5 14194.1 14400.6 14583.4 14624.1 14626.7 415160.0 419084.0 419227.0 420331.0 420793.0 48227.3 48653.5 48734.3 48806.0 48849.0 1165.5 1180.5 1191.4 1194.9 1203.6 25055.2 25614.9 26070.0 26191.2 26244.3 41800.6 41854.4 41943.6 42071.0 42130.0 363140.0 364523.0 365228.0 365500.0 366472.0 24747.8 24962.3 25199.1 25239.5 25289.4 40489.4 40916.2 41065.0 41147.8 42742.4 35537.0 36466.8 36557.3 36632.6 36772.4 35934.1 36003.1 36409.0 36591.8 36928.6 29763.6 34623.0 34828.8 34955.7 35034.3 29489.0 30856.5 30977.0 31103.8 31241.4 24839.6 25317.0 25583.7 25818.2 26181.0 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#2] jquery.html Cycles:180 Average:24213.53 Median:4877.67 stddev:62810.60 (1287.7%) stddev-sans-first:62961.22 06:47:15 INFO - PROCESS | 25185 | Values: 341.5 349.5 351.9 353.0 372.4 15389.1 16165.8 16943.3 16991.6 17122.7 14553.3 14676.3 14867.9 14932.3 14940.2 4848.6 4980.5 5042.3 5070.6 5094.1 3650.7 4906.7 5048.9 5088.5 5632.5 5799.9 5959.5 5967.7 5968.6 5976.7 5871.1 5887.3 5932.7 5959.0 5960.2 5216.3 5226.7 5228.9 5229.5 5240.0 20079.6 21165.9 21168.5 21189.6 21314.8 1903.1 1934.0 1955.5 2088.7 2563.6 9130.7 9272.2 9400.7 11830.0 12420.6 1680.2 1772.1 1775.9 1778.1 1781.3 69903.0 71238.0 71624.6 72455.3 73324.6 9669.7 9829.0 9849.9 10077.7 10088.7 13343.5 13369.4 13382.5 13389.7 13444.1 6948.6 7167.5 7211.8 7407.3 7411.4 6593.1 6709.4 6866.7 7021.3 7093.7 3989.8 4113.5 4154.4 4238.8 4275.1 1662.6 1778.3 1785.0 1789.5 1803.8 741.9 843.5 884.9 894.7 967.6 16651.6 17534.4 17596.9 17729.8 17858.8 823.8 838.6 869.0 883.6 898.7 9055.5 9839.5 9872.6 9925.5 9968.7 374637.0 376975.0 377864.0 381397.0 384378.0 71373.0 79252.8 80509.0 80881.6 81128.6 862.8 879.8 889.6 902.5 907.5 14482.9 14734.3 15788.2 15788.8 16930.3 27432.2 31269.2 36474.4 39908.0 40390.0 50397.0 52425.0 57381.7 58332.7 60204.4 7387.0 7415.0 7507.3 7611.0 7792.3 8803.8 11514.8 12210.2 12636.7 12851.9 10035.9 10188.9 10272.1 10633.8 11088.1 10682.8 11015.7 11086.1 11089.9 11332.3 9372.2 9635.7 9708.8 10431.9 10695.9 7943.7 7970.1 8063.5 8121.2 8227.9 9730.4 10128.0 10390.6 10448.0 10599.9 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#3] mootools.html Cycles:180 Average:5047.28 Median:5042.76 stddev:2865.98 (56.8%) stddev-sans-first:2860.38 06:47:15 INFO - PROCESS | 25185 | Values: 1327.1 1401.9 1424.3 1620.0 1637.8 6580.4 7465.7 7558.0 7986.8 8025.4 7630.5 7891.4 7949.9 7967.2 7990.4 2176.7 2208.2 2211.5 2212.5 2216.9 2147.3 2180.1 2219.0 2223.1 2224.2 2162.7 2172.2 2187.4 2194.5 2203.7 2111.6 2115.8 2121.7 2123.4 2133.5 2072.5 2106.3 2107.4 2113.9 2143.0 7865.1 7911.1 7936.9 7970.3 8022.4 4486.4 4545.6 4570.0 4599.7 4604.0 2799.6 2841.4 2889.5 2898.1 2932.7 874.8 900.6 904.9 925.7 930.7 10330.0 10404.0 10419.7 10471.6 10490.4 3943.7 4026.8 4183.2 4186.3 4260.2 8896.6 9035.9 9045.2 9049.0 9078.9 4547.1 4558.2 4558.4 4566.5 4630.2 3345.1 3958.6 4065.2 4193.1 4202.0 3510.5 3544.6 3654.1 3676.7 3679.0 1122.5 1165.8 1183.3 1186.6 1190.5 749.8 787.3 788.3 792.1 804.0 5267.1 5283.9 5295.4 5370.6 5395.6 388.0 392.3 407.7 421.4 423.4 3498.8 3524.1 3533.6 3553.1 3611.4 9365.8 9650.5 9704.9 9705.9 9744.1 9553.6 9665.3 9730.7 9742.0 9773.7 7287.9 7313.2 7354.4 7395.5 7423.3 5003.8 5081.7 5110.0 5244.7 5383.2 8735.7 8811.4 8882.0 8885.9 8930.7 8502.1 8672.8 8740.5 9019.1 9111.2 5718.4 6324.8 6424.8 6450.4 6612.1 7197.1 7251.9 7264.5 7265.8 7303.9 6221.3 6255.3 6311.2 6413.3 6427.6 6353.7 6425.2 6440.7 6441.7 6473.6 5967.9 6064.8 6069.0 6096.9 6106.9 4274.3 4429.0 4455.1 4472.5 4498.4 4377.9 4444.8 4497.6 4504.3 4545.5 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#4] prototype.html Cycles:180 Average:4437.17 Median:5133.85 stddev:1303.65 (25.4%) stddev-sans-first:1269.61 06:47:15 INFO - PROCESS | 25185 | Values: 290.2 296.2 302.3 306.6 311.4 5113.9 5141.8 5144.5 5151.8 5163.3 5008.1 5020.7 5047.4 5097.7 5125.9 3774.7 3784.9 3907.4 3941.6 3945.2 3928.6 3957.5 3962.7 3983.8 3987.3 3934.2 3957.7 3965.0 3965.4 3969.6 3806.6 3898.7 3926.3 3965.5 3979.9 3380.2 3383.6 3386.6 3394.6 3420.5 4961.0 4976.4 5001.5 5013.8 5015.8 4417.0 4472.4 4484.2 4508.3 4534.7 5255.6 5276.6 5337.1 5360.8 5366.3 3783.1 3787.8 3803.6 3803.7 3815.1 5398.8 5591.2 5627.5 5652.3 5658.2 3761.5 3812.3 3822.7 3823.5 3824.6 3867.8 3876.9 3879.0 3887.7 3888.5 4464.0 4468.3 4485.8 4493.1 4501.8 5243.7 5282.3 5357.0 5382.6 5431.9 1363.3 1374.8 1383.2 1384.0 1388.2 833.5 867.9 878.2 879.5 885.2 4481.7 4569.5 4746.8 4749.4 4755.6 5519.8 5532.1 5544.8 5603.3 5642.9 4615.2 4745.1 4760.9 4773.8 4792.1 2939.5 2963.9 2965.3 2969.2 2972.7 5203.8 5205.9 5209.3 5223.3 5246.1 5507.4 5649.4 5657.8 5690.4 5694.5 5146.1 5187.1 5202.9 5205.4 5217.5 5506.0 5523.4 5565.9 5574.4 5584.4 5258.4 5378.0 5401.6 5402.5 5423.0 5156.4 5157.8 5159.4 5168.5 5179.5 3953.1 3972.6 3975.1 3979.0 3985.3 5361.5 5504.0 5507.9 5525.5 5529.1 5376.0 5382.3 5391.8 5406.6 5426.8 5233.2 5357.4 5369.1 5392.3 5407.0 5270.5 5296.5 5308.7 5322.4 5323.8 5143.5 5249.3 5412.1 5425.2 5436.2 5261.4 5273.6 5286.9 5287.3 5301.3 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - PROCESS | 25185 | [#5] yui.html Cycles:180 Average:17310.76 Median:48043.02 stddev:25041.93 (52.1%) stddev-sans-first:25080.73 06:47:15 INFO - PROCESS | 25185 | Values: 596.3 616.5 617.7 626.9 660.3 12302.2 12628.3 12814.1 13269.4 13308.0 12864.2 13178.1 13198.0 13245.3 13292.5 629.8 752.3 775.0 778.5 780.3 755.0 779.0 779.0 782.5 782.9 820.4 823.7 824.2 825.3 825.4 809.6 812.7 812.8 814.6 815.6 595.1 595.2 595.5 598.9 599.4 12859.8 12948.7 12968.8 12975.2 13000.5 12653.4 12764.7 12860.4 13158.1 13434.7 9746.4 10367.7 10448.9 10555.3 10823.3 3294.4 3322.5 3391.3 3679.8 3727.3 47417.0 47773.0 47959.0 48127.0 48148.3 9810.6 9913.7 9915.3 10082.6 10098.2 17742.8 17878.6 17936.3 17947.9 18000.6 6073.9 6108.5 6257.1 6340.4 6407.4 3452.5 3491.6 3501.1 3515.7 3576.2 2846.3 2919.1 2919.8 2921.0 2939.7 489.4 500.9 511.3 516.5 518.2 575.6 602.9 607.0 617.6 619.3 7386.8 7672.4 7690.3 7891.1 8260.8 474.7 514.1 569.4 587.8 607.9 3602.2 3779.6 3809.2 3859.5 3890.1 94955.0 95982.5 96845.5 97010.0 100946.0 84923.0 86068.6 89858.0 91073.0 91808.5 62178.0 76140.2 76867.0 77508.0 77819.2 7399.9 7471.0 7471.4 7491.1 7602.6 32370.5 32545.5 44465.3 45290.8 45383.8 61039.0 61951.4 62232.7 65246.7 70217.6 9517.2 9654.9 9708.3 10494.5 10832.9 12562.7 12704.5 13125.6 13128.9 13419.9 11334.3 12189.9 12584.7 12589.9 12591.6 12127.6 12495.9 12687.2 12791.4 12985.1 11288.3 11450.5 11451.3 11735.9 11751.2 10122.7 10221.4 10475.1 10525.8 10660.3 9161.5 9460.6 10183.7 10293.1 10328.1 06:47:15 INFO - PROCESS | 25185 | -------- Summary: end -------- 06:47:15 INFO - PROCESS | 25185 | 06:47:15 INFO - TEST-INFO | 25185: exit 0 06:47:15 INFO - TEST-OK | dromaeo_css | took 1116365ms 06:47:15 INFO - TEST-START | kraken 06:47:15 INFO - operating with platform_type : linux_ 06:47:15 INFO - Initialising browser for kraken test... 06:47:15 INFO - TEST-INFO | started process 25430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5G7W2y/profile http://localhost:34960/getInfo.html) 06:47:19 INFO - PROCESS | 25430 | JavaScript error: , line 0: uncaught exception: undefined 06:47:20 INFO - PROCESS | 25430 | __metrics Screen width/height:1600/1200 06:47:20 INFO - PROCESS | 25430 | colorDepth:24 06:47:20 INFO - PROCESS | 25430 | Browser inner width/height: 1024/697 06:47:20 INFO - PROCESS | 25430 | __metrics 06:47:20 ERROR - PROCESS | 25430 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:47:21 INFO - TEST-INFO | 25430: exit 0 06:47:21 INFO - Browser initialized. 06:47:21 INFO - Running cycle 1/1 for kraken test... 06:47:21 INFO - TEST-INFO | started process 25548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5G7W2y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:33 INFO - PROCESS | 25548 | RSS: Main: 166506496 06:47:33 INFO - PROCESS | 25548 | 06:47:36 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34960/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:37 INFO - PROCESS | 25548 | RSS: Main: 171417600 06:47:37 INFO - PROCESS | 25548 | 06:47:40 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34960/tests/kraken/driver.html?testName=audio-dft) 06:47:40 INFO - PROCESS | 25548 | RSS: Main: 170221568 06:47:40 INFO - PROCESS | 25548 | 06:47:43 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34960/tests/kraken/driver.html?testName=audio-fft) 06:47:44 INFO - PROCESS | 25548 | RSS: Main: 166920192 06:47:44 INFO - PROCESS | 25548 | 06:47:46 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34960/tests/kraken/driver.html?testName=audio-oscillator) 06:47:47 INFO - PROCESS | 25548 | RSS: Main: 167583744 06:47:47 INFO - PROCESS | 25548 | 06:47:49 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34960/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:49 INFO - PROCESS | 25548 | RSS: Main: 168034304 06:47:49 INFO - PROCESS | 25548 | 06:47:53 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34960/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:53 INFO - PROCESS | 25548 | RSS: Main: 168062976 06:47:53 INFO - PROCESS | 25548 | 06:47:57 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34960/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:57 INFO - PROCESS | 25548 | RSS: Main: 165240832 06:47:57 INFO - PROCESS | 25548 | 06:48:00 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34960/tests/kraken/driver.html?testName=json-parse-financial) 06:48:01 INFO - PROCESS | 25548 | RSS: Main: 167329792 06:48:01 INFO - PROCESS | 25548 | 06:48:03 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34960/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:03 INFO - PROCESS | 25548 | RSS: Main: 167456768 06:48:03 INFO - PROCESS | 25548 | 06:48:05 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:06 INFO - PROCESS | 25548 | RSS: Main: 167919616 06:48:06 INFO - PROCESS | 25548 | 06:48:08 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:09 INFO - PROCESS | 25548 | RSS: Main: 168095744 06:48:09 INFO - PROCESS | 25548 | 06:48:12 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:12 INFO - PROCESS | 25548 | RSS: Main: 168116224 06:48:12 INFO - PROCESS | 25548 | 06:48:15 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:16 INFO - PROCESS | 25548 | RSS: Main: 168280064 06:48:16 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | Cycle 1(1): loaded http://localhost:34960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34960/tests/kraken/driver.html?testName=ai-astar) 06:48:18 INFO - PROCESS | 25548 | RSS: Main: 169062400 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | __start_tp_report 06:48:18 INFO - PROCESS | 25548 | _x_x_mozilla_page_load 06:48:18 INFO - PROCESS | 25548 | _x_x_mozilla_page_load_details 06:48:18 INFO - PROCESS | 25548 | |i|pagename|runs| 06:48:18 INFO - PROCESS | 25548 | |0;ai-astar;106;114;107;114;114;116;116;114;114;114 06:48:18 INFO - PROCESS | 25548 | |1;audio-beat-detection;151;126;153;180;123;156;159;125;195;124 06:48:18 INFO - PROCESS | 25548 | |2;audio-dft;165;163;163;176;164;163;163;165;164;163 06:48:18 INFO - PROCESS | 25548 | |3;audio-fft;75;76;77;169;76;78;76;74;154;78 06:48:18 INFO - PROCESS | 25548 | |4;audio-oscillator;86;86;145;86;85;87;136;85;87;132 06:48:18 INFO - PROCESS | 25548 | |5;imaging-gaussian-blur;118;117;118;118;118;118;119;118;118;118 06:48:18 INFO - PROCESS | 25548 | |6;imaging-darkroom;149;149;149;148;148;148;149;149;148;148 06:48:18 INFO - PROCESS | 25548 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;95;96 06:48:18 INFO - PROCESS | 25548 | |8;json-parse-financial;64;64;62;62;63;62;64;62;63;64 06:48:18 INFO - PROCESS | 25548 | |9;json-stringify-tinderbox;65;66;65;66;67;66;65;66;66;66 06:48:18 INFO - PROCESS | 25548 | |10;stanford-crypto-aes;82;86;80;81;80;81;80;82;85;80 06:48:18 INFO - PROCESS | 25548 | |11;stanford-crypto-ccm;132;131;132;135;141;154;131;134;167;138 06:48:18 INFO - PROCESS | 25548 | |12;stanford-crypto-pbkdf2;170;170;169;177;169;170;168;167;165;167 06:48:18 INFO - PROCESS | 25548 | |13;stanford-crypto-sha256-iterative;69;76;69;75;68;67;68;70;71;68 06:48:18 INFO - PROCESS | 25548 | __end_tp_report 06:48:18 INFO - PROCESS | 25548 | __start_cc_report 06:48:18 INFO - PROCESS | 25548 | _x_x_mozilla_cycle_collect,935 06:48:18 INFO - PROCESS | 25548 | __end_cc_report 06:48:18 INFO - PROCESS | 25548 | __startTimestamp1469713698296__endTimestamp 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | ------- Summary: start ------- 06:48:18 INFO - PROCESS | 25548 | Number of tests: 14 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.48 (3.1%) stddev-sans-first:2.65 06:48:18 INFO - PROCESS | 25548 | Values: 106.0 114.0 107.0 114.0 114.0 116.0 116.0 114.0 114.0 114.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:25.06 (16.2%) stddev-sans-first:26.57 06:48:18 INFO - PROCESS | 25548 | Values: 151.0 126.0 153.0 180.0 123.0 156.0 159.0 125.0 195.0 124.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.98 (2.4%) stddev-sans-first:4.23 06:48:18 INFO - PROCESS | 25548 | Values: 165.0 163.0 163.0 176.0 164.0 163.0 163.0 165.0 164.0 163.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.14 (47.6%) stddev-sans-first:37.72 06:48:18 INFO - PROCESS | 25548 | Values: 75.0 76.0 77.0 169.0 76.0 78.0 76.0 74.0 154.0 78.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:86.00 stddev:25.16 (29.3%) stddev-sans-first:26.06 06:48:18 INFO - PROCESS | 25548 | Values: 86.0 86.0 145.0 86.0 85.0 87.0 136.0 85.0 87.0 132.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:48:18 INFO - PROCESS | 25548 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:48:18 INFO - PROCESS | 25548 | Values: 149.0 149.0 149.0 148.0 148.0 148.0 149.0 149.0 148.0 148.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:48:18 INFO - PROCESS | 25548 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:0.94 (1.5%) stddev-sans-first:0.93 06:48:18 INFO - PROCESS | 25548 | Values: 64.0 64.0 62.0 62.0 63.0 62.0 64.0 62.0 63.0 64.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 06:48:18 INFO - PROCESS | 25548 | Values: 65.0 66.0 65.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:2.16 (2.7%) stddev-sans-first:2.29 06:48:18 INFO - PROCESS | 25548 | Values: 82.0 86.0 80.0 81.0 80.0 81.0 80.0 82.0 85.0 80.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:136.50 stddev:11.92 (8.7%) stddev-sans-first:12.33 06:48:18 INFO - PROCESS | 25548 | Values: 132.0 131.0 132.0 135.0 141.0 154.0 131.0 134.0 167.0 138.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.50 stddev:3.19 (1.9%) stddev-sans-first:3.37 06:48:18 INFO - PROCESS | 25548 | Values: 170.0 170.0 169.0 177.0 169.0 170.0 168.0 167.0 165.0 167.0 06:48:18 INFO - PROCESS | 25548 | 06:48:18 INFO - PROCESS | 25548 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.50 stddev:3.07 (4.4%) stddev-sans-first:3.23 06:48:18 INFO - PROCESS | 25548 | Values: 69.0 76.0 69.0 75.0 68.0 67.0 68.0 70.0 71.0 68.0 06:48:18 INFO - PROCESS | 25548 | -------- Summary: end -------- 06:48:18 INFO - PROCESS | 25548 | 06:48:19 INFO - TEST-INFO | 25548: exit 0 06:48:19 INFO - TEST-OK | kraken | took 63487ms 06:48:19 INFO - SUITE-END | took 1179s 06:48:19 INFO - Completed test suite (00:19:39) 06:48:19 INFO - javascript benchmark 06:48:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6349.3624404010625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.973570264297, 2648.6821581410227, 2667.199840047985, 2680.758731714145, 2695.8786854591553, 4703.200455922492, 4715.834945776903, 4771.451283102444, 4775.928361074587, 4819.951800481994, 4774.928376074362, 4797.448293446255, 4800.303955926389, 4805.1831188697915, 4874.317595536619, 4384.824607015716, 4451.821927122911, 4476.529964353745, 4495.820167193308, 4572.314152877078, 4417.88955276119, 4472.955270447286, 4488.304312831517, 4517.751523666197, 4529.501754806968, 4312.0, 4365.476142862877, 4383.561643835623, 4406.845760398387, 4411.316245981878, 4369.366441865912, 4397.450318710161, 4402.515723270438, 4413.955860441387, 4441.356003379524, 4398.64810815134, 4416.205083085043, 4461.754603496806, 4464.866054018385, 4508.008238187626, 4745.715257084551, 4747.8575642730775, 4764.166270902613, 4780.737059461728, 4854.635902307341, 5140.537351638333, 5172.2241663750365, 5211.270422140866, 5211.7915283389, 5256.159014557652, 5075.441701412841, 5197.766100525486, 5220.947790522084, 5221.843344699665, 5238.633295669305, 4777.092352453023, 4813.542713442217, 4825.034993001414, 4841.15279826029, 4887.0714564232685, 5283.418823929364, 5314.388845282765, 5319.1223448131395, 5323.733813309319, 5367.624266301399, 4960.578350840219, 5049.368828896388, 5051.924221136685, 5055.115354812893, 5066.9746651266505, 5142.948570514322, 5144.7942082316285, 5174.120399532088, 5199.168133098686, 5239.947600524022, 5135.2553879687985, 5145.9485405146215, 5149.2276158576515, 5163.974180129076, 5208.9739551302, 4905.288733133676, 5087.923681144785, 5129.256257842592, 5135.101357262464, 5149.304843846107, 4334.0248444099825, 4334.739915605074, 4359.847405340798, 4383.298672212494, 4405.31717583775, 3755.4179102239195, 3777.131259810259, 3799.7340186186702, 3824.3116239077235, 3829.7702137871815, 4308.9353659695125, 4374.321980093091, 4419.1824512464655, 4428.977855110768, 4446.221911165598, 5074.771635276422, 5164.974175129176, 5168.7415629218385, 5177.068127736969, 5225.216217567396, 4466.798994045275, 4494.07871386365, 4494.415725955605, 4498.887527811766, 4540.432445944257, 4513.616342610849, 4633.7683115844075, 4691.507391723888, 4692.061587682409, 4726.409198850144, 4813.855584332476, 4846.588040016638, 4849.903001940012, 4857.125717370907, 4912.92630610534, 5180.093483640423, 5184.7926082957765, 5185.974070129625, 5203.323567936144, 5245.186996015624, 4727.267273572602, 4796.37647105874, 4843.491433399583, 4849.0, 4886.022795440855, 5077.92383114261, 5093.286939828353, 5117.2068329409, 5144.871378215575, 5170.663906846043, 5211.114110601283, 5211.765470553758, 5222.764975576184, 5235.952809438051, 5269.841904742864, 4950.801967921243, 5062.493750624908, 5076.441591425014, 5078.695278283167, 5079.72061536619, 4965.627577931742, 5038.571721403721, 5053.039922414877, 5082.415522214993, 5123.743812809419, 4914.680545764514, 4945.4807245238735, 4952.380952380952, 4958.355413796184, 4983.576396006235, 4906.460289368238, 5092.0, 5093.286939828501, 5099.51554602327, 5104.081265372269, 4905.681130726492, 4909.3372394727685, 4930.186519224288, 4973.900521989468, 4999.775010124626], "value": 4735.085294655607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7903196785221, 566.2779955556665, 573.0945106731364, 576.8327185116317, 581.8923499152654, 36125.0, 37100.0, 37156.44265336022, 37187.62812371879, 37223.0, 39378.40932386016, 39808.60191398092, 39844.800775996155, 39947.20105597886, 40060.59484943776, 7559.962200188991, 7676.1939996300425, 7687.115981662097, 7697.653605587762, 7699.461037727361, 7645.0, 7756.495827771177, 7762.922370776277, 7771.184025677308, 7775.1447340792465, 7681.7695469136015, 7762.45662803604, 7790.259925307087, 7791.415643826707, 7795.14253432122, 7702.07575090987, 7771.766846994543, 7808.960955195216, 7809.531428114331, 7821.21787821219, 7614.809629759245, 7665.0, 7678.347340476011, 7679.539227646359, 7686.461947663665, 36255.637443625754, 36520.817395913116, 36550.817245913866, 36555.0, 36597.085072873124, 2849.6580410350684, 3224.3228921926425, 3252.0, 3527.7001454876367, 3566.8751593694356, 28724.8563757182, 29150.562741558893, 29207.269818254503, 29277.70722292771, 29558.852205739047, 3272.132884785534, 3292.703656670911, 3311.9668803311897, 3321.8671253149846, 3435.158386195373, 267441.0, 269328.0, 270434.0, 270533.0, 270568.999999998, 31369.37261254808, 32769.344613107605, 55013.0, 55287.447125529034, 55292.0, 33899.830500847835, 33963.490547641806, 33985.0, 34067.14832129217, 34082.73965754281, 13601.251931143883, 13734.107283026571, 13787.931060344634, 13793.517226897011, 13837.515686950908, 10935.398553079498, 10950.507227174796, 10977.341359518454, 11017.83473247902, 11025.393603351893, 7820.960895195488, 7827.295543401121, 7836.882446763303, 7953.443258971932, 7963.641636126388, 3092.969070309313, 3131.6242050954033, 3136.8588413521447, 3148.1185268124964, 3172.952405713916, 766.7738017284914, 828.3207769628847, 861.3927181337142, 895.6551727584797, 1008.7730260691433, 25396.238112856645, 26824.865875670497, 26899.86550067237, 26959.326016849343, 27560.03539876095, 795.5544894858898, 866.6056944090424, 891.5675897189858, 971.4656938683696, 1074.5164675895878, 14194.148351098967, 14400.567982960529, 14583.41666333356, 14624.122552646875, 14626.683598476187, 415160.0, 419084.0, 419227.0, 420331.0, 420793.0, 48227.276590851165, 48653.540393788244, 48734.26898596524, 48806.0, 48849.0, 1165.5337864854125, 1180.533689192764, 1191.4221602522769, 1194.904407647386, 1203.6148432501516, 25055.248342549752, 25614.87192564025, 26070.0, 26191.214263572125, 26244.343891402867, 41800.581994179665, 41854.372184417865, 41943.580564193966, 42071.0, 42130.0, 363140.0, 364523.0, 365228.0, 365500.0, 366472.0, 24747.752522474544, 24962.251132466055, 25199.11803086883, 25239.495210095327, 25289.367765806, 40489.392659109544, 40916.18167636571, 41065.0, 41147.7942610285, 42742.358864616435, 35537.0, 36466.8176659115, 36557.26885462329, 36632.633673662924, 36772.44841327436, 35934.101647457974, 36003.099922502144, 36409.0, 36591.81704091569, 36928.63071369252, 29763.55354669725, 34622.975532832534, 34828.82585587056, 34955.65044349524, 35034.29931401409, 29489.0, 30856.537151943186, 30977.0, 31103.84448077745, 31241.37517249597, 24839.627405589294, 25317.0, 25583.744162558138, 25818.22545323643, 26181.0], "value": 16324.077340936616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.54574416026685, 349.45136136266063, 351.94720791881224, 352.99220724830593, 372.37255224945966, 15389.07665540067, 16165.757513637305, 16943.322267109303, 16991.57521061974, 17122.743158852627, 14553.289742135186, 14676.266186690676, 14867.851321486782, 14932.253387330617, 14940.178290194062, 4848.6363522735755, 4980.501949805009, 5042.268871013701, 5070.619703522232, 5094.083065048289, 3650.671439570438, 4906.705597664151, 5048.899022019557, 5088.465711100337, 5632.464915832989, 5799.884002319951, 5959.493443057346, 5967.731452084667, 5968.612040217394, 5976.671283079429, 5871.060630299153, 5887.322957859858, 5932.733027013774, 5959.0, 5960.195373624549, 5216.347956505437, 5226.660267082628, 5228.8692782680355, 5229.477052294778, 5240.030594340021, 20079.598408031758, 21165.8941705292, 21168.470788230265, 21189.576208475744, 21314.786852131434, 1903.1245627011454, 1933.9903300483547, 1955.4915721912264, 2088.697138914864, 2563.641090247348, 9130.680426185118, 9272.211861991738, 9400.670976515858, 11829.99445047172, 12420.56528021524, 1680.2103011584659, 1772.087375001875, 1775.9289628414847, 1778.1109445277361, 1781.3498073203189, 69903.0, 71238.0, 71624.6418767908, 72455.27544724538, 73324.63337683331, 9669.70990870275, 9829.0, 9849.852252216222, 10077.69766906994, 10088.74778130538, 13343.532976345781, 13369.398377072861, 13382.531611393555, 13389.732205356033, 13444.058915875794, 6948.583085014915, 7167.534110282815, 7211.819704507429, 7407.2592740725495, 7411.444141689395, 6593.142891424084, 6709.429698475684, 6866.690998905061, 7021.29787021304, 7093.716251349992, 3989.7606143631474, 4113.547509773923, 4154.397612346193, 4238.766867822299, 4275.123599662062, 1662.609286817597, 1778.2709089273594, 1784.9821501785075, 1789.4878827390835, 1803.801581825998, 741.8775901976113, 843.5065486690355, 884.920357167858, 894.695803426825, 967.6371360739722, 16651.583710407096, 17534.386296479563, 17596.91201543984, 17729.846104776356, 17858.821411785975, 823.8228780812154, 838.6351936907465, 869.0483920107472, 883.6244596046654, 898.6944438890678, 9055.456672599665, 9839.458829764431, 9872.60509579623, 9925.454100024424, 9968.700938971842, 374637.0, 376975.0, 377864.0, 381397.0, 384378.0, 71373.0, 79252.81120783192, 80509.0, 80881.59559202167, 81128.59435702901, 862.7799911022774, 879.8020445399734, 889.621910687955, 902.5126431726925, 907.4600612635603, 14482.927585362006, 14734.336954836843, 15788.21058947025, 15788.842111579197, 16930.291153415394, 27432.17703468899, 31269.218269542533, 36474.35865386011, 39908.0, 40390.0, 50397.0, 52425.0, 57381.71309143428, 58332.70833645974, 60204.39795601988, 7386.96306518464, 7414.962925185339, 7507.286807753255, 7611.010568626043, 7792.259735325135, 8803.823923521622, 11514.827277590675, 12210.206336588093, 12636.684082898, 12851.871481285067, 10035.949820250851, 10188.949055254676, 10272.126869216201, 10633.787324253317, 11088.112950963743, 10682.8397574038, 11015.669529914116, 11086.113110950942, 11089.88910110921, 11332.263402878787, 9372.156505914229, 9635.710928672152, 9708.75728106803, 10431.895681043396, 10695.893041069801, 7943.6822527100585, 7970.083440404428, 8063.516189028443, 8121.187881211831, 8227.876581851157, 9730.36752611078, 10128.0, 10390.584376625153, 10448.0, 10599.940005999339], "value": 8234.783947772654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.077681011697, 1401.8598140185982, 1424.3376829774154, 1619.9919000404996, 1637.7625244339572, 6580.4406625436895, 7465.738699145524, 7558.0, 7986.760397188086, 8025.398095142866, 7630.5421674699555, 7891.4081443891655, 7949.880751788728, 7967.243111904374, 7990.360771138309, 2176.749673787515, 2208.216083290433, 2211.524522227721, 2212.4800671842186, 2216.92240771573, 2147.2699282244034, 2180.1279488204686, 2219.0236296029775, 2223.0885337011828, 2224.210405306117, 2162.7080344153496, 2172.228858755143, 2187.442202238427, 2194.47332640166, 2203.6694495825595, 2111.6093522698275, 2115.8201552868027, 2121.734783152106, 2123.4054464749893, 2133.4986278224605, 2072.4611600983703, 2106.3365040012345, 2107.3783233946024, 2113.904874280646, 2143.0, 7865.095514015847, 7911.050673919109, 7936.880946785803, 7970.322522585587, 8022.398320125955, 4486.394336764528, 4545.590896819269, 4570.017446249072, 4599.724016559017, 4603.953960460386, 2799.5520716685232, 2841.4459180459817, 2889.4943384907556, 2898.116074597247, 2932.6627437844495, 874.7550685807984, 900.6487469886683, 904.9321300902393, 925.7176561148914, 930.6975233049286, 10330.018648228406, 10404.0, 10419.687409377731, 10471.581136754521, 10490.370577765358, 3943.684505239574, 4026.8187931543152, 4183.205191013698, 4186.330187170038, 4260.190563792869, 8896.644134234688, 9035.864462033074, 9045.231155351737, 9049.049849765812, 9078.909210907806, 4547.067851090518, 4558.2251017327135, 4558.384618076583, 4566.493057291086, 4630.236011058138, 3345.0801029716536, 3958.604139586076, 4065.2276067547073, 4193.1404062167185, 4202.033532287591, 3510.472459828919, 3544.6455354464347, 3654.104744337601, 3676.6507181817683, 3679.043448703303, 1122.5229277557005, 1165.7785020846181, 1183.2782002978176, 1186.6262127429832, 1190.499990004183, 749.8162950077157, 787.2993036197788, 788.2550989315042, 792.0890975378246, 803.9659661057417, 5267.078261304257, 5283.9471605284225, 5295.364556253197, 5370.624056316098, 5395.649282796606, 387.96702280305925, 392.34478421036937, 407.6901554818359, 421.37425922505054, 423.3924318602815, 3498.7900725956524, 3524.136586536315, 3533.5759708835103, 3553.147244661263, 3611.4178362470434, 9365.765855853659, 9650.517474126265, 9704.902950970541, 9705.854412183822, 9744.07431294026, 9553.61785528571, 9665.275104367201, 9730.708078757649, 9741.951290243504, 9773.706788796348, 7287.890681639779, 7313.195548489662, 7354.411647068222, 7395.482316237812, 7423.331900129015, 5003.799848006039, 5081.72050537224, 5110.003549307849, 5244.737763111752, 5383.16560933056, 8735.737927862174, 8811.383203175716, 8882.022977472343, 8885.91114088851, 8930.732078037669, 8502.107278735644, 8672.826543469222, 8740.519271440131, 9019.098090190928, 9111.17999380059, 5718.428157184248, 6324.841878953063, 6424.839379015375, 6450.387213214737, 6612.140421745143, 7197.064381630355, 7251.927480725336, 7264.527805692613, 7265.818354541178, 7303.890441643486, 6221.2845522763655, 6255.343188965093, 6311.2426508819235, 6413.326600706859, 6427.646479443675, 6353.7140828661895, 6425.164728585254, 6440.742370305135, 6441.67791610427, 6473.611583305017, 5967.91048134287, 6064.757409703739, 6068.968275393106, 6096.8780624388155, 6106.877862442815, 4274.27337352657, 4429.047754732748, 4455.086707224947, 4472.498826443558, 4498.415206023196, 4377.912441751084, 4444.8444304449185, 4497.617702495194, 4504.256797628485, 4545.477270113979], "value": 3990.6086113123456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.22509898570814, 296.2490087627864, 302.2564491351276, 306.6167290886392, 311.4083241840501, 5113.948860511394, 5141.794328226866, 5144.511271429213, 5151.784732565, 5163.32876726026, 5008.146985615327, 5020.673656212343, 5047.435295058525, 5097.745112744357, 5125.8988312071215, 3774.7168962327796, 3784.924301513968, 3907.4138879168067, 3941.6401341537126, 3945.2109578084355, 3928.5678575356833, 3957.5250969883655, 3962.742421742592, 3983.760974341534, 3987.262356464049, 3934.2131573685233, 3957.7031722620773, 3965.048388386795, 3965.385365268374, 3969.622885825842, 3806.619338066171, 3898.67445068678, 3926.293267211901, 3965.484487016684, 3979.8806035818825, 3380.239446124602, 3383.629629999854, 3386.5766779152605, 3394.6096198937194, 3420.5201229108698, 4960.975195124001, 4976.35307410038, 5001.524855138756, 5013.849584512434, 5015.799368025311, 4416.955830441687, 4472.351509031172, 4484.170428470743, 4508.323751437278, 4534.6825722199455, 5255.5532779713385, 5276.630635855492, 5337.146056630921, 5360.812371567015, 5366.329208848894, 3783.129880127586, 3787.8484860605545, 3803.562590302123, 3803.7337386382965, 3815.084379748868, 5398.757055932531, 5591.189277554732, 5627.549796016309, 5652.265205523297, 5658.151277308396, 3761.4733937248807, 3812.3328417526823, 3822.6559609635265, 3823.5220597425323, 3824.571397162766, 3867.7679339239735, 3876.8836934891997, 3878.9612103879163, 3887.7278590498395, 3888.51393575803, 4463.977680111579, 4468.329750537446, 4485.820567177341, 4493.1013797240685, 4501.839117223751, 5243.659162154448, 5282.260483532308, 5357.0, 5382.596305277041, 5431.864203394868, 1363.2706502021372, 1374.8144000559996, 1383.2323060701206, 1383.979240311396, 1388.1879100725987, 833.5290560833109, 867.913208679127, 878.2315473960285, 879.5311829245176, 885.1944730295529, 4481.731096134243, 4569.520200378979, 4746.786394612251, 4749.430068391815, 4755.595774359149, 5519.834404967857, 5532.1425179097305, 5544.750486228048, 5603.327600687943, 5642.887142257214, 4615.192341340319, 4745.14587374269, 4760.857174284777, 4773.76131193439, 4792.137415265286, 2939.5149800282716, 2963.866626001835, 2965.3328001199557, 2969.1834745444744, 2972.7175918287726, 5203.765830537635, 5205.895882082337, 5209.270702101709, 5223.347081614798, 5246.108161612535, 5507.366652834895, 5649.446402239417, 5657.811859509549, 5690.4025077367105, 5694.4590263924865, 5146.147386940624, 5187.118189907725, 5202.895942081137, 5205.427402985669, 5217.530422262014, 5505.972470137784, 5523.4200408956485, 5565.888682226414, 5574.414686457863, 5584.357798853021, 5258.447862974333, 5378.01520156317, 5401.6218864679095, 5402.540784033401, 5423.0, 5156.4070131935305, 5157.7679004444135, 5159.355080614923, 5168.508991645787, 5179.45615710345, 3953.0710283084027, 3972.5630180679523, 3975.1453437511072, 3979.0303799619373, 3985.342418500915, 5361.490658387447, 5504.0, 5507.862303442446, 5525.502704756591, 5529.115341545334, 5376.0, 5382.3003009610065, 5391.75737091824, 5406.621311565683, 5426.810061647823, 5233.215017747369, 5357.437469065848, 5369.140937450145, 5392.272043274108, 5406.972965135306, 5270.472952704698, 5296.470352964827, 5308.654937429054, 5322.361316642027, 5323.787048518016, 5143.537081662668, 5249.2651028855225, 5412.134058550613, 5425.159100339453, 5436.211749296409, 5261.395274441332, 5273.551748101454, 5286.920696189637, 5287.312649355559, 5301.3373328333955], "value": 4016.560067867698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.2606368103553, 616.4821549898086, 617.6942413505315, 626.8808926304005, 660.3132741948374, 12302.200356976802, 12628.305443200621, 12814.103012789084, 13269.40287687054, 13308.0, 12864.163829351086, 13178.143420677674, 13198.0, 13245.271510066967, 13292.534761283358, 629.8393909553057, 752.289086812962, 775.0196002057373, 778.4823092643385, 780.254856611937, 755.0, 778.9805254868617, 779.0417786123072, 782.4913806026071, 782.8903953446522, 820.4379999700195, 823.7405217356544, 824.1552408780988, 825.335604838105, 825.4263287015526, 809.6397103289039, 812.6749300279877, 812.8496228197803, 814.6415577146037, 815.6085079162006, 595.0508938243495, 595.235122867118, 595.4700316718124, 598.8981873081586, 599.3766482857823, 12859.807102893465, 12948.676283092998, 12968.80546791799, 12975.221486710732, 13000.479980800757, 12653.430595623218, 12764.680882977907, 12860.356982150855, 13158.07893447459, 13434.731305373936, 9746.427521903102, 10367.688969330931, 10448.947755261252, 10555.261131720783, 10823.296485728402, 3294.4234758917096, 3322.4684050551796, 3391.253924136686, 3679.8344074516713, 3727.254549090193, 47417.0, 47773.04453910937, 47959.0, 48127.03745925062, 48148.27777583339, 9810.607575696893, 9913.65302214419, 9915.256355773347, 10082.647107351208, 10098.192144628412, 17742.822571774374, 17878.642427151382, 17936.282548697905, 17947.910260448876, 18000.639987200182, 6073.908891366633, 6108.450239478469, 6257.09272155544, 6340.365963403623, 6407.391297826793, 3452.533907922398, 3491.6159222485508, 3501.089716673632, 3515.7011654009184, 3576.2311103112434, 2846.331112188634, 2919.1242627212177, 2919.7810164237767, 2921.0, 2939.720726530976, 489.4036690444705, 500.92986981821844, 511.2561223419915, 516.5222169493204, 518.1657531374484, 575.6258432019138, 602.9397060294024, 606.9969650151721, 617.561531312764, 619.3404024713666, 7386.778396648109, 7672.42456815741, 7690.346320562703, 7891.092524359772, 8260.8347833043, 474.70093840880713, 514.1465167821399, 569.407815871489, 587.7619564076556, 607.9179310793074, 3602.171500554887, 3779.5842457329672, 3809.1810260794064, 3859.459675645412, 3890.144168282973, 94955.0, 95982.52008739911, 96845.51577242068, 97010.0, 100946.0, 84923.0, 86068.56965715131, 89858.0, 91073.0, 91808.54095729612, 62178.0, 76140.23859761443, 76866.99999999888, 77508.0, 77819.22180778233, 7399.852002960019, 7471.0, 7471.439642026979, 7491.10106787189, 7602.581857997863, 32370.514442283857, 32545.511817323233, 44465.33302000408, 45290.773546132055, 45383.773081134386, 61039.0, 61951.380486196365, 62232.68883655553, 65246.67376663086, 70217.64891175511, 9517.191038761783, 9654.903450965401, 9708.271879608916, 10494.52774625159, 10832.945835270773, 12562.748745024866, 12704.491820327083, 13125.60623181306, 13128.934355328161, 13419.932900335436, 11334.319940803578, 12189.878101218874, 12584.685382865502, 12589.93705031469, 12591.559295424617, 12127.575534856238, 12495.93752031234, 12687.175333603287, 12791.36043197855, 12985.091043626855, 11288.322700637988, 11450.541978320774, 11451.25566838153, 11735.882641173821, 11751.177417580688, 10122.696319110439, 10221.386716797017, 10475.109615682752, 10525.842112368473, 10660.307080039773, 9161.49611771359, 9460.574274157541, 10183.694489165337, 10293.125084367912, 10328.122109620766], "value": 6421.454557200868, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 114.0, 114.0, 116.0, 116.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 153.0, 180.0, 123.0, 156.0, 159.0, 125.0, 195.0, 124.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 176.0, 164.0, 163.0, 163.0, 165.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 169.0, 76.0, 78.0, 76.0, 74.0, 154.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 145.0, 86.0, 85.0, 87.0, 136.0, 85.0, 87.0, 132.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 63.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 80.0, 81.0, 80.0, 81.0, 80.0, 82.0, 85.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 132.0, 135.0, 141.0, 154.0, 131.0, 134.0, 167.0, 138.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 177.0, 169.0, 170.0, 168.0, 167.0, 165.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 69.0, 75.0, 68.0, 67.0, 68.0, 70.0, 71.0, 68.0], "value": 70.1, "unit": "score"}]}]} 06:48:19 INFO - Return code: 0 06:48:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:48:19 ERROR - # TBPL SUCCESS # 06:48:19 INFO - Running post-action listener: _resource_record_post_action 06:48:19 INFO - [mozharness: 2016-07-28 13:48:19.579410Z] Finished run-tests step (success) 06:48:19 INFO - Running post-run listener: _resource_record_post_run 06:48:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 541028352; Read time: 0; Write time: 439820 06:48:19 INFO - TinderboxPrint: CPU usage
13.3% 06:48:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:48:19 INFO - TinderboxPrint: I/O write bytes / time
541,028,352 / 439,820 06:48:19 INFO - TinderboxPrint: CPU idle
8,279.0 (86.7%) 06:48:19 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 06:48:19 INFO - TinderboxPrint: Swap in / out
0 / 0 06:48:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257175552; Read time: 0; Write time: 267092 06:48:19 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283852800; Read time: 0; Write time: 172728 06:48:20 INFO - Running post-run listener: _upload_blobber_files 06:48:20 INFO - Blob upload gear active. 06:48:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:20 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 06:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:20 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:21 INFO - (blobuploader) - INFO - Done attempting. 06:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:25 INFO - (blobuploader) - INFO - Done attempting. 06:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:48:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:26 INFO - (blobuploader) - INFO - Done attempting. 06:48:26 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:26 INFO - Return code: 0 06:48:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6233da64911e9b379067a7d1b09cbee172865eff6958c5b26693f8881a030bcdbbe98853ae0b0afc5ad232bc3bc7c508db896d2152f07de6b5830c09be8d94d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/785e37ea84fe0346b04477e1fee523f150bb53799e9b4fe962739b26d4c09d6ece80be2f78040513518c77eab47f5d14d32ca016d048ac7c3ab62a6accd95b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fcba3dfddb0c58174ba142fa5e85c13c0b001b33dd21796f5741e6d47867fdb313a14ca1d29dc10e1fc14df0a06f2bbe662554f9b9d60aaa413d7929159abdfb"} 06:48:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:26 INFO - Contents: 06:48:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6233da64911e9b379067a7d1b09cbee172865eff6958c5b26693f8881a030bcdbbe98853ae0b0afc5ad232bc3bc7c508db896d2152f07de6b5830c09be8d94d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/785e37ea84fe0346b04477e1fee523f150bb53799e9b4fe962739b26d4c09d6ece80be2f78040513518c77eab47f5d14d32ca016d048ac7c3ab62a6accd95b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fcba3dfddb0c58174ba142fa5e85c13c0b001b33dd21796f5741e6d47867fdb313a14ca1d29dc10e1fc14df0a06f2bbe662554f9b9d60aaa413d7929159abdfb"} 06:48:26 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:26 INFO - Copying logs to upload dir... 06:48:26 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.630998 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-28 06:48:26.436341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 06:48:26.441697) ========= 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=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 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-Non-PGO/sha512/6233da64911e9b379067a7d1b09cbee172865eff6958c5b26693f8881a030bcdbbe98853ae0b0afc5ad232bc3bc7c508db896d2152f07de6b5830c09be8d94d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/785e37ea84fe0346b04477e1fee523f150bb53799e9b4fe962739b26d4c09d6ece80be2f78040513518c77eab47f5d14d32ca016d048ac7c3ab62a6accd95b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fcba3dfddb0c58174ba142fa5e85c13c0b001b33dd21796f5741e6d47867fdb313a14ca1d29dc10e1fc14df0a06f2bbe662554f9b9d60aaa413d7929159abdfb"} build_url:https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/YM2SLKR4RSG_jYsPAALVVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6233da64911e9b379067a7d1b09cbee172865eff6958c5b26693f8881a030bcdbbe98853ae0b0afc5ad232bc3bc7c508db896d2152f07de6b5830c09be8d94d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/785e37ea84fe0346b04477e1fee523f150bb53799e9b4fe962739b26d4c09d6ece80be2f78040513518c77eab47f5d14d32ca016d048ac7c3ab62a6accd95b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fcba3dfddb0c58174ba142fa5e85c13c0b001b33dd21796f5741e6d47867fdb313a14ca1d29dc10e1fc14df0a06f2bbe662554f9b9d60aaa413d7929159abdfb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 06:48:26.466903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:48:26.467233) ========= 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=923d835db2ba3686ebe126b700000192-1469712468.936196-1339690741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 06:48:26.551599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 06:48:26.551910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 06:48:26.552222) ========= ========= Total master_lag: 0.17 =========