builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1469676074.9 results: success (0) buildid: 20160727173017 builduid: ed12dd8b1b924c6abd3093a09b1f2b8a revision: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:14.899675) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:14.900173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:14.900469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:15.052703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:15.053056) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 20:21:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.2M=0s 2016-07-27 20:21:15 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:15.172898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:15.173282) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:15.222807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 20:21:15.223172) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7c1ddc8223812aed002c47b4a169d7550a7c9c99 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7c1ddc8223812aed002c47b4a169d7550a7c9c99 --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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 20:21:15,441 truncating revision to first 12 chars 2016-07-27 20:21:15,441 Setting DEBUG logging. 2016-07-27 20:21:15,441 attempt 1/10 2016-07-27 20:21:15,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7c1ddc822381?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 20:21:16,700 unpacking tar archive at: fx-team-7c1ddc822381/testing/mozharness/ program finished with exit code 0 elapsedTime=1.664991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 20:21:16.901619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:16.901960) ========= script_repo_revision: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:16.902344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:16.902782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 20:21:16.912569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-27 20:21:16.912903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:21:17 INFO - MultiFileLogger online at 20160727 20:21:17 in /builds/slave/test 20:21:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:21:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:21:17 INFO - {'append_to_log': False, 20:21:17 INFO - 'base_work_dir': '/builds/slave/test', 20:21:17 INFO - 'blob_upload_branch': 'Fx-Team', 20:21:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:21:17 INFO - 'branch': 'Fx-Team', 20:21:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:21:17 INFO - 'config_files': ('talos/linux_config.py',), 20:21:17 INFO - 'default_actions': ('clobber', 20:21:17 INFO - 'read-buildbot-config', 20:21:17 INFO - 'download-and-extract', 20:21:17 INFO - 'populate-webroot', 20:21:17 INFO - 'create-virtualenv', 20:21:17 INFO - 'install', 20:21:17 INFO - 'run-tests'), 20:21:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:21:17 INFO - 'download_minidump_stackwalk': True, 20:21:17 INFO - 'download_symbols': 'ondemand', 20:21:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:21:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:21:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:21:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:21:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:21:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:21:17 INFO - 'installer_path': 'installer.exe', 20:21:17 INFO - 'log_level': 'info', 20:21:17 INFO - 'log_name': 'talos', 20:21:17 INFO - 'log_to_console': True, 20:21:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:21:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:21:17 INFO - 'opt_config_files': (), 20:21:17 INFO - 'pip_index': False, 20:21:17 INFO - 'sps_profile': False, 20:21:17 INFO - 'sps_profile_interval': 0, 20:21:17 INFO - 'suite': 'dromaeojs-e10s', 20:21:17 INFO - 'system_bits': '32', 20:21:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:21:17 INFO - 'title': 'talos-linux64-ix-004', 20:21:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:21:17 INFO - 'use_talos_json': True, 20:21:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:21:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:21:17 INFO - 'work_dir': 'build'} 20:21:17 INFO - [mozharness: 2016-07-28 03:21:17.228743Z] Running clobber step. 20:21:17 INFO - Running pre-action listener: _resource_record_pre_action 20:21:17 INFO - Running main action method: clobber 20:21:17 INFO - rmtree: /builds/slave/test/build 20:21:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:21:17 INFO - Running post-action listener: _resource_record_post_action 20:21:17 INFO - [mozharness: 2016-07-28 03:21:17.696318Z] Finished clobber step (success) 20:21:17 INFO - [mozharness: 2016-07-28 03:21:17.696419Z] Running read-buildbot-config step. 20:21:17 INFO - Running pre-action listener: _resource_record_pre_action 20:21:17 INFO - Running main action method: read_buildbot_config 20:21:17 INFO - Using buildbot properties: 20:21:17 INFO - { 20:21:17 INFO - "project": "", 20:21:17 INFO - "product": "firefox", 20:21:17 INFO - "script_repo_revision": "production", 20:21:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:21:17 INFO - "repository": "", 20:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:21:17 INFO - "buildid": "20160727173017", 20:21:17 INFO - "pgo_build": "True", 20:21:17 INFO - "basedir": "/builds/slave/test", 20:21:17 INFO - "buildnumber": 646, 20:21:17 INFO - "slavename": "talos-linux64-ix-004", 20:21:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:21:17 INFO - "platform": "ubuntu64_hw", 20:21:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:21:17 INFO - "branch": "fx-team", 20:21:17 INFO - "repo_path": "integration/fx-team", 20:21:17 INFO - "revision": "7c1ddc8223812aed002c47b4a169d7550a7c9c99", 20:21:17 INFO - "stage_platform": "linux64-pgo", 20:21:17 INFO - "builduid": "ed12dd8b1b924c6abd3093a09b1f2b8a", 20:21:17 INFO - "slavebuilddir": "test" 20:21:17 INFO - } 20:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:21:17 INFO - Running post-action listener: _resource_record_post_action 20:21:17 INFO - [mozharness: 2016-07-28 03:21:17.698860Z] Finished read-buildbot-config step (success) 20:21:17 INFO - [mozharness: 2016-07-28 03:21:17.698948Z] Running download-and-extract step. 20:21:17 INFO - Running pre-action listener: _resource_record_pre_action 20:21:17 INFO - Running main action method: download_and_extract 20:21:17 INFO - mkdir: /builds/slave/test/build/tests 20:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:17 INFO - https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:18 INFO - Downloaded 1361 bytes. 20:21:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:18 INFO - Using the following test package requirements: 20:21:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:21:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:21:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:21:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'jsshell-linux-x86_64.zip'], 20:21:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:21:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:21:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:21:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:21:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:21:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:21:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:21: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')]} 20:21:18 INFO - https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:19 INFO - Downloaded 24318212 bytes. 20:21:19 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'] 20:21:19 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 20:21:20 INFO - Return code: 0 20:21:20 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 20:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:20 INFO - https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:21 INFO - Downloaded 24318212 bytes. 20:21:21 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'] 20:21:21 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 20:21:22 INFO - Return code: 0 20:21: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')]} 20:21:22 INFO - https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:23 INFO - Downloaded 14413725 bytes. 20:21:23 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'] 20:21:23 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 20:21:24 INFO - Return code: 0 20:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:24 INFO - https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ficJQUfwTH21J-L49Xp77Q/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 20:21:25 INFO - Downloaded 60994033 bytes. 20:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:25 INFO - mkdir: /builds/slave/test/properties 20:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:21:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:21:25 INFO - Contents: 20:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:26 INFO - Running post-action listener: _resource_record_post_action 20:21:26 INFO - Running post-action listener: set_extra_try_arguments 20:21:26 INFO - [mozharness: 2016-07-28 03:21:26.104295Z] Finished download-and-extract step (success) 20:21:26 INFO - [mozharness: 2016-07-28 03:21:26.104526Z] Running populate-webroot step. 20:21:26 INFO - Running pre-action listener: _resource_record_pre_action 20:21:26 INFO - Running main action method: populate_webroot 20:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:21:26 INFO - '--tppagecycles', 20:21:26 INFO - '7'], 20:21:26 INFO - 'tests': ['tsvgm']}}, 20:21:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:21:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:21:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:21:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['damp', 'tps']}, 20:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'tests': ['damp', 'tps']}, 20:21:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['dromaeo_dom']}, 20:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:21:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['basic_compositor_video']}, 20:21:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:21:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['a11yr', 20:21:26 INFO - 'ts_paint', 20:21:26 INFO - 'tpaint', 20:21:26 INFO - 'sessionrestore', 20:21:26 INFO - 'sessionrestore_no_auto_restore', 20:21:26 INFO - 'tabpaint']}, 20:21:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['tsvgx', 20:21:26 INFO - 'tsvgr_opacity', 20:21:26 INFO - 'tart', 20:21:26 INFO - 'tscrollx', 20:21:26 INFO - 'cart']}, 20:21:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:21:26 INFO - 'tsvgr_opacity', 20:21:26 INFO - 'tart', 20:21:26 INFO - 'tscrollx', 20:21:26 INFO - 'cart']}, 20:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'talos_options': ['--disable-e10s'], 20:21:26 INFO - 'tests': ['tp5o']}, 20:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'tests': ['tp5o']}, 20:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'talos_options': ['--disable-e10s', 20:21:26 INFO - '--xperf_path', 20:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:21:26 INFO - 'tests': ['tp5n']}, 20:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:26 INFO - 'talos_options': ['--xperf_path', 20:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:21:26 INFO - 'tests': ['tp5n']}}, 20:21:26 INFO - 'talos.zip': {'path': '', 20:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:21:26 INFO - Running post-action listener: _resource_record_post_action 20:21:26 INFO - [mozharness: 2016-07-28 03:21:26.120967Z] Finished populate-webroot step (success) 20:21:26 INFO - [mozharness: 2016-07-28 03:21:26.121056Z] Running create-virtualenv step. 20:21:26 INFO - Running pre-action listener: _resource_record_pre_action 20:21:26 INFO - Running main action method: create_virtualenv 20:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:21:26 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 20:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:21:26 INFO - Using real prefix '/usr' 20:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:21:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:21:28 INFO - Installing pip.................done. 20:21:28 INFO - Return code: 0 20:21:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:21:28 INFO - Using env: {'DISPLAY': ':0', 20:21:28 INFO - 'HOME': '/home/cltbld', 20:21:28 INFO - 'LANG': 'en_US.UTF-8', 20:21:28 INFO - 'LANGUAGE': 'en_US:en', 20:21:28 INFO - 'LOGNAME': 'cltbld', 20:21:28 INFO - 'MAIL': '/var/mail/cltbld', 20:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:28 INFO - 'MOZ_NO_REMOTE': '1', 20:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:28 INFO - 'NO_EM_RESTART': '1', 20:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:28 INFO - 'PWD': '/builds/slave/test', 20:21:28 INFO - 'SHELL': '/bin/bash', 20:21:28 INFO - 'SHLVL': '1', 20:21:28 INFO - 'TERM': 'linux', 20:21:28 INFO - 'TMOUT': '86400', 20:21:28 INFO - 'USER': 'cltbld', 20:21:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:28 INFO - '_': '/tools/buildbot/bin/python'} 20:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:28 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 20:21:28 INFO - Cleaning up... 20:21:28 INFO - Return code: 0 20:21:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:21:28 INFO - Using env: {'DISPLAY': ':0', 20:21:28 INFO - 'HOME': '/home/cltbld', 20:21:28 INFO - 'LANG': 'en_US.UTF-8', 20:21:28 INFO - 'LANGUAGE': 'en_US:en', 20:21:28 INFO - 'LOGNAME': 'cltbld', 20:21:28 INFO - 'MAIL': '/var/mail/cltbld', 20:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:28 INFO - 'MOZ_NO_REMOTE': '1', 20:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:28 INFO - 'NO_EM_RESTART': '1', 20:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:28 INFO - 'PWD': '/builds/slave/test', 20:21:28 INFO - 'SHELL': '/bin/bash', 20:21:28 INFO - 'SHLVL': '1', 20:21:28 INFO - 'TERM': 'linux', 20:21:28 INFO - 'TMOUT': '86400', 20:21:28 INFO - 'USER': 'cltbld', 20:21:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:28 INFO - '_': '/tools/buildbot/bin/python'} 20:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:29 INFO - Downloading/unpacking psutil>=3.1.1 20:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:21:31 INFO - Installing collected packages: psutil 20:21:31 INFO - Running setup.py install for psutil 20:21:31 INFO - building 'psutil._psutil_linux' extension 20:21:31 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 20:21:31 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 20:21:31 INFO - building 'psutil._psutil_posix' extension 20:21:31 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 20:21:31 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 20:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:21:31 INFO - Successfully installed psutil 20:21:31 INFO - Cleaning up... 20:21:31 INFO - Return code: 0 20:21:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:21:31 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')]} 20:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:31 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')]} 20:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:31 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:31 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 20:21:31 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 20:21:31 INFO - Using env: {'DISPLAY': ':0', 20:21:31 INFO - 'HOME': '/home/cltbld', 20:21:31 INFO - 'LANG': 'en_US.UTF-8', 20:21:31 INFO - 'LANGUAGE': 'en_US:en', 20:21:31 INFO - 'LOGNAME': 'cltbld', 20:21:31 INFO - 'MAIL': '/var/mail/cltbld', 20:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:31 INFO - 'MOZ_NO_REMOTE': '1', 20:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:31 INFO - 'NO_EM_RESTART': '1', 20:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:31 INFO - 'PWD': '/builds/slave/test', 20:21:31 INFO - 'SHELL': '/bin/bash', 20:21:31 INFO - 'SHLVL': '1', 20:21:31 INFO - 'TERM': 'linux', 20:21:31 INFO - 'TMOUT': '86400', 20:21:31 INFO - 'USER': 'cltbld', 20:21:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:31 INFO - '_': '/tools/buildbot/bin/python'} 20:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:21:33 INFO - Installing collected packages: mozsystemmonitor 20:21:33 INFO - Running setup.py install for mozsystemmonitor 20:21:33 INFO - Successfully installed mozsystemmonitor 20:21:33 INFO - Cleaning up... 20:21:34 INFO - Return code: 0 20:21:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:21:34 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')]} 20:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:34 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')]} 20:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:34 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:34 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 20:21:34 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 20:21:34 INFO - Using env: {'DISPLAY': ':0', 20:21:34 INFO - 'HOME': '/home/cltbld', 20:21:34 INFO - 'LANG': 'en_US.UTF-8', 20:21:34 INFO - 'LANGUAGE': 'en_US:en', 20:21:34 INFO - 'LOGNAME': 'cltbld', 20:21:34 INFO - 'MAIL': '/var/mail/cltbld', 20:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:34 INFO - 'MOZ_NO_REMOTE': '1', 20:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:34 INFO - 'NO_EM_RESTART': '1', 20:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:34 INFO - 'PWD': '/builds/slave/test', 20:21:34 INFO - 'SHELL': '/bin/bash', 20:21:34 INFO - 'SHLVL': '1', 20:21:34 INFO - 'TERM': 'linux', 20:21:34 INFO - 'TMOUT': '86400', 20:21:34 INFO - 'USER': 'cltbld', 20:21:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:34 INFO - '_': '/tools/buildbot/bin/python'} 20:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:21:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:21:36 INFO - warning: no files found matching '*.txt' 20:21:36 INFO - no previously-included directories found matching 'build' 20:21:36 INFO - no previously-included directories found matching 'dist' 20:21:36 INFO - no previously-included directories found matching '.git*' 20:21:36 INFO - Installing collected packages: jsonschema, functools32 20:21:36 INFO - Running setup.py install for functools32 20:21:36 INFO - warning: no files found matching '*.txt' 20:21:36 INFO - no previously-included directories found matching 'build' 20:21:36 INFO - no previously-included directories found matching 'dist' 20:21:36 INFO - no previously-included directories found matching '.git*' 20:21:36 INFO - Successfully installed jsonschema functools32 20:21:36 INFO - Cleaning up... 20:21:36 INFO - Return code: 0 20:21:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:21:36 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')]} 20:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:36 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')]} 20:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:36 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:36 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 20:21:36 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 20:21:36 INFO - Using env: {'DISPLAY': ':0', 20:21:36 INFO - 'HOME': '/home/cltbld', 20:21:36 INFO - 'LANG': 'en_US.UTF-8', 20:21:36 INFO - 'LANGUAGE': 'en_US:en', 20:21:36 INFO - 'LOGNAME': 'cltbld', 20:21:36 INFO - 'MAIL': '/var/mail/cltbld', 20:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:36 INFO - 'MOZ_NO_REMOTE': '1', 20:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:36 INFO - 'NO_EM_RESTART': '1', 20:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:36 INFO - 'PWD': '/builds/slave/test', 20:21:36 INFO - 'SHELL': '/bin/bash', 20:21:36 INFO - 'SHLVL': '1', 20:21:36 INFO - 'TERM': 'linux', 20:21:36 INFO - 'TMOUT': '86400', 20:21:36 INFO - 'USER': 'cltbld', 20:21:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:36 INFO - '_': '/tools/buildbot/bin/python'} 20:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:21:36 INFO - Cleaning up... 20:21:36 INFO - Return code: 0 20:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:21:36 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')]} 20:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:36 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')]} 20:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:36 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:36 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 20:21:36 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 20:21:36 INFO - Using env: {'DISPLAY': ':0', 20:21:36 INFO - 'HOME': '/home/cltbld', 20:21:36 INFO - 'LANG': 'en_US.UTF-8', 20:21:36 INFO - 'LANGUAGE': 'en_US:en', 20:21:36 INFO - 'LOGNAME': 'cltbld', 20:21:36 INFO - 'MAIL': '/var/mail/cltbld', 20:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:36 INFO - 'MOZ_NO_REMOTE': '1', 20:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:36 INFO - 'NO_EM_RESTART': '1', 20:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:36 INFO - 'PWD': '/builds/slave/test', 20:21:36 INFO - 'SHELL': '/bin/bash', 20:21:36 INFO - 'SHLVL': '1', 20:21:36 INFO - 'TERM': 'linux', 20:21:36 INFO - 'TMOUT': '86400', 20:21:36 INFO - 'USER': 'cltbld', 20:21:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:36 INFO - '_': '/tools/buildbot/bin/python'} 20:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:37 INFO - Downloading/unpacking blobuploader==1.2.4 20:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:21:39 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 20:21:39 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 20:21:39 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 20:21:39 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 20:21:39 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 20:21:39 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 20:21:39 INFO - Downloading docopt-0.6.1.tar.gz 20:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:21:39 INFO - Running setup.py install for blobuploader 20:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:21:39 INFO - Running setup.py install for requests 20:21:40 INFO - Running setup.py install for docopt 20:21:40 INFO - Successfully installed blobuploader requests docopt 20:21:40 INFO - Cleaning up... 20:21:40 INFO - Return code: 0 20:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:40 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:40 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 20:21:40 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 20:21:40 INFO - Using env: {'DISPLAY': ':0', 20:21:40 INFO - 'HOME': '/home/cltbld', 20:21:40 INFO - 'LANG': 'en_US.UTF-8', 20:21:40 INFO - 'LANGUAGE': 'en_US:en', 20:21:40 INFO - 'LOGNAME': 'cltbld', 20:21:40 INFO - 'MAIL': '/var/mail/cltbld', 20:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:40 INFO - 'MOZ_NO_REMOTE': '1', 20:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:40 INFO - 'NO_EM_RESTART': '1', 20:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:40 INFO - 'PWD': '/builds/slave/test', 20:21:40 INFO - 'SHELL': '/bin/bash', 20:21:40 INFO - 'SHLVL': '1', 20:21:40 INFO - 'TERM': 'linux', 20:21:40 INFO - 'TMOUT': '86400', 20:21:40 INFO - 'USER': 'cltbld', 20:21:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:40 INFO - '_': '/tools/buildbot/bin/python'} 20:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:40 INFO - Running setup.py (path:/tmp/pip-O1KweW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:40 INFO - Running setup.py (path:/tmp/pip-IWCV3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:40 INFO - Running setup.py (path:/tmp/pip-hO647r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:40 INFO - Running setup.py (path:/tmp/pip-GZyLwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:40 INFO - Running setup.py (path:/tmp/pip-3vrjiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:40 INFO - Running setup.py (path:/tmp/pip-U29c0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:40 INFO - Running setup.py (path:/tmp/pip-f_NrTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:41 INFO - Running setup.py (path:/tmp/pip-m9WlPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:41 INFO - Running setup.py (path:/tmp/pip-gFlm5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:41 INFO - Running setup.py (path:/tmp/pip-RqAkrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:41 INFO - Running setup.py (path:/tmp/pip-u0zmmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:41 INFO - Running setup.py (path:/tmp/pip-cPrujO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:41 INFO - Running setup.py (path:/tmp/pip-LQ8WSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:41 INFO - Running setup.py (path:/tmp/pip-zqL3KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:41 INFO - Running setup.py (path:/tmp/pip-xG2UUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:41 INFO - Running setup.py (path:/tmp/pip-S08JXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:41 INFO - Running setup.py (path:/tmp/pip-4a7Qj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:21:41 INFO - Running setup.py install for manifestparser 20:21:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:21:41 INFO - Running setup.py install for mozcrash 20:21:41 INFO - Running setup.py install for mozdebug 20:21:42 INFO - Running setup.py install for mozdevice 20:21:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for mozfile 20:21:42 INFO - Running setup.py install for mozhttpd 20:21:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for mozinfo 20:21:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for mozInstall 20:21:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for mozleak 20:21:42 INFO - Running setup.py install for mozlog 20:21:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for moznetwork 20:21:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:21:42 INFO - Running setup.py install for mozprocess 20:21:42 INFO - Running setup.py install for mozprofile 20:21:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:21:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:21:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:21:43 INFO - Running setup.py install for mozrunner 20:21:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:21:43 INFO - Running setup.py install for mozscreenshot 20:21:43 INFO - Running setup.py install for moztest 20:21:43 INFO - Running setup.py install for mozversion 20:21:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:21:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:21:43 INFO - Cleaning up... 20:21:43 INFO - Return code: 0 20:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:43 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:43 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 20:21:43 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 20:21:43 INFO - Using env: {'DISPLAY': ':0', 20:21:43 INFO - 'HOME': '/home/cltbld', 20:21:43 INFO - 'LANG': 'en_US.UTF-8', 20:21:43 INFO - 'LANGUAGE': 'en_US:en', 20:21:43 INFO - 'LOGNAME': 'cltbld', 20:21:43 INFO - 'MAIL': '/var/mail/cltbld', 20:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:43 INFO - 'MOZ_NO_REMOTE': '1', 20:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:43 INFO - 'NO_EM_RESTART': '1', 20:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:43 INFO - 'PWD': '/builds/slave/test', 20:21:43 INFO - 'SHELL': '/bin/bash', 20:21:43 INFO - 'SHLVL': '1', 20:21:43 INFO - 'TERM': 'linux', 20:21:43 INFO - 'TMOUT': '86400', 20:21:43 INFO - 'USER': 'cltbld', 20:21:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:43 INFO - '_': '/tools/buildbot/bin/python'} 20:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:43 INFO - Running setup.py (path:/tmp/pip-cAaomg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:43 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)) 20:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:43 INFO - Running setup.py (path:/tmp/pip-Cfh3Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:43 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)) 20:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:43 INFO - Running setup.py (path:/tmp/pip-jclFn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:43 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)) 20:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:44 INFO - Running setup.py (path:/tmp/pip-5MJSRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:44 INFO - Running setup.py (path:/tmp/pip-D1UCYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:44 INFO - Running setup.py (path:/tmp/pip-tjkeyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:44 INFO - Running setup.py (path:/tmp/pip-PwEuN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:44 INFO - Running setup.py (path:/tmp/pip-5bgIbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:44 INFO - Running setup.py (path:/tmp/pip-zGv_vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:44 INFO - Running setup.py (path:/tmp/pip-bbU0Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:44 INFO - Running setup.py (path:/tmp/pip-hzS8gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:44 INFO - Running setup.py (path:/tmp/pip-ZE1S5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:44 INFO - Running setup.py (path:/tmp/pip-LXOeC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:44 INFO - Running setup.py (path:/tmp/pip-QVYjAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:44 INFO - Running setup.py (path:/tmp/pip-Zj4D4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:44 INFO - Running setup.py (path:/tmp/pip-Cwp9i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:44 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)) 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:44 INFO - Running setup.py (path:/tmp/pip-b8BeMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:45 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)) 20:21:45 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)) 20:21:45 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)) 20:21:45 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)) 20:21:45 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)) 20:21:45 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)) 20:21:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:21:45 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 20:21:45 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 20:21:45 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 20:21:45 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 20:21:45 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 20:21:45 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 20:21:46 INFO - Downloading blessings-1.6.tar.gz 20:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:21:46 INFO - Installing collected packages: blessings 20:21:46 INFO - Running setup.py install for blessings 20:21:47 INFO - Successfully installed blessings 20:21:47 INFO - Cleaning up... 20:21:47 INFO - Return code: 0 20:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:47 INFO - Reading from file tmpfile_stdout 20:21:47 INFO - Current package versions: 20:21:47 INFO - argparse == 1.2.1 20:21:47 INFO - blessings == 1.6 20:21:47 INFO - blobuploader == 1.2.4 20:21:47 INFO - docopt == 0.6.1 20:21:47 INFO - functools32 == 3.2.3-2 20:21:47 INFO - jsonschema == 2.5.1 20:21:47 INFO - manifestparser == 1.1 20:21:47 INFO - mozInstall == 1.12 20:21:47 INFO - mozcrash == 0.17 20:21:47 INFO - mozdebug == 0.1 20:21:47 INFO - mozdevice == 0.48 20:21:47 INFO - mozfile == 1.2 20:21:47 INFO - mozhttpd == 0.7 20:21:47 INFO - mozinfo == 0.9 20:21:47 INFO - mozleak == 0.1 20:21:47 INFO - mozlog == 3.3 20:21:47 INFO - moznetwork == 0.27 20:21:47 INFO - mozprocess == 0.23 20:21:47 INFO - mozprofile == 0.28 20:21:47 INFO - mozrunner == 6.12 20:21:47 INFO - mozscreenshot == 0.1 20:21:47 INFO - mozsystemmonitor == 0.3 20:21:47 INFO - moztest == 0.7 20:21:47 INFO - mozversion == 1.4 20:21:47 INFO - psutil == 3.1.1 20:21:47 INFO - requests == 1.2.3 20:21:47 INFO - wsgiref == 0.1.2 20:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:47 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 20:21:47 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 20:21:47 INFO - Using env: {'DISPLAY': ':0', 20:21:47 INFO - 'HOME': '/home/cltbld', 20:21:47 INFO - 'LANG': 'en_US.UTF-8', 20:21:47 INFO - 'LANGUAGE': 'en_US:en', 20:21:47 INFO - 'LOGNAME': 'cltbld', 20:21:47 INFO - 'MAIL': '/var/mail/cltbld', 20:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:47 INFO - 'MOZ_NO_REMOTE': '1', 20:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:47 INFO - 'NO_EM_RESTART': '1', 20:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:47 INFO - 'PWD': '/builds/slave/test', 20:21:47 INFO - 'SHELL': '/bin/bash', 20:21:47 INFO - 'SHLVL': '1', 20:21:47 INFO - 'TERM': 'linux', 20:21:47 INFO - 'TMOUT': '86400', 20:21:47 INFO - 'USER': 'cltbld', 20:21:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:47 INFO - '_': '/tools/buildbot/bin/python'} 20:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 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)) 20:21:47 INFO - Cleaning up... 20:21:47 INFO - Return code: 0 20:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 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 0x10c7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1388180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', '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 20:21:47 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 20:21:47 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 20:21:47 INFO - Using env: {'DISPLAY': ':0', 20:21:47 INFO - 'HOME': '/home/cltbld', 20:21:47 INFO - 'LANG': 'en_US.UTF-8', 20:21:47 INFO - 'LANGUAGE': 'en_US:en', 20:21:47 INFO - 'LOGNAME': 'cltbld', 20:21:47 INFO - 'MAIL': '/var/mail/cltbld', 20:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:47 INFO - 'MOZ_NO_REMOTE': '1', 20:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:47 INFO - 'NO_EM_RESTART': '1', 20:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:47 INFO - 'PWD': '/builds/slave/test', 20:21:47 INFO - 'SHELL': '/bin/bash', 20:21:47 INFO - 'SHLVL': '1', 20:21:47 INFO - 'TERM': 'linux', 20:21:47 INFO - 'TMOUT': '86400', 20:21:47 INFO - 'USER': 'cltbld', 20:21:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:47 INFO - '_': '/tools/buildbot/bin/python'} 20:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:21:47 INFO - Cleaning up... 20:21:47 INFO - Return code: 0 20:21:47 INFO - Running post-action listener: _resource_record_post_action 20:21:47 INFO - Running post-action listener: _start_resource_monitoring 20:21:47 INFO - Starting resource monitoring. 20:21:47 INFO - [mozharness: 2016-07-28 03:21:47.843741Z] Finished create-virtualenv step (success) 20:21:47 INFO - [mozharness: 2016-07-28 03:21:47.844215Z] Running install step. 20:21:47 INFO - Running pre-action listener: _resource_record_pre_action 20:21:47 INFO - Running main action method: install 20:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:48 INFO - Reading from file tmpfile_stdout 20:21:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:21:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:21:48 INFO - Reading from file tmpfile_stdout 20:21:48 INFO - Output received: 20:21:48 INFO - Usage: mozinstall [options] installer 20:21:48 INFO - Options: 20:21:48 INFO - -h, --help show this help message and exit 20:21:48 INFO - -d DEST, --destination=DEST 20:21:48 INFO - Directory to install application into. [default: 20:21:48 INFO - "/builds/slave/test"] 20:21:48 INFO - --app=APP Application being installed. [default: firefox] 20:21:48 INFO - mkdir: /builds/slave/test/build/application 20:21:48 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'] 20:21:48 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 20:22:05 INFO - Reading from file tmpfile_stdout 20:22:05 INFO - Output received: 20:22:05 INFO - /builds/slave/test/build/application/firefox/firefox 20:22:05 INFO - Running post-action listener: _resource_record_post_action 20:22:05 INFO - [mozharness: 2016-07-28 03:22:05.440130Z] Finished install step (success) 20:22:05 INFO - [mozharness: 2016-07-28 03:22:05.440376Z] Running run-tests step. 20:22:05 INFO - Running pre-action listener: _resource_record_pre_action 20:22:05 INFO - Running main action method: run_tests 20:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:22:05 INFO - Python 2.7.3 20:22:05 INFO - Return code: 0 20:22:05 INFO - grabbing minidump binary from tooltool 20:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:05 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 0x13863b0>, '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 0x13872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:22:05 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 20:22:05 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 20:22:05 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 20:22:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:22:05 INFO - Return code: 0 20:22:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:22:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:22:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:22:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:22:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 20:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 20:22:05 INFO - Using env: {'DISPLAY': ':0', 20:22:05 INFO - 'HOME': '/home/cltbld', 20:22:05 INFO - 'LANG': 'en_US.UTF-8', 20:22:05 INFO - 'LANGUAGE': 'en_US:en', 20:22:05 INFO - 'LOGNAME': 'cltbld', 20:22:05 INFO - 'MAIL': '/var/mail/cltbld', 20:22:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:22:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:05 INFO - 'MOZ_NO_REMOTE': '1', 20:22:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:05 INFO - 'NO_EM_RESTART': '1', 20:22:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:05 INFO - 'PWD': '/builds/slave/test', 20:22:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:22:05 INFO - 'SHELL': '/bin/bash', 20:22:05 INFO - 'SHLVL': '1', 20:22:05 INFO - 'TERM': 'linux', 20:22:05 INFO - 'TMOUT': '86400', 20:22:05 INFO - 'USER': 'cltbld', 20:22:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294', 20:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:05 INFO - '_': '/tools/buildbot/bin/python'} 20:22:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 20:22:05 INFO - mozversion application_buildid: 20160727173017 20:22:05 INFO - mozversion application_changeset: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 20:22:05 INFO - mozversion application_display_name: Nightly 20:22:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:22:05 INFO - mozversion application_name: Firefox 20:22:05 INFO - mozversion application_remotingname: firefox 20:22:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:22:05 INFO - mozversion application_vendor: Mozilla 20:22:05 INFO - mozversion application_version: 50.0a1 20:22:05 INFO - mozversion platform_buildid: 20160727173017 20:22:05 INFO - mozversion platform_changeset: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 20:22:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:22:05 INFO - mozversion platform_version: 50.0a1 20:22:05 INFO - using testdate: 1469676125 20:22:05 INFO - actual date: 1469676125 20:22:05 INFO - starting webserver on 'localhost:39713' 20:22:05 INFO - SUITE-START | Running 2 tests 20:22:05 INFO - TEST-START | dromaeo_css 20:22:05 INFO - operating with platform_type : linux_ 20:22:05 INFO - Initialising browser for dromaeo_css test... 20:22:05 INFO - TEST-INFO | started process 7221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE_vpy/profile http://localhost:39713/getInfo.html) 20:22:09 INFO - PROCESS | 7221 | JavaScript error: , line 0: uncaught exception: undefined 20:22:10 INFO - PROCESS | 7221 | __metrics Screen width/height:1600/1200 20:22:10 INFO - PROCESS | 7221 | colorDepth:24 20:22:10 INFO - PROCESS | 7221 | Browser inner width/height: 1024/697 20:22:10 INFO - PROCESS | 7221 | __metrics 20:22:10 ERROR - PROCESS | 7221 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:22:11 INFO - TEST-INFO | 7221: exit 0 20:22:11 INFO - Browser initialized. 20:22:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:22:11 INFO - TEST-INFO | started process 7341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE_vpy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:23 INFO - PROCESS | 7341 | RSS: Main: 164962304 20:22:23 INFO - PROCESS | 7341 | 20:23:13 INFO - PROCESS | 7341 | 1469676193094 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] 20:25:21 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39713/tests/dromaeo/cssquery-ext.html) 20:25:22 INFO - PROCESS | 7341 | RSS: Main: 169861120 20:25:22 INFO - PROCESS | 7341 | 20:28:24 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-ext.html (next: http://localhost:39713/tests/dromaeo/cssquery-jquery.html) 20:28:24 INFO - PROCESS | 7341 | RSS: Main: 166522880 20:28:24 INFO - PROCESS | 7341 | 20:31:26 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39713/tests/dromaeo/cssquery-mootools.html) 20:31:27 INFO - PROCESS | 7341 | RSS: Main: 170934272 20:31:27 INFO - PROCESS | 7341 | 20:34:29 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39713/tests/dromaeo/cssquery-prototype.html) 20:34:29 INFO - PROCESS | 7341 | RSS: Main: 165847040 20:34:29 INFO - PROCESS | 7341 | 20:37:32 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39713/tests/dromaeo/cssquery-yui.html) 20:37:32 INFO - PROCESS | 7341 | RSS: Main: 167706624 20:37:32 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | Cycle 1(1): loaded http://localhost:39713/tests/dromaeo/cssquery-yui.html (next: http://localhost:39713/tests/dromaeo/cssquery-dojo.html) 20:40:35 INFO - PROCESS | 7341 | RSS: Main: 170848256 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | __start_tp_report 20:40:35 INFO - PROCESS | 7341 | _x_x_mozilla_page_load 20:40:35 INFO - PROCESS | 7341 | _x_x_mozilla_page_load_details 20:40:35 INFO - PROCESS | 7341 | |i|pagename|runs| 20:40:35 INFO - PROCESS | 7341 | |0;dojo.html;3089.953650695239;3103.270731378127;3135.1378370947987;3138.1370123216125;3143.1670607289057;5312.203169524573;5350.7859685612575;5354.384245811732;5415.566754659628;5419.756110975006;5381.81163659272;5386.622936394454;5404.540614047801;5452.727363631822;5465.180222966557;4836.903261934768;4920.70475771453;4935.777889994941;4978.128827455199;4984.651074424792;4930.457649658535;4953.380827396575;5010.398752149729;5026;5054.064997975368;4864.489228630996;4883.804647814083;4904.730239836807;4925.556699897009;5006.199008158677;4907.950920490785;4908.656394052417;4909.337239472661;4913;4986.626003049786;4899.8775030624165;4904.5340692634145;4921.827736029258;4930;4982.60139188864;5323.866903327448;5342.091844386464;5404.216388623667;5425.403205647375;5493.587980901449;5796.072628379439;5808.244928159313;5817.156512305692;5821.592488525805;5848.5321174305955;5863.2670916135485;5881.029630111027;5886.970565147147;5894.58737888348;5902.793402230901;5295.993761185362;5463.508284254396;5490.423505531941;5490.780368785244;5584.5811564132855;5999.910001349983;6001.369856165127;6009.459148676553;6023.939760602426;6033.034714445667;5761;5774.191613174159;5779.2775903012125;5787.681677507778;5790.88418231633;5608.1587761835235;5797.072468405035;5836.678982655994;5837.503812176013;5931.58478906481;5564.638298510584;5702.857428564319;5783.59514833966;5793.7392817323325;5803.419658034163;5840.3575606683235;5841.766329346863;5850.151727999416;5852.385499522574;5859.384764599741;4353.064091220403;4405.471343438808;4408.559144085566;4469.955300447019;4478.261086920622;3912.315344814703;3980.5422376426504;3989.2420440116284;3989.960100399017;4018.8392464301687;5556.91664625031;5585.357683866326;5588.580856435784;5592.105263157957;5650.7174641267775;5615.803446879339;5879.5002424794375;5922.644641321534;5937.732802023919;5938.554608404387;5594.524465420485;5607.495325420732;5640.8871822563315;5660.433956604306;5677.063284558084;5031.22016087507;5083.212102124176;5083.61872859537;5088.542031217208;5133.204353325241;5889.617174883619;6107.572469927062;6110.694465276719;6113.083037544404;6117.235345581802;5767.596268261265;5792.7103644818435;5803.883922321445;5853.64878107315;5896.498797602252;5987.6108052976415;6009.639421634716;6012.759489620366;6033.18551995475;6059.030555111161;5627.296587926509;5678;5741.311042674905;5742.425757424224;5754.942450575608;5827.650340979555;5839.445252700986;5850.795222167204;5898.8230353089475;5947.316058653138;5726.455986681259;5742.942570574241;5744.712764361849;5752.28096487939;5765.538756899522;5467.425920278313;5720.141978703228;5734.655920644775;5743.655380677173;5743.6840973745175;5661.518770904519;5717.313922329347;5724.74238659253;5724.771009159587;5760.884782304414;5797.420257974169;5819.76720931158;5848.181254624441;5853.824385268449;5856.619319744203;5412.458754124556;5629.408912064175;5695.373508914099;5711.771529138788;5731.283589551306 20:40:35 INFO - PROCESS | 7341 | |1;ext.html;531.410134750427;564.8841987392585;569.3736889421637;583.6439771739241;589.4488653109341;31565.68434315656;40900.59099409005;41414.585854141485;41530.16939661205;41624;43973.78013109938;44490.555094449046;44501.554984450144;44561.777191114;44569;8973.371863969509;9101.815564264562;9130.77173070672;9135.17783399494;9135.68025119121;8855.247303979137;8864.822703545926;8958.820823583525;8988.191062804346;8995.955020224923;9029;9079.500627465486;9092.727218183432;9094.636214551443;9106.817863642724;8923.15230053144;8942.687005954793;8965;8972.551372431351;8986.550672466416;8892.955535222347;8945.418547794437;8991.190792828676;9013.36906416551;9015.36892417531;41968.79015604933;42569;42571.148577028594;42605.78697106495;42777.35833962493;3489.685928266468;3530.1704099536587;3620.8008559529217;3671.173985853162;3671.504346913159;32470.675293247;32521.837390813133;32620.347593048005;32710.83644581762;32713.83643081793;4246.363045543162;4308.289132293168;4331.610155086058;4334.089841133366;4355.455568053993;349884;351942;352287.99999999744;352772;355725;49937.250941235914;50202.246966295534;50255.74872125616;50341.74829125904;50356.496435035915;34952;35952.82023589865;35979.280414391564;59535.70232148811;59633;15441.459548915958;15534.067955922681;15598.610034748996;15642.139682317582;15666.216689165496;10670.786584268271;10719.19606029551;10846.18653600983;10847.67456976292;10921.672349829518;19272.421827345202;19342.903285483764;19461.51346216356;19473.90263048704;19505.219791208478;7170.533915295593;7229.132504099542;7305.415566754753;7321;7392.852142957218;1012.6506355307407;1024.2113572549094;1030.6083688198437;1031.2265800649513;1104.3760275444508;31666.525002124985;32645.51031734526;33138.66861331404;33643.327133457686;33771.83114084414;1106.0322218059198;1106.7952428800536;1109.4896347680158;1179.351356753782;1192.4276347353318;17213.22540485681;17270.654586908193;17488.737668934977;17513.299468021138;17560.29758809633;565453;566528;568185;573256;573776;57831.13253301204;57954.71022644944;58043.70978145082;58255.41744582585;58361.70819145877;1272.3765354975994;1318.3013003108176;1328.4088580581742;1334.3128288931402;1337.6923307639297;31107.37785244328;31918.68081319157;33002.504962426065;33212.335753284315;33338.499922501665;54530.72734636301;54926.72536637291;55458.168127477315;55495;55617.72191139018;528566;533192;534614;535038;535195;44382;44392.778036109616;44553.65847561381;44973.32540011968;45044.32433513566;47937.280940786615;48341.27488087611;48704.51295487142;48868;50148.49851501584;40789.592104078576;41087;41872.6970016652;42770.35844462398;43249.78375108104;41627.583724162374;42426.78786606047;42516;42971.57028429676;43163;35254.471182932786;37216.44175337426;40941.1811763769;41278.174436511705;41998.79000604978;32695.836520818197;35579;36813.63186368102;37685.623143768215;38978.80510597429;28857.567136493388;29128.854355728086;29222.56166157467;29246.415071698022;29267.121986340444 20:40:35 INFO - PROCESS | 7341 | |2;jquery.html;381.717529028519;386.7664239019663;388.2196784463229;393.41970593374765;413.72900750008756;13589.728205435886;18271;18480.630387392244;19812.20751169955;19839.801601983974;18805.717914231296;18946.715799262987;19323.613527729438;19430.514237144078;19507.317243896465;5582.330120385549;5692.288463942007;5694.544436445074;5743.741531631065;5747.3677895431465;5534.944650553503;5607.971960140214;5658.207850900877;5659.886802263953;5673.347565030012;5515.779368825242;5618.185363122345;5629.3526244482;5757.481826635602;5833.3874943130995;5791.189233507313;5807.274090738658;5832.037713777243;5988.9101663475085;6255.343188965184;5741.282339707536;5813.447722466359;5863.5016023638045;5872.882542349172;5874.7943821966455;13390.598282051456;13517.526886559022;13562.593122206252;13623.25072121033;13781.517646882412;2324.8140148788057;2348.2955113466064;2491.0783010286127;2542.313575334668;2841.0908509277037;9560.426374417557;9992.200623950139;10104.646337378157;10170.18638508925;10236.641717539851;1810.5383127302453;1829.5151784777045;1885.70771530413;1976.4268362175096;1998.1108406759;77582.6120869392;81536;82782.9999999994;82990;84253.57873210595;10698.251122421356;10877.945610272056;10950.014498695156;11071.225014248925;11090.833637495443;15179.544613661608;15223.923880380527;15248.390064397521;15310;15380.384784608714;7473.663685134182;7792.805179870548;7934.603269836485;8084.474509157004;8110.675572977133;7366.815829604196;7367.26327367259;7434.070741157356;7582;7624.8475030500185;4633.559811817872;4641.976790116096;4671.369365135731;4729.125111854318;4834.734089625104;1947.9610407791765;1956.5499935015025;1964.774050984155;1970.1429878003114;2001.119507416761;985.9605615775289;1003.6687892995294;1009.8535712321673;1044.6709286574705;1052.6315789473622;19231.615367692848;19612.607747844962;19788.50528736793;19867.60264794696;20023.09896054652;935.5462600638684;981.2052237687496;1004.829179039565;1013.6502906497246;1029.8867124616286;10443.381275902095;10911.181661375429;10967.396793176293;11027.338359698444;11120.165987550805;450067;459397;474246;482733;483937;89735.55132224428;92141.77503787335;92779.53610231906;93491.53254233685;93765.5311723437;963.6819849449524;992.8361820299714;1010.3382284603597;1013.2299452416216;1016.9084782369622;16478.25847836826;17104.401345952832;17462.738058928873;17555.473335799947;17676.823231767517;39839.20321593494;41455.58544414638;41507.58492415158;41589;42499;57358.13962790645;57797;58657.4134258652;59031;59862;7923.20767923203;7943.721969731032;7954.403419743659;7968.0836703779805;8300.04549476818;9249.352545321763;11792.056635469313;11991.64025079249;12491.93754031224;12661.177023493443;10596;10712.143028557852;10807.13542916549;10850.67447976562;10964.890351096386;10240.334378265388;10637.202209834448;10651.467426628793;10652.09457196147;10741.409222492837;10603.89396106029;10650.307729997836;10763.94618026905;10878.40168790724;11322.037626801484;7867.842643146991;7901.960490197513;8036.758897233092;8051.315638170821;8099.352051835721;8104.83790324202;9795.804083918425;10364.481775911023;10660.73348166271;11042.944785276022 20:40:35 INFO - PROCESS | 7341 | |3;mootools.html;1483.0191315455934;1500.6923580665964;1609.2838686784378;1706.8719846011536;1727.1795896948952;7515;8289.544075075868;8364.163583641634;8833.69082082128;8846.557672116392;8683.739487815375;8698.565071746403;8779.912200877989;8801.031886492481;8810.339224558167;2324.0013588314077;2339.2163625185585;2365.4914193448403;2366.1954935321987;2366.4438856868624;2295.8507696999727;2308.3075077476774;2350.2949115265437;2361.1381845626393;2367.822413318999;2310.4108452344713;2319.5940710375703;2332;2343.625019996792;2367.30164601443;2298.7356454007836;2308.2613563659634;2315.7221133463922;2322.15241436876;2326.8603883767028;2239.3393948785147;2242.786935241166;2251.1445650652813;2253.1663284584642;2260.547890421922;8857.601407936594;8938.731838044869;8978.371513994023;8997.955010224907;8998.190162885372;5027.4721154279005;5162.793488260465;5167.7932882684645;5173.844784656429;5174.068667639824;3118.5166299223656;3134.451470992567;3172.841357932094;3201.3437245364644;3253.235489659928;1083.5286650307062;1089.4389389464432;1099.2525082943596;1105.1876870500175;1110.4447776111945;11912.34482103484;11940.522379104825;11957.641270761891;11979.820302695467;12035.277883327028;4379.562043795659;4413.360062790877;4498.077894031716;4539.841105561355;4594.747288899142;10306.793864122676;10317.896821031844;10322.793544129076;10330.741731456623;10333.534990925426;5195.350581177353;5195.6622819516615;5209.635325527177;5224.582033437316;5228.4510126436935;4147.440095587118;4488.842890498817;4572.7942242599165;4586.564276393738;4795.664303498722;3834.9616503835164;3892.980535097363;3962.227365663668;4002.199560087994;4014.9397759033636;1162.68607475981;1235.1539195651008;1235.932023738703;1241.74544218435;1243.421808858885;981.4209616326401;993.1756641987133;1009.1018993096151;1022.2997246885907;1033.4419413516766;5928.555358348055;6093.847653808691;6167.784127555514;6252.9370007098905;6277.748890044347;459.3958943988644;478.17992143474106;481.0547274605417;484.8303093917101;1052.710504611238;4200.894977625584;4399.714018588781;4449.844255451044;4453.398791163217;4468.061707041557;10070.546825392876;10386.636467723594;10403.739906502398;10442.321249118782;10446.268761186644;10331.48342582868;10346.172306215485;10356.17150627948;10358.274920755475;10369.844452333222;7397.852042959218;7612.885806712904;7659.157492675801;7871.0948240951875;7946.9271648327895;6081.695915204134;6082.695865206811;6126.5711400203345;6296.968515157395;6367.299597044414;9839.901600983898;10261.538230779783;10296.124829389286;10368.429736364573;10381.636642717469;10092.394456332644;10169.89830101719;10310.278280520291;10315.948420257851;10318.226133040202;7054.541454805421;7515.962420187864;7667.0416197975255;7803.804904877196;7903.288704016666;8504.574771261288;8562.315014798676;8594.527300998505;8601.580739177965;8623.310135189295;7646.31183193493;7765.72819951299;7810.062792464941;7935.2064793522495;7974.641141148778;7513.39892808563;7532.736354227576;7540.208278130717;7625.504342217738;7673.4244931631465;6826.41975432074;6934.965325173342;6941.687624057031;6950.826229344307;6959.652017399211;5320.760565774627;5326.25432439451;5354.7858085676135;5401.459854014567;5553.222548843246;5314.760835762478;5369.3556773187465;5395;5431.321084864392;5459.781608735765 20:40:35 INFO - PROCESS | 7341 | |4;prototype.html;325.69710169542316;332.3469382663067;332.9367420190164;342.1241621449091;344.05728304445825;5437.776500287433;5458.590605704578;5607.186957891104;5636.605437619363;5643.351014633318;5477.5070243678065;5522.751476183571;5565.582581306408;5581.4371975846725;5584.966781145491;4362.498312694033;4368.453943257085;4375.571557785428;4376.102898905732;4387.451568553931;4131.5248746394245;4311.6335111515555;4351.173277077361;4384.342348647697;4414.536473670267;4280.272353699863;4282.486101667789;4282.635975942048;4282.914341713164;4284.2930916398755;4280.850170244042;4286.97856510717;4320.805563749639;4324.870253892388;4336.609705126522;3739.5325584301963;3763.209725957552;3826.2730081284467;3838.2707285615643;3840.6735427488697;5370.89896571202;5374.140137577969;5375.973120134413;5422.620416570841;5484.177373393983;4914.827981020647;4924.236743304794;4932.161532539477;4934.136526107916;4934.629902757308;5534.584906132016;5754.741036653319;5801.506871915893;5804.100364443518;5815.88368232633;4158.37624356349;4159.251334759742;4159.376093585956;4165.83336666533;4206.831726730927;6124.724387402578;6133.202683651141;6143;6151.154653603901;6178.578926846805;4170.582941705805;4260.595243451867;4273.273543497613;4322.848700295474;4327.285997810326;4311.396404503372;4311.805968731414;4313.2883074292395;4316.935245971313;4317.7193482423545;4879.4388645305535;4926.704397736075;4926.802927882916;4935.358403407534;4940.975295123501;5719.599628025998;5754.410515268146;5857.326407463111;5900.675462849498;5920.703964801743;1452.2230606625405;1485.2499487758828;1488.2112480385413;1489.80632517772;1492.2986196487634;913.4930113786779;939.609378120372;954.5513608603945;957.5547370472764;959.8080383923103;4982.850514484571;5037.093323201859;5045.41977672565;5066.290719299301;5089.745512724349;5248.9737551312;5262.868428289324;5276.261323414725;5359.5712343012465;5383.703896285663;5143.27406474569;5155.510226528474;5170.353705786777;5390.460953904657;5788.913166302509;3200.3439294944947;3224.6452890182063;3234.741220702338;3235.2558911450496;3239.6598357172156;6042.244719410074;6213.607761012043;6239.96880015597;6294.213223347082;6310.800947819899;6109.236345456818;6112.358202388774;6120.755169793248;6126.6017708848785;6152.969235153885;6218.160548326008;6263.3736626337;6272.749090036347;6298.370162983757;6306.297299728955;5787.8553036174435;5930.584859059824;5987.161797348462;6004.759809607742;6008.158857760004;5928.399332180374;5984.760609575568;5989.760409583568;6030.276366836008;6047.606905551125;5909.55678324136;6247;6249.687515624291;6368.840778980377;6373.107764913008;4172.979135104427;4271.1671224111;4280.272353699816;4290.635295999875;4323.351497275434;6045.78839740607;6092.116643086816;6092.45167934888;6107.389261073857;6113.602615829956;5628.296462942132;5793.565482588907;5847.210626565529;5851.502622276984;5861.267341582302;5788.813293274953;5817.825465236049;5841.415858414294;5847.310237290894;5880.794701986755;5771.913421298768;5779.884402312015;5792.9710351447975;5808.286555466063;5875.911861322169;5582.748776305158;5848.53211743051;5860.179574859438;5907.881842363043;5920.674362909909;5714.5142263011085;5829.892320459099;5834.416558344302;5888.3228428731245;5893.204417403767 20:40:35 INFO - PROCESS | 7341 | |5;yui.html;739.7263012685304;770.7340967366257;771.2326235395782;790.9683612655494;792.5838934559356;14336.426542938283;15119.999999999973;15260.236988150604;15272.312745926432;15311.770323445144;14031.92984035081;14105.717885642282;14172.50396236132;14179.574612761633;14189.645258868533;651.4072194303185;770.2490072179636;784.584170389693;792.5997371327501;802.8434455281223;807.5154907055778;809.5992483720566;811.3428123220181;811.6428771340592;812.9309008734235;854.4403415762686;855.6791203298762;855.8502262104138;856.3192262151605;860.8192279621287;847.4152834544145;849.5794581682076;851.3317046118798;854.6709516836;855.4140413816556;618.9690515474208;622.5019984012816;625.1778910732418;625.2996643758974;626.2891618013588;13713.45146194161;13810.516631917835;13821.447142114404;13854.584362469142;13987.720245595134;14269.005847953236;14934.25328733559;14950.177740224284;14996.175210363426;15263.618409539851;11856.585019524362;11959.940200298943;11968;12066.939665301705;12193.085518586053;3532.540769699948;3537.398642230801;3582.5342705448124;3583.3191693578397;3623.6376362363817;61833.69083154555;62584.06123908145;62827;62842;63091;11283.435828208556;11376.317420954769;11491.71270718222;11521.251118677259;11802.350870702023;21136.15455381798;21141.89429052845;21152.048157832935;21190.258340957993;21316;8427.536485493234;8683.348748843735;8760.211580957744;8820.2061814437;8919.331050171264;4700.388949436551;4813.590844778163;4832.906939558685;4907.730074845917;4911.386076740408;3208.6470488246273;3249.1552196429097;3266.461033929375;3295.2915123248135;3312.734981201498;571.7798647520734;575.2981362737454;580.2427831679698;582.962107463022;586.7330364684059;614.6496496996758;701.9435749197527;729.8321386081232;751.4702134994816;752.811886294657;9658.613655453702;9841.753956151153;9899.010098990188;10147.847782283272;10220.744481388025;658.9637569933603;696.7665831946254;697.7906628011576;742.9739959101405;745.5899255409612;4368.7815609219415;4593.724376537419;4826.463398240464;4896.265560165933;4908.558229759267;51849;55520;70032.2996770036;72199.63900180465;73060;62770.68614656897;69227;69284;70355;73151.63424182951;65342.346576534575;65770;65821;67078.3292167072;67224;9595.664151754934;9972.900270997487;10072.395656260647;10072.7848258276;10202.438865862448;42756.14487710166;43316.35025474557;44185;44394.11211775682;44751;36669.63330366662;37205.0698732523;37303.06742331355;40157.196856063296;53972.73013635064;10518.105960993402;11183;11206;12890.35548222604;13237.338133093499;12752.4261408235;12756.234625922474;12823.61529154127;14425.134491930517;14704.338304776096;13885.861141388457;14032.22822744759;14301.856981430468;14413.85586144167;14424.495142669955;13523.120997135155;13911.165330080228;14040.648983775487;14451.349689264218;15062.171580563174;13028.54400095992;13625.795613065613;14620.268986550418;14651.340689669203;15030.323635436212;11268;11335.659930202108;11688;11702.941485292518;12226.449809758404;11904.940475297568;12010.175065093597;12142.034396473126;12169.39153042362;12250.264984100982 20:40:35 INFO - PROCESS | 7341 | __end_tp_report 20:40:35 INFO - PROCESS | 7341 | __start_cc_report 20:40:35 INFO - PROCESS | 7341 | _x_x_mozilla_cycle_collect,355 20:40:35 INFO - PROCESS | 7341 | __end_cc_report 20:40:35 INFO - PROCESS | 7341 | __startTimestamp1469677235519__endTimestamp 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | ------- Summary: start ------- 20:40:35 INFO - PROCESS | 7341 | Number of tests: 6 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#0] dojo.html Cycles:165 Average:5425.19 Median:5677.06 stddev:629.68 (11.1%) stddev-sans-first:604.38 20:40:35 INFO - PROCESS | 7341 | Values: 3090.0 3103.3 3135.1 3138.1 3143.2 5312.2 5350.8 5354.4 5415.6 5419.8 5381.8 5386.6 5404.5 5452.7 5465.2 4836.9 4920.7 4935.8 4978.1 4984.7 4930.5 4953.4 5010.4 5026.0 5054.1 4864.5 4883.8 4904.7 4925.6 5006.2 4908.0 4908.7 4909.3 4913.0 4986.6 4899.9 4904.5 4921.8 4930.0 4982.6 5323.9 5342.1 5404.2 5425.4 5493.6 5796.1 5808.2 5817.2 5821.6 5848.5 5863.3 5881.0 5887.0 5894.6 5902.8 5296.0 5463.5 5490.4 5490.8 5584.6 5999.9 6001.4 6009.5 6023.9 6033.0 5761.0 5774.2 5779.3 5787.7 5790.9 5608.2 5797.1 5836.7 5837.5 5931.6 5564.6 5702.9 5783.6 5793.7 5803.4 5840.4 5841.8 5850.2 5852.4 5859.4 4353.1 4405.5 4408.6 4470.0 4478.3 3912.3 3980.5 3989.2 3990.0 4018.8 5556.9 5585.4 5588.6 5592.1 5650.7 5615.8 5879.5 5922.6 5937.7 5938.6 5594.5 5607.5 5640.9 5660.4 5677.1 5031.2 5083.2 5083.6 5088.5 5133.2 5889.6 6107.6 6110.7 6113.1 6117.2 5767.6 5792.7 5803.9 5853.6 5896.5 5987.6 6009.6 6012.8 6033.2 6059.0 5627.3 5678.0 5741.3 5742.4 5754.9 5827.7 5839.4 5850.8 5898.8 5947.3 5726.5 5742.9 5744.7 5752.3 5765.5 5467.4 5720.1 5734.7 5743.7 5743.7 5661.5 5717.3 5724.7 5724.8 5760.9 5797.4 5819.8 5848.2 5853.8 5856.6 5412.5 5629.4 5695.4 5711.8 5731.3 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#1] ext.html Cycles:180 Average:63853.40 Median:42542.50 stddev:131503.97 (309.1%) stddev-sans-first:131786.93 20:40:35 INFO - PROCESS | 7341 | Values: 531.4 564.9 569.4 583.6 589.4 31565.7 40900.6 41414.6 41530.2 41624.0 43973.8 44490.6 44501.6 44561.8 44569.0 8973.4 9101.8 9130.8 9135.2 9135.7 8855.2 8864.8 8958.8 8988.2 8996.0 9029.0 9079.5 9092.7 9094.6 9106.8 8923.2 8942.7 8965.0 8972.6 8986.6 8893.0 8945.4 8991.2 9013.4 9015.4 41968.8 42569.0 42571.1 42605.8 42777.4 3489.7 3530.2 3620.8 3671.2 3671.5 32470.7 32521.8 32620.3 32710.8 32713.8 4246.4 4308.3 4331.6 4334.1 4355.5 349884.0 351942.0 352288.0 352772.0 355725.0 49937.3 50202.2 50255.7 50341.7 50356.5 34952.0 35952.8 35979.3 59535.7 59633.0 15441.5 15534.1 15598.6 15642.1 15666.2 10670.8 10719.2 10846.2 10847.7 10921.7 19272.4 19342.9 19461.5 19473.9 19505.2 7170.5 7229.1 7305.4 7321.0 7392.9 1012.7 1024.2 1030.6 1031.2 1104.4 31666.5 32645.5 33138.7 33643.3 33771.8 1106.0 1106.8 1109.5 1179.4 1192.4 17213.2 17270.7 17488.7 17513.3 17560.3 565453.0 566528.0 568185.0 573256.0 573776.0 57831.1 57954.7 58043.7 58255.4 58361.7 1272.4 1318.3 1328.4 1334.3 1337.7 31107.4 31918.7 33002.5 33212.3 33338.5 54530.7 54926.7 55458.2 55495.0 55617.7 528566.0 533192.0 534614.0 535038.0 535195.0 44382.0 44392.8 44553.7 44973.3 45044.3 47937.3 48341.3 48704.5 48868.0 50148.5 40789.6 41087.0 41872.7 42770.4 43249.8 41627.6 42426.8 42516.0 42971.6 43163.0 35254.5 37216.4 40941.2 41278.2 41998.8 32695.8 35579.0 36813.6 37685.6 38978.8 28857.6 29128.9 29222.6 29246.4 29267.1 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#2] jquery.html Cycles:180 Average:27986.33 Median:384.24 stddev:77766.61 (20239.0%) stddev-sans-first:77957.15 20:40:35 INFO - PROCESS | 7341 | Values: 381.7 386.8 388.2 393.4 413.7 13589.7 18271.0 18480.6 19812.2 19839.8 18805.7 18946.7 19323.6 19430.5 19507.3 5582.3 5692.3 5694.5 5743.7 5747.4 5534.9 5608.0 5658.2 5659.9 5673.3 5515.8 5618.2 5629.4 5757.5 5833.4 5791.2 5807.3 5832.0 5988.9 6255.3 5741.3 5813.4 5863.5 5872.9 5874.8 13390.6 13517.5 13562.6 13623.3 13781.5 2324.8 2348.3 2491.1 2542.3 2841.1 9560.4 9992.2 10104.6 10170.2 10236.6 1810.5 1829.5 1885.7 1976.4 1998.1 77582.6 81536.0 82783.0 82990.0 84253.6 10698.3 10877.9 10950.0 11071.2 11090.8 15179.5 15223.9 15248.4 15310.0 15380.4 7473.7 7792.8 7934.6 8084.5 8110.7 7366.8 7367.3 7434.1 7582.0 7624.8 4633.6 4642.0 4671.4 4729.1 4834.7 1948.0 1956.5 1964.8 1970.1 2001.1 986.0 1003.7 1009.9 1044.7 1052.6 19231.6 19612.6 19788.5 19867.6 20023.1 935.5 981.2 1004.8 1013.7 1029.9 10443.4 10911.2 10967.4 11027.3 11120.2 450067.0 459397.0 474246.0 482733.0 483937.0 89735.6 92141.8 92779.5 93491.5 93765.5 963.7 992.8 1010.3 1013.2 1016.9 16478.3 17104.4 17462.7 17555.5 17676.8 39839.2 41455.6 41507.6 41589.0 42499.0 57358.1 57797.0 58657.4 59031.0 59862.0 7923.2 7943.7 7954.4 7968.1 8300.0 9249.4 11792.1 11991.6 12491.9 12661.2 10596.0 10712.1 10807.1 10850.7 10964.9 10240.3 10637.2 10651.5 10652.1 10741.4 10603.9 10650.3 10763.9 10878.4 11322.0 7867.8 7902.0 8036.8 8051.3 8099.4 8104.8 9795.8 10364.5 10660.7 11042.9 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#3] mootools.html Cycles:180 Average:5745.28 Median:4478.45 stddev:3243.16 (72.4%) stddev-sans-first:3236.44 20:40:35 INFO - PROCESS | 7341 | Values: 1483.0 1500.7 1609.3 1706.9 1727.2 7515.0 8289.5 8364.2 8833.7 8846.6 8683.7 8698.6 8779.9 8801.0 8810.3 2324.0 2339.2 2365.5 2366.2 2366.4 2295.9 2308.3 2350.3 2361.1 2367.8 2310.4 2319.6 2332.0 2343.6 2367.3 2298.7 2308.3 2315.7 2322.2 2326.9 2239.3 2242.8 2251.1 2253.2 2260.5 8857.6 8938.7 8978.4 8998.0 8998.2 5027.5 5162.8 5167.8 5173.8 5174.1 3118.5 3134.5 3172.8 3201.3 3253.2 1083.5 1089.4 1099.3 1105.2 1110.4 11912.3 11940.5 11957.6 11979.8 12035.3 4379.6 4413.4 4498.1 4539.8 4594.7 10306.8 10317.9 10322.8 10330.7 10333.5 5195.4 5195.7 5209.6 5224.6 5228.5 4147.4 4488.8 4572.8 4586.6 4795.7 3835.0 3893.0 3962.2 4002.2 4014.9 1162.7 1235.2 1235.9 1241.7 1243.4 981.4 993.2 1009.1 1022.3 1033.4 5928.6 6093.8 6167.8 6252.9 6277.7 459.4 478.2 481.1 484.8 1052.7 4200.9 4399.7 4449.8 4453.4 4468.1 10070.5 10386.6 10403.7 10442.3 10446.3 10331.5 10346.2 10356.2 10358.3 10369.8 7397.9 7612.9 7659.2 7871.1 7946.9 6081.7 6082.7 6126.6 6297.0 6367.3 9839.9 10261.5 10296.1 10368.4 10381.6 10092.4 10169.9 10310.3 10315.9 10318.2 7054.5 7516.0 7667.0 7803.8 7903.3 8504.6 8562.3 8594.5 8601.6 8623.3 7646.3 7765.7 7810.1 7935.2 7974.6 7513.4 7532.7 7540.2 7625.5 7673.4 6826.4 6935.0 6941.7 6950.8 6959.7 5320.8 5326.3 5354.8 5401.5 5553.2 5314.8 5369.4 5395.0 5431.3 5459.8 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#4] prototype.html Cycles:180 Average:4884.05 Median:5480.84 stddev:1445.40 (26.4%) stddev-sans-first:1408.37 20:40:35 INFO - PROCESS | 7341 | Values: 325.7 332.3 332.9 342.1 344.1 5437.8 5458.6 5607.2 5636.6 5643.4 5477.5 5522.8 5565.6 5581.4 5585.0 4362.5 4368.5 4375.6 4376.1 4387.5 4131.5 4311.6 4351.2 4384.3 4414.5 4280.3 4282.5 4282.6 4282.9 4284.3 4280.9 4287.0 4320.8 4324.9 4336.6 3739.5 3763.2 3826.3 3838.3 3840.7 5370.9 5374.1 5376.0 5422.6 5484.2 4914.8 4924.2 4932.2 4934.1 4934.6 5534.6 5754.7 5801.5 5804.1 5815.9 4158.4 4159.3 4159.4 4165.8 4206.8 6124.7 6133.2 6143.0 6151.2 6178.6 4170.6 4260.6 4273.3 4322.8 4327.3 4311.4 4311.8 4313.3 4316.9 4317.7 4879.4 4926.7 4926.8 4935.4 4941.0 5719.6 5754.4 5857.3 5900.7 5920.7 1452.2 1485.2 1488.2 1489.8 1492.3 913.5 939.6 954.6 957.6 959.8 4982.9 5037.1 5045.4 5066.3 5089.7 5249.0 5262.9 5276.3 5359.6 5383.7 5143.3 5155.5 5170.4 5390.5 5788.9 3200.3 3224.6 3234.7 3235.3 3239.7 6042.2 6213.6 6240.0 6294.2 6310.8 6109.2 6112.4 6120.8 6126.6 6153.0 6218.2 6263.4 6272.7 6298.4 6306.3 5787.9 5930.6 5987.2 6004.8 6008.2 5928.4 5984.8 5989.8 6030.3 6047.6 5909.6 6247.0 6249.7 6368.8 6373.1 4173.0 4271.2 4280.3 4290.6 4323.4 6045.8 6092.1 6092.5 6107.4 6113.6 5628.3 5793.6 5847.2 5851.5 5861.3 5788.8 5817.8 5841.4 5847.3 5880.8 5771.9 5779.9 5793.0 5808.3 5875.9 5582.7 5848.5 5860.2 5907.9 5920.7 5714.5 5829.9 5834.4 5888.3 5893.2 20:40:35 INFO - PROCESS | 7341 | 20:40:35 INFO - PROCESS | 7341 | [#5] yui.html Cycles:180 Average:16480.13 Median:23842.57 stddev:20005.47 (83.9%) stddev-sans-first:20026.67 20:40:35 INFO - PROCESS | 7341 | Values: 739.7 770.7 771.2 791.0 792.6 14336.4 15120.0 15260.2 15272.3 15311.8 14031.9 14105.7 14172.5 14179.6 14189.6 651.4 770.2 784.6 792.6 802.8 807.5 809.6 811.3 811.6 812.9 854.4 855.7 855.9 856.3 860.8 847.4 849.6 851.3 854.7 855.4 619.0 622.5 625.2 625.3 626.3 13713.5 13810.5 13821.4 13854.6 13987.7 14269.0 14934.3 14950.2 14996.2 15263.6 11856.6 11959.9 11968.0 12066.9 12193.1 3532.5 3537.4 3582.5 3583.3 3623.6 61833.7 62584.1 62827.0 62842.0 63091.0 11283.4 11376.3 11491.7 11521.3 11802.4 21136.2 21141.9 21152.0 21190.3 21316.0 8427.5 8683.3 8760.2 8820.2 8919.3 4700.4 4813.6 4832.9 4907.7 4911.4 3208.6 3249.2 3266.5 3295.3 3312.7 571.8 575.3 580.2 583.0 586.7 614.6 701.9 729.8 751.5 752.8 9658.6 9841.8 9899.0 10147.8 10220.7 659.0 696.8 697.8 743.0 745.6 4368.8 4593.7 4826.5 4896.3 4908.6 51849.0 55520.0 70032.3 72199.6 73060.0 62770.7 69227.0 69284.0 70355.0 73151.6 65342.3 65770.0 65821.0 67078.3 67224.0 9595.7 9972.9 10072.4 10072.8 10202.4 42756.1 43316.4 44185.0 44394.1 44751.0 36669.6 37205.1 37303.1 40157.2 53972.7 10518.1 11183.0 11206.0 12890.4 13237.3 12752.4 12756.2 12823.6 14425.1 14704.3 13885.9 14032.2 14301.9 14413.9 14424.5 13523.1 13911.2 14040.6 14451.3 15062.2 13028.5 13625.8 14620.3 14651.3 15030.3 11268.0 11335.7 11688.0 11702.9 12226.4 11904.9 12010.2 12142.0 12169.4 12250.3 20:40:35 INFO - PROCESS | 7341 | -------- Summary: end -------- 20:40:35 INFO - PROCESS | 7341 | 20:40:36 INFO - TEST-INFO | 7341: exit 0 20:40:36 INFO - TEST-OK | dromaeo_css | took 1110557ms 20:40:36 INFO - TEST-START | kraken 20:40:36 INFO - operating with platform_type : linux_ 20:40:36 INFO - Initialising browser for kraken test... 20:40:36 INFO - TEST-INFO | started process 7583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dbPQE/profile http://localhost:39713/getInfo.html) 20:40:39 INFO - PROCESS | 7583 | JavaScript error: , line 0: uncaught exception: undefined 20:40:40 INFO - PROCESS | 7583 | __metrics Screen width/height:1600/1200 20:40:40 INFO - PROCESS | 7583 | colorDepth:24 20:40:40 INFO - PROCESS | 7583 | Browser inner width/height: 1024/697 20:40:40 INFO - PROCESS | 7583 | __metrics 20:40:41 ERROR - PROCESS | 7583 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:40:42 INFO - TEST-INFO | 7583: exit 0 20:40:42 INFO - Browser initialized. 20:40:42 INFO - Running cycle 1/1 for kraken test... 20:40:42 INFO - TEST-INFO | started process 7704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dbPQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:54 INFO - PROCESS | 7704 | RSS: Main: 164909056 20:40:54 INFO - PROCESS | 7704 | 20:40:56 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39713/tests/kraken/driver.html?testName=audio-beat-detection) 20:40:57 INFO - PROCESS | 7704 | RSS: Main: 170418176 20:40:57 INFO - PROCESS | 7704 | 20:41:00 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39713/tests/kraken/driver.html?testName=audio-dft) 20:41:00 INFO - PROCESS | 7704 | RSS: Main: 169132032 20:41:00 INFO - PROCESS | 7704 | 20:41:03 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39713/tests/kraken/driver.html?testName=audio-fft) 20:41:04 INFO - PROCESS | 7704 | RSS: Main: 164765696 20:41:04 INFO - PROCESS | 7704 | 20:41:06 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39713/tests/kraken/driver.html?testName=audio-oscillator) 20:41:06 INFO - PROCESS | 7704 | RSS: Main: 166400000 20:41:06 INFO - PROCESS | 7704 | 20:41:09 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:41:09 INFO - PROCESS | 7704 | RSS: Main: 166625280 20:41:09 INFO - PROCESS | 7704 | 20:41:12 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39713/tests/kraken/driver.html?testName=imaging-darkroom) 20:41:13 INFO - PROCESS | 7704 | RSS: Main: 165986304 20:41:13 INFO - PROCESS | 7704 | 20:41:16 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39713/tests/kraken/driver.html?testName=imaging-desaturate) 20:41:17 INFO - PROCESS | 7704 | RSS: Main: 164720640 20:41:17 INFO - PROCESS | 7704 | 20:41:20 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39713/tests/kraken/driver.html?testName=json-parse-financial) 20:41:21 INFO - PROCESS | 7704 | RSS: Main: 166113280 20:41:21 INFO - PROCESS | 7704 | 20:41:22 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:41:23 INFO - PROCESS | 7704 | RSS: Main: 166121472 20:41:23 INFO - PROCESS | 7704 | 20:41:24 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:41:25 INFO - PROCESS | 7704 | RSS: Main: 166268928 20:41:25 INFO - PROCESS | 7704 | 20:41:27 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:41:28 INFO - PROCESS | 7704 | RSS: Main: 166711296 20:41:28 INFO - PROCESS | 7704 | 20:41:30 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:41:31 INFO - PROCESS | 7704 | RSS: Main: 167047168 20:41:31 INFO - PROCESS | 7704 | 20:41:34 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:41:34 INFO - PROCESS | 7704 | RSS: Main: 167129088 20:41:34 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:39713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39713/tests/kraken/driver.html?testName=ai-astar) 20:41:36 INFO - PROCESS | 7704 | RSS: Main: 168112128 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | __start_tp_report 20:41:36 INFO - PROCESS | 7704 | _x_x_mozilla_page_load 20:41:36 INFO - PROCESS | 7704 | _x_x_mozilla_page_load_details 20:41:36 INFO - PROCESS | 7704 | |i|pagename|runs| 20:41:36 INFO - PROCESS | 7704 | |0;ai-astar;101;112;106;115;114;113;114;112;112;112 20:41:36 INFO - PROCESS | 7704 | |1;audio-beat-detection;145;119;146;174;120;150;146;125;179;120 20:41:36 INFO - PROCESS | 7704 | |2;audio-dft;163;164;162;163;165;168;167;162;163;161 20:41:36 INFO - PROCESS | 7704 | |3;audio-fft;75;75;76;172;76;75;75;75;160;75 20:41:36 INFO - PROCESS | 7704 | |4;audio-oscillator;84;84;151;87;88;84;149;83;84;151 20:41:36 INFO - PROCESS | 7704 | |5;imaging-gaussian-blur;118;118;117;118;117;118;117;117;119;118 20:41:36 INFO - PROCESS | 7704 | |6;imaging-darkroom;147;148;148;148;147;147;147;147;146;147 20:41:36 INFO - PROCESS | 7704 | |7;imaging-desaturate;95;97;96;96;96;96;95;96;95;97 20:41:36 INFO - PROCESS | 7704 | |8;json-parse-financial;51;53;53;52;52;54;52;53;51;52 20:41:36 INFO - PROCESS | 7704 | |9;json-stringify-tinderbox;63;63;61;63;62;62;63;62;63;64 20:41:36 INFO - PROCESS | 7704 | |10;stanford-crypto-aes;82;80;86;77;79;82;76;76;82;76 20:41:36 INFO - PROCESS | 7704 | |11;stanford-crypto-ccm;130;123;130;131;124;122;127;131;161;122 20:41:36 INFO - PROCESS | 7704 | |12;stanford-crypto-pbkdf2;158;163;154;160;160;157;166;156;159;154 20:41:36 INFO - PROCESS | 7704 | |13;stanford-crypto-sha256-iterative;66;64;64;63;65;63;66;64;63;62 20:41:36 INFO - PROCESS | 7704 | __end_tp_report 20:41:36 INFO - PROCESS | 7704 | __start_cc_report 20:41:36 INFO - PROCESS | 7704 | _x_x_mozilla_cycle_collect,865 20:41:36 INFO - PROCESS | 7704 | __end_cc_report 20:41:36 INFO - PROCESS | 7704 | __startTimestamp1469677296813__endTimestamp 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | ------- Summary: start ------- 20:41:36 INFO - PROCESS | 7704 | Number of tests: 14 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:4.31 (3.8%) stddev-sans-first:2.59 20:41:36 INFO - PROCESS | 7704 | Values: 101.0 112.0 106.0 115.0 114.0 113.0 114.0 112.0 112.0 112.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:146.00 stddev:21.81 (14.9%) stddev-sans-first:23.12 20:41:36 INFO - PROCESS | 7704 | Values: 145.0 119.0 146.0 174.0 120.0 150.0 146.0 125.0 179.0 120.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.25 (1.4%) stddev-sans-first:2.37 20:41:36 INFO - PROCESS | 7704 | Values: 163.0 164.0 162.0 163.0 165.0 168.0 167.0 162.0 163.0 161.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.37 (51.2%) stddev-sans-first:40.12 20:41:36 INFO - PROCESS | 7704 | Values: 75.0 75.0 76.0 172.0 76.0 75.0 75.0 75.0 160.0 75.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:84.00 stddev:31.67 (37.7%) stddev-sans-first:32.71 20:41:36 INFO - PROCESS | 7704 | Values: 84.0 84.0 151.0 87.0 88.0 84.0 149.0 83.0 84.0 151.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:41:36 INFO - PROCESS | 7704 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 119.0 118.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:41:36 INFO - PROCESS | 7704 | Values: 147.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 147.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 20:41:36 INFO - PROCESS | 7704 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 97.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.88 20:41:36 INFO - PROCESS | 7704 | Values: 51.0 53.0 53.0 52.0 52.0 54.0 52.0 53.0 51.0 52.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 20:41:36 INFO - PROCESS | 7704 | Values: 63.0 63.0 61.0 63.0 62.0 62.0 63.0 62.0 63.0 64.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:81.00 stddev:3.41 (4.2%) stddev-sans-first:3.50 20:41:36 INFO - PROCESS | 7704 | Values: 82.0 80.0 86.0 77.0 79.0 82.0 76.0 76.0 82.0 76.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.00 stddev:11.47 (8.8%) stddev-sans-first:12.17 20:41:36 INFO - PROCESS | 7704 | Values: 130.0 123.0 130.0 131.0 124.0 122.0 127.0 131.0 161.0 122.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:3.80 (2.4%) stddev-sans-first:4.02 20:41:36 INFO - PROCESS | 7704 | Values: 158.0 163.0 154.0 160.0 160.0 157.0 166.0 156.0 159.0 154.0 20:41:36 INFO - PROCESS | 7704 | 20:41:36 INFO - PROCESS | 7704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.33 (2.1%) stddev-sans-first:1.20 20:41:36 INFO - PROCESS | 7704 | Values: 66.0 64.0 64.0 63.0 65.0 63.0 66.0 64.0 63.0 62.0 20:41:36 INFO - PROCESS | 7704 | -------- Summary: end -------- 20:41:36 INFO - PROCESS | 7704 | 20:41:37 INFO - TEST-INFO | 7704: exit 0 20:41:37 INFO - TEST-OK | kraken | took 61483ms 20:41:37 INFO - SUITE-END | took 1172s 20:41:37 INFO - Completed test suite (00:19:32) 20:41:37 INFO - javascript benchmark 20:41:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7193.54460195978, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.953650695239, 3103.270731378127, 3135.1378370947987, 3138.1370123216125, 3143.1670607289057, 5312.203169524573, 5350.7859685612575, 5354.384245811732, 5415.566754659628, 5419.756110975006, 5381.81163659272, 5386.622936394454, 5404.540614047801, 5452.727363631822, 5465.180222966557, 4836.903261934768, 4920.70475771453, 4935.777889994941, 4978.128827455199, 4984.651074424792, 4930.457649658535, 4953.380827396575, 5010.398752149729, 5026.0, 5054.064997975368, 4864.489228630996, 4883.804647814083, 4904.730239836807, 4925.556699897009, 5006.199008158677, 4907.950920490785, 4908.656394052417, 4909.337239472661, 4913.0, 4986.626003049786, 4899.8775030624165, 4904.5340692634145, 4921.827736029258, 4930.0, 4982.60139188864, 5323.866903327448, 5342.091844386464, 5404.216388623667, 5425.403205647375, 5493.587980901449, 5796.072628379439, 5808.244928159313, 5817.156512305692, 5821.592488525805, 5848.5321174305955, 5863.2670916135485, 5881.029630111027, 5886.970565147147, 5894.58737888348, 5902.793402230901, 5295.993761185362, 5463.508284254396, 5490.423505531941, 5490.780368785244, 5584.5811564132855, 5999.910001349983, 6001.369856165127, 6009.459148676553, 6023.939760602426, 6033.034714445667, 5761.0, 5774.191613174159, 5779.2775903012125, 5787.681677507778, 5790.88418231633, 5608.1587761835235, 5797.072468405035, 5836.678982655994, 5837.503812176013, 5931.58478906481, 5564.638298510584, 5702.857428564319, 5783.59514833966, 5793.7392817323325, 5803.419658034163, 5840.3575606683235, 5841.766329346863, 5850.151727999416, 5852.385499522574, 5859.384764599741, 4353.064091220403, 4405.471343438808, 4408.559144085566, 4469.955300447019, 4478.261086920622, 3912.315344814703, 3980.5422376426504, 3989.2420440116284, 3989.960100399017, 4018.8392464301687, 5556.91664625031, 5585.357683866326, 5588.580856435784, 5592.105263157957, 5650.7174641267775, 5615.803446879339, 5879.5002424794375, 5922.644641321534, 5937.732802023919, 5938.554608404387, 5594.524465420485, 5607.495325420732, 5640.8871822563315, 5660.433956604306, 5677.063284558084, 5031.22016087507, 5083.212102124176, 5083.61872859537, 5088.542031217208, 5133.204353325241, 5889.617174883619, 6107.572469927062, 6110.694465276719, 6113.083037544404, 6117.235345581802, 5767.596268261265, 5792.7103644818435, 5803.883922321445, 5853.64878107315, 5896.498797602252, 5987.6108052976415, 6009.639421634716, 6012.759489620366, 6033.18551995475, 6059.030555111161, 5627.296587926509, 5678.0, 5741.311042674905, 5742.425757424224, 5754.942450575608, 5827.650340979555, 5839.445252700986, 5850.795222167204, 5898.8230353089475, 5947.316058653138, 5726.455986681259, 5742.942570574241, 5744.712764361849, 5752.28096487939, 5765.538756899522, 5467.425920278313, 5720.141978703228, 5734.655920644775, 5743.655380677173, 5743.6840973745175, 5661.518770904519, 5717.313922329347, 5724.74238659253, 5724.771009159587, 5760.884782304414, 5797.420257974169, 5819.76720931158, 5848.181254624441, 5853.824385268449, 5856.619319744203, 5412.458754124556, 5629.408912064175, 5695.373508914099, 5711.771529138788, 5731.283589551306], "value": 5381.654303220855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.410134750427, 564.8841987392585, 569.3736889421637, 583.6439771739241, 589.4488653109341, 31565.68434315656, 40900.59099409005, 41414.585854141485, 41530.16939661205, 41624.0, 43973.78013109938, 44490.555094449046, 44501.554984450144, 44561.777191114, 44569.0, 8973.371863969509, 9101.815564264562, 9130.77173070672, 9135.17783399494, 9135.68025119121, 8855.247303979137, 8864.822703545926, 8958.820823583525, 8988.191062804346, 8995.955020224923, 9029.0, 9079.500627465486, 9092.727218183432, 9094.636214551443, 9106.817863642724, 8923.15230053144, 8942.687005954793, 8965.0, 8972.551372431351, 8986.550672466416, 8892.955535222347, 8945.418547794437, 8991.190792828676, 9013.36906416551, 9015.36892417531, 41968.79015604933, 42569.0, 42571.148577028594, 42605.78697106495, 42777.35833962493, 3489.685928266468, 3530.1704099536587, 3620.8008559529217, 3671.173985853162, 3671.504346913159, 32470.675293247, 32521.837390813133, 32620.347593048005, 32710.83644581762, 32713.83643081793, 4246.363045543162, 4308.289132293168, 4331.610155086058, 4334.089841133366, 4355.455568053993, 349884.0, 351942.0, 352287.99999999744, 352772.0, 355725.0, 49937.250941235914, 50202.246966295534, 50255.74872125616, 50341.74829125904, 50356.496435035915, 34952.0, 35952.82023589865, 35979.280414391564, 59535.70232148811, 59633.0, 15441.459548915958, 15534.067955922681, 15598.610034748996, 15642.139682317582, 15666.216689165496, 10670.786584268271, 10719.19606029551, 10846.18653600983, 10847.67456976292, 10921.672349829518, 19272.421827345202, 19342.903285483764, 19461.51346216356, 19473.90263048704, 19505.219791208478, 7170.533915295593, 7229.132504099542, 7305.415566754753, 7321.0, 7392.852142957218, 1012.6506355307407, 1024.2113572549094, 1030.6083688198437, 1031.2265800649513, 1104.3760275444508, 31666.525002124985, 32645.51031734526, 33138.66861331404, 33643.327133457686, 33771.83114084414, 1106.0322218059198, 1106.7952428800536, 1109.4896347680158, 1179.351356753782, 1192.4276347353318, 17213.22540485681, 17270.654586908193, 17488.737668934977, 17513.299468021138, 17560.29758809633, 565453.0, 566528.0, 568185.0, 573256.0, 573776.0, 57831.13253301204, 57954.71022644944, 58043.70978145082, 58255.41744582585, 58361.70819145877, 1272.3765354975994, 1318.3013003108176, 1328.4088580581742, 1334.3128288931402, 1337.6923307639297, 31107.37785244328, 31918.68081319157, 33002.504962426065, 33212.335753284315, 33338.499922501665, 54530.72734636301, 54926.72536637291, 55458.168127477315, 55495.0, 55617.72191139018, 528566.0, 533192.0, 534614.0, 535038.0, 535195.0, 44382.0, 44392.778036109616, 44553.65847561381, 44973.32540011968, 45044.32433513566, 47937.280940786615, 48341.27488087611, 48704.51295487142, 48868.0, 50148.49851501584, 40789.592104078576, 41087.0, 41872.6970016652, 42770.35844462398, 43249.78375108104, 41627.583724162374, 42426.78786606047, 42516.0, 42971.57028429676, 43163.0, 35254.471182932786, 37216.44175337426, 40941.1811763769, 41278.174436511705, 41998.79000604978, 32695.836520818197, 35579.0, 36813.63186368102, 37685.623143768215, 38978.80510597429, 28857.567136493388, 29128.854355728086, 29222.56166157467, 29246.415071698022, 29267.121986340444], "value": 20271.169182354628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.717529028519, 386.7664239019663, 388.2196784463229, 393.41970593374765, 413.72900750008756, 13589.728205435886, 18271.0, 18480.630387392244, 19812.20751169955, 19839.801601983974, 18805.717914231296, 18946.715799262987, 19323.613527729438, 19430.514237144078, 19507.317243896465, 5582.330120385549, 5692.288463942007, 5694.544436445074, 5743.741531631065, 5747.3677895431465, 5534.944650553503, 5607.971960140214, 5658.207850900877, 5659.886802263953, 5673.347565030012, 5515.779368825242, 5618.185363122345, 5629.3526244482, 5757.481826635602, 5833.3874943130995, 5791.189233507313, 5807.274090738658, 5832.037713777243, 5988.9101663475085, 6255.343188965184, 5741.282339707536, 5813.447722466359, 5863.5016023638045, 5872.882542349172, 5874.7943821966455, 13390.598282051456, 13517.526886559022, 13562.593122206252, 13623.25072121033, 13781.517646882412, 2324.8140148788057, 2348.2955113466064, 2491.0783010286127, 2542.313575334668, 2841.0908509277037, 9560.426374417557, 9992.200623950139, 10104.646337378157, 10170.18638508925, 10236.641717539851, 1810.5383127302453, 1829.5151784777045, 1885.70771530413, 1976.4268362175096, 1998.1108406759, 77582.6120869392, 81536.0, 82782.9999999994, 82990.0, 84253.57873210595, 10698.251122421356, 10877.945610272056, 10950.014498695156, 11071.225014248925, 11090.833637495443, 15179.544613661608, 15223.923880380527, 15248.390064397521, 15310.0, 15380.384784608714, 7473.663685134182, 7792.805179870548, 7934.603269836485, 8084.474509157004, 8110.675572977133, 7366.815829604196, 7367.26327367259, 7434.070741157356, 7582.0, 7624.8475030500185, 4633.559811817872, 4641.976790116096, 4671.369365135731, 4729.125111854318, 4834.734089625104, 1947.9610407791765, 1956.5499935015025, 1964.774050984155, 1970.1429878003114, 2001.119507416761, 985.9605615775289, 1003.6687892995294, 1009.8535712321673, 1044.6709286574705, 1052.6315789473622, 19231.615367692848, 19612.607747844962, 19788.50528736793, 19867.60264794696, 20023.09896054652, 935.5462600638684, 981.2052237687496, 1004.829179039565, 1013.6502906497246, 1029.8867124616286, 10443.381275902095, 10911.181661375429, 10967.396793176293, 11027.338359698444, 11120.165987550805, 450067.0, 459397.0, 474246.0, 482733.0, 483937.0, 89735.55132224428, 92141.77503787335, 92779.53610231906, 93491.53254233685, 93765.5311723437, 963.6819849449524, 992.8361820299714, 1010.3382284603597, 1013.2299452416216, 1016.9084782369622, 16478.25847836826, 17104.401345952832, 17462.738058928873, 17555.473335799947, 17676.823231767517, 39839.20321593494, 41455.58544414638, 41507.58492415158, 41589.0, 42499.0, 57358.13962790645, 57797.0, 58657.4134258652, 59031.0, 59862.0, 7923.20767923203, 7943.721969731032, 7954.403419743659, 7968.0836703779805, 8300.04549476818, 9249.352545321763, 11792.056635469313, 11991.64025079249, 12491.93754031224, 12661.177023493443, 10596.0, 10712.143028557852, 10807.13542916549, 10850.67447976562, 10964.890351096386, 10240.334378265388, 10637.202209834448, 10651.467426628793, 10652.09457196147, 10741.409222492837, 10603.89396106029, 10650.307729997836, 10763.94618026905, 10878.40168790724, 11322.037626801484, 7867.842643146991, 7901.960490197513, 8036.758897233092, 8051.315638170821, 8099.352051835721, 8104.83790324202, 9795.804083918425, 10364.481775911023, 10660.73348166271, 11042.944785276022], "value": 8900.044317072885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.0191315455934, 1500.6923580665964, 1609.2838686784378, 1706.8719846011536, 1727.1795896948952, 7515.0, 8289.544075075868, 8364.163583641634, 8833.69082082128, 8846.557672116392, 8683.739487815375, 8698.565071746403, 8779.912200877989, 8801.031886492481, 8810.339224558167, 2324.0013588314077, 2339.2163625185585, 2365.4914193448403, 2366.1954935321987, 2366.4438856868624, 2295.8507696999727, 2308.3075077476774, 2350.2949115265437, 2361.1381845626393, 2367.822413318999, 2310.4108452344713, 2319.5940710375703, 2332.0, 2343.625019996792, 2367.30164601443, 2298.7356454007836, 2308.2613563659634, 2315.7221133463922, 2322.15241436876, 2326.8603883767028, 2239.3393948785147, 2242.786935241166, 2251.1445650652813, 2253.1663284584642, 2260.547890421922, 8857.601407936594, 8938.731838044869, 8978.371513994023, 8997.955010224907, 8998.190162885372, 5027.4721154279005, 5162.793488260465, 5167.7932882684645, 5173.844784656429, 5174.068667639824, 3118.5166299223656, 3134.451470992567, 3172.841357932094, 3201.3437245364644, 3253.235489659928, 1083.5286650307062, 1089.4389389464432, 1099.2525082943596, 1105.1876870500175, 1110.4447776111945, 11912.34482103484, 11940.522379104825, 11957.641270761891, 11979.820302695467, 12035.277883327028, 4379.562043795659, 4413.360062790877, 4498.077894031716, 4539.841105561355, 4594.747288899142, 10306.793864122676, 10317.896821031844, 10322.793544129076, 10330.741731456623, 10333.534990925426, 5195.350581177353, 5195.6622819516615, 5209.635325527177, 5224.582033437316, 5228.4510126436935, 4147.440095587118, 4488.842890498817, 4572.7942242599165, 4586.564276393738, 4795.664303498722, 3834.9616503835164, 3892.980535097363, 3962.227365663668, 4002.199560087994, 4014.9397759033636, 1162.68607475981, 1235.1539195651008, 1235.932023738703, 1241.74544218435, 1243.421808858885, 981.4209616326401, 993.1756641987133, 1009.1018993096151, 1022.2997246885907, 1033.4419413516766, 5928.555358348055, 6093.847653808691, 6167.784127555514, 6252.9370007098905, 6277.748890044347, 459.3958943988644, 478.17992143474106, 481.0547274605417, 484.8303093917101, 1052.710504611238, 4200.894977625584, 4399.714018588781, 4449.844255451044, 4453.398791163217, 4468.061707041557, 10070.546825392876, 10386.636467723594, 10403.739906502398, 10442.321249118782, 10446.268761186644, 10331.48342582868, 10346.172306215485, 10356.17150627948, 10358.274920755475, 10369.844452333222, 7397.852042959218, 7612.885806712904, 7659.157492675801, 7871.0948240951875, 7946.9271648327895, 6081.695915204134, 6082.695865206811, 6126.5711400203345, 6296.968515157395, 6367.299597044414, 9839.901600983898, 10261.538230779783, 10296.124829389286, 10368.429736364573, 10381.636642717469, 10092.394456332644, 10169.89830101719, 10310.278280520291, 10315.948420257851, 10318.226133040202, 7054.541454805421, 7515.962420187864, 7667.0416197975255, 7803.804904877196, 7903.288704016666, 8504.574771261288, 8562.315014798676, 8594.527300998505, 8601.580739177965, 8623.310135189295, 7646.31183193493, 7765.72819951299, 7810.062792464941, 7935.2064793522495, 7974.641141148778, 7513.39892808563, 7532.736354227576, 7540.208278130717, 7625.504342217738, 7673.4244931631465, 6826.41975432074, 6934.965325173342, 6941.687624057031, 6950.826229344307, 6959.652017399211, 5320.760565774627, 5326.25432439451, 5354.7858085676135, 5401.459854014567, 5553.222548843246, 5314.760835762478, 5369.3556773187465, 5395.0, 5431.321084864392, 5459.781608735765], "value": 4561.01280014631, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.69710169542316, 332.3469382663067, 332.9367420190164, 342.1241621449091, 344.05728304445825, 5437.776500287433, 5458.590605704578, 5607.186957891104, 5636.605437619363, 5643.351014633318, 5477.5070243678065, 5522.751476183571, 5565.582581306408, 5581.4371975846725, 5584.966781145491, 4362.498312694033, 4368.453943257085, 4375.571557785428, 4376.102898905732, 4387.451568553931, 4131.5248746394245, 4311.6335111515555, 4351.173277077361, 4384.342348647697, 4414.536473670267, 4280.272353699863, 4282.486101667789, 4282.635975942048, 4282.914341713164, 4284.2930916398755, 4280.850170244042, 4286.97856510717, 4320.805563749639, 4324.870253892388, 4336.609705126522, 3739.5325584301963, 3763.209725957552, 3826.2730081284467, 3838.2707285615643, 3840.6735427488697, 5370.89896571202, 5374.140137577969, 5375.973120134413, 5422.620416570841, 5484.177373393983, 4914.827981020647, 4924.236743304794, 4932.161532539477, 4934.136526107916, 4934.629902757308, 5534.584906132016, 5754.741036653319, 5801.506871915893, 5804.100364443518, 5815.88368232633, 4158.37624356349, 4159.251334759742, 4159.376093585956, 4165.83336666533, 4206.831726730927, 6124.724387402578, 6133.202683651141, 6143.0, 6151.154653603901, 6178.578926846805, 4170.582941705805, 4260.595243451867, 4273.273543497613, 4322.848700295474, 4327.285997810326, 4311.396404503372, 4311.805968731414, 4313.2883074292395, 4316.935245971313, 4317.7193482423545, 4879.4388645305535, 4926.704397736075, 4926.802927882916, 4935.358403407534, 4940.975295123501, 5719.599628025998, 5754.410515268146, 5857.326407463111, 5900.675462849498, 5920.703964801743, 1452.2230606625405, 1485.2499487758828, 1488.2112480385413, 1489.80632517772, 1492.2986196487634, 913.4930113786779, 939.609378120372, 954.5513608603945, 957.5547370472764, 959.8080383923103, 4982.850514484571, 5037.093323201859, 5045.41977672565, 5066.290719299301, 5089.745512724349, 5248.9737551312, 5262.868428289324, 5276.261323414725, 5359.5712343012465, 5383.703896285663, 5143.27406474569, 5155.510226528474, 5170.353705786777, 5390.460953904657, 5788.913166302509, 3200.3439294944947, 3224.6452890182063, 3234.741220702338, 3235.2558911450496, 3239.6598357172156, 6042.244719410074, 6213.607761012043, 6239.96880015597, 6294.213223347082, 6310.800947819899, 6109.236345456818, 6112.358202388774, 6120.755169793248, 6126.6017708848785, 6152.969235153885, 6218.160548326008, 6263.3736626337, 6272.749090036347, 6298.370162983757, 6306.297299728955, 5787.8553036174435, 5930.584859059824, 5987.161797348462, 6004.759809607742, 6008.158857760004, 5928.399332180374, 5984.760609575568, 5989.760409583568, 6030.276366836008, 6047.606905551125, 5909.55678324136, 6247.0, 6249.687515624291, 6368.840778980377, 6373.107764913008, 4172.979135104427, 4271.1671224111, 4280.272353699816, 4290.635295999875, 4323.351497275434, 6045.78839740607, 6092.116643086816, 6092.45167934888, 6107.389261073857, 6113.602615829956, 5628.296462942132, 5793.565482588907, 5847.210626565529, 5851.502622276984, 5861.267341582302, 5788.813293274953, 5817.825465236049, 5841.415858414294, 5847.310237290894, 5880.794701986755, 5771.913421298768, 5779.884402312015, 5792.9710351447975, 5808.286555466063, 5875.911861322169, 5582.748776305158, 5848.53211743051, 5860.179574859438, 5907.881842363043, 5920.674362909909, 5714.5142263011085, 5829.892320459099, 5834.416558344302, 5888.3228428731245, 5893.204417403767], "value": 4417.834293442456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7263012685304, 770.7340967366257, 771.2326235395782, 790.9683612655494, 792.5838934559356, 14336.426542938283, 15119.999999999973, 15260.236988150604, 15272.312745926432, 15311.770323445144, 14031.92984035081, 14105.717885642282, 14172.50396236132, 14179.574612761633, 14189.645258868533, 651.4072194303185, 770.2490072179636, 784.584170389693, 792.5997371327501, 802.8434455281223, 807.5154907055778, 809.5992483720566, 811.3428123220181, 811.6428771340592, 812.9309008734235, 854.4403415762686, 855.6791203298762, 855.8502262104138, 856.3192262151605, 860.8192279621287, 847.4152834544145, 849.5794581682076, 851.3317046118798, 854.6709516836, 855.4140413816556, 618.9690515474208, 622.5019984012816, 625.1778910732418, 625.2996643758974, 626.2891618013588, 13713.45146194161, 13810.516631917835, 13821.447142114404, 13854.584362469142, 13987.720245595134, 14269.005847953236, 14934.25328733559, 14950.177740224284, 14996.175210363426, 15263.618409539851, 11856.585019524362, 11959.940200298943, 11968.0, 12066.939665301705, 12193.085518586053, 3532.540769699948, 3537.398642230801, 3582.5342705448124, 3583.3191693578397, 3623.6376362363817, 61833.69083154555, 62584.06123908145, 62827.0, 62842.0, 63091.0, 11283.435828208556, 11376.317420954769, 11491.71270718222, 11521.251118677259, 11802.350870702023, 21136.15455381798, 21141.89429052845, 21152.048157832935, 21190.258340957993, 21316.0, 8427.536485493234, 8683.348748843735, 8760.211580957744, 8820.2061814437, 8919.331050171264, 4700.388949436551, 4813.590844778163, 4832.906939558685, 4907.730074845917, 4911.386076740408, 3208.6470488246273, 3249.1552196429097, 3266.461033929375, 3295.2915123248135, 3312.734981201498, 571.7798647520734, 575.2981362737454, 580.2427831679698, 582.962107463022, 586.7330364684059, 614.6496496996758, 701.9435749197527, 729.8321386081232, 751.4702134994816, 752.811886294657, 9658.613655453702, 9841.753956151153, 9899.010098990188, 10147.847782283272, 10220.744481388025, 658.9637569933603, 696.7665831946254, 697.7906628011576, 742.9739959101405, 745.5899255409612, 4368.7815609219415, 4593.724376537419, 4826.463398240464, 4896.265560165933, 4908.558229759267, 51849.0, 55520.0, 70032.2996770036, 72199.63900180465, 73060.0, 62770.68614656897, 69227.0, 69284.0, 70355.0, 73151.63424182951, 65342.346576534575, 65770.0, 65821.0, 67078.3292167072, 67224.0, 9595.664151754934, 9972.900270997487, 10072.395656260647, 10072.7848258276, 10202.438865862448, 42756.14487710166, 43316.35025474557, 44185.0, 44394.11211775682, 44751.0, 36669.63330366662, 37205.0698732523, 37303.06742331355, 40157.196856063296, 53972.73013635064, 10518.105960993402, 11183.0, 11206.0, 12890.35548222604, 13237.338133093499, 12752.4261408235, 12756.234625922474, 12823.61529154127, 14425.134491930517, 14704.338304776096, 13885.861141388457, 14032.22822744759, 14301.856981430468, 14413.85586144167, 14424.495142669955, 13523.120997135155, 13911.165330080228, 14040.648983775487, 14451.349689264218, 15062.171580563174, 13028.54400095992, 13625.795613065613, 14620.268986550418, 14651.340689669203, 15030.323635436212, 11268.0, 11335.659930202108, 11688.0, 11702.941485292518, 12226.449809758404, 11904.940475297568, 12010.175065093597, 12142.034396473126, 12169.39153042362, 12250.264984100982], "value": 7082.011823341848, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 106.0, 115.0, 114.0, 113.0, 114.0, 112.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 146.0, 174.0, 120.0, 150.0, 146.0, 125.0, 179.0, 120.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 165.0, 168.0, 167.0, 162.0, 163.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 172.0, 76.0, 75.0, 75.0, 75.0, 160.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 87.0, 88.0, 84.0, 149.0, 83.0, 84.0, 151.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 53.0, 52.0, 52.0, 54.0, 52.0, 53.0, 51.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 64.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 86.0, 77.0, 79.0, 82.0, 76.0, 76.0, 82.0, 76.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 130.0, 131.0, 124.0, 122.0, 127.0, 131.0, 161.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 154.0, 160.0, 160.0, 157.0, 166.0, 156.0, 159.0, 154.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 65.0, 63.0, 66.0, 64.0, 63.0, 62.0], "value": 64.0, "unit": "score"}]}]} 20:41:38 INFO - Return code: 0 20:41:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:41:38 ERROR - # TBPL SUCCESS # 20:41:38 INFO - Running post-action listener: _resource_record_post_action 20:41:38 INFO - [mozharness: 2016-07-28 03:41:38.137166Z] Finished run-tests step (success) 20:41:38 INFO - Running post-run listener: _resource_record_post_run 20:41:38 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555241472; Read time: 84; Write time: 518904 20:41:38 INFO - TinderboxPrint: CPU usage
13.3% 20:41:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 84 20:41:38 INFO - TinderboxPrint: I/O write bytes / time
555,241,472 / 518,904 20:41:38 INFO - TinderboxPrint: CPU idle
8,227.8 (86.6%) 20:41:38 INFO - TinderboxPrint: CPU user
1,209.4 (12.7%) 20:41:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:41:38 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257679360; Read time: 0; Write time: 287192 20:41:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297562112; Read time: 72; Write time: 231712 20:41:38 INFO - Running post-run listener: _upload_blobber_files 20:41:38 INFO - Blob upload gear active. 20:41:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:41:38 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 20:41:38 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:41:38 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:41:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:39 INFO - (blobuploader) - INFO - Done attempting. 20:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:40 INFO - (blobuploader) - INFO - Done attempting. 20:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:44 INFO - (blobuploader) - INFO - Done attempting. 20:41:44 INFO - (blobuploader) - INFO - Iteration through files over. 20:41:44 INFO - Return code: 0 20:41:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:41:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:41:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d01bce60b8fc4f4d6086858d0ff13aff02cd8576da3f727a028d0961d78c3d73950fe5203b5111c9258da5282655c7a965edd5113b9c281980056f95be23ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8995365523ebbd0c4e587ecffbaccda8ab8bcbcf97d2961e5e7a536067ffaa7a55bd514aa659741fc0448e6a2e5b8abdb2d13703726a1e8330bcc6e0c8212d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa9bb7fcfe9517f5af39bacabb162c199f2741e88b996900890a60483116316346ad7309695e89fa350451a5de1887cf6f148b6fbaff15a0a1d87ee812093f24"} 20:41:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:41:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:41:44 INFO - Contents: 20:41:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d01bce60b8fc4f4d6086858d0ff13aff02cd8576da3f727a028d0961d78c3d73950fe5203b5111c9258da5282655c7a965edd5113b9c281980056f95be23ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8995365523ebbd0c4e587ecffbaccda8ab8bcbcf97d2961e5e7a536067ffaa7a55bd514aa659741fc0448e6a2e5b8abdb2d13703726a1e8330bcc6e0c8212d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa9bb7fcfe9517f5af39bacabb162c199f2741e88b996900890a60483116316346ad7309695e89fa350451a5de1887cf6f148b6fbaff15a0a1d87ee812093f24"} 20:41:44 INFO - Running post-run listener: copy_logs_to_upload_dir 20:41:44 INFO - Copying logs to upload dir... 20:41:44 INFO - mkdir: /builds/slave/test/build/upload/logs 20:41:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.739425 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-27 20:41:44.674619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 20:41:44.678332) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 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/Fx-Team/sha512/61d01bce60b8fc4f4d6086858d0ff13aff02cd8576da3f727a028d0961d78c3d73950fe5203b5111c9258da5282655c7a965edd5113b9c281980056f95be23ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8995365523ebbd0c4e587ecffbaccda8ab8bcbcf97d2961e5e7a536067ffaa7a55bd514aa659741fc0448e6a2e5b8abdb2d13703726a1e8330bcc6e0c8212d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa9bb7fcfe9517f5af39bacabb162c199f2741e88b996900890a60483116316346ad7309695e89fa350451a5de1887cf6f148b6fbaff15a0a1d87ee812093f24"} build_url:https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/ficJQUfwTH21J-L49Xp77Q/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/Fx-Team/sha512/61d01bce60b8fc4f4d6086858d0ff13aff02cd8576da3f727a028d0961d78c3d73950fe5203b5111c9258da5282655c7a965edd5113b9c281980056f95be23ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8995365523ebbd0c4e587ecffbaccda8ab8bcbcf97d2961e5e7a536067ffaa7a55bd514aa659741fc0448e6a2e5b8abdb2d13703726a1e8330bcc6e0c8212d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa9bb7fcfe9517f5af39bacabb162c199f2741e88b996900890a60483116316346ad7309695e89fa350451a5de1887cf6f148b6fbaff15a0a1d87ee812093f24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 20:41:44.705033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:41:44.705439) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469676061.930555-1929729294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:41:44.790465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 20:41:44.791181) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 20:41:44.791779) ========= ========= Total master_lag: 0.18 =========