builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1469676135.16 results: success (0) buildid: 20160727173017 builduid: ed12dd8b1b924c6abd3093a09b1f2b8a revision: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.164618) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.165086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.165466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.199253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.199589) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 20:22: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% 39.2M=0s 2016-07-27 20:22:15 (39.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.332049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.332379) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.381185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:15.381570) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 20:22:15,532 truncating revision to first 12 chars 2016-07-27 20:22:15,532 Setting DEBUG logging. 2016-07-27 20:22:15,532 attempt 1/10 2016-07-27 20:22:15,532 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:22:15,853 unpacking tar archive at: fx-team-7c1ddc822381/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:16.081259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:16.081604) ========= script_repo_revision: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:16.081999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:16.082269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 20:22:16.092669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-27 20:22:16.093034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:16 INFO - MultiFileLogger online at 20160727 20:22:16 in /builds/slave/test 20:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:16 INFO - {'append_to_log': False, 20:22:16 INFO - 'base_work_dir': '/builds/slave/test', 20:22:16 INFO - 'blob_upload_branch': 'Fx-Team', 20:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:16 INFO - 'branch': 'Fx-Team', 20:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:16 INFO - 'config_files': ('talos/linux_config.py',), 20:22:16 INFO - 'default_actions': ('clobber', 20:22:16 INFO - 'read-buildbot-config', 20:22:16 INFO - 'download-and-extract', 20:22:16 INFO - 'populate-webroot', 20:22:16 INFO - 'create-virtualenv', 20:22:16 INFO - 'install', 20:22:16 INFO - 'run-tests'), 20:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:16 INFO - 'download_minidump_stackwalk': True, 20:22:16 INFO - 'download_symbols': 'ondemand', 20:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:16 INFO - 'installer_path': 'installer.exe', 20:22:16 INFO - 'log_level': 'info', 20:22:16 INFO - 'log_name': 'talos', 20:22:16 INFO - 'log_to_console': True, 20:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:16 INFO - 'opt_config_files': (), 20:22:16 INFO - 'pip_index': False, 20:22:16 INFO - 'sps_profile': False, 20:22:16 INFO - 'sps_profile_interval': 0, 20:22:16 INFO - 'suite': 'dromaeojs', 20:22:16 INFO - 'system_bits': '32', 20:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:16 INFO - 'title': 'talos-linux64-ix-014', 20:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:16 INFO - 'use_talos_json': True, 20:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:16 INFO - 'work_dir': 'build'} 20:22:16 INFO - [mozharness: 2016-07-28 03:22:16.339975Z] Running clobber step. 20:22:16 INFO - Running pre-action listener: _resource_record_pre_action 20:22:16 INFO - Running main action method: clobber 20:22:16 INFO - rmtree: /builds/slave/test/build 20:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:16 INFO - Running post-action listener: _resource_record_post_action 20:22:16 INFO - [mozharness: 2016-07-28 03:22:16.811331Z] Finished clobber step (success) 20:22:16 INFO - [mozharness: 2016-07-28 03:22:16.811431Z] Running read-buildbot-config step. 20:22:16 INFO - Running pre-action listener: _resource_record_pre_action 20:22:16 INFO - Running main action method: read_buildbot_config 20:22:16 INFO - Using buildbot properties: 20:22:16 INFO - { 20:22:16 INFO - "project": "", 20:22:16 INFO - "product": "firefox", 20:22:16 INFO - "script_repo_revision": "production", 20:22:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:22:16 INFO - "repository": "", 20:22:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:22:16 INFO - "buildid": "20160727173017", 20:22:16 INFO - "pgo_build": "True", 20:22:16 INFO - "basedir": "/builds/slave/test", 20:22:16 INFO - "buildnumber": 1375, 20:22:16 INFO - "slavename": "talos-linux64-ix-014", 20:22:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:22:16 INFO - "platform": "ubuntu64_hw", 20:22:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:22:16 INFO - "branch": "fx-team", 20:22:16 INFO - "repo_path": "integration/fx-team", 20:22:16 INFO - "revision": "7c1ddc8223812aed002c47b4a169d7550a7c9c99", 20:22:16 INFO - "stage_platform": "linux64-pgo", 20:22:16 INFO - "builduid": "ed12dd8b1b924c6abd3093a09b1f2b8a", 20:22:16 INFO - "slavebuilddir": "test" 20:22:16 INFO - } 20:22:16 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:22:16 INFO - Running post-action listener: _resource_record_post_action 20:22:16 INFO - [mozharness: 2016-07-28 03:22:16.813860Z] Finished read-buildbot-config step (success) 20:22:16 INFO - [mozharness: 2016-07-28 03:22:16.813948Z] Running download-and-extract step. 20:22:16 INFO - Running pre-action listener: _resource_record_pre_action 20:22:16 INFO - Running main action method: download_and_extract 20:22:16 INFO - mkdir: /builds/slave/test/build/tests 20:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:16 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:22:16 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:22:16 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:22:16 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:22:16 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:22:17 INFO - Downloaded 1361 bytes. 20:22:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:17 INFO - Using the following test package requirements: 20:22:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:22:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'jsshell-linux-x86_64.zip'], 20:22:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22: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:22:17 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:22: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.common.tests.zip 20:22: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.common.tests.zip 20:22: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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:17 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:22:18 INFO - Downloaded 24318212 bytes. 20:22:18 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:22:18 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:22:19 INFO - Return code: 0 20:22:19 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:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:20 INFO - Downloaded 24318212 bytes. 20:22:20 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:22:20 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:22:22 INFO - Return code: 0 20:22: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:22: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:22: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:22: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:22: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:22: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:22:23 INFO - Downloaded 14413725 bytes. 20:22: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:22: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:22:23 INFO - Return code: 0 20:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:23 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:22:23 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:22:23 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:22:23 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:22:23 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:22:24 INFO - Downloaded 60994033 bytes. 20:22:24 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:22:24 INFO - mkdir: /builds/slave/test/properties 20:22:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:24 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:24 INFO - Contents: 20:22:24 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:22:25 INFO - Running post-action listener: _resource_record_post_action 20:22:25 INFO - Running post-action listener: set_extra_try_arguments 20:22:25 INFO - [mozharness: 2016-07-28 03:22:25.479931Z] Finished download-and-extract step (success) 20:22:25 INFO - [mozharness: 2016-07-28 03:22:25.480163Z] Running populate-webroot step. 20:22:25 INFO - Running pre-action listener: _resource_record_pre_action 20:22:25 INFO - Running main action method: populate_webroot 20:22:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:25 INFO - '--tppagecycles', 20:22:25 INFO - '7'], 20:22:25 INFO - 'tests': ['tsvgm']}}, 20:22:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:22:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:22:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:22:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['damp', 'tps']}, 20:22:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'tests': ['damp', 'tps']}, 20:22:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['dromaeo_dom']}, 20:22:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['basic_compositor_video']}, 20:22:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:22:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['a11yr', 20:22:25 INFO - 'ts_paint', 20:22:25 INFO - 'tpaint', 20:22:25 INFO - 'sessionrestore', 20:22:25 INFO - 'sessionrestore_no_auto_restore', 20:22:25 INFO - 'tabpaint']}, 20:22:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['tsvgx', 20:22:25 INFO - 'tsvgr_opacity', 20:22:25 INFO - 'tart', 20:22:25 INFO - 'tscrollx', 20:22:25 INFO - 'cart']}, 20:22:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:22:25 INFO - 'tsvgr_opacity', 20:22:25 INFO - 'tart', 20:22:25 INFO - 'tscrollx', 20:22:25 INFO - 'cart']}, 20:22:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'talos_options': ['--disable-e10s'], 20:22:25 INFO - 'tests': ['tp5o']}, 20:22:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'tests': ['tp5o']}, 20:22:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'talos_options': ['--disable-e10s', 20:22:25 INFO - '--xperf_path', 20:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:25 INFO - 'tests': ['tp5n']}, 20:22:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:25 INFO - 'talos_options': ['--xperf_path', 20:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:25 INFO - 'tests': ['tp5n']}}, 20:22:25 INFO - 'talos.zip': {'path': '', 20:22:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:25 INFO - Running post-action listener: _resource_record_post_action 20:22:25 INFO - [mozharness: 2016-07-28 03:22:25.504531Z] Finished populate-webroot step (success) 20:22:25 INFO - [mozharness: 2016-07-28 03:22:25.504620Z] Running create-virtualenv step. 20:22:25 INFO - Running pre-action listener: _resource_record_pre_action 20:22:25 INFO - Running main action method: create_virtualenv 20:22:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:25 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:22:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:25 INFO - Using real prefix '/usr' 20:22:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:28 INFO - Installing pip.................done. 20:22:28 INFO - Return code: 0 20:22:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22: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:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:28 INFO - Using env: {'DISPLAY': ':0', 20:22:28 INFO - 'HOME': '/home/cltbld', 20:22:28 INFO - 'LANG': 'en_US.UTF-8', 20:22:28 INFO - 'LANGUAGE': 'en_US:en', 20:22:28 INFO - 'LOGNAME': 'cltbld', 20:22:28 INFO - 'MAIL': '/var/mail/cltbld', 20:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:28 INFO - 'MOZ_NO_REMOTE': '1', 20:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:28 INFO - 'NO_EM_RESTART': '1', 20:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:28 INFO - 'PWD': '/builds/slave/test', 20:22:28 INFO - 'SHELL': '/bin/bash', 20:22:28 INFO - 'SHLVL': '1', 20:22:28 INFO - 'TERM': 'linux', 20:22:28 INFO - 'TMOUT': '86400', 20:22:28 INFO - 'USER': 'cltbld', 20:22:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:28 INFO - '_': '/tools/buildbot/bin/python'} 20:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22: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:22:28 INFO - Cleaning up... 20:22:28 INFO - Return code: 0 20:22:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:22: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:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:28 INFO - Using env: {'DISPLAY': ':0', 20:22:28 INFO - 'HOME': '/home/cltbld', 20:22:28 INFO - 'LANG': 'en_US.UTF-8', 20:22:28 INFO - 'LANGUAGE': 'en_US:en', 20:22:28 INFO - 'LOGNAME': 'cltbld', 20:22:28 INFO - 'MAIL': '/var/mail/cltbld', 20:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:28 INFO - 'MOZ_NO_REMOTE': '1', 20:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:28 INFO - 'NO_EM_RESTART': '1', 20:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:28 INFO - 'PWD': '/builds/slave/test', 20:22:28 INFO - 'SHELL': '/bin/bash', 20:22:28 INFO - 'SHLVL': '1', 20:22:28 INFO - 'TERM': 'linux', 20:22:28 INFO - 'TMOUT': '86400', 20:22:28 INFO - 'USER': 'cltbld', 20:22:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:28 INFO - '_': '/tools/buildbot/bin/python'} 20:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:28 INFO - Downloading/unpacking psutil>=3.1.1 20:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:30 INFO - Installing collected packages: psutil 20:22:30 INFO - Running setup.py install for psutil 20:22:30 INFO - building 'psutil._psutil_linux' extension 20:22:30 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:22:30 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:22:30 INFO - building 'psutil._psutil_posix' extension 20:22:30 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:22:30 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:22:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:31 INFO - Successfully installed psutil 20:22:31 INFO - Cleaning up... 20:22:31 INFO - Return code: 0 20:22:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:22: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:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:31 INFO - Using env: {'DISPLAY': ':0', 20:22:31 INFO - 'HOME': '/home/cltbld', 20:22:31 INFO - 'LANG': 'en_US.UTF-8', 20:22:31 INFO - 'LANGUAGE': 'en_US:en', 20:22:31 INFO - 'LOGNAME': 'cltbld', 20:22:31 INFO - 'MAIL': '/var/mail/cltbld', 20:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:31 INFO - 'MOZ_NO_REMOTE': '1', 20:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:31 INFO - 'NO_EM_RESTART': '1', 20:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:31 INFO - 'PWD': '/builds/slave/test', 20:22:31 INFO - 'SHELL': '/bin/bash', 20:22:31 INFO - 'SHLVL': '1', 20:22:31 INFO - 'TERM': 'linux', 20:22:31 INFO - 'TMOUT': '86400', 20:22:31 INFO - 'USER': 'cltbld', 20:22:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:31 INFO - '_': '/tools/buildbot/bin/python'} 20:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:22: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:22: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:22: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:22: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:22: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:22: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:22:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:22: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:22:33 INFO - Installing collected packages: mozsystemmonitor 20:22:33 INFO - Running setup.py install for mozsystemmonitor 20:22:33 INFO - Successfully installed mozsystemmonitor 20:22:33 INFO - Cleaning up... 20:22:33 INFO - Return code: 0 20:22:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:22:33 INFO - Using env: {'DISPLAY': ':0', 20:22:33 INFO - 'HOME': '/home/cltbld', 20:22:33 INFO - 'LANG': 'en_US.UTF-8', 20:22:33 INFO - 'LANGUAGE': 'en_US:en', 20:22:33 INFO - 'LOGNAME': 'cltbld', 20:22:33 INFO - 'MAIL': '/var/mail/cltbld', 20:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:33 INFO - 'MOZ_NO_REMOTE': '1', 20:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:33 INFO - 'NO_EM_RESTART': '1', 20:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:33 INFO - 'PWD': '/builds/slave/test', 20:22:33 INFO - 'SHELL': '/bin/bash', 20:22:33 INFO - 'SHLVL': '1', 20:22:33 INFO - 'TERM': 'linux', 20:22:33 INFO - 'TMOUT': '86400', 20:22:33 INFO - 'USER': 'cltbld', 20:22:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:33 INFO - '_': '/tools/buildbot/bin/python'} 20:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:33 INFO - Downloading/unpacking jsonschema==2.5.1 20:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:22:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:22:36 INFO - warning: no files found matching '*.txt' 20:22:36 INFO - no previously-included directories found matching 'build' 20:22:36 INFO - no previously-included directories found matching 'dist' 20:22:36 INFO - no previously-included directories found matching '.git*' 20:22:36 INFO - Installing collected packages: jsonschema, functools32 20:22:36 INFO - Running setup.py install for functools32 20:22:36 INFO - warning: no files found matching '*.txt' 20:22:36 INFO - no previously-included directories found matching 'build' 20:22:36 INFO - no previously-included directories found matching 'dist' 20:22:36 INFO - no previously-included directories found matching '.git*' 20:22:36 INFO - Successfully installed jsonschema functools32 20:22:36 INFO - Cleaning up... 20:22:36 INFO - Return code: 0 20:22:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:22: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:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:36 INFO - Using env: {'DISPLAY': ':0', 20:22:36 INFO - 'HOME': '/home/cltbld', 20:22:36 INFO - 'LANG': 'en_US.UTF-8', 20:22:36 INFO - 'LANGUAGE': 'en_US:en', 20:22:36 INFO - 'LOGNAME': 'cltbld', 20:22:36 INFO - 'MAIL': '/var/mail/cltbld', 20:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:36 INFO - 'MOZ_NO_REMOTE': '1', 20:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:36 INFO - 'NO_EM_RESTART': '1', 20:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:36 INFO - 'PWD': '/builds/slave/test', 20:22:36 INFO - 'SHELL': '/bin/bash', 20:22:36 INFO - 'SHLVL': '1', 20:22:36 INFO - 'TERM': 'linux', 20:22:36 INFO - 'TMOUT': '86400', 20:22:36 INFO - 'USER': 'cltbld', 20:22:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:36 INFO - '_': '/tools/buildbot/bin/python'} 20:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:22:36 INFO - Cleaning up... 20:22:36 INFO - Return code: 0 20:22:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:22: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:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:36 INFO - Using env: {'DISPLAY': ':0', 20:22:36 INFO - 'HOME': '/home/cltbld', 20:22:36 INFO - 'LANG': 'en_US.UTF-8', 20:22:36 INFO - 'LANGUAGE': 'en_US:en', 20:22:36 INFO - 'LOGNAME': 'cltbld', 20:22:36 INFO - 'MAIL': '/var/mail/cltbld', 20:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:36 INFO - 'MOZ_NO_REMOTE': '1', 20:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:36 INFO - 'NO_EM_RESTART': '1', 20:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:36 INFO - 'PWD': '/builds/slave/test', 20:22:36 INFO - 'SHELL': '/bin/bash', 20:22:36 INFO - 'SHLVL': '1', 20:22:36 INFO - 'TERM': 'linux', 20:22:36 INFO - 'TMOUT': '86400', 20:22:36 INFO - 'USER': 'cltbld', 20:22:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:36 INFO - '_': '/tools/buildbot/bin/python'} 20:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:36 INFO - Downloading/unpacking blobuploader==1.2.4 20:22: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:22: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:22: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:22: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:22: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:22: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:22:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:22:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:22: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:22: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:22: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:22: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:22: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:22: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:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:22:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:22: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:22: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:22: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:22: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:22: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:22: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:22:39 INFO - Downloading docopt-0.6.1.tar.gz 20:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:22:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:22:39 INFO - Running setup.py install for blobuploader 20:22:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:22:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:22:39 INFO - Running setup.py install for requests 20:22:39 INFO - Running setup.py install for docopt 20:22:40 INFO - Successfully installed blobuploader requests docopt 20:22:40 INFO - Cleaning up... 20:22:40 INFO - Return code: 0 20:22:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22: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:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:40 INFO - Using env: {'DISPLAY': ':0', 20:22:40 INFO - 'HOME': '/home/cltbld', 20:22:40 INFO - 'LANG': 'en_US.UTF-8', 20:22:40 INFO - 'LANGUAGE': 'en_US:en', 20:22:40 INFO - 'LOGNAME': 'cltbld', 20:22:40 INFO - 'MAIL': '/var/mail/cltbld', 20:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:40 INFO - 'MOZ_NO_REMOTE': '1', 20:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:40 INFO - 'NO_EM_RESTART': '1', 20:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:40 INFO - 'PWD': '/builds/slave/test', 20:22:40 INFO - 'SHELL': '/bin/bash', 20:22:40 INFO - 'SHLVL': '1', 20:22:40 INFO - 'TERM': 'linux', 20:22:40 INFO - 'TMOUT': '86400', 20:22:40 INFO - 'USER': 'cltbld', 20:22:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:40 INFO - '_': '/tools/buildbot/bin/python'} 20:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:40 INFO - Running setup.py (path:/tmp/pip-076WOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:40 INFO - Running setup.py (path:/tmp/pip-ymEQpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:40 INFO - Running setup.py (path:/tmp/pip-8lCAo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:40 INFO - Running setup.py (path:/tmp/pip-GpkPQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:40 INFO - Running setup.py (path:/tmp/pip-8ZHLw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:40 INFO - Running setup.py (path:/tmp/pip-lMnK0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:40 INFO - Running setup.py (path:/tmp/pip-VpaLL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:40 INFO - Running setup.py (path:/tmp/pip-m98N1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:40 INFO - Running setup.py (path:/tmp/pip-bkfAl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:41 INFO - Running setup.py (path:/tmp/pip-TYH9Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:41 INFO - Running setup.py (path:/tmp/pip-RMsolR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:41 INFO - Running setup.py (path:/tmp/pip-iV9QQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:41 INFO - Running setup.py (path:/tmp/pip-7A6Q1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:41 INFO - Running setup.py (path:/tmp/pip-dpmtR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:41 INFO - Running setup.py (path:/tmp/pip-OoAPk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:41 INFO - Running setup.py (path:/tmp/pip-QRJpgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:41 INFO - Running setup.py (path:/tmp/pip-BHqawU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:22:41 INFO - Running setup.py install for manifestparser 20:22:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:22:41 INFO - Running setup.py install for mozcrash 20:22:41 INFO - Running setup.py install for mozdebug 20:22:41 INFO - Running setup.py install for mozdevice 20:22:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:22:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:22:41 INFO - Running setup.py install for mozfile 20:22:42 INFO - Running setup.py install for mozhttpd 20:22:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for mozinfo 20:22:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for mozInstall 20:22:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for mozleak 20:22:42 INFO - Running setup.py install for mozlog 20:22:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for moznetwork 20:22:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for mozprocess 20:22:42 INFO - Running setup.py install for mozprofile 20:22:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:22:42 INFO - Running setup.py install for mozrunner 20:22:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:22:43 INFO - Running setup.py install for mozscreenshot 20:22:43 INFO - Running setup.py install for moztest 20:22:43 INFO - Running setup.py install for mozversion 20:22:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:22:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:22:43 INFO - Cleaning up... 20:22:43 INFO - Return code: 0 20:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22: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:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:43 INFO - Using env: {'DISPLAY': ':0', 20:22:43 INFO - 'HOME': '/home/cltbld', 20:22:43 INFO - 'LANG': 'en_US.UTF-8', 20:22:43 INFO - 'LANGUAGE': 'en_US:en', 20:22:43 INFO - 'LOGNAME': 'cltbld', 20:22:43 INFO - 'MAIL': '/var/mail/cltbld', 20:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:43 INFO - 'MOZ_NO_REMOTE': '1', 20:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:43 INFO - 'NO_EM_RESTART': '1', 20:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:43 INFO - 'PWD': '/builds/slave/test', 20:22:43 INFO - 'SHELL': '/bin/bash', 20:22:43 INFO - 'SHLVL': '1', 20:22:43 INFO - 'TERM': 'linux', 20:22:43 INFO - 'TMOUT': '86400', 20:22:43 INFO - 'USER': 'cltbld', 20:22:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:43 INFO - '_': '/tools/buildbot/bin/python'} 20:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:43 INFO - Running setup.py (path:/tmp/pip-1VPWYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22: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:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:43 INFO - Running setup.py (path:/tmp/pip-oOquXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22: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:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:43 INFO - Running setup.py (path:/tmp/pip-rqqTaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22: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:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:43 INFO - Running setup.py (path:/tmp/pip-SGslSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:43 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:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:43 INFO - Running setup.py (path:/tmp/pip-A_WKh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:43 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:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:43 INFO - Running setup.py (path:/tmp/pip-sGC04N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:44 INFO - Running setup.py (path:/tmp/pip-0b4LTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:44 INFO - Running setup.py (path:/tmp/pip-3eHN77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:44 INFO - Running setup.py (path:/tmp/pip-FYU89d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:44 INFO - Running setup.py (path:/tmp/pip-9pwhT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:44 INFO - Running setup.py (path:/tmp/pip-6RcZq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:44 INFO - Running setup.py (path:/tmp/pip-9po7R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:44 INFO - Running setup.py (path:/tmp/pip-FIsNt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:44 INFO - Running setup.py (path:/tmp/pip-n0V8vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:44 INFO - Running setup.py (path:/tmp/pip-Jgwu14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:44 INFO - Running setup.py (path:/tmp/pip-PpzSkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22: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:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:44 INFO - Running setup.py (path:/tmp/pip-VQduvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:44 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:22:44 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:22:44 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:22:44 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:22:44 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:22:44 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:22:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:22:44 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:22:44 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:22:44 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:22:44 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:22:44 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:22:44 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:22:46 INFO - Downloading blessings-1.6.tar.gz 20:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:22:46 INFO - Installing collected packages: blessings 20:22:46 INFO - Running setup.py install for blessings 20:22:46 INFO - Successfully installed blessings 20:22:46 INFO - Cleaning up... 20:22:46 INFO - Return code: 0 20:22:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Current package versions: 20:22:47 INFO - argparse == 1.2.1 20:22:47 INFO - blessings == 1.6 20:22:47 INFO - blobuploader == 1.2.4 20:22:47 INFO - docopt == 0.6.1 20:22:47 INFO - functools32 == 3.2.3-2 20:22:47 INFO - jsonschema == 2.5.1 20:22:47 INFO - manifestparser == 1.1 20:22:47 INFO - mozInstall == 1.12 20:22:47 INFO - mozcrash == 0.17 20:22:47 INFO - mozdebug == 0.1 20:22:47 INFO - mozdevice == 0.48 20:22:47 INFO - mozfile == 1.2 20:22:47 INFO - mozhttpd == 0.7 20:22:47 INFO - mozinfo == 0.9 20:22:47 INFO - mozleak == 0.1 20:22:47 INFO - mozlog == 3.3 20:22:47 INFO - moznetwork == 0.27 20:22:47 INFO - mozprocess == 0.23 20:22:47 INFO - mozprofile == 0.28 20:22:47 INFO - mozrunner == 6.12 20:22:47 INFO - mozscreenshot == 0.1 20:22:47 INFO - mozsystemmonitor == 0.3 20:22:47 INFO - moztest == 0.7 20:22:47 INFO - mozversion == 1.4 20:22:47 INFO - psutil == 3.1.1 20:22:47 INFO - requests == 1.2.3 20:22:47 INFO - wsgiref == 0.1.2 20:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22: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:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:47 INFO - Using env: {'DISPLAY': ':0', 20:22:47 INFO - 'HOME': '/home/cltbld', 20:22:47 INFO - 'LANG': 'en_US.UTF-8', 20:22:47 INFO - 'LANGUAGE': 'en_US:en', 20:22:47 INFO - 'LOGNAME': 'cltbld', 20:22:47 INFO - 'MAIL': '/var/mail/cltbld', 20:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:47 INFO - 'MOZ_NO_REMOTE': '1', 20:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:47 INFO - 'NO_EM_RESTART': '1', 20:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:47 INFO - 'PWD': '/builds/slave/test', 20:22:47 INFO - 'SHELL': '/bin/bash', 20:22:47 INFO - 'SHLVL': '1', 20:22:47 INFO - 'TERM': 'linux', 20:22:47 INFO - 'TMOUT': '86400', 20:22:47 INFO - 'USER': 'cltbld', 20:22:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:47 INFO - '_': '/tools/buildbot/bin/python'} 20:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22: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:22: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:22: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:22: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:22: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:22: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:22: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:22: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:22: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:22: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:22: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:22:47 INFO - Cleaning up... 20:22:47 INFO - Return code: 0 20:22:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:22: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:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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 0x1c80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', '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:22: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:22: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:22:47 INFO - Using env: {'DISPLAY': ':0', 20:22:47 INFO - 'HOME': '/home/cltbld', 20:22:47 INFO - 'LANG': 'en_US.UTF-8', 20:22:47 INFO - 'LANGUAGE': 'en_US:en', 20:22:47 INFO - 'LOGNAME': 'cltbld', 20:22:47 INFO - 'MAIL': '/var/mail/cltbld', 20:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:47 INFO - 'MOZ_NO_REMOTE': '1', 20:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:47 INFO - 'NO_EM_RESTART': '1', 20:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:47 INFO - 'PWD': '/builds/slave/test', 20:22:47 INFO - 'SHELL': '/bin/bash', 20:22:47 INFO - 'SHLVL': '1', 20:22:47 INFO - 'TERM': 'linux', 20:22:47 INFO - 'TMOUT': '86400', 20:22:47 INFO - 'USER': 'cltbld', 20:22:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:47 INFO - '_': '/tools/buildbot/bin/python'} 20:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:22:47 INFO - Cleaning up... 20:22:47 INFO - Return code: 0 20:22:47 INFO - Running post-action listener: _resource_record_post_action 20:22:47 INFO - Running post-action listener: _start_resource_monitoring 20:22:47 INFO - Starting resource monitoring. 20:22:47 INFO - [mozharness: 2016-07-28 03:22:47.658893Z] Finished create-virtualenv step (success) 20:22:47 INFO - [mozharness: 2016-07-28 03:22:47.659370Z] Running install step. 20:22:47 INFO - Running pre-action listener: _resource_record_pre_action 20:22:47 INFO - Running main action method: install 20:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 20:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Output received: 20:22:47 INFO - Usage: mozinstall [options] installer 20:22:47 INFO - Options: 20:22:47 INFO - -h, --help show this help message and exit 20:22:47 INFO - -d DEST, --destination=DEST 20:22:47 INFO - Directory to install application into. [default: 20:22:47 INFO - "/builds/slave/test"] 20:22:47 INFO - --app=APP Application being installed. [default: firefox] 20:22:47 INFO - mkdir: /builds/slave/test/build/application 20:22:47 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:22:47 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:23:05 INFO - Reading from file tmpfile_stdout 20:23:05 INFO - Output received: 20:23:05 INFO - /builds/slave/test/build/application/firefox/firefox 20:23:05 INFO - Running post-action listener: _resource_record_post_action 20:23:05 INFO - [mozharness: 2016-07-28 03:23:05.236839Z] Finished install step (success) 20:23:05 INFO - [mozharness: 2016-07-28 03:23:05.237160Z] Running run-tests step. 20:23:05 INFO - Running pre-action listener: _resource_record_pre_action 20:23:05 INFO - Running main action method: run_tests 20:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:23:05 INFO - Python 2.7.3 20:23:05 INFO - Return code: 0 20:23:05 INFO - grabbing minidump binary from tooltool 20:23: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:23: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 0x1f3f3b0>, '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 0x1f402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f40740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:23: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:23: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:23: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:23:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:23:05 INFO - Return code: 0 20:23:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:23:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:23:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:23:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:23:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:23: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', '--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-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:23: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 --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-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:23:05 INFO - Using env: {'DISPLAY': ':0', 20:23:05 INFO - 'HOME': '/home/cltbld', 20:23:05 INFO - 'LANG': 'en_US.UTF-8', 20:23:05 INFO - 'LANGUAGE': 'en_US:en', 20:23:05 INFO - 'LOGNAME': 'cltbld', 20:23:05 INFO - 'MAIL': '/var/mail/cltbld', 20:23:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:23:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:05 INFO - 'MOZ_NO_REMOTE': '1', 20:23:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:05 INFO - 'NO_EM_RESTART': '1', 20:23:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:05 INFO - 'PWD': '/builds/slave/test', 20:23:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:23:05 INFO - 'SHELL': '/bin/bash', 20:23:05 INFO - 'SHLVL': '1', 20:23:05 INFO - 'TERM': 'linux', 20:23:05 INFO - 'TMOUT': '86400', 20:23:05 INFO - 'USER': 'cltbld', 20:23:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484', 20:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:05 INFO - '_': '/tools/buildbot/bin/python'} 20:23: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', '--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-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:23:05 INFO - mozversion application_buildid: 20160727173017 20:23:05 INFO - mozversion application_changeset: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 20:23:05 INFO - mozversion application_display_name: Nightly 20:23:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:23:05 INFO - mozversion application_name: Firefox 20:23:05 INFO - mozversion application_remotingname: firefox 20:23:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:23:05 INFO - mozversion application_vendor: Mozilla 20:23:05 INFO - mozversion application_version: 50.0a1 20:23:05 INFO - mozversion platform_buildid: 20160727173017 20:23:05 INFO - mozversion platform_changeset: 7c1ddc8223812aed002c47b4a169d7550a7c9c99 20:23:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:23:05 INFO - mozversion platform_version: 50.0a1 20:23:05 INFO - using testdate: 1469676185 20:23:05 INFO - actual date: 1469676185 20:23:05 INFO - starting webserver on 'localhost:43356' 20:23:05 INFO - SUITE-START | Running 2 tests 20:23:05 INFO - TEST-START | dromaeo_css 20:23:05 INFO - operating with platform_type : linux_ 20:23:05 INFO - Initialising browser for dromaeo_css test... 20:23:05 INFO - TEST-INFO | started process 16605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2kfrP/profile http://localhost:43356/getInfo.html) 20:23:08 INFO - PROCESS | 16605 | JavaScript error: , line 0: uncaught exception: undefined 20:23:09 INFO - PROCESS | 16605 | __metrics Screen width/height:1600/1200 20:23:09 INFO - PROCESS | 16605 | colorDepth:24 20:23:09 INFO - PROCESS | 16605 | Browser inner width/height: 1024/697 20:23:09 INFO - PROCESS | 16605 | __metrics 20:23:10 INFO - PROCESS | 16605 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:23:10 INFO - PROCESS | 16605 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:11 INFO - TEST-INFO | 16605: exit 0 20:23:11 INFO - Browser initialized. 20:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:23:11 INFO - TEST-INFO | started process 16687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2kfrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:23 INFO - PROCESS | 16687 | RSS: Main: 158318592 20:23:23 INFO - PROCESS | 16687 | 20:24:14 INFO - PROCESS | 16687 | 1469676254637 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:26:22 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43356/tests/dromaeo/cssquery-ext.html) 20:26:23 INFO - PROCESS | 16687 | RSS: Main: 264286208 20:26:23 INFO - PROCESS | 16687 | 20:29:25 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-ext.html (next: http://localhost:43356/tests/dromaeo/cssquery-jquery.html) 20:29:26 INFO - PROCESS | 16687 | RSS: Main: 243355648 20:29:26 INFO - PROCESS | 16687 | 20:32:28 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43356/tests/dromaeo/cssquery-mootools.html) 20:32:29 INFO - PROCESS | 16687 | RSS: Main: 186535936 20:32:29 INFO - PROCESS | 16687 | 20:35:31 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43356/tests/dromaeo/cssquery-prototype.html) 20:35:31 INFO - PROCESS | 16687 | RSS: Main: 186392576 20:35:31 INFO - PROCESS | 16687 | 20:38:34 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43356/tests/dromaeo/cssquery-yui.html) 20:38:35 INFO - PROCESS | 16687 | RSS: Main: 186679296 20:38:35 INFO - PROCESS | 16687 | 20:41:37 INFO - PROCESS | 16687 | Cycle 1(1): loaded http://localhost:43356/tests/dromaeo/cssquery-yui.html (next: http://localhost:43356/tests/dromaeo/cssquery-dojo.html) 20:41:38 INFO - PROCESS | 16687 | RSS: Main: 279556096 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | __start_tp_report 20:41:38 INFO - PROCESS | 16687 | _x_x_mozilla_page_load 20:41:38 INFO - PROCESS | 16687 | _x_x_mozilla_page_load_details 20:41:38 INFO - PROCESS | 16687 | |i|pagename|runs| 20:41:38 INFO - PROCESS | 16687 | |0;dojo.html;3067.8772849086035;3102.7362674172696;3125.187451262671;3126.374725054988;3141.4345417824784;5244.475552444763;5282.947170528294;5368.946310536893;5455.863603409916;5465.043617366955;5337.919931201025;5343.706096164709;5388.218708287296;5412.485813847678;5476;4844.975775121128;4904.632152588552;4934.777934992916;4945.9258111128365;5105.489451054883;5009.273655319977;5036.34527511423;5049.520295571915;5065.670731402465;5066.949330506703;4799.424069111711;4828.468868424488;4840;4906.55840974314;5014.423341315741;4778.378810754614;4785.21044027735;4838.903221935577;4860.756962151913;4969.975150124226;4800.567948884617;4842.66101372904;4849.442314133849;4853.39332583427;4865.82969596066;5244.449332820075;5342.465753424665;5362.651427657229;5418.972905135489;5423.430539793304;5740.512056475204;5741.368449470555;5838.182654428383;5844.444777746107;5846.678432686201;5810.796622118248;5873.177755114288;5886.117082437626;5890.145928840337;5892.823215303548;5207.4792520748;5416.458354164592;5449.809256676037;5453.072977593819;5465.808696695596;5978.04351303798;5980.671063091485;6021.397860214031;6023.066424704178;6036.698165091728;5764.913526297109;5767.336756272998;5813.709314534256;5814.796482123105;5817.7963771267805;5556.055470570012;5703.429657034263;5746.597738158289;5895.823125306248;5905.143754155623;5763.827085187451;5766.913496297559;5809.2738407699035;5817.418258174149;5820.941790582125;5727.284089488814;5765.711714414262;5779.88440231193;5781.566382521328;5788.0449725795615;4310.439642846472;4369.80335884886;4385.144896745104;4433.534478879671;4480.081583275421;3893.3381325174787;3952.446657467957;3962.9405558916637;3979.2837289287627;4021.5375231848125;5502.944970550323;5503.229547863302;5508.697021663847;5509.559235261169;5514.09017512114;5577.637453565505;5757.165211044375;5792.0732682771395;5809.738561764731;5851.824445266649;5481.342238931354;5510.862228444321;5516.641418307797;5539.473749993825;5557.249771280906;4992.900141997213;5033.194688849767;5036.244563315532;5036.697798132051;5047.16721740916;5810.6513609183585;5911.793087241926;5965.135055417027;5976.252968378953;5976.9402305977255;5691.231683722644;5728.942710572841;5739.655620662774;5787.36339002701;5789.1605717171615;5938.317093534299;5948.2862056553495;5949.3753155918;5950.2264705587995;5950.464458198783;5603.10350343943;5645.350784659817;5650.350209725934;5698.544116470755;5701.287339082614;5749.166370876116;5769.798057067983;5820.447057529528;5856.0630299151935;5872.031114865999;5654.491095801398;5657.179708942263;5668.376478587435;5686.374498805211;5690.118031705092;5427.050266203478;5575.944240557543;5648.4633959773755;5649.915251271316;5657.151427285776;5525.309336332958;5614.494695477263;5619.213310136666;5668.319801623831;5669.291338582677;5695.231143795535;5700.287464066992;5749.482546570829;5750.712464376848;5750.942490575041;5372.597055220952;5563.443655634404;5573.247611572386;5574.358948720949;5582.27430434041 20:41:38 INFO - PROCESS | 16687 | |1;ext.html;602.3374288282889;608.6256951974535;627.1752645271467;630.653140772575;637.5600835423554;43803.34294985574;44792.10415791682;44948.32577511336;44990;47780.761096194554;45437;45971.77014114933;45989.31016034754;46028.76985615076;46080.53919460804;9096.727098187032;9170.495622740747;9226.261899048093;9229.6308147674;9239.122283383067;9058.365914385995;9149.817003659957;9153.496557689325;9154.588043538057;9158.679446219383;9155;9177.495237761921;9177.587008584629;9200.953995230015;9210.447373157598;9105.180533751962;9133.223675987549;9134;9141.725748227564;9151.130642588976;9002.909970900339;9055;9057.637694492212;9073.909260907372;9090.727278181665;42928.785356073335;43136.137277254595;43234;43236.3514547282;43251.351229731576;3377.493375993596;3586.964130358689;3717.3866312058476;3975.8608448704445;4246.8725938221905;33418;33595.328093437995;34473.31053378918;34948.82525587381;35523.28953420943;4386.122775444892;4452.799624016927;4502.144592527409;4531.977340113312;4672.252439609646;338461;339130;341571;345052.2747386272;345263;34454.82772586171;35447.82276088603;59340.703296484106;59590.404095959355;59628.403715963155;36974.445383319275;37108.257834843695;37127.62872371242;37138.81430592884;37162.62837371592;13815.516456923959;13914.930425348011;13924.58226253214;13926.164430134224;13979.37092830825;11304.15218858589;11363.886361136449;11396.974272315532;11408.258463199865;11409.315441073562;8335.208155225244;8344.415890887702;8374.832503349899;8398.328133749286;8431.831363372698;3201.055688571877;3218.742500599946;3219.7585181111513;3259.3970115528705;3264.4776835706175;1028.9897101029044;1050.837120246363;1066.2893131901028;1142.3374442823308;1177.6290468502393;33188.66811331904;33298.66701333004;33322.500162497585;33527.832360838525;34005;1087.2497976396262;1103.773726386089;1111.3054341036852;1154.203599516331;1196.9341686207167;17296.308147674205;17539.98290196618;17689.292428302724;17766.822331776515;17823.10884455772;424520;539694;541086;541265;889811;59109.40890591125;59346.406535934955;59599.70200148971;59677.701611492535;59782.701086494286;1228.6498347970785;1345.2063282663275;1347.1378317876568;1358.2529608715167;1387.0775934003775;32419.837900810344;34164.90021197373;34343.48484772781;34497.31005379929;34660.82669586636;50570;51491;51527.227091592904;51565;51565.742171288905;452811;455235;456829;457215;457692;25275.494490109726;27633.309167270978;27918.86040569784;28027.719722803326;28669.426611468072;47231.763841180575;47694.28458573193;47808;47828.52171478241;48831.267530987774;41637.37543936904;41895.7905210472;41992.370114447695;42239.15521689488;43516.34725479057;41261.1747765049;41833.16333673248;41937;42722.35916461193;43110.784446078826;29990.55014174833;40322.79838600905;41147.7942610285;41851.1629767409;43155.78422107869;35869.461958070126;37595.62404375921;37794.4672304751;38420.807895960344;38444.6155538441;28678.42643147167;28992.275193120342;29038.564421534116;29348;29399.85300073486 20:41:38 INFO - PROCESS | 16687 | |2;jquery.html;364.62261559286145;374.9681277091449;385.40454997029593;385.93439115350395;407.31367645517304;17342.653146937053;19140.330088446924;19315.323963661274;19446.70829937552;20496.38510844673;19598.60802783947;19793.802061979375;19834.60330793387;20007.099680514377;20646.174153033862;5760.279965004374;5831.737571809268;6005.699715014253;6011.939880601181;6614.669266536678;6713.69788359525;6722.831929201785;6752.797416077526;6757.189137303506;6758.493113016519;6510;6582.17722784652;6658;6696.531242813005;6705.497087718416;6583.308752581006;6602.900956485657;6646.534742568022;6650.567713098633;6651.334866513334;5674.489295963342;5777.59556831022;5821.912671309934;5831.679257640828;5832.795852145197;22799;23436.414089647726;23478.53042939149;23581.88209058944;23826.52346953051;2356.8821558921986;2427.757224277576;2473.4558397152596;2714.7285271472892;2941.882324707009;9909.851352229722;10483.37099774016;10486.685399438029;10576.10103141234;10629.04338609521;1956.9315073972484;1965.4005528313858;1997.2310660395708;2008.98995505023;2044.1414605865423;64177.35822641761;64623;66523.66738166279;76100.61949690271;87266.56366718125;10416.687499375032;10804.729881753019;11030.558777648805;11039.944800276107;11083.168762342857;12008.639740807615;14141.43434262618;14768.187749673656;14935.029223100464;15365.231738413258;7026.894596581055;7173.569585824867;7208.891866622005;7421.257874212643;7507.662155203029;6633.9668301658185;6725.831854203684;6798.116244888133;6975.883858582602;6987.336203060701;4628.421447319085;4742.264948932921;4750.714957102585;4754.120487709784;4927.77824997876;1943.16443929109;2016.314453085958;2037.0833125093768;2040.5612793249522;2055.6710926252026;878.4202426398547;980.9803803924025;988.7182153086479;1019.6788011776267;1046.304207701885;19848.90075549613;20112.79887201109;20137.295194668117;20245.493862653257;20249.595008099757;959.098447459386;965.6958058211641;970.2626004236831;971.7036303927229;973.6689525561343;10803.729906752395;11230;11251.437428128724;11347.20569560123;11375.715607109723;490626;491548;492272;508595;509653;58917.70541147267;66488.66755666191;91457;93740;94489;961.4279503695429;973.6008236623093;998.0817647764075;999.4153420249236;1001.2040427859869;17027.48917532476;17743.556411089827;18079.548011299823;18118.909405452887;18339.174737137128;43283.78358108315;43469.78265108654;43664.781676091414;44208.778956105016;44426;54676.453235468725;61583;62041.68979155075;62123;63537.36462635315;8071.556064416513;8129.552874591955;8384.706535271236;8547.957260213909;8679.522626255617;12601;12789.784970427794;13065.542706005244;13141.474341026253;13337.799933000819;11224.214304998572;11519.712007199887;11666.70833229176;11753.118516111497;12168.452419641315;11343;11425.085993120696;11732.12009099304;11847.526098955945;12235.632931012084;11659.300441973508;11787.941060294643;12169.574064907685;12228.144029917821;12325;8136.877946830684;8316.126806685212;8356.916430835858;8580.399372043898;8713.956430217808;10000.749981250527;10874.238803283693;11308.378039207593;11678.70803229926;12074.517019319128 20:41:38 INFO - PROCESS | 16687 | |3;mootools.html;1317.328162637055;1439.3594850291622;1501.2268681628964;1612.6774645070989;1747.0827815396915;8412.789680257996;8799.34004949629;8857.955710221448;9109.908900910988;9112.134347237003;8949.731508054769;8949.776255593613;9025.638974441032;9033.593488293027;9035.096490350961;2365.5505453963733;2393.413613664655;2394.8084153267782;2395.9880200598973;2396.2212281008656;2265.8753768542724;2305.8385912986096;2362.0905951208824;2363.0311572255378;2365.5150694107665;2339.87130707811;2349.8707571083582;2366.4912043910554;2396.520695860826;2403.0507949359994;2290.8854557272234;2335.135999680112;2354.058376649337;2354.6703461515485;2356.069352605711;2288.107638021173;2296.724393072825;2300.654901764732;2303.424143964009;2308.180595888452;8496.70261540843;9046.05016473274;9073.682421115229;9131.13254240846;9147.0852914708;5115.360579927509;5322.414534401213;5332.880095180017;5334.1732031535175;5344.7862085516535;3285.8357082146035;3301.4387554115856;3304.5704058472484;3362.4620060790403;3380.138064793462;1126.763379690266;1137.732632831284;1142.0749193153572;1149.5229479765972;1161.8257261410772;11639;11681.532738690443;11681.591144309908;11735.23720958135;11737.58918437859;4167.624913757716;4329.740215587075;4406.515283318832;4475.104979004147;4486.551344865487;9371.671991480265;9378.812423751488;9381.202597779129;9387.859182112274;9395.812083758423;5069.543741063322;5078.5175408336145;5078.619103567247;5085.593152547787;5085.644004919694;4185.937210941838;4319.827206911688;4388.978055109704;4771.73755443447;4859.34398856157;3822.120912190156;3831.252905683365;3924;3934;3942.2903877301787;1129.6046383765615;1152.0380482297376;1153.3887039868882;1158.98588734857;1169.8713141554422;832.4838600067876;866.4974314897345;941.5527624378366;960.3037797596826;962.3407965543626;5720.08478643415;6124.203853499106;6180.752769889244;6224.8213125406655;6271.874562508816;446.75205261079765;459.9632029437637;460.7627072057893;464.4751430883081;1026.958921643126;4123.793810309473;4387.188370151533;4442.089371678798;4447.488538818013;4452.777361131931;11070.169737269736;11420.942895285636;11445.313281203154;11480.885191148149;11493.080553555696;11313.264637798517;11323.433828308716;11339.319640821577;11377.54489820398;11390.601328953448;7994.64024118916;8333.624986875606;8340.833183336299;8431.114732952952;8497.787555311166;6025.578209525466;6175.382461753788;6285.622862628257;6362.6818659067785;6441.1304473895425;9967.152792012761;10524.736881578021;10636.255462117577;10662.573497060032;10668.62659806903;9544.284178686488;10060.44667543263;10331.121854642139;10372;10647.520861561094;8001.759947201594;8120.634571444417;8134.63394147253;8369.95815020921;8388.24505794457;8302.128276530877;8310.335173186251;8340.777188368565;8358;8383.664653413794;7524.774256772305;7613.505122167041;7668.271514206142;7710.961445192963;7776.066871975399;7423.331900129015;7479.738209162653;7498.437617178843;7550.395968322631;7722.3049925506975;6894.793156205322;6895.310468953266;6923.376896079377;6969.442444604318;6989;5051.989602079525;5085.110105731408;5109.718965456936;5141.126008578476;5218.9739051304505;4977.651564390603;5072.721000345016;5142.408623008402;5169.224616307584;5182.455842136521 20:41:38 INFO - PROCESS | 16687 | |4;prototype.html;314.7922371234985;316.67698947074;321.7827966122868;326.1715243282064;333.6180073815481;5280.339957505312;5306.885554033657;5336.70648114354;5349.491798279158;5351.277577527033;5246.190064427767;5260.263563101159;5306;5311.415744268127;5312.203169524573;3872.3029854626157;3959.9408307679987;4070.87787366378;4071;4071.5928407159195;4174;4174.812133454002;4225.197212529625;4241.660667146621;4260.233158031553;4170.937435938464;4174.227767862955;4177.456930599018;4184.14225083857;4224.197402493532;4021.698372622065;4151.3150330195485;4174.394712766662;4184.811683474251;4216.451861258048;3714.387126124186;3720.8883733488037;3737.8131093445218;3741.7942013189536;3750.5686846012786;5145.76844042019;5186.377634683862;5196.402413722432;5198.870028249286;5223.52988231061;4687.88280292992;4769;4800.879978000543;4805.20714082176;4826.734529600871;5456;5488.259085023511;5497.642653227527;5505.532029777473;5578.2707360718305;4082.836686532535;4083.081306705997;4087.7547347159266;4105.178964207141;4118.19695159444;5526.45259327389;5721;5728.7110400160045;5798.536117110621;5806.535477161817;4170.77060761655;4173.290540608104;4185.2885009547845;4190.769507677046;4191.895202619959;4232.576742325743;4234.87295381139;4241.681873859473;4259.212045771542;4269.527013180448;4627.5835174833755;4733.573978341966;4816.157172494799;4825.9758701206265;4827.831025914146;5526.005319042531;5530.834074977757;5531.861703457445;5533.253010843565;5550.639208451518;1441.668416264265;1445.2584635514181;1454.7271137754465;1458.5843034735049;1463.0490181381974;910.2308549275851;913.1621640000394;935.3265648732902;961.8797650293714;975.5366201054443;5291.444398338119;5317.654352467077;5341.729764849923;5342.465753424626;5353.839384818461;5590.636608620427;5591.944080559224;5616.241807356037;5632.436756324417;5646.2377579027125;5077.796888124508;5308.30134357002;5311.415744268127;5341.744689997848;5369.382521010134;2996.6553846307515;2998.385331007138;3006.879724810983;3026.803257788237;3035.5294929285997;5816.592838501264;5855.945929732689;5856.941430585724;5889.851478961561;5889.911651325234;5609.467100625434;5854.765809367663;5859.414058594191;5863.20846685692;5869.031609784338;5916.911246331309;5941.792037278675;5956.8808623828145;5962.522998160137;5997.340292567901;5578.191162281528;5726.938302211117;5758.798442054508;5765.164051212634;5799.536037116936;5691.14632805066;5698.772049117989;5699.7435115419075;5705.031764041399;5720.971395142998;5859.326177489473;5917.467427931507;5979.282486101695;5993.280806303272;5998.730057147526;4063.431119643193;4081.2245673321972;4081.3673880548563;4083.3670781028986;4102.2821006324375;5738.9139162913425;5761.654300741969;5765.654060756368;5772;5774.624649397776;5471.863203419946;5512.228288039758;5512.889742205213;5550.4449555044175;5573.27547418833;5510.641808282448;5511.311086114236;5530.806421775219;5580.414056524169;5597.776088956396;5334.093204155225;5554.416786237549;5559.471850174227;5565.471280228372;5581.720913954205;5443.836684899459;5595.608307418442;5598.888022239614;5611.719414029364;5623.297087864017;5475.863103422446;5482.205080263419;5497.26836046644;5499.2576002240785;5508.531774799187 20:41:38 INFO - PROCESS | 16687 | |5;yui.html;759.8062494064013;780.6135962698465;783.385042741448;788.9566073865935;851.3657325292658;15514.922425387871;17032.914835425836;17075.146242687846;17101.48695539134;17108.401205957794;13973.091749036306;13995.300234988235;14022.088564243317;14035.438582456714;14050.016498845085;652.6214795418657;776.0842206196686;796.1520980156145;801.2028032108061;805.4724155678011;797.3581267080027;797.8165022044933;799.7200979657132;800.0519384529351;800.5796956597775;846.8814365988767;847.7414388611471;848.0247715127622;848.8641817309232;849.3163003781953;683.2279524137717;812.4394168024074;825.0841565861889;825.3067423364403;829.0921441022072;614.5851550203639;614.858582526017;614.9016157414792;615.0651010464114;615.2371059885754;15896;15916.840831591768;15938.760918586231;15940.840591594168;15948.20258987046;14201.218932958684;14254.786178207336;14408.207548584824;14424.855751442456;14430.783538246935;13495.122817016962;13643.113197642122;13657.931710341483;13675.042747007714;13760.380782864795;4611.377464042345;4621.69958952667;4726.881827954328;4830.9275360869615;4852.393450818648;74299;75091.62454187694;77287.61356193239;77759.22240777577;78530;12059.57791477294;12200.694982625328;12207.877921220674;12258.26450412978;12316.876831231752;22714.886425567765;22804.885975570018;22848.200312988967;22883.08467661308;22883.42791430194;8396.958015210008;8556.700515481929;8589.312854971713;8840.955795220983;9095.545222738836;4791.808327666854;4871.074495845778;4900.803967841246;4938.407391113017;5044.924326135111;3212.1969507623094;3282.5568548245683;3319.751018673609;3322.352141332465;3330.5170750241077;597.4503456819737;598.7215944585702;600.129811772931;615.0681717198448;619.3032838057186;605.6517502436117;671.4292851076643;686.3788271614197;688.9276625954303;725.684327317608;9188.90811091894;9394.95302523483;9856.260780441495;9936.900630993598;10028.849567256497;569.7806344557292;616.1835567872587;673.1988933169611;682.4199430484049;691.4261163234503;4437.955620443819;4676.158291507561;4767.070421267819;4862.7325497098;4879.365682461257;66383;92190.53904730434;110996;122155.3892230551;122515.29816422086;87609.56195218983;104860.18408803403;105700.47149764202;105817.94182058235;106841;77878;89759.55120224488;90307.54846225727;93030;93714.53142734243;10112.672691802436;10255.28213025111;10346.37921724699;10461.215408844215;10765.192610554397;51865;54454.455455444935;54617.453825461234;55698.72150639221;56726.7163664179;71434.28565714277;72643.63678181576;78345;79418.20581794108;80585.19414805777;13830.792538111735;13834.515791947233;13925.373358198703;14011.719765604426;14725.779113313523;15769.132697701736;15924.94730279384;16066.919665401598;16941.491755247363;17025.659486809946;14957.775633365725;15323.157226352212;15527.45653902108;15528.611784705472;15537;14563.563093107225;14841.925790370979;15216.619584510476;15445.382184712485;15977.155661757013;14211.360488778237;14314.642133946318;14993.325300361292;15008.099514029193;15055.397784088515;11848.36486580814;12081.862246424469;12243.938780306398;12480.5007799687;12834.358282086045;11752.882471175179;12620.873791262336;12702.872971270539;12949.870501294867;13039.934800325938 20:41:38 INFO - PROCESS | 16687 | __end_tp_report 20:41:38 INFO - PROCESS | 16687 | __start_cc_report 20:41:38 INFO - PROCESS | 16687 | _x_x_mozilla_cycle_collect,1005 20:41:38 INFO - PROCESS | 16687 | __end_cc_report 20:41:38 INFO - PROCESS | 16687 | __startTimestamp1469677298104__endTimestamp 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | ------- Summary: start ------- 20:41:38 INFO - PROCESS | 16687 | Number of tests: 6 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#0] dojo.html Cycles:165 Average:5375.78 Median:5575.94 stddev:616.52 (11.1%) stddev-sans-first:591.23 20:41:38 INFO - PROCESS | 16687 | Values: 3067.9 3102.7 3125.2 3126.4 3141.4 5244.5 5282.9 5368.9 5455.9 5465.0 5337.9 5343.7 5388.2 5412.5 5476.0 4845.0 4904.6 4934.8 4945.9 5105.5 5009.3 5036.3 5049.5 5065.7 5066.9 4799.4 4828.5 4840.0 4906.6 5014.4 4778.4 4785.2 4838.9 4860.8 4970.0 4800.6 4842.7 4849.4 4853.4 4865.8 5244.4 5342.5 5362.7 5419.0 5423.4 5740.5 5741.4 5838.2 5844.4 5846.7 5810.8 5873.2 5886.1 5890.1 5892.8 5207.5 5416.5 5449.8 5453.1 5465.8 5978.0 5980.7 6021.4 6023.1 6036.7 5764.9 5767.3 5813.7 5814.8 5817.8 5556.1 5703.4 5746.6 5895.8 5905.1 5763.8 5766.9 5809.3 5817.4 5820.9 5727.3 5765.7 5779.9 5781.6 5788.0 4310.4 4369.8 4385.1 4433.5 4480.1 3893.3 3952.4 3962.9 3979.3 4021.5 5502.9 5503.2 5508.7 5509.6 5514.1 5577.6 5757.2 5792.1 5809.7 5851.8 5481.3 5510.9 5516.6 5539.5 5557.2 4992.9 5033.2 5036.2 5036.7 5047.2 5810.7 5911.8 5965.1 5976.3 5976.9 5691.2 5728.9 5739.7 5787.4 5789.2 5938.3 5948.3 5949.4 5950.2 5950.5 5603.1 5645.4 5650.4 5698.5 5701.3 5749.2 5769.8 5820.4 5856.1 5872.0 5654.5 5657.2 5668.4 5686.4 5690.1 5427.1 5575.9 5648.5 5649.9 5657.2 5525.3 5614.5 5619.2 5668.3 5669.3 5695.2 5700.3 5749.5 5750.7 5750.9 5372.6 5563.4 5573.2 5574.4 5582.3 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#1] ext.html Cycles:180 Average:61041.15 Median:42115.76 stddev:128563.99 (305.3%) stddev-sans-first:128844.56 20:41:38 INFO - PROCESS | 16687 | Values: 602.3 608.6 627.2 630.7 637.6 43803.3 44792.1 44948.3 44990.0 47780.8 45437.0 45971.8 45989.3 46028.8 46080.5 9096.7 9170.5 9226.3 9229.6 9239.1 9058.4 9149.8 9153.5 9154.6 9158.7 9155.0 9177.5 9177.6 9201.0 9210.4 9105.2 9133.2 9134.0 9141.7 9151.1 9002.9 9055.0 9057.6 9073.9 9090.7 42928.8 43136.1 43234.0 43236.4 43251.4 3377.5 3587.0 3717.4 3975.9 4246.9 33418.0 33595.3 34473.3 34948.8 35523.3 4386.1 4452.8 4502.1 4532.0 4672.3 338461.0 339130.0 341571.0 345052.3 345263.0 34454.8 35447.8 59340.7 59590.4 59628.4 36974.4 37108.3 37127.6 37138.8 37162.6 13815.5 13914.9 13924.6 13926.2 13979.4 11304.2 11363.9 11397.0 11408.3 11409.3 8335.2 8344.4 8374.8 8398.3 8431.8 3201.1 3218.7 3219.8 3259.4 3264.5 1029.0 1050.8 1066.3 1142.3 1177.6 33188.7 33298.7 33322.5 33527.8 34005.0 1087.2 1103.8 1111.3 1154.2 1196.9 17296.3 17540.0 17689.3 17766.8 17823.1 424520.0 539694.0 541086.0 541265.0 889811.0 59109.4 59346.4 59599.7 59677.7 59782.7 1228.6 1345.2 1347.1 1358.3 1387.1 32419.8 34164.9 34343.5 34497.3 34660.8 50570.0 51491.0 51527.2 51565.0 51565.7 452811.0 455235.0 456829.0 457215.0 457692.0 25275.5 27633.3 27918.9 28027.7 28669.4 47231.8 47694.3 47808.0 47828.5 48831.3 41637.4 41895.8 41992.4 42239.2 43516.3 41261.2 41833.2 41937.0 42722.4 43110.8 29990.6 40322.8 41147.8 41851.2 43155.8 35869.5 37595.6 37794.5 38420.8 38444.6 28678.4 28992.3 29038.6 29348.0 29399.9 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#2] jquery.html Cycles:180 Average:28892.81 Median:396.62 stddev:81877.73 (20643.7%) stddev-sans-first:82079.40 20:41:38 INFO - PROCESS | 16687 | Values: 364.6 375.0 385.4 385.9 407.3 17342.7 19140.3 19315.3 19446.7 20496.4 19598.6 19793.8 19834.6 20007.1 20646.2 5760.3 5831.7 6005.7 6011.9 6614.7 6713.7 6722.8 6752.8 6757.2 6758.5 6510.0 6582.2 6658.0 6696.5 6705.5 6583.3 6602.9 6646.5 6650.6 6651.3 5674.5 5777.6 5821.9 5831.7 5832.8 22799.0 23436.4 23478.5 23581.9 23826.5 2356.9 2427.8 2473.5 2714.7 2941.9 9909.9 10483.4 10486.7 10576.1 10629.0 1956.9 1965.4 1997.2 2009.0 2044.1 64177.4 64623.0 66523.7 76100.6 87266.6 10416.7 10804.7 11030.6 11039.9 11083.2 12008.6 14141.4 14768.2 14935.0 15365.2 7026.9 7173.6 7208.9 7421.3 7507.7 6634.0 6725.8 6798.1 6975.9 6987.3 4628.4 4742.3 4750.7 4754.1 4927.8 1943.2 2016.3 2037.1 2040.6 2055.7 878.4 981.0 988.7 1019.7 1046.3 19848.9 20112.8 20137.3 20245.5 20249.6 959.1 965.7 970.3 971.7 973.7 10803.7 11230.0 11251.4 11347.2 11375.7 490626.0 491548.0 492272.0 508595.0 509653.0 58917.7 66488.7 91457.0 93740.0 94489.0 961.4 973.6 998.1 999.4 1001.2 17027.5 17743.6 18079.5 18118.9 18339.2 43283.8 43469.8 43664.8 44208.8 44426.0 54676.5 61583.0 62041.7 62123.0 63537.4 8071.6 8129.6 8384.7 8548.0 8679.5 12601.0 12789.8 13065.5 13141.5 13337.8 11224.2 11519.7 11666.7 11753.1 12168.5 11343.0 11425.1 11732.1 11847.5 12235.6 11659.3 11787.9 12169.6 12228.1 12325.0 8136.9 8316.1 8356.9 8580.4 8714.0 10000.7 10874.2 11308.4 11678.7 12074.5 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#3] mootools.html Cycles:180 Average:5799.48 Median:2618.11 stddev:3332.26 (127.3%) stddev-sans-first:3324.58 20:41:38 INFO - PROCESS | 16687 | Values: 1317.3 1439.4 1501.2 1612.7 1747.1 8412.8 8799.3 8858.0 9109.9 9112.1 8949.7 8949.8 9025.6 9033.6 9035.1 2365.6 2393.4 2394.8 2396.0 2396.2 2265.9 2305.8 2362.1 2363.0 2365.5 2339.9 2349.9 2366.5 2396.5 2403.1 2290.9 2335.1 2354.1 2354.7 2356.1 2288.1 2296.7 2300.7 2303.4 2308.2 8496.7 9046.1 9073.7 9131.1 9147.1 5115.4 5322.4 5332.9 5334.2 5344.8 3285.8 3301.4 3304.6 3362.5 3380.1 1126.8 1137.7 1142.1 1149.5 1161.8 11639.0 11681.5 11681.6 11735.2 11737.6 4167.6 4329.7 4406.5 4475.1 4486.6 9371.7 9378.8 9381.2 9387.9 9395.8 5069.5 5078.5 5078.6 5085.6 5085.6 4185.9 4319.8 4389.0 4771.7 4859.3 3822.1 3831.3 3924.0 3934.0 3942.3 1129.6 1152.0 1153.4 1159.0 1169.9 832.5 866.5 941.6 960.3 962.3 5720.1 6124.2 6180.8 6224.8 6271.9 446.8 460.0 460.8 464.5 1027.0 4123.8 4387.2 4442.1 4447.5 4452.8 11070.2 11420.9 11445.3 11480.9 11493.1 11313.3 11323.4 11339.3 11377.5 11390.6 7994.6 8333.6 8340.8 8431.1 8497.8 6025.6 6175.4 6285.6 6362.7 6441.1 9967.2 10524.7 10636.3 10662.6 10668.6 9544.3 10060.4 10331.1 10372.0 10647.5 8001.8 8120.6 8134.6 8370.0 8388.2 8302.1 8310.3 8340.8 8358.0 8383.7 7524.8 7613.5 7668.3 7711.0 7776.1 7423.3 7479.7 7498.4 7550.4 7722.3 6894.8 6895.3 6923.4 6969.4 6989.0 5052.0 5085.1 5109.7 5141.1 5219.0 4977.7 5072.7 5142.4 5169.2 5182.5 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#4] prototype.html Cycles:180 Average:4705.09 Median:5342.11 stddev:1373.32 (25.7%) stddev-sans-first:1337.06 20:41:38 INFO - PROCESS | 16687 | Values: 314.8 316.7 321.8 326.2 333.6 5280.3 5306.9 5336.7 5349.5 5351.3 5246.2 5260.3 5306.0 5311.4 5312.2 3872.3 3959.9 4070.9 4071.0 4071.6 4174.0 4174.8 4225.2 4241.7 4260.2 4170.9 4174.2 4177.5 4184.1 4224.2 4021.7 4151.3 4174.4 4184.8 4216.5 3714.4 3720.9 3737.8 3741.8 3750.6 5145.8 5186.4 5196.4 5198.9 5223.5 4687.9 4769.0 4800.9 4805.2 4826.7 5456.0 5488.3 5497.6 5505.5 5578.3 4082.8 4083.1 4087.8 4105.2 4118.2 5526.5 5721.0 5728.7 5798.5 5806.5 4170.8 4173.3 4185.3 4190.8 4191.9 4232.6 4234.9 4241.7 4259.2 4269.5 4627.6 4733.6 4816.2 4826.0 4827.8 5526.0 5530.8 5531.9 5533.3 5550.6 1441.7 1445.3 1454.7 1458.6 1463.0 910.2 913.2 935.3 961.9 975.5 5291.4 5317.7 5341.7 5342.5 5353.8 5590.6 5591.9 5616.2 5632.4 5646.2 5077.8 5308.3 5311.4 5341.7 5369.4 2996.7 2998.4 3006.9 3026.8 3035.5 5816.6 5855.9 5856.9 5889.9 5889.9 5609.5 5854.8 5859.4 5863.2 5869.0 5916.9 5941.8 5956.9 5962.5 5997.3 5578.2 5726.9 5758.8 5765.2 5799.5 5691.1 5698.8 5699.7 5705.0 5721.0 5859.3 5917.5 5979.3 5993.3 5998.7 4063.4 4081.2 4081.4 4083.4 4102.3 5738.9 5761.7 5765.7 5772.0 5774.6 5471.9 5512.2 5512.9 5550.4 5573.3 5510.6 5511.3 5530.8 5580.4 5597.8 5334.1 5554.4 5559.5 5565.5 5581.7 5443.8 5595.6 5598.9 5611.7 5623.3 5475.9 5482.2 5497.3 5499.3 5508.5 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - PROCESS | 16687 | [#5] yui.html Cycles:180 Average:21250.76 Median:4648.93 stddev:29686.19 (638.6%) stddev-sans-first:29729.60 20:41:38 INFO - PROCESS | 16687 | Values: 759.8 780.6 783.4 789.0 851.4 15514.9 17032.9 17075.1 17101.5 17108.4 13973.1 13995.3 14022.1 14035.4 14050.0 652.6 776.1 796.2 801.2 805.5 797.4 797.8 799.7 800.1 800.6 846.9 847.7 848.0 848.9 849.3 683.2 812.4 825.1 825.3 829.1 614.6 614.9 614.9 615.1 615.2 15896.0 15916.8 15938.8 15940.8 15948.2 14201.2 14254.8 14408.2 14424.9 14430.8 13495.1 13643.1 13657.9 13675.0 13760.4 4611.4 4621.7 4726.9 4830.9 4852.4 74299.0 75091.6 77287.6 77759.2 78530.0 12059.6 12200.7 12207.9 12258.3 12316.9 22714.9 22804.9 22848.2 22883.1 22883.4 8397.0 8556.7 8589.3 8841.0 9095.5 4791.8 4871.1 4900.8 4938.4 5044.9 3212.2 3282.6 3319.8 3322.4 3330.5 597.5 598.7 600.1 615.1 619.3 605.7 671.4 686.4 688.9 725.7 9188.9 9395.0 9856.3 9936.9 10028.8 569.8 616.2 673.2 682.4 691.4 4438.0 4676.2 4767.1 4862.7 4879.4 66383.0 92190.5 110996.0 122155.4 122515.3 87609.6 104860.2 105700.5 105817.9 106841.0 77878.0 89759.6 90307.5 93030.0 93714.5 10112.7 10255.3 10346.4 10461.2 10765.2 51865.0 54454.5 54617.5 55698.7 56726.7 71434.3 72643.6 78345.0 79418.2 80585.2 13830.8 13834.5 13925.4 14011.7 14725.8 15769.1 15924.9 16066.9 16941.5 17025.7 14957.8 15323.2 15527.5 15528.6 15537.0 14563.6 14841.9 15216.6 15445.4 15977.2 14211.4 14314.6 14993.3 15008.1 15055.4 11848.4 12081.9 12243.9 12480.5 12834.4 11752.9 12620.9 12702.9 12949.9 13039.9 20:41:38 INFO - PROCESS | 16687 | -------- Summary: end -------- 20:41:38 INFO - PROCESS | 16687 | 20:41:38 INFO - TEST-INFO | 16687: exit 0 20:41:38 INFO - TEST-OK | dromaeo_css | took 1113396ms 20:41:38 INFO - TEST-START | kraken 20:41:38 INFO - operating with platform_type : linux_ 20:41:38 INFO - Initialising browser for kraken test... 20:41:38 INFO - TEST-INFO | started process 16877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgAY6od/profile http://localhost:43356/getInfo.html) 20:41:41 INFO - PROCESS | 16877 | JavaScript error: , line 0: uncaught exception: undefined 20:41:42 INFO - PROCESS | 16877 | __metrics Screen width/height:1600/1200 20:41:42 INFO - PROCESS | 16877 | colorDepth:24 20:41:42 INFO - PROCESS | 16877 | Browser inner width/height: 1024/697 20:41:42 INFO - PROCESS | 16877 | __metrics 20:41:43 INFO - PROCESS | 16877 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:41:43 INFO - PROCESS | 16877 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:44 INFO - TEST-INFO | 16877: exit 0 20:41:44 INFO - Browser initialized. 20:41:44 INFO - Running cycle 1/1 for kraken test... 20:41:44 INFO - TEST-INFO | started process 16958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgAY6od/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:56 INFO - PROCESS | 16958 | RSS: Main: 158056448 20:41:56 INFO - PROCESS | 16958 | 20:41:58 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43356/tests/kraken/driver.html?testName=audio-beat-detection) 20:41:59 INFO - PROCESS | 16958 | RSS: Main: 214134784 20:41:59 INFO - PROCESS | 16958 | 20:42:02 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43356/tests/kraken/driver.html?testName=audio-dft) 20:42:02 INFO - PROCESS | 16958 | RSS: Main: 192753664 20:42:02 INFO - PROCESS | 16958 | 20:42:05 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43356/tests/kraken/driver.html?testName=audio-fft) 20:42:06 INFO - PROCESS | 16958 | RSS: Main: 269385728 20:42:06 INFO - PROCESS | 16958 | 20:42:08 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43356/tests/kraken/driver.html?testName=audio-oscillator) 20:42:08 INFO - PROCESS | 16958 | RSS: Main: 180649984 20:42:08 INFO - PROCESS | 16958 | 20:42:11 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:11 INFO - PROCESS | 16958 | RSS: Main: 184807424 20:42:11 INFO - PROCESS | 16958 | 20:42:14 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43356/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:15 INFO - PROCESS | 16958 | RSS: Main: 221757440 20:42:15 INFO - PROCESS | 16958 | 20:42:18 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43356/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:19 INFO - PROCESS | 16958 | RSS: Main: 220950528 20:42:19 INFO - PROCESS | 16958 | 20:42:22 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43356/tests/kraken/driver.html?testName=json-parse-financial) 20:42:22 INFO - PROCESS | 16958 | RSS: Main: 220766208 20:42:22 INFO - PROCESS | 16958 | 20:42:24 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:24 INFO - PROCESS | 16958 | RSS: Main: 185069568 20:42:24 INFO - PROCESS | 16958 | 20:42:26 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:27 INFO - PROCESS | 16958 | RSS: Main: 190812160 20:42:27 INFO - PROCESS | 16958 | 20:42:29 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:29 INFO - PROCESS | 16958 | RSS: Main: 195264512 20:42:29 INFO - PROCESS | 16958 | 20:42:32 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:42:32 INFO - PROCESS | 16958 | RSS: Main: 189706240 20:42:32 INFO - PROCESS | 16958 | 20:42:35 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:42:36 INFO - PROCESS | 16958 | RSS: Main: 194105344 20:42:36 INFO - PROCESS | 16958 | 20:42:37 INFO - PROCESS | 16958 | Cycle 1(1): loaded http://localhost:43356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43356/tests/kraken/driver.html?testName=ai-astar) 20:42:38 INFO - PROCESS | 16958 | RSS: Main: 243793920 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | __start_tp_report 20:42:38 INFO - PROCESS | 16958 | _x_x_mozilla_page_load 20:42:38 INFO - PROCESS | 16958 | _x_x_mozilla_page_load_details 20:42:38 INFO - PROCESS | 16958 | |i|pagename|runs| 20:42:38 INFO - PROCESS | 16958 | |0;ai-astar;104;110;111;111;110;110;110;109;111;111 20:42:38 INFO - PROCESS | 16958 | |1;audio-beat-detection;145;117;120;190;119;118;144;124;155;119 20:42:38 INFO - PROCESS | 16958 | |2;audio-dft;161;161;160;160;163;160;160;163;161;160 20:42:38 INFO - PROCESS | 16958 | |3;audio-fft;74;74;74;115;75;76;75;74;118;74 20:42:38 INFO - PROCESS | 16958 | |4;audio-oscillator;83;84;123;84;85;84;119;84;84;132 20:42:38 INFO - PROCESS | 16958 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 20:42:38 INFO - PROCESS | 16958 | |6;imaging-darkroom;147;146;145;145;145;145;145;145;145;145 20:42:38 INFO - PROCESS | 16958 | |7;imaging-desaturate;95;94;94;95;94;95;95;95;95;94 20:42:38 INFO - PROCESS | 16958 | |8;json-parse-financial;50;50;55;50;50;51;52;49;50;50 20:42:38 INFO - PROCESS | 16958 | |9;json-stringify-tinderbox;62;62;62;61;63;62;62;62;62;62 20:42:38 INFO - PROCESS | 16958 | |10;stanford-crypto-aes;80;76;78;80;75;75;84;79;76;76 20:42:38 INFO - PROCESS | 16958 | |11;stanford-crypto-ccm;122;123;118;119;116;128;127;118;204;130 20:42:38 INFO - PROCESS | 16958 | |12;stanford-crypto-pbkdf2;152;159;157;156;159;166;158;154;162;152 20:42:38 INFO - PROCESS | 16958 | |13;stanford-crypto-sha256-iterative;63;63;70;63;64;62;62;61;61;61 20:42:38 INFO - PROCESS | 16958 | __end_tp_report 20:42:38 INFO - PROCESS | 16958 | __start_cc_report 20:42:38 INFO - PROCESS | 16958 | _x_x_mozilla_cycle_collect,1659 20:42:38 INFO - PROCESS | 16958 | __end_cc_report 20:42:38 INFO - PROCESS | 16958 | __startTimestamp1469677358131__endTimestamp 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | ------- Summary: start ------- 20:42:38 INFO - PROCESS | 16958 | Number of tests: 14 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.11 (1.9%) stddev-sans-first:0.71 20:42:38 INFO - PROCESS | 16958 | Values: 104.0 110.0 111.0 111.0 110.0 110.0 110.0 109.0 111.0 111.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:134.00 stddev:23.75 (17.7%) stddev-sans-first:24.92 20:42:38 INFO - PROCESS | 16958 | Values: 145.0 117.0 120.0 190.0 119.0 118.0 144.0 124.0 155.0 119.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 20:42:38 INFO - PROCESS | 16958 | Values: 161.0 161.0 160.0 160.0 163.0 160.0 160.0 163.0 161.0 160.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.00 stddev:17.74 (24.0%) stddev-sans-first:18.52 20:42:38 INFO - PROCESS | 16958 | Values: 74.0 74.0 74.0 115.0 75.0 76.0 75.0 74.0 118.0 74.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:19.90 (23.7%) stddev-sans-first:20.52 20:42:38 INFO - PROCESS | 16958 | Values: 83.0 84.0 123.0 84.0 85.0 84.0 119.0 84.0 84.0 132.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:42:38 INFO - PROCESS | 16958 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 20:42:38 INFO - PROCESS | 16958 | Values: 147.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:42:38 INFO - PROCESS | 16958 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:50.00 stddev:1.70 (3.4%) stddev-sans-first:1.79 20:42:38 INFO - PROCESS | 16958 | Values: 50.0 50.0 55.0 50.0 50.0 51.0 52.0 49.0 50.0 50.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 20:42:38 INFO - PROCESS | 16958 | Values: 62.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 62.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:2.88 (3.7%) stddev-sans-first:2.96 20:42:38 INFO - PROCESS | 16958 | Values: 80.0 76.0 78.0 80.0 75.0 75.0 84.0 79.0 76.0 76.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:125.00 stddev:26.26 (21.0%) stddev-sans-first:27.67 20:42:38 INFO - PROCESS | 16958 | Values: 122.0 123.0 118.0 119.0 116.0 128.0 127.0 118.0 204.0 130.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.50 stddev:4.38 (2.8%) stddev-sans-first:4.17 20:42:38 INFO - PROCESS | 16958 | Values: 152.0 159.0 157.0 156.0 159.0 166.0 158.0 154.0 162.0 152.0 20:42:38 INFO - PROCESS | 16958 | 20:42:38 INFO - PROCESS | 16958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:2.67 (4.2%) stddev-sans-first:2.83 20:42:38 INFO - PROCESS | 16958 | Values: 63.0 63.0 70.0 63.0 64.0 62.0 62.0 61.0 61.0 61.0 20:42:38 INFO - PROCESS | 16958 | -------- Summary: end -------- 20:42:38 INFO - PROCESS | 16958 | 20:42:39 INFO - TEST-INFO | 16958: exit 0 20:42:39 INFO - TEST-OK | kraken | took 60334ms 20:42:39 INFO - SUITE-END | took 1173s 20:42:39 INFO - Completed test suite (00:19:33) 20:42:39 INFO - javascript benchmark 20:42:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.8772849086035, 3102.7362674172696, 3125.187451262671, 3126.374725054988, 3141.4345417824784, 5244.475552444763, 5282.947170528294, 5368.946310536893, 5455.863603409916, 5465.043617366955, 5337.919931201025, 5343.706096164709, 5388.218708287296, 5412.485813847678, 5476.0, 4844.975775121128, 4904.632152588552, 4934.777934992916, 4945.9258111128365, 5105.489451054883, 5009.273655319977, 5036.34527511423, 5049.520295571915, 5065.670731402465, 5066.949330506703, 4799.424069111711, 4828.468868424488, 4840.0, 4906.55840974314, 5014.423341315741, 4778.378810754614, 4785.21044027735, 4838.903221935577, 4860.756962151913, 4969.975150124226, 4800.567948884617, 4842.66101372904, 4849.442314133849, 4853.39332583427, 4865.82969596066, 5244.449332820075, 5342.465753424665, 5362.651427657229, 5418.972905135489, 5423.430539793304, 5740.512056475204, 5741.368449470555, 5838.182654428383, 5844.444777746107, 5846.678432686201, 5810.796622118248, 5873.177755114288, 5886.117082437626, 5890.145928840337, 5892.823215303548, 5207.4792520748, 5416.458354164592, 5449.809256676037, 5453.072977593819, 5465.808696695596, 5978.04351303798, 5980.671063091485, 6021.397860214031, 6023.066424704178, 6036.698165091728, 5764.913526297109, 5767.336756272998, 5813.709314534256, 5814.796482123105, 5817.7963771267805, 5556.055470570012, 5703.429657034263, 5746.597738158289, 5895.823125306248, 5905.143754155623, 5763.827085187451, 5766.913496297559, 5809.2738407699035, 5817.418258174149, 5820.941790582125, 5727.284089488814, 5765.711714414262, 5779.88440231193, 5781.566382521328, 5788.0449725795615, 4310.439642846472, 4369.80335884886, 4385.144896745104, 4433.534478879671, 4480.081583275421, 3893.3381325174787, 3952.446657467957, 3962.9405558916637, 3979.2837289287627, 4021.5375231848125, 5502.944970550323, 5503.229547863302, 5508.697021663847, 5509.559235261169, 5514.09017512114, 5577.637453565505, 5757.165211044375, 5792.0732682771395, 5809.738561764731, 5851.824445266649, 5481.342238931354, 5510.862228444321, 5516.641418307797, 5539.473749993825, 5557.249771280906, 4992.900141997213, 5033.194688849767, 5036.244563315532, 5036.697798132051, 5047.16721740916, 5810.6513609183585, 5911.793087241926, 5965.135055417027, 5976.252968378953, 5976.9402305977255, 5691.231683722644, 5728.942710572841, 5739.655620662774, 5787.36339002701, 5789.1605717171615, 5938.317093534299, 5948.2862056553495, 5949.3753155918, 5950.2264705587995, 5950.464458198783, 5603.10350343943, 5645.350784659817, 5650.350209725934, 5698.544116470755, 5701.287339082614, 5749.166370876116, 5769.798057067983, 5820.447057529528, 5856.0630299151935, 5872.031114865999, 5654.491095801398, 5657.179708942263, 5668.376478587435, 5686.374498805211, 5690.118031705092, 5427.050266203478, 5575.944240557543, 5648.4633959773755, 5649.915251271316, 5657.151427285776, 5525.309336332958, 5614.494695477263, 5619.213310136666, 5668.319801623831, 5669.291338582677, 5695.231143795535, 5700.287464066992, 5749.482546570829, 5750.712464376848, 5750.942490575041, 5372.597055220952, 5563.443655634404, 5573.247611572386, 5574.358948720949, 5582.27430434041], "value": 5333.74252191527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3374288282889, 608.6256951974535, 627.1752645271467, 630.653140772575, 637.5600835423554, 43803.34294985574, 44792.10415791682, 44948.32577511336, 44990.0, 47780.761096194554, 45437.0, 45971.77014114933, 45989.31016034754, 46028.76985615076, 46080.53919460804, 9096.727098187032, 9170.495622740747, 9226.261899048093, 9229.6308147674, 9239.122283383067, 9058.365914385995, 9149.817003659957, 9153.496557689325, 9154.588043538057, 9158.679446219383, 9155.0, 9177.495237761921, 9177.587008584629, 9200.953995230015, 9210.447373157598, 9105.180533751962, 9133.223675987549, 9134.0, 9141.725748227564, 9151.130642588976, 9002.909970900339, 9055.0, 9057.637694492212, 9073.909260907372, 9090.727278181665, 42928.785356073335, 43136.137277254595, 43234.0, 43236.3514547282, 43251.351229731576, 3377.493375993596, 3586.964130358689, 3717.3866312058476, 3975.8608448704445, 4246.8725938221905, 33418.0, 33595.328093437995, 34473.31053378918, 34948.82525587381, 35523.28953420943, 4386.122775444892, 4452.799624016927, 4502.144592527409, 4531.977340113312, 4672.252439609646, 338461.0, 339130.0, 341571.0, 345052.2747386272, 345263.0, 34454.82772586171, 35447.82276088603, 59340.703296484106, 59590.404095959355, 59628.403715963155, 36974.445383319275, 37108.257834843695, 37127.62872371242, 37138.81430592884, 37162.62837371592, 13815.516456923959, 13914.930425348011, 13924.58226253214, 13926.164430134224, 13979.37092830825, 11304.15218858589, 11363.886361136449, 11396.974272315532, 11408.258463199865, 11409.315441073562, 8335.208155225244, 8344.415890887702, 8374.832503349899, 8398.328133749286, 8431.831363372698, 3201.055688571877, 3218.742500599946, 3219.7585181111513, 3259.3970115528705, 3264.4776835706175, 1028.9897101029044, 1050.837120246363, 1066.2893131901028, 1142.3374442823308, 1177.6290468502393, 33188.66811331904, 33298.66701333004, 33322.500162497585, 33527.832360838525, 34005.0, 1087.2497976396262, 1103.773726386089, 1111.3054341036852, 1154.203599516331, 1196.9341686207167, 17296.308147674205, 17539.98290196618, 17689.292428302724, 17766.822331776515, 17823.10884455772, 424520.0, 539694.0, 541086.0, 541265.0, 889811.0, 59109.40890591125, 59346.406535934955, 59599.70200148971, 59677.701611492535, 59782.701086494286, 1228.6498347970785, 1345.2063282663275, 1347.1378317876568, 1358.2529608715167, 1387.0775934003775, 32419.837900810344, 34164.90021197373, 34343.48484772781, 34497.31005379929, 34660.82669586636, 50570.0, 51491.0, 51527.227091592904, 51565.0, 51565.742171288905, 452811.0, 455235.0, 456829.0, 457215.0, 457692.0, 25275.494490109726, 27633.309167270978, 27918.86040569784, 28027.719722803326, 28669.426611468072, 47231.763841180575, 47694.28458573193, 47808.0, 47828.52171478241, 48831.267530987774, 41637.37543936904, 41895.7905210472, 41992.370114447695, 42239.15521689488, 43516.34725479057, 41261.1747765049, 41833.16333673248, 41937.0, 42722.35916461193, 43110.784446078826, 29990.55014174833, 40322.79838600905, 41147.7942610285, 41851.1629767409, 43155.78422107869, 35869.461958070126, 37595.62404375921, 37794.4672304751, 38420.807895960344, 38444.6155538441, 28678.42643147167, 28992.275193120342, 29038.564421534116, 29348.0, 29399.85300073486], "value": 19187.357025771267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.62261559286145, 374.9681277091449, 385.40454997029593, 385.93439115350395, 407.31367645517304, 17342.653146937053, 19140.330088446924, 19315.323963661274, 19446.70829937552, 20496.38510844673, 19598.60802783947, 19793.802061979375, 19834.60330793387, 20007.099680514377, 20646.174153033862, 5760.279965004374, 5831.737571809268, 6005.699715014253, 6011.939880601181, 6614.669266536678, 6713.69788359525, 6722.831929201785, 6752.797416077526, 6757.189137303506, 6758.493113016519, 6510.0, 6582.17722784652, 6658.0, 6696.531242813005, 6705.497087718416, 6583.308752581006, 6602.900956485657, 6646.534742568022, 6650.567713098633, 6651.334866513334, 5674.489295963342, 5777.59556831022, 5821.912671309934, 5831.679257640828, 5832.795852145197, 22799.0, 23436.414089647726, 23478.53042939149, 23581.88209058944, 23826.52346953051, 2356.8821558921986, 2427.757224277576, 2473.4558397152596, 2714.7285271472892, 2941.882324707009, 9909.851352229722, 10483.37099774016, 10486.685399438029, 10576.10103141234, 10629.04338609521, 1956.9315073972484, 1965.4005528313858, 1997.2310660395708, 2008.98995505023, 2044.1414605865423, 64177.35822641761, 64623.0, 66523.66738166279, 76100.61949690271, 87266.56366718125, 10416.687499375032, 10804.729881753019, 11030.558777648805, 11039.944800276107, 11083.168762342857, 12008.639740807615, 14141.43434262618, 14768.187749673656, 14935.029223100464, 15365.231738413258, 7026.894596581055, 7173.569585824867, 7208.891866622005, 7421.257874212643, 7507.662155203029, 6633.9668301658185, 6725.831854203684, 6798.116244888133, 6975.883858582602, 6987.336203060701, 4628.421447319085, 4742.264948932921, 4750.714957102585, 4754.120487709784, 4927.77824997876, 1943.16443929109, 2016.314453085958, 2037.0833125093768, 2040.5612793249522, 2055.6710926252026, 878.4202426398547, 980.9803803924025, 988.7182153086479, 1019.6788011776267, 1046.304207701885, 19848.90075549613, 20112.79887201109, 20137.295194668117, 20245.493862653257, 20249.595008099757, 959.098447459386, 965.6958058211641, 970.2626004236831, 971.7036303927229, 973.6689525561343, 10803.729906752395, 11230.0, 11251.437428128724, 11347.20569560123, 11375.715607109723, 490626.0, 491548.0, 492272.0, 508595.0, 509653.0, 58917.70541147267, 66488.66755666191, 91457.0, 93740.0, 94489.0, 961.4279503695429, 973.6008236623093, 998.0817647764075, 999.4153420249236, 1001.2040427859869, 17027.48917532476, 17743.556411089827, 18079.548011299823, 18118.909405452887, 18339.174737137128, 43283.78358108315, 43469.78265108654, 43664.781676091414, 44208.778956105016, 44426.0, 54676.453235468725, 61583.0, 62041.68979155075, 62123.0, 63537.36462635315, 8071.556064416513, 8129.552874591955, 8384.706535271236, 8547.957260213909, 8679.522626255617, 12601.0, 12789.784970427794, 13065.542706005244, 13141.474341026253, 13337.799933000819, 11224.214304998572, 11519.712007199887, 11666.70833229176, 11753.118516111497, 12168.452419641315, 11343.0, 11425.085993120696, 11732.12009099304, 11847.526098955945, 12235.632931012084, 11659.300441973508, 11787.941060294643, 12169.574064907685, 12228.144029917821, 12325.0, 8136.877946830684, 8316.126806685212, 8356.916430835858, 8580.399372043898, 8713.956430217808, 10000.749981250527, 10874.238803283693, 11308.378039207593, 11678.70803229926, 12074.517019319128], "value": 9286.745688871686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.328162637055, 1439.3594850291622, 1501.2268681628964, 1612.6774645070989, 1747.0827815396915, 8412.789680257996, 8799.34004949629, 8857.955710221448, 9109.908900910988, 9112.134347237003, 8949.731508054769, 8949.776255593613, 9025.638974441032, 9033.593488293027, 9035.096490350961, 2365.5505453963733, 2393.413613664655, 2394.8084153267782, 2395.9880200598973, 2396.2212281008656, 2265.8753768542724, 2305.8385912986096, 2362.0905951208824, 2363.0311572255378, 2365.5150694107665, 2339.87130707811, 2349.8707571083582, 2366.4912043910554, 2396.520695860826, 2403.0507949359994, 2290.8854557272234, 2335.135999680112, 2354.058376649337, 2354.6703461515485, 2356.069352605711, 2288.107638021173, 2296.724393072825, 2300.654901764732, 2303.424143964009, 2308.180595888452, 8496.70261540843, 9046.05016473274, 9073.682421115229, 9131.13254240846, 9147.0852914708, 5115.360579927509, 5322.414534401213, 5332.880095180017, 5334.1732031535175, 5344.7862085516535, 3285.8357082146035, 3301.4387554115856, 3304.5704058472484, 3362.4620060790403, 3380.138064793462, 1126.763379690266, 1137.732632831284, 1142.0749193153572, 1149.5229479765972, 1161.8257261410772, 11639.0, 11681.532738690443, 11681.591144309908, 11735.23720958135, 11737.58918437859, 4167.624913757716, 4329.740215587075, 4406.515283318832, 4475.104979004147, 4486.551344865487, 9371.671991480265, 9378.812423751488, 9381.202597779129, 9387.859182112274, 9395.812083758423, 5069.543741063322, 5078.5175408336145, 5078.619103567247, 5085.593152547787, 5085.644004919694, 4185.937210941838, 4319.827206911688, 4388.978055109704, 4771.73755443447, 4859.34398856157, 3822.120912190156, 3831.252905683365, 3924.0, 3934.0, 3942.2903877301787, 1129.6046383765615, 1152.0380482297376, 1153.3887039868882, 1158.98588734857, 1169.8713141554422, 832.4838600067876, 866.4974314897345, 941.5527624378366, 960.3037797596826, 962.3407965543626, 5720.08478643415, 6124.203853499106, 6180.752769889244, 6224.8213125406655, 6271.874562508816, 446.75205261079765, 459.9632029437637, 460.7627072057893, 464.4751430883081, 1026.958921643126, 4123.793810309473, 4387.188370151533, 4442.089371678798, 4447.488538818013, 4452.777361131931, 11070.169737269736, 11420.942895285636, 11445.313281203154, 11480.885191148149, 11493.080553555696, 11313.264637798517, 11323.433828308716, 11339.319640821577, 11377.54489820398, 11390.601328953448, 7994.64024118916, 8333.624986875606, 8340.833183336299, 8431.114732952952, 8497.787555311166, 6025.578209525466, 6175.382461753788, 6285.622862628257, 6362.6818659067785, 6441.1304473895425, 9967.152792012761, 10524.736881578021, 10636.255462117577, 10662.573497060032, 10668.62659806903, 9544.284178686488, 10060.44667543263, 10331.121854642139, 10372.0, 10647.520861561094, 8001.759947201594, 8120.634571444417, 8134.63394147253, 8369.95815020921, 8388.24505794457, 8302.128276530877, 8310.335173186251, 8340.777188368565, 8358.0, 8383.664653413794, 7524.774256772305, 7613.505122167041, 7668.271514206142, 7710.961445192963, 7776.066871975399, 7423.331900129015, 7479.738209162653, 7498.437617178843, 7550.395968322631, 7722.3049925506975, 6894.793156205322, 6895.310468953266, 6923.376896079377, 6969.442444604318, 6989.0, 5051.989602079525, 5085.110105731408, 5109.718965456936, 5141.126008578476, 5218.9739051304505, 4977.651564390603, 5072.721000345016, 5142.408623008402, 5169.224616307584, 5182.455842136521], "value": 4565.740946736332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.7922371234985, 316.67698947074, 321.7827966122868, 326.1715243282064, 333.6180073815481, 5280.339957505312, 5306.885554033657, 5336.70648114354, 5349.491798279158, 5351.277577527033, 5246.190064427767, 5260.263563101159, 5306.0, 5311.415744268127, 5312.203169524573, 3872.3029854626157, 3959.9408307679987, 4070.87787366378, 4071.0, 4071.5928407159195, 4174.0, 4174.812133454002, 4225.197212529625, 4241.660667146621, 4260.233158031553, 4170.937435938464, 4174.227767862955, 4177.456930599018, 4184.14225083857, 4224.197402493532, 4021.698372622065, 4151.3150330195485, 4174.394712766662, 4184.811683474251, 4216.451861258048, 3714.387126124186, 3720.8883733488037, 3737.8131093445218, 3741.7942013189536, 3750.5686846012786, 5145.76844042019, 5186.377634683862, 5196.402413722432, 5198.870028249286, 5223.52988231061, 4687.88280292992, 4769.0, 4800.879978000543, 4805.20714082176, 4826.734529600871, 5456.0, 5488.259085023511, 5497.642653227527, 5505.532029777473, 5578.2707360718305, 4082.836686532535, 4083.081306705997, 4087.7547347159266, 4105.178964207141, 4118.19695159444, 5526.45259327389, 5721.0, 5728.7110400160045, 5798.536117110621, 5806.535477161817, 4170.77060761655, 4173.290540608104, 4185.2885009547845, 4190.769507677046, 4191.895202619959, 4232.576742325743, 4234.87295381139, 4241.681873859473, 4259.212045771542, 4269.527013180448, 4627.5835174833755, 4733.573978341966, 4816.157172494799, 4825.9758701206265, 4827.831025914146, 5526.005319042531, 5530.834074977757, 5531.861703457445, 5533.253010843565, 5550.639208451518, 1441.668416264265, 1445.2584635514181, 1454.7271137754465, 1458.5843034735049, 1463.0490181381974, 910.2308549275851, 913.1621640000394, 935.3265648732902, 961.8797650293714, 975.5366201054443, 5291.444398338119, 5317.654352467077, 5341.729764849923, 5342.465753424626, 5353.839384818461, 5590.636608620427, 5591.944080559224, 5616.241807356037, 5632.436756324417, 5646.2377579027125, 5077.796888124508, 5308.30134357002, 5311.415744268127, 5341.744689997848, 5369.382521010134, 2996.6553846307515, 2998.385331007138, 3006.879724810983, 3026.803257788237, 3035.5294929285997, 5816.592838501264, 5855.945929732689, 5856.941430585724, 5889.851478961561, 5889.911651325234, 5609.467100625434, 5854.765809367663, 5859.414058594191, 5863.20846685692, 5869.031609784338, 5916.911246331309, 5941.792037278675, 5956.8808623828145, 5962.522998160137, 5997.340292567901, 5578.191162281528, 5726.938302211117, 5758.798442054508, 5765.164051212634, 5799.536037116936, 5691.14632805066, 5698.772049117989, 5699.7435115419075, 5705.031764041399, 5720.971395142998, 5859.326177489473, 5917.467427931507, 5979.282486101695, 5993.280806303272, 5998.730057147526, 4063.431119643193, 4081.2245673321972, 4081.3673880548563, 4083.3670781028986, 4102.2821006324375, 5738.9139162913425, 5761.654300741969, 5765.654060756368, 5772.0, 5774.624649397776, 5471.863203419946, 5512.228288039758, 5512.889742205213, 5550.4449555044175, 5573.27547418833, 5510.641808282448, 5511.311086114236, 5530.806421775219, 5580.414056524169, 5597.776088956396, 5334.093204155225, 5554.416786237549, 5559.471850174227, 5565.471280228372, 5581.720913954205, 5443.836684899459, 5595.608307418442, 5598.888022239614, 5611.719414029364, 5623.297087864017, 5475.863103422446, 5482.205080263419, 5497.26836046644, 5499.2576002240785, 5508.531774799187], "value": 4262.738411847106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.8062494064013, 780.6135962698465, 783.385042741448, 788.9566073865935, 851.3657325292658, 15514.922425387871, 17032.914835425836, 17075.146242687846, 17101.48695539134, 17108.401205957794, 13973.091749036306, 13995.300234988235, 14022.088564243317, 14035.438582456714, 14050.016498845085, 652.6214795418657, 776.0842206196686, 796.1520980156145, 801.2028032108061, 805.4724155678011, 797.3581267080027, 797.8165022044933, 799.7200979657132, 800.0519384529351, 800.5796956597775, 846.8814365988767, 847.7414388611471, 848.0247715127622, 848.8641817309232, 849.3163003781953, 683.2279524137717, 812.4394168024074, 825.0841565861889, 825.3067423364403, 829.0921441022072, 614.5851550203639, 614.858582526017, 614.9016157414792, 615.0651010464114, 615.2371059885754, 15896.0, 15916.840831591768, 15938.760918586231, 15940.840591594168, 15948.20258987046, 14201.218932958684, 14254.786178207336, 14408.207548584824, 14424.855751442456, 14430.783538246935, 13495.122817016962, 13643.113197642122, 13657.931710341483, 13675.042747007714, 13760.380782864795, 4611.377464042345, 4621.69958952667, 4726.881827954328, 4830.9275360869615, 4852.393450818648, 74299.0, 75091.62454187694, 77287.61356193239, 77759.22240777577, 78530.0, 12059.57791477294, 12200.694982625328, 12207.877921220674, 12258.26450412978, 12316.876831231752, 22714.886425567765, 22804.885975570018, 22848.200312988967, 22883.08467661308, 22883.42791430194, 8396.958015210008, 8556.700515481929, 8589.312854971713, 8840.955795220983, 9095.545222738836, 4791.808327666854, 4871.074495845778, 4900.803967841246, 4938.407391113017, 5044.924326135111, 3212.1969507623094, 3282.5568548245683, 3319.751018673609, 3322.352141332465, 3330.5170750241077, 597.4503456819737, 598.7215944585702, 600.129811772931, 615.0681717198448, 619.3032838057186, 605.6517502436117, 671.4292851076643, 686.3788271614197, 688.9276625954303, 725.684327317608, 9188.90811091894, 9394.95302523483, 9856.260780441495, 9936.900630993598, 10028.849567256497, 569.7806344557292, 616.1835567872587, 673.1988933169611, 682.4199430484049, 691.4261163234503, 4437.955620443819, 4676.158291507561, 4767.070421267819, 4862.7325497098, 4879.365682461257, 66383.0, 92190.53904730434, 110996.0, 122155.3892230551, 122515.29816422086, 87609.56195218983, 104860.18408803403, 105700.47149764202, 105817.94182058235, 106841.0, 77878.0, 89759.55120224488, 90307.54846225727, 93030.0, 93714.53142734243, 10112.672691802436, 10255.28213025111, 10346.37921724699, 10461.215408844215, 10765.192610554397, 51865.0, 54454.455455444935, 54617.453825461234, 55698.72150639221, 56726.7163664179, 71434.28565714277, 72643.63678181576, 78345.0, 79418.20581794108, 80585.19414805777, 13830.792538111735, 13834.515791947233, 13925.373358198703, 14011.719765604426, 14725.779113313523, 15769.132697701736, 15924.94730279384, 16066.919665401598, 16941.491755247363, 17025.659486809946, 14957.775633365725, 15323.157226352212, 15527.45653902108, 15528.611784705472, 15537.0, 14563.563093107225, 14841.925790370979, 15216.619584510476, 15445.382184712485, 15977.155661757013, 14211.360488778237, 14314.642133946318, 14993.325300361292, 15008.099514029193, 15055.397784088515, 11848.36486580814, 12081.862246424469, 12243.938780306398, 12480.5007799687, 12834.358282086045, 11752.882471175179, 12620.873791262336, 12702.872971270539, 12949.870501294867, 13039.934800325938], "value": 7795.233254978829, "unit": "score"}], "name": "dromaeo_css", "value": 7241.534183283102, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 120.0, 190.0, 119.0, 118.0, 144.0, 124.0, 155.0, 119.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 163.0, 160.0, 160.0, 163.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 115.0, 75.0, 76.0, 75.0, 74.0, 118.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 123.0, 84.0, 85.0, 84.0, 119.0, 84.0, 84.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 55.0, 50.0, 50.0, 51.0, 52.0, 49.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 78.0, 80.0, 75.0, 75.0, 84.0, 79.0, 76.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 118.0, 119.0, 116.0, 128.0, 127.0, 118.0, 204.0, 130.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 157.0, 156.0, 159.0, 166.0, 158.0, 154.0, 162.0, 152.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 70.0, 63.0, 64.0, 62.0, 62.0, 61.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1483.1000000000004, "alertThreshold": 2.0}]} 20:42:39 INFO - Return code: 0 20:42:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:42:39 INFO - # TBPL SUCCESS # 20:42:39 INFO - Running post-action listener: _resource_record_post_action 20:42:39 INFO - [mozharness: 2016-07-28 03:42:39.425608Z] Finished run-tests step (success) 20:42:39 INFO - Running post-run listener: _resource_record_post_run 20:42:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 567599104; Read time: 336; Write time: 449112 20:42:39 INFO - TinderboxPrint: CPU usage
13.0% 20:42:39 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 336 20:42:39 INFO - TinderboxPrint: I/O write bytes / time
567,599,104 / 449,112 20:42:39 INFO - TinderboxPrint: CPU idle
8,272.4 (87.0%) 20:42:39 INFO - TinderboxPrint: CPU user
1,189.4 (12.5%) 20:42:39 INFO - TinderboxPrint: Swap in / out
0 / 0 20:42:39 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 268722176; Read time: 140; Write time: 263428 20:42:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298876928; Read time: 188; Write time: 185684 20:42:40 INFO - Running post-run listener: _upload_blobber_files 20:42:40 INFO - Blob upload gear active. 20:42:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:42:40 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:42:40 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:42:40 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:42:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:41 INFO - (blobuploader) - INFO - Done attempting. 20:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:47 INFO - (blobuploader) - INFO - Done attempting. 20:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:48 INFO - (blobuploader) - INFO - Done attempting. 20:42:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:42:48 INFO - Return code: 0 20:42:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:42:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:42:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d876194716ee449dfd53662abc9910d0c1ff70e88c5f6e845466025c245ff258e9d706eb4dd636732a01feacbe31d87be1a5e624db6f1c1773db56bc40f29e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bae2be6b31c919124b06230c6f1b4600d1cce38317af0cad8ac86d68240654250b8ec9c753ccf75aa50d1d6e4668f85156e765635f4b70f248c51c376100f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d8f4f5b777bec04873893381287519c8314e0bda6ea799b0fec4edfba1f6421a2ebd86e4befe90656c49a21456f0abf4a5df35ef7df77cbd6aa05ac1bb18a04"} 20:42:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:42:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:42:48 INFO - Contents: 20:42:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d876194716ee449dfd53662abc9910d0c1ff70e88c5f6e845466025c245ff258e9d706eb4dd636732a01feacbe31d87be1a5e624db6f1c1773db56bc40f29e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bae2be6b31c919124b06230c6f1b4600d1cce38317af0cad8ac86d68240654250b8ec9c753ccf75aa50d1d6e4668f85156e765635f4b70f248c51c376100f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d8f4f5b777bec04873893381287519c8314e0bda6ea799b0fec4edfba1f6421a2ebd86e4befe90656c49a21456f0abf4a5df35ef7df77cbd6aa05ac1bb18a04"} 20:42:48 INFO - Running post-run listener: copy_logs_to_upload_dir 20:42:48 INFO - Copying logs to upload dir... 20:42:48 INFO - mkdir: /builds/slave/test/build/upload/logs 20:42:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.007696 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-27 20:42:48.116560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 20:42:48.121769) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d876194716ee449dfd53662abc9910d0c1ff70e88c5f6e845466025c245ff258e9d706eb4dd636732a01feacbe31d87be1a5e624db6f1c1773db56bc40f29e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bae2be6b31c919124b06230c6f1b4600d1cce38317af0cad8ac86d68240654250b8ec9c753ccf75aa50d1d6e4668f85156e765635f4b70f248c51c376100f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d8f4f5b777bec04873893381287519c8314e0bda6ea799b0fec4edfba1f6421a2ebd86e4befe90656c49a21456f0abf4a5df35ef7df77cbd6aa05ac1bb18a04"} 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.011335 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d876194716ee449dfd53662abc9910d0c1ff70e88c5f6e845466025c245ff258e9d706eb4dd636732a01feacbe31d87be1a5e624db6f1c1773db56bc40f29e4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bae2be6b31c919124b06230c6f1b4600d1cce38317af0cad8ac86d68240654250b8ec9c753ccf75aa50d1d6e4668f85156e765635f4b70f248c51c376100f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d8f4f5b777bec04873893381287519c8314e0bda6ea799b0fec4edfba1f6421a2ebd86e4befe90656c49a21456f0abf4a5df35ef7df77cbd6aa05ac1bb18a04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 20:42:48.146616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:42:48.146922) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469676134.246999-379842484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 20:42:48.232183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 20:42:48.232530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 20:42:48.232817) ========= ========= Total master_lag: 0.17 =========