builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1470259259.65 results: success (0) buildid: 20160803113011 builduid: 3771ab0a826845c6ae8d64d3ebe97f83 revision: 41072825cb0d9bb0914bd211c54bd6dc51a917fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.645929) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.646490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.646968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.663739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.664327) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 14:20:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 162K=0.07s 2016-08-03 14:20:59 (162 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.829590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.830073) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.882346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:20:59.882865) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 41072825cb0d9bb0914bd211c54bd6dc51a917fb --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 41072825cb0d9bb0914bd211c54bd6dc51a917fb --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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 14:21:00,015 truncating revision to first 12 chars 2016-08-03 14:21:00,016 Setting DEBUG logging. 2016-08-03 14:21:00,016 attempt 1/10 2016-08-03 14:21:00,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/41072825cb0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 14:21:00,320 unpacking tar archive at: fx-team-41072825cb0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:21:00.548720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 14:21:00.549101) ========= script_repo_revision: 41072825cb0d9bb0914bd211c54bd6dc51a917fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 14:21:00.549620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 14:21:00.549896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 14:21:00.560522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-03 14:21:00.561072) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:21:00 INFO - MultiFileLogger online at 20160803 14:21:00 in /builds/slave/test 14:21:00 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 14:21:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:00 INFO - {'append_to_log': False, 14:21:00 INFO - 'base_work_dir': '/builds/slave/test', 14:21:00 INFO - 'blob_upload_branch': 'Fx-Team', 14:21:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:00 INFO - 'branch': 'Fx-Team', 14:21:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:00 INFO - 'config_files': ('talos/linux_config.py',), 14:21:00 INFO - 'default_actions': ('clobber', 14:21:00 INFO - 'read-buildbot-config', 14:21:00 INFO - 'download-and-extract', 14:21:00 INFO - 'populate-webroot', 14:21:00 INFO - 'create-virtualenv', 14:21:00 INFO - 'install', 14:21:00 INFO - 'run-tests'), 14:21:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:00 INFO - 'download_minidump_stackwalk': True, 14:21:00 INFO - 'download_symbols': 'ondemand', 14:21:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:00 INFO - 'installer_path': 'installer.exe', 14:21:00 INFO - 'log_level': 'info', 14:21:00 INFO - 'log_name': 'talos', 14:21:00 INFO - 'log_to_console': True, 14:21:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:21:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:21:00 INFO - 'opt_config_files': (), 14:21:00 INFO - 'pip_index': False, 14:21:00 INFO - 'sps_profile': False, 14:21:00 INFO - 'sps_profile_interval': 0, 14:21:00 INFO - 'suite': 'dromaeojs', 14:21:00 INFO - 'system_bits': '32', 14:21:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:00 INFO - 'title': 'talos-linux64-ix-029', 14:21:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:00 INFO - 'use_talos_json': True, 14:21:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:00 INFO - 'work_dir': 'build'} 14:21:00 INFO - [mozharness: 2016-08-03 21:21:00.787728Z] Running clobber step. 14:21:00 INFO - Running pre-action listener: _resource_record_pre_action 14:21:00 INFO - Running main action method: clobber 14:21:00 INFO - rmtree: /builds/slave/test/build 14:21:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - [mozharness: 2016-08-03 21:21:01.248565Z] Finished clobber step (success) 14:21:01 INFO - [mozharness: 2016-08-03 21:21:01.248677Z] Running read-buildbot-config step. 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: read_buildbot_config 14:21:01 INFO - Using buildbot properties: 14:21:01 INFO - { 14:21:01 INFO - "project": "", 14:21:01 INFO - "product": "firefox", 14:21:01 INFO - "script_repo_revision": "production", 14:21:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:21:01 INFO - "repository": "", 14:21:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:21:01 INFO - "buildid": "20160803113011", 14:21:01 INFO - "pgo_build": "True", 14:21:01 INFO - "basedir": "/builds/slave/test", 14:21:01 INFO - "buildnumber": 948, 14:21:01 INFO - "slavename": "talos-linux64-ix-029", 14:21:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:21:01 INFO - "platform": "ubuntu64_hw", 14:21:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:21:01 INFO - "branch": "fx-team", 14:21:01 INFO - "repo_path": "integration/fx-team", 14:21:01 INFO - "revision": "41072825cb0d9bb0914bd211c54bd6dc51a917fb", 14:21:01 INFO - "stage_platform": "linux64-pgo", 14:21:01 INFO - "builduid": "3771ab0a826845c6ae8d64d3ebe97f83", 14:21:01 INFO - "slavebuilddir": "test" 14:21:01 INFO - } 14:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - [mozharness: 2016-08-03 21:21:01.251277Z] Finished read-buildbot-config step (success) 14:21:01 INFO - [mozharness: 2016-08-03 21:21:01.251382Z] Running download-and-extract step. 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: download_and_extract 14:21:01 INFO - mkdir: /builds/slave/test/build/tests 14:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:01 INFO - https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:21:01 INFO - Downloaded 1361 bytes. 14:21:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:21:01 INFO - Using the following test package requirements: 14:21:01 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:21:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:21:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:21:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'jsshell-linux-x86_64.zip'], 14:21:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:21:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:21:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:21:01 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:21:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:21:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:21:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:01 INFO - https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:21:02 INFO - Downloaded 21812619 bytes. 14:21:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:21:04 INFO - Return code: 0 14:21:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:04 INFO - https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:21:05 INFO - Downloaded 21812619 bytes. 14:21:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:21:06 INFO - Return code: 0 14:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:06 INFO - https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:21:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:21:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:21:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:21:07 INFO - Downloaded 14413723 bytes. 14:21:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:21:07 INFO - Return code: 0 14:21:07 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')]} 14:21:07 INFO - https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:21:08 INFO - Downloaded 59351624 bytes. 14:21:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:21:08 INFO - mkdir: /builds/slave/test/properties 14:21:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:08 INFO - Contents: 14:21:08 INFO - build_url:https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:21:09 INFO - Running post-action listener: _resource_record_post_action 14:21:09 INFO - Running post-action listener: set_extra_try_arguments 14:21:09 INFO - [mozharness: 2016-08-03 21:21:09.517271Z] Finished download-and-extract step (success) 14:21:09 INFO - [mozharness: 2016-08-03 21:21:09.517502Z] Running populate-webroot step. 14:21:09 INFO - Running pre-action listener: _resource_record_pre_action 14:21:09 INFO - Running main action method: populate_webroot 14:21:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:09 INFO - '--tppagecycles', 14:21:09 INFO - '7'], 14:21:09 INFO - 'tests': ['tsvgm']}}, 14:21:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['damp', 'tps']}, 14:21:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'tests': ['damp', 'tps']}, 14:21:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['dromaeo_dom']}, 14:21:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['basic_compositor_video']}, 14:21:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:21:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['a11yr', 14:21:09 INFO - 'ts_paint', 14:21:09 INFO - 'tpaint', 14:21:09 INFO - 'sessionrestore', 14:21:09 INFO - 'sessionrestore_no_auto_restore', 14:21:09 INFO - 'tabpaint']}, 14:21:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['tsvgx', 14:21:09 INFO - 'tsvgr_opacity', 14:21:09 INFO - 'tart', 14:21:09 INFO - 'tscrollx', 14:21:09 INFO - 'cart']}, 14:21:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:09 INFO - 'tsvgr_opacity', 14:21:09 INFO - 'tart', 14:21:09 INFO - 'tscrollx', 14:21:09 INFO - 'cart']}, 14:21:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'talos_options': ['--disable-e10s'], 14:21:09 INFO - 'tests': ['tp5o']}, 14:21:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'tests': ['tp5o']}, 14:21:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'talos_options': ['--disable-e10s', 14:21:09 INFO - '--xperf_path', 14:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:09 INFO - 'tests': ['tp5n']}, 14:21:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:09 INFO - 'talos_options': ['--xperf_path', 14:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:09 INFO - 'tests': ['tp5n']}}, 14:21:09 INFO - 'talos.zip': {'path': '', 14:21:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:09 INFO - Running post-action listener: _resource_record_post_action 14:21:09 INFO - [mozharness: 2016-08-03 21:21:09.539511Z] Finished populate-webroot step (success) 14:21:09 INFO - [mozharness: 2016-08-03 21:21:09.539599Z] Running create-virtualenv step. 14:21:09 INFO - Running pre-action listener: _resource_record_pre_action 14:21:09 INFO - Running main action method: create_virtualenv 14:21:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:09 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 14:21:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:09 INFO - Using real prefix '/usr' 14:21:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:12 INFO - Installing pip.................done. 14:21:12 INFO - Return code: 0 14:21:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:12 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')]} 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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')]} 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:12 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 14:21:12 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 14:21:12 INFO - Using env: {'DISPLAY': ':0', 14:21:12 INFO - 'HOME': '/home/cltbld', 14:21:12 INFO - 'LANG': 'en_US.UTF-8', 14:21:12 INFO - 'LANGUAGE': 'en_US:en', 14:21:12 INFO - 'LOGNAME': 'cltbld', 14:21:12 INFO - 'MAIL': '/var/mail/cltbld', 14:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:12 INFO - 'MOZ_NO_REMOTE': '1', 14:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:12 INFO - 'NO_EM_RESTART': '1', 14:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:12 INFO - 'PWD': '/builds/slave/test', 14:21:12 INFO - 'SHELL': '/bin/bash', 14:21:12 INFO - 'SHLVL': '1', 14:21:12 INFO - 'TERM': 'linux', 14:21:12 INFO - 'TMOUT': '86400', 14:21:12 INFO - 'USER': 'cltbld', 14:21:12 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:12 INFO - '_': '/tools/buildbot/bin/python'} 14:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:12 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 14:21:12 INFO - Cleaning up... 14:21:12 INFO - Return code: 0 14:21:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:12 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')]} 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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')]} 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:12 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 14:21:12 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 14:21:12 INFO - Using env: {'DISPLAY': ':0', 14:21:12 INFO - 'HOME': '/home/cltbld', 14:21:12 INFO - 'LANG': 'en_US.UTF-8', 14:21:12 INFO - 'LANGUAGE': 'en_US:en', 14:21:12 INFO - 'LOGNAME': 'cltbld', 14:21:12 INFO - 'MAIL': '/var/mail/cltbld', 14:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:12 INFO - 'MOZ_NO_REMOTE': '1', 14:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:12 INFO - 'NO_EM_RESTART': '1', 14:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:12 INFO - 'PWD': '/builds/slave/test', 14:21:12 INFO - 'SHELL': '/bin/bash', 14:21:12 INFO - 'SHLVL': '1', 14:21:12 INFO - 'TERM': 'linux', 14:21:12 INFO - 'TMOUT': '86400', 14:21:12 INFO - 'USER': 'cltbld', 14:21:12 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:12 INFO - '_': '/tools/buildbot/bin/python'} 14:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:12 INFO - Downloading/unpacking psutil>=3.1.1 14:21:12 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 14:21:12 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 14:21:12 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 14:21:12 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 14:21:12 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 14:21:12 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 14:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:14 INFO - Installing collected packages: psutil 14:21:14 INFO - Running setup.py install for psutil 14:21:14 INFO - building 'psutil._psutil_linux' extension 14:21:14 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 14:21:14 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 14:21:14 INFO - building 'psutil._psutil_posix' extension 14:21:14 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 14:21:14 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 14:21:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:15 INFO - Successfully installed psutil 14:21:15 INFO - Cleaning up... 14:21:15 INFO - Return code: 0 14:21:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:21:15 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')]} 14:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:15 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')]} 14:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:15 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:15 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 14:21:15 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 14:21:15 INFO - Using env: {'DISPLAY': ':0', 14:21:15 INFO - 'HOME': '/home/cltbld', 14:21:15 INFO - 'LANG': 'en_US.UTF-8', 14:21:15 INFO - 'LANGUAGE': 'en_US:en', 14:21:15 INFO - 'LOGNAME': 'cltbld', 14:21:15 INFO - 'MAIL': '/var/mail/cltbld', 14:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:15 INFO - 'MOZ_NO_REMOTE': '1', 14:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:15 INFO - 'NO_EM_RESTART': '1', 14:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:15 INFO - 'PWD': '/builds/slave/test', 14:21:15 INFO - 'SHELL': '/bin/bash', 14:21:15 INFO - 'SHLVL': '1', 14:21:15 INFO - 'TERM': 'linux', 14:21:15 INFO - 'TMOUT': '86400', 14:21:15 INFO - 'USER': 'cltbld', 14:21:15 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:15 INFO - '_': '/tools/buildbot/bin/python'} 14:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:21:15 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 14:21:15 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 14:21:15 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 14:21:15 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 14:21:15 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 14:21:15 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 14:21:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:21:17 INFO - Installing collected packages: mozsystemmonitor 14:21:17 INFO - Running setup.py install for mozsystemmonitor 14:21:17 INFO - Successfully installed mozsystemmonitor 14:21:17 INFO - Cleaning up... 14:21:17 INFO - Return code: 0 14:21:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:17 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:17 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 14:21:17 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 14:21:17 INFO - Using env: {'DISPLAY': ':0', 14:21:17 INFO - 'HOME': '/home/cltbld', 14:21:17 INFO - 'LANG': 'en_US.UTF-8', 14:21:17 INFO - 'LANGUAGE': 'en_US:en', 14:21:17 INFO - 'LOGNAME': 'cltbld', 14:21:17 INFO - 'MAIL': '/var/mail/cltbld', 14:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:17 INFO - 'MOZ_NO_REMOTE': '1', 14:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:17 INFO - 'NO_EM_RESTART': '1', 14:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:17 INFO - 'PWD': '/builds/slave/test', 14:21:17 INFO - 'SHELL': '/bin/bash', 14:21:17 INFO - 'SHLVL': '1', 14:21:17 INFO - 'TERM': 'linux', 14:21:17 INFO - 'TMOUT': '86400', 14:21:17 INFO - 'USER': 'cltbld', 14:21:17 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:17 INFO - '_': '/tools/buildbot/bin/python'} 14:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:17 INFO - Downloading/unpacking jsonschema==2.5.1 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:19 INFO - warning: no files found matching '*.txt' 14:21:19 INFO - no previously-included directories found matching 'build' 14:21:19 INFO - no previously-included directories found matching 'dist' 14:21:19 INFO - no previously-included directories found matching '.git*' 14:21:19 INFO - Installing collected packages: jsonschema, functools32 14:21:19 INFO - Running setup.py install for functools32 14:21:19 INFO - warning: no files found matching '*.txt' 14:21:19 INFO - no previously-included directories found matching 'build' 14:21:19 INFO - no previously-included directories found matching 'dist' 14:21:19 INFO - no previously-included directories found matching '.git*' 14:21:19 INFO - Successfully installed jsonschema functools32 14:21:19 INFO - Cleaning up... 14:21:19 INFO - Return code: 0 14:21:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:19 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:19 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 14:21:19 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 14:21:19 INFO - Using env: {'DISPLAY': ':0', 14:21:19 INFO - 'HOME': '/home/cltbld', 14:21:19 INFO - 'LANG': 'en_US.UTF-8', 14:21:19 INFO - 'LANGUAGE': 'en_US:en', 14:21:19 INFO - 'LOGNAME': 'cltbld', 14:21:19 INFO - 'MAIL': '/var/mail/cltbld', 14:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:19 INFO - 'MOZ_NO_REMOTE': '1', 14:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:19 INFO - 'NO_EM_RESTART': '1', 14:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:19 INFO - 'PWD': '/builds/slave/test', 14:21:19 INFO - 'SHELL': '/bin/bash', 14:21:19 INFO - 'SHLVL': '1', 14:21:19 INFO - 'TERM': 'linux', 14:21:19 INFO - 'TMOUT': '86400', 14:21:19 INFO - 'USER': 'cltbld', 14:21:19 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:19 INFO - '_': '/tools/buildbot/bin/python'} 14:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:21:20 INFO - Cleaning up... 14:21:20 INFO - Return code: 0 14:21:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:20 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:20 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 14:21:20 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 14:21:20 INFO - Using env: {'DISPLAY': ':0', 14:21:20 INFO - 'HOME': '/home/cltbld', 14:21:20 INFO - 'LANG': 'en_US.UTF-8', 14:21:20 INFO - 'LANGUAGE': 'en_US:en', 14:21:20 INFO - 'LOGNAME': 'cltbld', 14:21:20 INFO - 'MAIL': '/var/mail/cltbld', 14:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:20 INFO - 'MOZ_NO_REMOTE': '1', 14:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:20 INFO - 'NO_EM_RESTART': '1', 14:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:20 INFO - 'PWD': '/builds/slave/test', 14:21:20 INFO - 'SHELL': '/bin/bash', 14:21:20 INFO - 'SHLVL': '1', 14:21:20 INFO - 'TERM': 'linux', 14:21:20 INFO - 'TMOUT': '86400', 14:21:20 INFO - 'USER': 'cltbld', 14:21:20 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:20 INFO - '_': '/tools/buildbot/bin/python'} 14:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:20 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:20 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 14:21:20 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 14:21:20 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 14:21:20 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 14:21:20 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 14:21:20 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 14:21:22 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 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 14:21:22 INFO - Downloading docopt-0.6.1.tar.gz 14:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:22 INFO - Running setup.py install for blobuploader 14:21:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:23 INFO - Running setup.py install for requests 14:21:23 INFO - Running setup.py install for docopt 14:21:23 INFO - Successfully installed blobuploader requests docopt 14:21:23 INFO - Cleaning up... 14:21:23 INFO - Return code: 0 14:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:23 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:23 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 14:21:23 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 14:21:23 INFO - Using env: {'DISPLAY': ':0', 14:21:23 INFO - 'HOME': '/home/cltbld', 14:21:23 INFO - 'LANG': 'en_US.UTF-8', 14:21:23 INFO - 'LANGUAGE': 'en_US:en', 14:21:23 INFO - 'LOGNAME': 'cltbld', 14:21:23 INFO - 'MAIL': '/var/mail/cltbld', 14:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:23 INFO - 'MOZ_NO_REMOTE': '1', 14:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:23 INFO - 'NO_EM_RESTART': '1', 14:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:23 INFO - 'PWD': '/builds/slave/test', 14:21:23 INFO - 'SHELL': '/bin/bash', 14:21:23 INFO - 'SHLVL': '1', 14:21:23 INFO - 'TERM': 'linux', 14:21:23 INFO - 'TMOUT': '86400', 14:21:23 INFO - 'USER': 'cltbld', 14:21:23 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:23 INFO - '_': '/tools/buildbot/bin/python'} 14:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:23 INFO - Running setup.py (path:/tmp/pip-uHKa3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:23 INFO - Running setup.py (path:/tmp/pip-vFJiGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:23 INFO - Running setup.py (path:/tmp/pip-rSOEsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:24 INFO - Running setup.py (path:/tmp/pip-BXYrJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:24 INFO - Running setup.py (path:/tmp/pip-Yb5uZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:24 INFO - Running setup.py (path:/tmp/pip-Qc2w1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:24 INFO - Running setup.py (path:/tmp/pip-4Da3Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:24 INFO - Running setup.py (path:/tmp/pip-26Kq9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:24 INFO - Running setup.py (path:/tmp/pip-z0ykcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:24 INFO - Running setup.py (path:/tmp/pip-nBqYQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:24 INFO - Running setup.py (path:/tmp/pip-RYeOqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:24 INFO - Running setup.py (path:/tmp/pip-JfDaoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:24 INFO - Running setup.py (path:/tmp/pip-IQvGNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:24 INFO - Running setup.py (path:/tmp/pip-Mzu4__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:24 INFO - Running setup.py (path:/tmp/pip-0rJFAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:24 INFO - Running setup.py (path:/tmp/pip-wZKb6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:24 INFO - Running setup.py (path:/tmp/pip-alKqZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:25 INFO - Running setup.py install for manifestparser 14:21:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Running setup.py install for mozcrash 14:21:25 INFO - Running setup.py install for mozdebug 14:21:25 INFO - Running setup.py install for mozdevice 14:21:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Running setup.py install for mozfile 14:21:25 INFO - Running setup.py install for mozhttpd 14:21:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Running setup.py install for mozinfo 14:21:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Running setup.py install for mozInstall 14:21:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:25 INFO - Running setup.py install for mozleak 14:21:25 INFO - Running setup.py install for mozlog 14:21:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Running setup.py install for moznetwork 14:21:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Running setup.py install for mozprocess 14:21:26 INFO - Running setup.py install for mozprofile 14:21:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Running setup.py install for mozrunner 14:21:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Running setup.py install for mozscreenshot 14:21:26 INFO - Running setup.py install for moztest 14:21:26 INFO - Running setup.py install for mozversion 14:21:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:26 INFO - Cleaning up... 14:21:26 INFO - Return code: 0 14:21:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:26 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')]} 14:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:26 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')]} 14:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:26 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:26 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 14:21:26 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 14:21:26 INFO - Using env: {'DISPLAY': ':0', 14:21:26 INFO - 'HOME': '/home/cltbld', 14:21:26 INFO - 'LANG': 'en_US.UTF-8', 14:21:26 INFO - 'LANGUAGE': 'en_US:en', 14:21:26 INFO - 'LOGNAME': 'cltbld', 14:21:26 INFO - 'MAIL': '/var/mail/cltbld', 14:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:26 INFO - 'MOZ_NO_REMOTE': '1', 14:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:26 INFO - 'NO_EM_RESTART': '1', 14:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:26 INFO - 'PWD': '/builds/slave/test', 14:21:26 INFO - 'SHELL': '/bin/bash', 14:21:26 INFO - 'SHLVL': '1', 14:21:26 INFO - 'TERM': 'linux', 14:21:26 INFO - 'TMOUT': '86400', 14:21:26 INFO - 'USER': 'cltbld', 14:21:26 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:26 INFO - '_': '/tools/buildbot/bin/python'} 14:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:27 INFO - Running setup.py (path:/tmp/pip-dlHDSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:27 INFO - Running setup.py (path:/tmp/pip-3YdDnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:27 INFO - Running setup.py (path:/tmp/pip-C01KMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:27 INFO - Running setup.py (path:/tmp/pip-Tio2xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:27 INFO - Running setup.py (path:/tmp/pip-6Fq0f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:27 INFO - Running setup.py (path:/tmp/pip-lQCzV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:27 INFO - Running setup.py (path:/tmp/pip-qBRfyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:27 INFO - Running setup.py (path:/tmp/pip-VlvBJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:27 INFO - Running setup.py (path:/tmp/pip-XKE7Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:27 INFO - Running setup.py (path:/tmp/pip-5XCuYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:27 INFO - Running setup.py (path:/tmp/pip-HDUHXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:27 INFO - Running setup.py (path:/tmp/pip-osGjd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:27 INFO - Running setup.py (path:/tmp/pip-wFhELH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:27 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)) 14:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:27 INFO - Running setup.py (path:/tmp/pip-h1iZMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:28 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)) 14:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:28 INFO - Running setup.py (path:/tmp/pip-e4Liht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:28 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)) 14:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:28 INFO - Running setup.py (path:/tmp/pip-Dan44K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:28 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)) 14:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:28 INFO - Running setup.py (path:/tmp/pip-Iu2fP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:28 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)) 14:21:28 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)) 14:21:28 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)) 14:21:28 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)) 14:21:28 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)) 14:21:28 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)) 14:21:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:30 INFO - Downloading blessings-1.6.tar.gz 14:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:21:30 INFO - Installing collected packages: blessings 14:21:30 INFO - Running setup.py install for blessings 14:21:30 INFO - Successfully installed blessings 14:21:30 INFO - Cleaning up... 14:21:30 INFO - Return code: 0 14:21:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:30 INFO - Reading from file tmpfile_stdout 14:21:30 INFO - Current package versions: 14:21:30 INFO - argparse == 1.2.1 14:21:30 INFO - blessings == 1.6 14:21:30 INFO - blobuploader == 1.2.4 14:21:30 INFO - docopt == 0.6.1 14:21:30 INFO - functools32 == 3.2.3-2 14:21:30 INFO - jsonschema == 2.5.1 14:21:30 INFO - manifestparser == 1.1 14:21:30 INFO - mozInstall == 1.12 14:21:30 INFO - mozcrash == 0.17 14:21:30 INFO - mozdebug == 0.1 14:21:30 INFO - mozdevice == 0.48 14:21:30 INFO - mozfile == 1.2 14:21:30 INFO - mozhttpd == 0.7 14:21:30 INFO - mozinfo == 0.9 14:21:30 INFO - mozleak == 0.1 14:21:30 INFO - mozlog == 3.3 14:21:30 INFO - moznetwork == 0.27 14:21:30 INFO - mozprocess == 0.23 14:21:30 INFO - mozprofile == 0.28 14:21:30 INFO - mozrunner == 6.12 14:21:30 INFO - mozscreenshot == 0.1 14:21:30 INFO - mozsystemmonitor == 0.3 14:21:30 INFO - moztest == 0.7 14:21:30 INFO - mozversion == 1.4 14:21:30 INFO - psutil == 3.1.1 14:21:30 INFO - requests == 1.2.3 14:21:30 INFO - wsgiref == 0.1.2 14:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:30 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 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:30 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 14:21:30 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 14:21:30 INFO - Using env: {'DISPLAY': ':0', 14:21:30 INFO - 'HOME': '/home/cltbld', 14:21:30 INFO - 'LANG': 'en_US.UTF-8', 14:21:30 INFO - 'LANGUAGE': 'en_US:en', 14:21:30 INFO - 'LOGNAME': 'cltbld', 14:21:30 INFO - 'MAIL': '/var/mail/cltbld', 14:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:30 INFO - 'MOZ_NO_REMOTE': '1', 14:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:30 INFO - 'NO_EM_RESTART': '1', 14:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:30 INFO - 'PWD': '/builds/slave/test', 14:21:30 INFO - 'SHELL': '/bin/bash', 14:21:30 INFO - 'SHLVL': '1', 14:21:30 INFO - 'TERM': 'linux', 14:21:30 INFO - 'TMOUT': '86400', 14:21:30 INFO - 'USER': 'cltbld', 14:21:30 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:30 INFO - '_': '/tools/buildbot/bin/python'} 14:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 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)) 14:21:30 INFO - Cleaning up... 14:21:30 INFO - Return code: 0 14:21:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', '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 14:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:21:30 INFO - Using env: {'DISPLAY': ':0', 14:21:30 INFO - 'HOME': '/home/cltbld', 14:21:30 INFO - 'LANG': 'en_US.UTF-8', 14:21:30 INFO - 'LANGUAGE': 'en_US:en', 14:21:30 INFO - 'LOGNAME': 'cltbld', 14:21:30 INFO - 'MAIL': '/var/mail/cltbld', 14:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:30 INFO - 'MOZ_NO_REMOTE': '1', 14:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:30 INFO - 'NO_EM_RESTART': '1', 14:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:30 INFO - 'PWD': '/builds/slave/test', 14:21:30 INFO - 'SHELL': '/bin/bash', 14:21:30 INFO - 'SHLVL': '1', 14:21:30 INFO - 'TERM': 'linux', 14:21:30 INFO - 'TMOUT': '86400', 14:21:30 INFO - 'USER': 'cltbld', 14:21:30 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:30 INFO - '_': '/tools/buildbot/bin/python'} 14:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:21:31 INFO - Cleaning up... 14:21:31 INFO - Return code: 0 14:21:31 INFO - Running post-action listener: _resource_record_post_action 14:21:31 INFO - Running post-action listener: _start_resource_monitoring 14:21:31 INFO - Starting resource monitoring. 14:21:31 INFO - [mozharness: 2016-08-03 21:21:31.085417Z] Finished create-virtualenv step (success) 14:21:31 INFO - [mozharness: 2016-08-03 21:21:31.085845Z] Running install step. 14:21:31 INFO - Running pre-action listener: _resource_record_pre_action 14:21:31 INFO - Running main action method: install 14:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:31 INFO - Reading from file tmpfile_stdout 14:21:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:31 INFO - Reading from file tmpfile_stdout 14:21:31 INFO - Output received: 14:21:31 INFO - Usage: mozinstall [options] installer 14:21:31 INFO - Options: 14:21:31 INFO - -h, --help show this help message and exit 14:21:31 INFO - -d DEST, --destination=DEST 14:21:31 INFO - Directory to install application into. [default: 14:21:31 INFO - "/builds/slave/test"] 14:21:31 INFO - --app=APP Application being installed. [default: firefox] 14:21:31 INFO - mkdir: /builds/slave/test/build/application 14:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:21:48 INFO - Reading from file tmpfile_stdout 14:21:48 INFO - Output received: 14:21:48 INFO - /builds/slave/test/build/application/firefox/firefox 14:21:48 INFO - Running post-action listener: _resource_record_post_action 14:21:48 INFO - [mozharness: 2016-08-03 21:21:48.415470Z] Finished install step (success) 14:21:48 INFO - [mozharness: 2016-08-03 21:21:48.415756Z] Running run-tests step. 14:21:48 INFO - Running pre-action listener: _resource_record_pre_action 14:21:48 INFO - Running main action method: run_tests 14:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:21:48 INFO - Python 2.7.3 14:21:48 INFO - Return code: 0 14:21:48 INFO - grabbing minidump binary from tooltool 14:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:48 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 0x1bfb3b0>, '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 0x1bfc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:21:48 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 14:21:48 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 14:21:48 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 14:21:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:21:48 INFO - Return code: 0 14:21:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:21:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:21:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:21:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:21:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:21:48 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/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 14:21:48 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/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 14:21:48 INFO - Using env: {'DISPLAY': ':0', 14:21:48 INFO - 'HOME': '/home/cltbld', 14:21:48 INFO - 'LANG': 'en_US.UTF-8', 14:21:48 INFO - 'LANGUAGE': 'en_US:en', 14:21:48 INFO - 'LOGNAME': 'cltbld', 14:21:48 INFO - 'MAIL': '/var/mail/cltbld', 14:21:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:21:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:48 INFO - 'MOZ_NO_REMOTE': '1', 14:21:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:48 INFO - 'NO_EM_RESTART': '1', 14:21:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:48 INFO - 'PWD': '/builds/slave/test', 14:21:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:21:48 INFO - 'SHELL': '/bin/bash', 14:21:48 INFO - 'SHLVL': '1', 14:21:48 INFO - 'TERM': 'linux', 14:21:48 INFO - 'TMOUT': '86400', 14:21:48 INFO - 'USER': 'cltbld', 14:21:48 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568', 14:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:48 INFO - '_': '/tools/buildbot/bin/python'} 14:21:48 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/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 14:21:48 INFO - mozversion application_buildid: 20160803113011 14:21:48 INFO - mozversion application_changeset: 41072825cb0d9bb0914bd211c54bd6dc51a917fb 14:21:48 INFO - mozversion application_display_name: Nightly 14:21:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:21:48 INFO - mozversion application_name: Firefox 14:21:48 INFO - mozversion application_remotingname: firefox 14:21:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:21:48 INFO - mozversion application_vendor: Mozilla 14:21:48 INFO - mozversion application_version: 51.0a1 14:21:48 INFO - mozversion platform_buildid: 20160803113011 14:21:48 INFO - mozversion platform_changeset: 41072825cb0d9bb0914bd211c54bd6dc51a917fb 14:21:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:21:48 INFO - mozversion platform_version: 51.0a1 14:21:48 INFO - using testdate: 1470259308 14:21:48 INFO - actual date: 1470259308 14:21:48 INFO - starting webserver on 'localhost:42885' 14:21:48 INFO - SUITE-START | Running 2 tests 14:21:48 INFO - TEST-START | dromaeo_css 14:21:48 INFO - operating with platform_type : linux_ 14:21:48 INFO - Initialising browser for dromaeo_css test... 14:21:48 INFO - TEST-INFO | started process 32445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRL6tdG/profile http://localhost:42885/getInfo.html) 14:21:52 INFO - PROCESS | 32445 | __metrics Screen width/height:1600/1200 14:21:52 INFO - PROCESS | 32445 | colorDepth:24 14:21:52 INFO - PROCESS | 32445 | Browser inner width/height: 1024/697 14:21:52 INFO - PROCESS | 32445 | __metrics 14:21:53 INFO - PROCESS | 32445 | 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" 14:21:53 INFO - PROCESS | 32445 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:54 INFO - TEST-INFO | 32445: exit 0 14:21:54 INFO - Browser initialized. 14:21:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:21:54 INFO - TEST-INFO | started process 32523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRL6tdG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:06 INFO - PROCESS | 32523 | RSS: Main: 156434432 14:22:06 INFO - PROCESS | 32523 | 14:22:57 INFO - PROCESS | 32523 | 1470259377855 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] 14:25:07 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42885/tests/dromaeo/cssquery-ext.html) 14:25:08 INFO - PROCESS | 32523 | RSS: Main: 257830912 14:25:08 INFO - PROCESS | 32523 | 14:28:10 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-ext.html (next: http://localhost:42885/tests/dromaeo/cssquery-jquery.html) 14:28:11 INFO - PROCESS | 32523 | RSS: Main: 242937856 14:28:11 INFO - PROCESS | 32523 | 14:31:13 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42885/tests/dromaeo/cssquery-mootools.html) 14:31:13 INFO - PROCESS | 32523 | RSS: Main: 241442816 14:31:13 INFO - PROCESS | 32523 | 14:34:15 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42885/tests/dromaeo/cssquery-prototype.html) 14:34:16 INFO - PROCESS | 32523 | RSS: Main: 228118528 14:34:16 INFO - PROCESS | 32523 | 14:37:18 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42885/tests/dromaeo/cssquery-yui.html) 14:37:19 INFO - PROCESS | 32523 | RSS: Main: 190050304 14:37:19 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | Cycle 1(1): loaded http://localhost:42885/tests/dromaeo/cssquery-yui.html (next: http://localhost:42885/tests/dromaeo/cssquery-dojo.html) 14:40:22 INFO - PROCESS | 32523 | RSS: Main: 275279872 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | __start_tp_report 14:40:22 INFO - PROCESS | 32523 | _x_x_mozilla_page_load 14:40:22 INFO - PROCESS | 32523 | _x_x_mozilla_page_load_details 14:40:22 INFO - PROCESS | 32523 | |i|pagename|runs| 14:40:22 INFO - PROCESS | 32523 | |0;dojo.html;3029.0609910927615;3037.7417919476843;3068.631764188298;3070.646875609305;3079.030105516762;5251.186066159742;5306.124489459245;5334.679919204846;5440.102383106788;5472.917906231405;5317.893642127165;5378.435264297251;5381.0852155133625;5399.082156033474;5412.107002344608;4821.349117869096;4894.706317620937;4897.730624815634;4910.950890491085;5074.771635276422;5005.324281222025;5031.84904452867;5036.219385995177;5050.646454748169;5054.974725126388;4826.107170173529;4835.226363781796;4882.536159064884;4889.926651100236;4931.211006239003;4873.707577545359;4888.631183268655;4894.290327902434;4947.579455746266;4999.32509111269;4906.901861962777;4932.630052746023;4938.728369939652;4948.035133149037;4977.626677999165;5249.42256351801;5302.469753024705;5357.732113394353;5373.704446255454;5431.185322201702;5745.683987380692;5811.738471768738;5820.912686309709;5822.039363505017;5826.096954971986;5556.111022236463;5839.299284085894;5856.882862342772;5859.736311865976;5867.530597552186;5326.174442961347;5378.892422151535;5381.219723140122;5437.429069947678;5443.101888188484;5954.49386802118;5955.880882382415;5960.0761881908375;5965.970170149121;5966.433188847052;5679.8864022720145;5714.7428365723645;5734.283214598176;5736.110902810071;5736.827895163152;5658.943410565842;5676.772929082873;5681.289838770153;5693.658380497183;5767.394423585463;5656.632318899258;5695.914561281584;5697.4302569742695;5703.914441283384;5706.457886500776;5656.830295091154;5700.714964251771;5709.22925405065;5710.971445142748;5711.942880571224;4255.3829694694095;4270.145970805851;4272.572742725764;4314.201872653569;4320.740755554677;3797.430385442206;3887.941680874789;3913.4325522799036;3920.17676287977;3946.9802650987135;5432.130859062531;5438.293021907127;5440.265564148868;5441.047816632074;5491.560675146058;5651.632643878134;5775.88448231033;5779.566532510079;5785.537157027427;5790.855228619318;5373.38206106295;5401.405845357008;5420.051490989061;5453.945460545344;5477.67133971963;4928.852134435972;4969.676970996874;4975.179095449283;4977.975110124498;5010.649254552146;5803.680797556175;5966.85082872923;6019.398060194033;6026.9095963560585;6030.155778191057;5676.631018983918;5704.286964129484;5722.656640601577;5758.395368486249;5810.360860305447;5959.28488581373;5968.074948383008;5974.581779275409;5975.223220981418;5979.312379076462;5565.916511252415;5645.012122878397;5658.943410566007;5660;5662.490375866192;5732.3121225453215;5743.253377060955;5751.079827227623;5841.299044114733;5891.882162356815;5640.88718225625;5672.744726487235;5679.971600141973;5686.57350698691;5691.743871525874;5408.188771684278;5690.487856092972;5697.487226149667;5698.914516282342;5704.600677952503;5473.507384335429;5478.506934375925;5488.423715509974;5554.75003624846;5616.241807355955;5636.4927156556105;5637.577181711306;5675.091985282335;5688.232088667977;5705.4579814917515;5378.2739330189925;5418.593605479684;5459.890802184013;5504;5543.473370029841 14:40:22 INFO - PROCESS | 32523 | |1;ext.html;595.5057302438976;613.6440864298706;627.9089532017855;642.5694784494389;644.6712176789837;32318.19204519888;33008.504872426936;42748.78625606868;43545;43879;42507.36238956411;46299.30551041729;46421.30368044482;46430;46611.30083048748;8989.550522473883;9126.58930348136;9138.314626403013;9138.817223655524;9148.634054637807;9010.098990101003;9084.182423581877;9100.453972761623;9103.681371152012;9106.089391060874;9123.270138388913;9128.634854605842;9129.68046118386;9161.816763664723;9162.587683554257;9071.047540008303;9095.31785116119;9110.86333704995;9112.544372781367;9113.95443022784;9015.188633023059;9070.954645226797;9082.364234503588;9082.636694532212;9084.8637270441;42711;43105.35341969873;43115.7844210777;43123;43143.13713725739;3165.7150856422804;3362.69735723786;3378.2905589826164;3501.7548771586;3765.8681946131755;33081.17297067568;33085.17287067843;33226.3354732904;33342.83328583366;33702.6629733702;4406.911861762779;4542.5684559967085;4543.977280113611;4559.544045595414;4594.655400844917;266959;267111;267483;268385;269318.999999998;54108.188377174374;54127;54173.72913135409;54228;54314;37804.43293350602;38376;38654.226915461535;40608.59391406048;63790.68104659447;16662;16759.748603770953;16769;16772.496825095266;16790.160491975596;13456.05807593459;13590.59228223155;13593.388297526635;13597.796033059512;13613.727725445435;19930.60138797245;20316.59366812685;20324.49188770263;20332.491687707927;20456.69314960277;7134.255719946178;7350.669219885118;7373.437640499959;7492.737754178577;7513.361364283987;993.6571882700457;1033.7105610429091;1037.7716902281486;1068.6847380022912;1120.618989543559;33224.16939576482;33648.83175584155;33878.66121338755;33907.83046084803;34009.48985765215;1104.5029736618553;1129.4239937631703;1137.6814491942268;1140.9885901140883;1164.8252762085756;17751.289948401918;17776.9111154446;17781.911090444464;17858.821411785975;18109.547261318574;538718;543874;545035;547589;548158;61513.69243153845;62254.37745622576;62295.06557401643;62344.37655623386;62442;1225.4485481533345;1351.2703140304322;1383.5710929611853;1385.1827421820972;1385.7020740540631;32476;35036.824815875756;35061.29877402489;35474.60012288673;35872;51566.48433515767;57091.71454142703;59450.405495944484;59563.702181490546;64326.35673643203;518511;525312;525480;525667;526208;36734.265314693024;43229.56770432381;43704.56295437005;46444.53555464402;46561;48688.26967595418;48902;48959.26561101658;49029.75485122694;49055;40779;41112;41165.382519262836;42298.78850605727;42314.788426057676;42158;42498.575014249465;42567;43376.56623433725;43760.78119609381;42082.579174207865;42204.78897605615;43525.3471197926;43924.780376097915;43955.34066988934;35005.47491787574;37668;37727.62272377351;38486.42270365891;38737.61262387453;29155.7084429153;29187.270318242216;29247.268818279714;29480.852595736884;29603.407931841673 14:40:22 INFO - PROCESS | 32523 | |2;jquery.html;394.27059939112627;398.46804515971183;399.5564922935543;403.2881963334715;419.0278553755289;13267.93366033171;18708.53228669282;20045.097970591323;20265.290714824965;20339.694904576445;19486.512837179078;19821.702674459895;19986.50033749157;20131;20209.595808083828;5804.912926306109;5830.57150998004;5970.044792833148;6008.789692360769;6015.909761353583;4283.271843786548;5628.774849006035;5939.376365481627;5946.345901950782;5948.286205655328;6400.551961362707;6639.867202655944;6693.866122677544;6750.797476075701;6766.492513061516;6537.5423720339595;6610.7025183866845;6644.4020038196795;6676.24263099621;6755.392014718675;5820.563457740686;5827.562932780016;5829.067349224104;5832.212651292064;5838.970805145989;14195.148291102567;15507.147106909115;22307;23023.424414389774;23047.427648714474;2229.297771202066;2253.8084262837515;2295.1507942061376;2805.2566069991467;3105.7204851563242;9866.90133098667;10175.59297628094;10600.628977985734;10699.83950240747;10731.570737170503;1917.4822797844504;1997.2011195521761;2022.7572691276994;2028.614563232981;2033.044469099521;71505.28494715039;76714;80146;83798.58100709518;84554.57722711409;10814.513346899408;10873.945630271797;11095.889041109647;11177.385243811506;11242.325460472397;15545.22273886301;15585.454509092127;15595.454159104376;15597.766033509506;15602.765958510632;8051.275385215359;8217.465864718893;8262.17378262181;8334.458260213189;8433.19884610961;8078.192180781993;8082.474639148437;8113.823495593106;8276.172382761795;8281.54451505173;4695.765211739399;4765.9761701191965;4767.356406885096;4911.115999120193;4915.557599816034;1905.5902980859182;1975.2888959974398;1988.5525756704626;1991.6912878503856;2014.7783743788173;880.225401646547;959.4770849886828;969.2294625772528;983.9655612053543;997.2221667099674;17559.239003783023;19913;20293.49266268355;20397.898010509853;20570.177192912415;970.2141265574907;989.2531138990016;990.821652102614;1045.2265323660436;1046.4819914142547;10694.893051069545;11283.66149015531;11355.54577816878;11363;11366;480375;484414.88962776214;485439;485733;488039;85867.57066214629;86828;87894.56052719695;87994.56002719945;89811.55094224487;985.1133979418437;991.0981007283337;1015.5227043289642;1018.4245901065874;1019.97450063749;17352.739708904122;17807.821921780618;18222;18247.361342352953;18405;42306.57693423027;42528.57471425246;42667;42933.35599966066;43774.56225437705;54228.72885635547;55817.44182558285;58319.70840145772;60027.69986150041;65962;8379.622916968872;8402.453840500348;8431.451955622864;8569.914300856912;8966.68616598442;12453.564125255572;13116.409761560562;13440.93279533596;13520.526781562598;13965.441382344592;11339.09287257034;11605.709857253636;11652.184347095961;11833.704157396134;11846.229995050295;11041.39272340029;11310.20828542027;11519.02088322502;11549.6535103947;12080.879191207976;11388.316700997966;11836;11895.583654572049;12068.939655301667;12213.976963245992;8497.83004339922;8747.737567872973;8762.605682744419;8837.381383303364;8973.461592304482;10757.515911783832;11822.586209482626;12013.699657508632;12121.424179867137;12240.571579994657 14:40:22 INFO - PROCESS | 32523 | |3;mootools.html;1341.1952828303026;1487.4719474586525;1546.2577962577964;1667.7915260592426;1828.8811227270235;8308.459950103239;8615.956920215398;8729.34529910257;8958.686445974392;8977.326700497457;8807.383483156182;8902.376833621633;8929.73210803677;8941.23999460045;8947.150020748019;2380.809535237177;2411.602085655865;2417.9637305440347;2422.648715936188;2427.745086765891;2371.845830021052;2390.772876576731;2418.0327868852423;2420.6006009008493;2422.1522467136538;2397.160993652225;2399.3401814500976;2411.131992482705;2435;2435.07467162478;2331.6735657008035;2357.8113750899975;2360.3509035015422;2363.4327761337327;2364.302530753423;2301.5166814968875;2320.048780000209;2323.0707716913203;2324.047140672333;2326.1509549014486;8714.389992700513;8765.254953328975;8815.735527934172;8832.205101540829;8883.822323553557;5374.7043912584795;5458.1266997280645;5510.6969116698565;5511.972440137773;5519.972400137974;3557.48416479609;3572.1962558424148;3619.94570081449;3646.3254297954963;3657.561092668897;1186.6736647422028;1212.6543934978488;1217.2513903949095;1232.8458942632171;1285.543632010632;12476.625701228977;12509.624711258677;12593.433295501725;12635.49458021678;12653.177543459738;4408.955910440919;4643.976780116078;4720.834770783006;4750.406199225097;4756.143894099096;9904.801903961881;9922.702318930444;9923.305368624127;9931.453770042717;9940.950295248478;5374.27447294618;5384.623076384615;5386.569074474032;5388.703621300866;5405.621606487508;4382.364557139261;4777.498362671939;4992.700437973661;5028.949710502849;5032.547070763649;4098.549159592442;4154.626083652486;4238.825254056191;4255.851045213402;4289.635380992589;1330.0423694939627;1372.6842826150041;1376.9586912392645;1378.076688618628;1393.1432169216062;811.8660421030582;971.2618410008304;992.513668302541;1002.9097381235724;1033.8552602635637;5897.292324920951;5933.673647949404;5951.345352011275;6047;6116.938830611726;468.615735097217;470.83050101963266;475.34165181224256;479.714569830957;482.1947347928967;4187.958120418818;4277.828886844553;4298.914021719548;4317.633001194934;4338.219120558267;11022.118230541697;11494.770104598028;11510;11512.654620361403;11519.136064795173;10608.363498190134;11092.611758588571;11341.943290283662;11360;11392.658220253406;8288.958555207186;8444.57777111142;8532.445391049561;8533.786655333666;8539.146085391536;5874.441928016831;5889.263842019747;6016.849578760566;6022;6288.685565721604;10076.899231007596;10341.276110672181;10399.272050956662;10441.947790261303;10480.371177729361;10421.895781042396;10579.5239214234;10626.89373106259;10684.519196636325;10738.14094872424;7591.962040189985;7746.264104910025;7802.882956755767;7808;7924.286814186751;8814.515201663713;8853.822923541622;8872.73381798547;8879.11208879107;8888.200061994452;7884.487508311941;7989.121196668246;7990.800229994296;8114.0741620637;8263.256306932404;7693.307602315818;7694.269044440769;7802.804929876798;7818.804529886798;7881.5665138417935;6748.493862960199;6824.522283440111;6871.106756121672;6902.378785909293;6903.620300883299;4988.700677959334;5024.371953505812;5134.204198349262;5250.553702935294;5556.722163891708;5361.195820626937;5407.78368865241;5420.620556561003;5453.072977593898;5497.47773961473 14:40:22 INFO - PROCESS | 32523 | |4;prototype.html;323.9433099207638;337.6151187646083;340.7887109991805;342.09345235126926;342.10710046777905;4985.426675932269;5074.771635276412;5133.460986596409;5218.512723873697;5261.842144735654;5072.619553533481;5085.160948443511;5095.719735414551;5115.514026167518;5160.535551800337;4128.525219599747;4136.751794892301;4143.917121657565;4144.585541445861;4193.517745459266;3942.605739426049;4085.836566537335;4155.979220103895;4157.189348077126;4181.205570941526;4060.1473690525027;4062.6343629073376;4062.73592216505;4066.2477441673236;4077.2049450357194;4055.614716601918;4066.6136717011836;4087.305158123126;4092.058826469899;4092.9590704093175;3630;3634.509341238925;3635.054885729703;3643.417053271464;3656.579493358271;4996.50104968508;5041.9747901260625;5047.369078865142;5052.646314757969;5058.848234552969;4618.8152473901;4630.7453090080035;4635;4636.327732478805;4637.466691330506;5379.946200537984;5382.327209098863;5383.273258110184;5386.946130538684;5403.729813509348;3757.3236817372863;3886.7473614214987;3890.630390112935;3904.570497245301;3916.138449541125;5582.385937546866;5599.972000139973;5606.887862242773;5626.831195064155;5636.633618814764;4001.3997900315185;4008.2584721826556;4021.678265738734;4025.1547175092974;4034.495688038995;3977.960220397759;4028.529586700833;4048.230836141183;4068.816903239361;4075.673946084306;4600.263957766741;4628.490866004737;4632.2125238709505;4664.953350466452;4665.813367465331;5443.815368009679;5458.426865179178;5464.644798088111;5519.448055194448;5520.806771762969;1329.3884812986134;1359.5581436033328;1365.688938618917;1389.3400634698437;1391.2278685329738;916.5371487398954;938.6339327662081;944.3955868244192;947.980920510454;948.0045951750634;5138.3833939927445;5143.765496280866;5182.844514664566;5195.740212989335;5199.818006369835;5392.40683524812;5402.972985135049;5410.702411367412;5435.537979271727;5441.782328706887;4894.437139728905;5076.18780995039;5102.744862756847;5150.742462876841;5170.457102004236;2558.2453176313034;2563.2950938492063;2565.320190149612;2576.6263891735593;2588.404666926617;5018.372703412074;5027.824026159067;5057;5068.518490743373;5070.518300761421;4711.293306004127;4902.803887844518;4958.504149585085;4959.528844759742;4970.602351811846;5006.696919417109;5013.994402239134;5038.722870242099;5048.823291184791;5077.365329333833;4832.371791667061;4835.419749629927;4842.709437433765;4859;4890.070886531547;4503.459584849839;4794.489735733233;4804.6876952997945;4829.106615276185;4836.758162091952;5043.5460808527405;5052.393712754493;5052.469490703424;5070.467600901852;5114.974425127851;3579.7673151245085;3590.7127429806073;3595.9101022474647;3618.7285953553064;3644.2689722381656;4543.909121817479;4784.760761961818;4924.852254432372;4942.4316203637045;4987.3017777511905;4708;4722.338872557776;4735.83424580138;4738.905221895474;4759.119562880878;4694.192735796674;4746.050789841976;4768.356271903387;4863.805447782049;4869.513048695244;4535.79588918506;4678.76606169697;4681.859544213679;4695.483496815279;4707.340972263954;4751.809927602857;4756.571908528249;4756.619470442425;4766.428028636586;4780.95219047819;4642.628589712883;4712.670113092051;4714.316424118552;4719.646026548091;4744.288356746378 14:40:22 INFO - PROCESS | 32523 | |5;yui.html;770.8419773946341;781.1914668318288;782.5422128055087;783.5024759277857;896.480041575886;15250.237488125606;16258.674826503478;16269.186540672978;17380;17395.391161309355;16787.580310492212;16875.493735187934;17059.658806823856;17062.14689265538;17084.487465376027;685.1880521581942;802.7350974178507;821.0680877204371;838.2413915406536;839.5340585974812;842.9662813487453;849.5370023337265;852.7058164933088;852.8507511185549;852.9872051919226;882.6954700628305;887.4497811356968;889.8264838356523;889.8798662180587;890.2255038116847;695.1172011545309;708.5996412027188;883.659790980474;884.2439714044496;884.8761173435724;525.8396189162304;612.3050337866554;630.9242890853081;634.2294112653149;636.3572791480592;15326.080435173813;15337.769933451007;15365.308561114776;15374.308156132889;15389.923050384788;14074;14401.279936003262;14585.343659535347;14665.780013299809;15027.173505457196;12370.62888113358;12459.688507787287;12548.498060077585;12561.937190314082;12668.746625067539;4228.746275223496;4266.253405654029;4294.634956028742;4450.888727781799;4462.062966776981;66692.99960500597;70124.64937675279;86376.56811715964;86798;86875;10978.505967231495;11169.83245251322;11467.254628449124;11538.423078846192;11582.47878845454;21665.67501487479;21710.674339884914;21989.23037693673;22262.888685556467;22383.664245036336;8364.079951205362;8368.20502052304;8493.745187644381;8523.48859068458;9157.725268241964;4665.720056796536;4768.499307572724;4785.928211076836;4896.534829191221;4898.975505122452;3638.636136386393;3791.6208379161862;3798.3922572388287;3812;3820.6179382061573;620.6617393520543;621.3941407128104;631.6147150238351;632.3486808587163;649.8505343770959;693.2616763147232;714.9714011439588;715.9391451726557;731.5939653492256;735.8675438421028;9663.46850923206;9750.219982401391;10312.896871031344;10605.787884242272;10615.628453004108;543.7335705504274;684.2029036172902;694.2918223412091;728.4964861922181;748.7491690283816;4809.350737650372;4869.9269510957365;4885.364902562644;4946.604271658259;4957.553820156203;71063.2893671067;92522;96193.51903240579;96846;132221;111676;111846;113755.03714740054;115764.42355764356;116915;92023;96923.51538242404;96930.51534742423;96936.51531742296;98983.50508247556;9173.266138708754;9223.723288301362;9404.623815047322;9445.952770236105;9553.140217380469;55148.17277740757;56294;56303.71848140733;56767.432325677866;58467;62235.6888215556;76427.61786191033;82598;83237;83599.5820020896;13223.933880330536;13246.20522768637;13800.378982945993;13862.514811981533;13879.930600346934;15344.232788360761;15368.846311536741;15548.844511555191;16619.750703739697;16769.07770072658;14667.119972801665;14701.41194352214;14711.632209194428;15626.218689065274;15838.68322633564;13769.793453098411;14262.572122835916;14466.05970611907;14498.782518262024;14593.708125837637;13751.174929504261;13815.79276310836;14354.425822966965;14762.704745905237;15147.772783408038;11320.547178112784;11965;12255.509779608716;12388.161735719825;12666;12571.18287311322;13115.868841311465;13154.671133221364;13273.269970151348;13323.13399629021 14:40:22 INFO - PROCESS | 32523 | __end_tp_report 14:40:22 INFO - PROCESS | 32523 | __start_cc_report 14:40:22 INFO - PROCESS | 32523 | _x_x_mozilla_cycle_collect,981 14:40:22 INFO - PROCESS | 32523 | __end_cc_report 14:40:22 INFO - PROCESS | 32523 | __startTimestamp1470260422432__endTimestamp 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | ------- Summary: start ------- 14:40:22 INFO - PROCESS | 32523 | Number of tests: 6 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#0] dojo.html Cycles:165 Average:5346.80 Median:5504.00 stddev:619.56 (11.3%) stddev-sans-first:594.18 14:40:22 INFO - PROCESS | 32523 | Values: 3029.1 3037.7 3068.6 3070.6 3079.0 5251.2 5306.1 5334.7 5440.1 5472.9 5317.9 5378.4 5381.1 5399.1 5412.1 4821.3 4894.7 4897.7 4911.0 5074.8 5005.3 5031.8 5036.2 5050.6 5055.0 4826.1 4835.2 4882.5 4889.9 4931.2 4873.7 4888.6 4894.3 4947.6 4999.3 4906.9 4932.6 4938.7 4948.0 4977.6 5249.4 5302.5 5357.7 5373.7 5431.2 5745.7 5811.7 5820.9 5822.0 5826.1 5556.1 5839.3 5856.9 5859.7 5867.5 5326.2 5378.9 5381.2 5437.4 5443.1 5954.5 5955.9 5960.1 5966.0 5966.4 5679.9 5714.7 5734.3 5736.1 5736.8 5658.9 5676.8 5681.3 5693.7 5767.4 5656.6 5695.9 5697.4 5703.9 5706.5 5656.8 5700.7 5709.2 5711.0 5711.9 4255.4 4270.1 4272.6 4314.2 4320.7 3797.4 3887.9 3913.4 3920.2 3947.0 5432.1 5438.3 5440.3 5441.0 5491.6 5651.6 5775.9 5779.6 5785.5 5790.9 5373.4 5401.4 5420.1 5453.9 5477.7 4928.9 4969.7 4975.2 4978.0 5010.6 5803.7 5966.9 6019.4 6026.9 6030.2 5676.6 5704.3 5722.7 5758.4 5810.4 5959.3 5968.1 5974.6 5975.2 5979.3 5565.9 5645.0 5658.9 5660.0 5662.5 5732.3 5743.3 5751.1 5841.3 5891.9 5640.9 5672.7 5680.0 5686.6 5691.7 5408.2 5690.5 5697.5 5698.9 5704.6 5473.5 5478.5 5488.4 5554.8 5616.2 5636.5 5637.6 5675.1 5688.2 5705.5 5378.3 5418.6 5459.9 5504.0 5543.5 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#1] ext.html Cycles:180 Average:61252.10 Median:43119.39 stddev:123165.76 (285.6%) stddev-sans-first:123427.08 14:40:22 INFO - PROCESS | 32523 | Values: 595.5 613.6 627.9 642.6 644.7 32318.2 33008.5 42748.8 43545.0 43879.0 42507.4 46299.3 46421.3 46430.0 46611.3 8989.6 9126.6 9138.3 9138.8 9148.6 9010.1 9084.2 9100.5 9103.7 9106.1 9123.3 9128.6 9129.7 9161.8 9162.6 9071.0 9095.3 9110.9 9112.5 9114.0 9015.2 9071.0 9082.4 9082.6 9084.9 42711.0 43105.4 43115.8 43123.0 43143.1 3165.7 3362.7 3378.3 3501.8 3765.9 33081.2 33085.2 33226.3 33342.8 33702.7 4406.9 4542.6 4544.0 4559.5 4594.7 266959.0 267111.0 267483.0 268385.0 269319.0 54108.2 54127.0 54173.7 54228.0 54314.0 37804.4 38376.0 38654.2 40608.6 63790.7 16662.0 16759.7 16769.0 16772.5 16790.2 13456.1 13590.6 13593.4 13597.8 13613.7 19930.6 20316.6 20324.5 20332.5 20456.7 7134.3 7350.7 7373.4 7492.7 7513.4 993.7 1033.7 1037.8 1068.7 1120.6 33224.2 33648.8 33878.7 33907.8 34009.5 1104.5 1129.4 1137.7 1141.0 1164.8 17751.3 17776.9 17781.9 17858.8 18109.5 538718.0 543874.0 545035.0 547589.0 548158.0 61513.7 62254.4 62295.1 62344.4 62442.0 1225.4 1351.3 1383.6 1385.2 1385.7 32476.0 35036.8 35061.3 35474.6 35872.0 51566.5 57091.7 59450.4 59563.7 64326.4 518511.0 525312.0 525480.0 525667.0 526208.0 36734.3 43229.6 43704.6 46444.5 46561.0 48688.3 48902.0 48959.3 49029.8 49055.0 40779.0 41112.0 41165.4 42298.8 42314.8 42158.0 42498.6 42567.0 43376.6 43760.8 42082.6 42204.8 43525.3 43924.8 43955.3 35005.5 37668.0 37727.6 38486.4 38737.6 29155.7 29187.3 29247.3 29480.9 29603.4 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#2] jquery.html Cycles:180 Average:28799.40 Median:399.01 stddev:79840.60 (20009.6%) stddev-sans-first:80036.08 14:40:22 INFO - PROCESS | 32523 | Values: 394.3 398.5 399.6 403.3 419.0 13267.9 18708.5 20045.1 20265.3 20339.7 19486.5 19821.7 19986.5 20131.0 20209.6 5804.9 5830.6 5970.0 6008.8 6015.9 4283.3 5628.8 5939.4 5946.3 5948.3 6400.6 6639.9 6693.9 6750.8 6766.5 6537.5 6610.7 6644.4 6676.2 6755.4 5820.6 5827.6 5829.1 5832.2 5839.0 14195.1 15507.1 22307.0 23023.4 23047.4 2229.3 2253.8 2295.2 2805.3 3105.7 9866.9 10175.6 10600.6 10699.8 10731.6 1917.5 1997.2 2022.8 2028.6 2033.0 71505.3 76714.0 80146.0 83798.6 84554.6 10814.5 10873.9 11095.9 11177.4 11242.3 15545.2 15585.5 15595.5 15597.8 15602.8 8051.3 8217.5 8262.2 8334.5 8433.2 8078.2 8082.5 8113.8 8276.2 8281.5 4695.8 4766.0 4767.4 4911.1 4915.6 1905.6 1975.3 1988.6 1991.7 2014.8 880.2 959.5 969.2 984.0 997.2 17559.2 19913.0 20293.5 20397.9 20570.2 970.2 989.3 990.8 1045.2 1046.5 10694.9 11283.7 11355.5 11363.0 11366.0 480375.0 484414.9 485439.0 485733.0 488039.0 85867.6 86828.0 87894.6 87994.6 89811.6 985.1 991.1 1015.5 1018.4 1020.0 17352.7 17807.8 18222.0 18247.4 18405.0 42306.6 42528.6 42667.0 42933.4 43774.6 54228.7 55817.4 58319.7 60027.7 65962.0 8379.6 8402.5 8431.5 8569.9 8966.7 12453.6 13116.4 13440.9 13520.5 13965.4 11339.1 11605.7 11652.2 11833.7 11846.2 11041.4 11310.2 11519.0 11549.7 12080.9 11388.3 11836.0 11895.6 12068.9 12214.0 8497.8 8747.7 8762.6 8837.4 8973.5 10757.5 11822.6 12013.7 12121.4 12240.6 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#3] mootools.html Cycles:180 Average:5912.24 Median:4766.82 stddev:3367.16 (70.6%) stddev-sans-first:3359.08 14:40:22 INFO - PROCESS | 32523 | Values: 1341.2 1487.5 1546.3 1667.8 1828.9 8308.5 8616.0 8729.3 8958.7 8977.3 8807.4 8902.4 8929.7 8941.2 8947.2 2380.8 2411.6 2418.0 2422.6 2427.7 2371.8 2390.8 2418.0 2420.6 2422.2 2397.2 2399.3 2411.1 2435.0 2435.1 2331.7 2357.8 2360.4 2363.4 2364.3 2301.5 2320.0 2323.1 2324.0 2326.2 8714.4 8765.3 8815.7 8832.2 8883.8 5374.7 5458.1 5510.7 5512.0 5520.0 3557.5 3572.2 3619.9 3646.3 3657.6 1186.7 1212.7 1217.3 1232.8 1285.5 12476.6 12509.6 12593.4 12635.5 12653.2 4409.0 4644.0 4720.8 4750.4 4756.1 9904.8 9922.7 9923.3 9931.5 9941.0 5374.3 5384.6 5386.6 5388.7 5405.6 4382.4 4777.5 4992.7 5028.9 5032.5 4098.5 4154.6 4238.8 4255.9 4289.6 1330.0 1372.7 1377.0 1378.1 1393.1 811.9 971.3 992.5 1002.9 1033.9 5897.3 5933.7 5951.3 6047.0 6116.9 468.6 470.8 475.3 479.7 482.2 4188.0 4277.8 4298.9 4317.6 4338.2 11022.1 11494.8 11510.0 11512.7 11519.1 10608.4 11092.6 11341.9 11360.0 11392.7 8289.0 8444.6 8532.4 8533.8 8539.1 5874.4 5889.3 6016.8 6022.0 6288.7 10076.9 10341.3 10399.3 10441.9 10480.4 10421.9 10579.5 10626.9 10684.5 10738.1 7592.0 7746.3 7802.9 7808.0 7924.3 8814.5 8853.8 8872.7 8879.1 8888.2 7884.5 7989.1 7990.8 8114.1 8263.3 7693.3 7694.3 7802.8 7818.8 7881.6 6748.5 6824.5 6871.1 6902.4 6903.6 4988.7 5024.4 5134.2 5250.6 5556.7 5361.2 5407.8 5420.6 5453.1 5497.5 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#4] prototype.html Cycles:180 Average:4323.06 Median:4756.60 stddev:1215.60 (25.6%) stddev-sans-first:1181.37 14:40:22 INFO - PROCESS | 32523 | Values: 323.9 337.6 340.8 342.1 342.1 4985.4 5074.8 5133.5 5218.5 5261.8 5072.6 5085.2 5095.7 5115.5 5160.5 4128.5 4136.8 4143.9 4144.6 4193.5 3942.6 4085.8 4156.0 4157.2 4181.2 4060.1 4062.6 4062.7 4066.2 4077.2 4055.6 4066.6 4087.3 4092.1 4093.0 3630.0 3634.5 3635.1 3643.4 3656.6 4996.5 5042.0 5047.4 5052.6 5058.8 4618.8 4630.7 4635.0 4636.3 4637.5 5379.9 5382.3 5383.3 5386.9 5403.7 3757.3 3886.7 3890.6 3904.6 3916.1 5582.4 5600.0 5606.9 5626.8 5636.6 4001.4 4008.3 4021.7 4025.2 4034.5 3978.0 4028.5 4048.2 4068.8 4075.7 4600.3 4628.5 4632.2 4665.0 4665.8 5443.8 5458.4 5464.6 5519.4 5520.8 1329.4 1359.6 1365.7 1389.3 1391.2 916.5 938.6 944.4 948.0 948.0 5138.4 5143.8 5182.8 5195.7 5199.8 5392.4 5403.0 5410.7 5435.5 5441.8 4894.4 5076.2 5102.7 5150.7 5170.5 2558.2 2563.3 2565.3 2576.6 2588.4 5018.4 5027.8 5057.0 5068.5 5070.5 4711.3 4902.8 4958.5 4959.5 4970.6 5006.7 5014.0 5038.7 5048.8 5077.4 4832.4 4835.4 4842.7 4859.0 4890.1 4503.5 4794.5 4804.7 4829.1 4836.8 5043.5 5052.4 5052.5 5070.5 5115.0 3579.8 3590.7 3595.9 3618.7 3644.3 4543.9 4784.8 4924.9 4942.4 4987.3 4708.0 4722.3 4735.8 4738.9 4759.1 4694.2 4746.1 4768.4 4863.8 4869.5 4535.8 4678.8 4681.9 4695.5 4707.3 4751.8 4756.6 4756.6 4766.4 4781.0 4642.6 4712.7 4714.3 4719.6 4744.3 14:40:22 INFO - PROCESS | 32523 | 14:40:22 INFO - PROCESS | 32523 | [#5] yui.html Cycles:180 Average:21728.76 Median:4777.21 stddev:31016.79 (649.3%) stddev-sans-first:31063.88 14:40:22 INFO - PROCESS | 32523 | Values: 770.8 781.2 782.5 783.5 896.5 15250.2 16258.7 16269.2 17380.0 17395.4 16787.6 16875.5 17059.7 17062.1 17084.5 685.2 802.7 821.1 838.2 839.5 843.0 849.5 852.7 852.9 853.0 882.7 887.4 889.8 889.9 890.2 695.1 708.6 883.7 884.2 884.9 525.8 612.3 630.9 634.2 636.4 15326.1 15337.8 15365.3 15374.3 15389.9 14074.0 14401.3 14585.3 14665.8 15027.2 12370.6 12459.7 12548.5 12561.9 12668.7 4228.7 4266.3 4294.6 4450.9 4462.1 66693.0 70124.6 86376.6 86798.0 86875.0 10978.5 11169.8 11467.3 11538.4 11582.5 21665.7 21710.7 21989.2 22262.9 22383.7 8364.1 8368.2 8493.7 8523.5 9157.7 4665.7 4768.5 4785.9 4896.5 4899.0 3638.6 3791.6 3798.4 3812.0 3820.6 620.7 621.4 631.6 632.3 649.9 693.3 715.0 715.9 731.6 735.9 9663.5 9750.2 10312.9 10605.8 10615.6 543.7 684.2 694.3 728.5 748.7 4809.4 4869.9 4885.4 4946.6 4957.6 71063.3 92522.0 96193.5 96846.0 132221.0 111676.0 111846.0 113755.0 115764.4 116915.0 92023.0 96923.5 96930.5 96936.5 98983.5 9173.3 9223.7 9404.6 9446.0 9553.1 55148.2 56294.0 56303.7 56767.4 58467.0 62235.7 76427.6 82598.0 83237.0 83599.6 13223.9 13246.2 13800.4 13862.5 13879.9 15344.2 15368.8 15548.8 16619.8 16769.1 14667.1 14701.4 14711.6 15626.2 15838.7 13769.8 14262.6 14466.1 14498.8 14593.7 13751.2 13815.8 14354.4 14762.7 15147.8 11320.5 11965.0 12255.5 12388.2 12666.0 12571.2 13115.9 13154.7 13273.3 13323.1 14:40:22 INFO - PROCESS | 32523 | -------- Summary: end -------- 14:40:22 INFO - PROCESS | 32523 | 14:40:23 INFO - TEST-INFO | 32523: exit 0 14:40:23 INFO - TEST-OK | dromaeo_css | took 1114515ms 14:40:23 INFO - TEST-START | kraken 14:40:23 INFO - operating with platform_type : linux_ 14:40:23 INFO - Initialising browser for kraken test... 14:40:23 INFO - TEST-INFO | started process 32717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YFXid/profile http://localhost:42885/getInfo.html) 14:40:27 INFO - PROCESS | 32717 | __metrics Screen width/height:1600/1200 14:40:27 INFO - PROCESS | 32717 | colorDepth:24 14:40:27 INFO - PROCESS | 32717 | Browser inner width/height: 1024/697 14:40:27 INFO - PROCESS | 32717 | __metrics 14:40:28 INFO - PROCESS | 32717 | 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" 14:40:28 INFO - PROCESS | 32717 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:29 INFO - TEST-INFO | 32717: exit 0 14:40:29 INFO - Browser initialized. 14:40:29 INFO - Running cycle 1/1 for kraken test... 14:40:29 INFO - TEST-INFO | started process 326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YFXid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:40 INFO - PROCESS | 326 | RSS: Main: 155910144 14:40:40 INFO - PROCESS | 326 | 14:40:43 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42885/tests/kraken/driver.html?testName=audio-beat-detection) 14:40:44 INFO - PROCESS | 326 | RSS: Main: 212963328 14:40:44 INFO - PROCESS | 326 | 14:40:46 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42885/tests/kraken/driver.html?testName=audio-dft) 14:40:47 INFO - PROCESS | 326 | RSS: Main: 191262720 14:40:47 INFO - PROCESS | 326 | 14:40:50 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42885/tests/kraken/driver.html?testName=audio-fft) 14:40:51 INFO - PROCESS | 326 | RSS: Main: 269586432 14:40:51 INFO - PROCESS | 326 | 14:40:53 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42885/tests/kraken/driver.html?testName=audio-oscillator) 14:40:53 INFO - PROCESS | 326 | RSS: Main: 179662848 14:40:53 INFO - PROCESS | 326 | 14:40:56 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:40:56 INFO - PROCESS | 326 | RSS: Main: 183975936 14:40:56 INFO - PROCESS | 326 | 14:40:59 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42885/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:00 INFO - PROCESS | 326 | RSS: Main: 219279360 14:41:00 INFO - PROCESS | 326 | 14:41:03 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42885/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:04 INFO - PROCESS | 326 | RSS: Main: 219295744 14:41:04 INFO - PROCESS | 326 | 14:41:07 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42885/tests/kraken/driver.html?testName=json-parse-financial) 14:41:07 INFO - PROCESS | 326 | RSS: Main: 219443200 14:41:07 INFO - PROCESS | 326 | 14:41:09 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:09 INFO - PROCESS | 326 | RSS: Main: 183701504 14:41:09 INFO - PROCESS | 326 | 14:41:11 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:12 INFO - PROCESS | 326 | RSS: Main: 188141568 14:41:12 INFO - PROCESS | 326 | 14:41:13 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:14 INFO - PROCESS | 326 | RSS: Main: 194338816 14:41:14 INFO - PROCESS | 326 | 14:41:17 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:17 INFO - PROCESS | 326 | RSS: Main: 188227584 14:41:17 INFO - PROCESS | 326 | 14:41:20 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:21 INFO - PROCESS | 326 | RSS: Main: 192999424 14:41:21 INFO - PROCESS | 326 | 14:41:22 INFO - PROCESS | 326 | Cycle 1(1): loaded http://localhost:42885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42885/tests/kraken/driver.html?testName=ai-astar) 14:41:22 INFO - PROCESS | 326 | RSS: Main: 243154944 14:41:22 INFO - PROCESS | 326 | 14:41:22 INFO - PROCESS | 326 | __start_tp_report 14:41:23 INFO - PROCESS | 326 | _x_x_mozilla_page_load 14:41:23 INFO - PROCESS | 326 | _x_x_mozilla_page_load_details 14:41:23 INFO - PROCESS | 326 | |i|pagename|runs| 14:41:23 INFO - PROCESS | 326 | |0;ai-astar;102;113;111;111;113;111;111;111;111;111 14:41:23 INFO - PROCESS | 326 | |1;audio-beat-detection;156;122;119;182;123;125;146;117;147;116 14:41:23 INFO - PROCESS | 326 | |2;audio-dft;161;162;160;163;161;163;158;159;161;161 14:41:23 INFO - PROCESS | 326 | |3;audio-fft;75;77;74;109;84;76;74;75;102;75 14:41:23 INFO - PROCESS | 326 | |4;audio-oscillator;83;85;109;84;84;83;124;83;84;132 14:41:23 INFO - PROCESS | 326 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;116;117 14:41:23 INFO - PROCESS | 326 | |6;imaging-darkroom;145;146;146;146;145;146;147;176;145;146 14:41:23 INFO - PROCESS | 326 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 14:41:23 INFO - PROCESS | 326 | |8;json-parse-financial;50;49;49;48;50;49;50;49;49;49 14:41:23 INFO - PROCESS | 326 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;60;60;61 14:41:23 INFO - PROCESS | 326 | |10;stanford-crypto-aes;74;75;77;76;75;80;76;75;75;75 14:41:23 INFO - PROCESS | 326 | |11;stanford-crypto-ccm;130;121;122;129;121;120;120;131;197;121 14:41:23 INFO - PROCESS | 326 | |12;stanford-crypto-pbkdf2;157;158;160;153;154;155;155;160;157;157 14:41:23 INFO - PROCESS | 326 | |13;stanford-crypto-sha256-iterative;73;63;63;66;63;62;61;61;64;62 14:41:23 INFO - PROCESS | 326 | __end_tp_report 14:41:23 INFO - PROCESS | 326 | __start_cc_report 14:41:23 INFO - PROCESS | 326 | _x_x_mozilla_cycle_collect,1656 14:41:23 INFO - PROCESS | 326 | __end_cc_report 14:41:23 INFO - PROCESS | 326 | __startTimestamp1470260482997__endTimestamp 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | ------- Summary: start ------- 14:41:23 INFO - PROCESS | 326 | Number of tests: 14 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.10 (2.8%) stddev-sans-first:0.88 14:41:23 INFO - PROCESS | 326 | Values: 102.0 113.0 111.0 111.0 113.0 111.0 111.0 111.0 111.0 111.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:135.50 stddev:21.78 (16.1%) stddev-sans-first:21.77 14:41:23 INFO - PROCESS | 326 | Values: 156.0 122.0 119.0 182.0 123.0 125.0 146.0 117.0 147.0 116.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 14:41:23 INFO - PROCESS | 326 | Values: 161.0 162.0 160.0 163.0 161.0 163.0 158.0 159.0 161.0 161.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:12.78 (17.0%) stddev-sans-first:13.29 14:41:23 INFO - PROCESS | 326 | Values: 75.0 77.0 74.0 109.0 84.0 76.0 74.0 75.0 102.0 75.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.50 stddev:19.15 (22.9%) stddev-sans-first:19.81 14:41:23 INFO - PROCESS | 326 | Values: 83.0 85.0 109.0 84.0 84.0 83.0 124.0 83.0 84.0 132.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:41:23 INFO - PROCESS | 326 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:146.00 stddev:9.58 (6.6%) stddev-sans-first:10.06 14:41:23 INFO - PROCESS | 326 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 147.0 176.0 145.0 146.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:41:23 INFO - PROCESS | 326 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.63 (1.3%) stddev-sans-first:0.60 14:41:23 INFO - PROCESS | 326 | Values: 50.0 49.0 49.0 48.0 50.0 49.0 50.0 49.0 49.0 49.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 14:41:23 INFO - PROCESS | 326 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:1.69 (2.2%) stddev-sans-first:1.66 14:41:23 INFO - PROCESS | 326 | Values: 74.0 75.0 77.0 76.0 75.0 80.0 76.0 75.0 75.0 75.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:125.50 stddev:23.53 (18.8%) stddev-sans-first:24.95 14:41:23 INFO - PROCESS | 326 | Values: 130.0 121.0 122.0 129.0 121.0 120.0 120.0 131.0 197.0 121.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:2.37 (1.5%) stddev-sans-first:2.51 14:41:23 INFO - PROCESS | 326 | Values: 157.0 158.0 160.0 153.0 154.0 155.0 155.0 160.0 157.0 157.0 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - PROCESS | 326 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.55 (5.6%) stddev-sans-first:1.56 14:41:23 INFO - PROCESS | 326 | Values: 73.0 63.0 63.0 66.0 63.0 62.0 61.0 61.0 64.0 62.0 14:41:23 INFO - PROCESS | 326 | -------- Summary: end -------- 14:41:23 INFO - PROCESS | 326 | 14:41:23 INFO - TEST-INFO | 326: exit 0 14:41:23 INFO - TEST-OK | kraken | took 60792ms 14:41:23 INFO - SUITE-END | took 1175s 14:41:24 INFO - Completed test suite (00:19:35) 14:41:24 INFO - javascript benchmark 14:41:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.0609910927615, 3037.7417919476843, 3068.631764188298, 3070.646875609305, 3079.030105516762, 5251.186066159742, 5306.124489459245, 5334.679919204846, 5440.102383106788, 5472.917906231405, 5317.893642127165, 5378.435264297251, 5381.0852155133625, 5399.082156033474, 5412.107002344608, 4821.349117869096, 4894.706317620937, 4897.730624815634, 4910.950890491085, 5074.771635276422, 5005.324281222025, 5031.84904452867, 5036.219385995177, 5050.646454748169, 5054.974725126388, 4826.107170173529, 4835.226363781796, 4882.536159064884, 4889.926651100236, 4931.211006239003, 4873.707577545359, 4888.631183268655, 4894.290327902434, 4947.579455746266, 4999.32509111269, 4906.901861962777, 4932.630052746023, 4938.728369939652, 4948.035133149037, 4977.626677999165, 5249.42256351801, 5302.469753024705, 5357.732113394353, 5373.704446255454, 5431.185322201702, 5745.683987380692, 5811.738471768738, 5820.912686309709, 5822.039363505017, 5826.096954971986, 5556.111022236463, 5839.299284085894, 5856.882862342772, 5859.736311865976, 5867.530597552186, 5326.174442961347, 5378.892422151535, 5381.219723140122, 5437.429069947678, 5443.101888188484, 5954.49386802118, 5955.880882382415, 5960.0761881908375, 5965.970170149121, 5966.433188847052, 5679.8864022720145, 5714.7428365723645, 5734.283214598176, 5736.110902810071, 5736.827895163152, 5658.943410565842, 5676.772929082873, 5681.289838770153, 5693.658380497183, 5767.394423585463, 5656.632318899258, 5695.914561281584, 5697.4302569742695, 5703.914441283384, 5706.457886500776, 5656.830295091154, 5700.714964251771, 5709.22925405065, 5710.971445142748, 5711.942880571224, 4255.3829694694095, 4270.145970805851, 4272.572742725764, 4314.201872653569, 4320.740755554677, 3797.430385442206, 3887.941680874789, 3913.4325522799036, 3920.17676287977, 3946.9802650987135, 5432.130859062531, 5438.293021907127, 5440.265564148868, 5441.047816632074, 5491.560675146058, 5651.632643878134, 5775.88448231033, 5779.566532510079, 5785.537157027427, 5790.855228619318, 5373.38206106295, 5401.405845357008, 5420.051490989061, 5453.945460545344, 5477.67133971963, 4928.852134435972, 4969.676970996874, 4975.179095449283, 4977.975110124498, 5010.649254552146, 5803.680797556175, 5966.85082872923, 6019.398060194033, 6026.9095963560585, 6030.155778191057, 5676.631018983918, 5704.286964129484, 5722.656640601577, 5758.395368486249, 5810.360860305447, 5959.28488581373, 5968.074948383008, 5974.581779275409, 5975.223220981418, 5979.312379076462, 5565.916511252415, 5645.012122878397, 5658.943410566007, 5660.0, 5662.490375866192, 5732.3121225453215, 5743.253377060955, 5751.079827227623, 5841.299044114733, 5891.882162356815, 5640.88718225625, 5672.744726487235, 5679.971600141973, 5686.57350698691, 5691.743871525874, 5408.188771684278, 5690.487856092972, 5697.487226149667, 5698.914516282342, 5704.600677952503, 5473.507384335429, 5478.506934375925, 5488.423715509974, 5554.75003624846, 5616.241807355955, 5636.4927156556105, 5637.577181711306, 5675.091985282335, 5688.232088667977, 5705.4579814917515, 5378.2739330189925, 5418.593605479684, 5459.890802184013, 5504.0, 5543.473370029841], "value": 5303.676203378832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5057302438976, 613.6440864298706, 627.9089532017855, 642.5694784494389, 644.6712176789837, 32318.19204519888, 33008.504872426936, 42748.78625606868, 43545.0, 43879.0, 42507.36238956411, 46299.30551041729, 46421.30368044482, 46430.0, 46611.30083048748, 8989.550522473883, 9126.58930348136, 9138.314626403013, 9138.817223655524, 9148.634054637807, 9010.098990101003, 9084.182423581877, 9100.453972761623, 9103.681371152012, 9106.089391060874, 9123.270138388913, 9128.634854605842, 9129.68046118386, 9161.816763664723, 9162.587683554257, 9071.047540008303, 9095.31785116119, 9110.86333704995, 9112.544372781367, 9113.95443022784, 9015.188633023059, 9070.954645226797, 9082.364234503588, 9082.636694532212, 9084.8637270441, 42711.0, 43105.35341969873, 43115.7844210777, 43123.0, 43143.13713725739, 3165.7150856422804, 3362.69735723786, 3378.2905589826164, 3501.7548771586, 3765.8681946131755, 33081.17297067568, 33085.17287067843, 33226.3354732904, 33342.83328583366, 33702.6629733702, 4406.911861762779, 4542.5684559967085, 4543.977280113611, 4559.544045595414, 4594.655400844917, 266959.0, 267111.0, 267483.0, 268385.0, 269318.999999998, 54108.188377174374, 54127.0, 54173.72913135409, 54228.0, 54314.0, 37804.43293350602, 38376.0, 38654.226915461535, 40608.59391406048, 63790.68104659447, 16662.0, 16759.748603770953, 16769.0, 16772.496825095266, 16790.160491975596, 13456.05807593459, 13590.59228223155, 13593.388297526635, 13597.796033059512, 13613.727725445435, 19930.60138797245, 20316.59366812685, 20324.49188770263, 20332.491687707927, 20456.69314960277, 7134.255719946178, 7350.669219885118, 7373.437640499959, 7492.737754178577, 7513.361364283987, 993.6571882700457, 1033.7105610429091, 1037.7716902281486, 1068.6847380022912, 1120.618989543559, 33224.16939576482, 33648.83175584155, 33878.66121338755, 33907.83046084803, 34009.48985765215, 1104.5029736618553, 1129.4239937631703, 1137.6814491942268, 1140.9885901140883, 1164.8252762085756, 17751.289948401918, 17776.9111154446, 17781.911090444464, 17858.821411785975, 18109.547261318574, 538718.0, 543874.0, 545035.0, 547589.0, 548158.0, 61513.69243153845, 62254.37745622576, 62295.06557401643, 62344.37655623386, 62442.0, 1225.4485481533345, 1351.2703140304322, 1383.5710929611853, 1385.1827421820972, 1385.7020740540631, 32476.0, 35036.824815875756, 35061.29877402489, 35474.60012288673, 35872.0, 51566.48433515767, 57091.71454142703, 59450.405495944484, 59563.702181490546, 64326.35673643203, 518511.0, 525312.0, 525480.0, 525667.0, 526208.0, 36734.265314693024, 43229.56770432381, 43704.56295437005, 46444.53555464402, 46561.0, 48688.26967595418, 48902.0, 48959.26561101658, 49029.75485122694, 49055.0, 40779.0, 41112.0, 41165.382519262836, 42298.78850605727, 42314.788426057676, 42158.0, 42498.575014249465, 42567.0, 43376.56623433725, 43760.78119609381, 42082.579174207865, 42204.78897605615, 43525.3471197926, 43924.780376097915, 43955.34066988934, 35005.47491787574, 37668.0, 37727.62272377351, 38486.42270365891, 38737.61262387453, 29155.7084429153, 29187.270318242216, 29247.268818279714, 29480.852595736884, 29603.407931841673], "value": 20632.302435504036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.27059939112627, 398.46804515971183, 399.5564922935543, 403.2881963334715, 419.0278553755289, 13267.93366033171, 18708.53228669282, 20045.097970591323, 20265.290714824965, 20339.694904576445, 19486.512837179078, 19821.702674459895, 19986.50033749157, 20131.0, 20209.595808083828, 5804.912926306109, 5830.57150998004, 5970.044792833148, 6008.789692360769, 6015.909761353583, 4283.271843786548, 5628.774849006035, 5939.376365481627, 5946.345901950782, 5948.286205655328, 6400.551961362707, 6639.867202655944, 6693.866122677544, 6750.797476075701, 6766.492513061516, 6537.5423720339595, 6610.7025183866845, 6644.4020038196795, 6676.24263099621, 6755.392014718675, 5820.563457740686, 5827.562932780016, 5829.067349224104, 5832.212651292064, 5838.970805145989, 14195.148291102567, 15507.147106909115, 22307.0, 23023.424414389774, 23047.427648714474, 2229.297771202066, 2253.8084262837515, 2295.1507942061376, 2805.2566069991467, 3105.7204851563242, 9866.90133098667, 10175.59297628094, 10600.628977985734, 10699.83950240747, 10731.570737170503, 1917.4822797844504, 1997.2011195521761, 2022.7572691276994, 2028.614563232981, 2033.044469099521, 71505.28494715039, 76714.0, 80146.0, 83798.58100709518, 84554.57722711409, 10814.513346899408, 10873.945630271797, 11095.889041109647, 11177.385243811506, 11242.325460472397, 15545.22273886301, 15585.454509092127, 15595.454159104376, 15597.766033509506, 15602.765958510632, 8051.275385215359, 8217.465864718893, 8262.17378262181, 8334.458260213189, 8433.19884610961, 8078.192180781993, 8082.474639148437, 8113.823495593106, 8276.172382761795, 8281.54451505173, 4695.765211739399, 4765.9761701191965, 4767.356406885096, 4911.115999120193, 4915.557599816034, 1905.5902980859182, 1975.2888959974398, 1988.5525756704626, 1991.6912878503856, 2014.7783743788173, 880.225401646547, 959.4770849886828, 969.2294625772528, 983.9655612053543, 997.2221667099674, 17559.239003783023, 19913.0, 20293.49266268355, 20397.898010509853, 20570.177192912415, 970.2141265574907, 989.2531138990016, 990.821652102614, 1045.2265323660436, 1046.4819914142547, 10694.893051069545, 11283.66149015531, 11355.54577816878, 11363.0, 11366.0, 480375.0, 484414.88962776214, 485439.0, 485733.0, 488039.0, 85867.57066214629, 86828.0, 87894.56052719695, 87994.56002719945, 89811.55094224487, 985.1133979418437, 991.0981007283337, 1015.5227043289642, 1018.4245901065874, 1019.97450063749, 17352.739708904122, 17807.821921780618, 18222.0, 18247.361342352953, 18405.0, 42306.57693423027, 42528.57471425246, 42667.0, 42933.35599966066, 43774.56225437705, 54228.72885635547, 55817.44182558285, 58319.70840145772, 60027.69986150041, 65962.0, 8379.622916968872, 8402.453840500348, 8431.451955622864, 8569.914300856912, 8966.68616598442, 12453.564125255572, 13116.409761560562, 13440.93279533596, 13520.526781562598, 13965.441382344592, 11339.09287257034, 11605.709857253636, 11652.184347095961, 11833.704157396134, 11846.229995050295, 11041.39272340029, 11310.20828542027, 11519.02088322502, 11549.6535103947, 12080.879191207976, 11388.316700997966, 11836.0, 11895.583654572049, 12068.939655301667, 12213.976963245992, 8497.83004339922, 8747.737567872973, 8762.605682744419, 8837.381383303364, 8973.461592304482, 10757.515911783832, 11822.586209482626, 12013.699657508632, 12121.424179867137, 12240.571579994657], "value": 9351.226375809823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.1952828303026, 1487.4719474586525, 1546.2577962577964, 1667.7915260592426, 1828.8811227270235, 8308.459950103239, 8615.956920215398, 8729.34529910257, 8958.686445974392, 8977.326700497457, 8807.383483156182, 8902.376833621633, 8929.73210803677, 8941.23999460045, 8947.150020748019, 2380.809535237177, 2411.602085655865, 2417.9637305440347, 2422.648715936188, 2427.745086765891, 2371.845830021052, 2390.772876576731, 2418.0327868852423, 2420.6006009008493, 2422.1522467136538, 2397.160993652225, 2399.3401814500976, 2411.131992482705, 2435.0, 2435.07467162478, 2331.6735657008035, 2357.8113750899975, 2360.3509035015422, 2363.4327761337327, 2364.302530753423, 2301.5166814968875, 2320.048780000209, 2323.0707716913203, 2324.047140672333, 2326.1509549014486, 8714.389992700513, 8765.254953328975, 8815.735527934172, 8832.205101540829, 8883.822323553557, 5374.7043912584795, 5458.1266997280645, 5510.6969116698565, 5511.972440137773, 5519.972400137974, 3557.48416479609, 3572.1962558424148, 3619.94570081449, 3646.3254297954963, 3657.561092668897, 1186.6736647422028, 1212.6543934978488, 1217.2513903949095, 1232.8458942632171, 1285.543632010632, 12476.625701228977, 12509.624711258677, 12593.433295501725, 12635.49458021678, 12653.177543459738, 4408.955910440919, 4643.976780116078, 4720.834770783006, 4750.406199225097, 4756.143894099096, 9904.801903961881, 9922.702318930444, 9923.305368624127, 9931.453770042717, 9940.950295248478, 5374.27447294618, 5384.623076384615, 5386.569074474032, 5388.703621300866, 5405.621606487508, 4382.364557139261, 4777.498362671939, 4992.700437973661, 5028.949710502849, 5032.547070763649, 4098.549159592442, 4154.626083652486, 4238.825254056191, 4255.851045213402, 4289.635380992589, 1330.0423694939627, 1372.6842826150041, 1376.9586912392645, 1378.076688618628, 1393.1432169216062, 811.8660421030582, 971.2618410008304, 992.513668302541, 1002.9097381235724, 1033.8552602635637, 5897.292324920951, 5933.673647949404, 5951.345352011275, 6047.0, 6116.938830611726, 468.615735097217, 470.83050101963266, 475.34165181224256, 479.714569830957, 482.1947347928967, 4187.958120418818, 4277.828886844553, 4298.914021719548, 4317.633001194934, 4338.219120558267, 11022.118230541697, 11494.770104598028, 11510.0, 11512.654620361403, 11519.136064795173, 10608.363498190134, 11092.611758588571, 11341.943290283662, 11360.0, 11392.658220253406, 8288.958555207186, 8444.57777111142, 8532.445391049561, 8533.786655333666, 8539.146085391536, 5874.441928016831, 5889.263842019747, 6016.849578760566, 6022.0, 6288.685565721604, 10076.899231007596, 10341.276110672181, 10399.272050956662, 10441.947790261303, 10480.371177729361, 10421.895781042396, 10579.5239214234, 10626.89373106259, 10684.519196636325, 10738.14094872424, 7591.962040189985, 7746.264104910025, 7802.882956755767, 7808.0, 7924.286814186751, 8814.515201663713, 8853.822923541622, 8872.73381798547, 8879.11208879107, 8888.200061994452, 7884.487508311941, 7989.121196668246, 7990.800229994296, 8114.0741620637, 8263.256306932404, 7693.307602315818, 7694.269044440769, 7802.804929876798, 7818.804529886798, 7881.5665138417935, 6748.493862960199, 6824.522283440111, 6871.106756121672, 6902.378785909293, 6903.620300883299, 4988.700677959334, 5024.371953505812, 5134.204198349262, 5250.553702935294, 5556.722163891708, 5361.195820626937, 5407.78368865241, 5420.620556561003, 5453.072977593898, 5497.47773961473], "value": 4667.286020322932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.9433099207638, 337.6151187646083, 340.7887109991805, 342.09345235126926, 342.10710046777905, 4985.426675932269, 5074.771635276412, 5133.460986596409, 5218.512723873697, 5261.842144735654, 5072.619553533481, 5085.160948443511, 5095.719735414551, 5115.514026167518, 5160.535551800337, 4128.525219599747, 4136.751794892301, 4143.917121657565, 4144.585541445861, 4193.517745459266, 3942.605739426049, 4085.836566537335, 4155.979220103895, 4157.189348077126, 4181.205570941526, 4060.1473690525027, 4062.6343629073376, 4062.73592216505, 4066.2477441673236, 4077.2049450357194, 4055.614716601918, 4066.6136717011836, 4087.305158123126, 4092.058826469899, 4092.9590704093175, 3630.0, 3634.509341238925, 3635.054885729703, 3643.417053271464, 3656.579493358271, 4996.50104968508, 5041.9747901260625, 5047.369078865142, 5052.646314757969, 5058.848234552969, 4618.8152473901, 4630.7453090080035, 4635.0, 4636.327732478805, 4637.466691330506, 5379.946200537984, 5382.327209098863, 5383.273258110184, 5386.946130538684, 5403.729813509348, 3757.3236817372863, 3886.7473614214987, 3890.630390112935, 3904.570497245301, 3916.138449541125, 5582.385937546866, 5599.972000139973, 5606.887862242773, 5626.831195064155, 5636.633618814764, 4001.3997900315185, 4008.2584721826556, 4021.678265738734, 4025.1547175092974, 4034.495688038995, 3977.960220397759, 4028.529586700833, 4048.230836141183, 4068.816903239361, 4075.673946084306, 4600.263957766741, 4628.490866004737, 4632.2125238709505, 4664.953350466452, 4665.813367465331, 5443.815368009679, 5458.426865179178, 5464.644798088111, 5519.448055194448, 5520.806771762969, 1329.3884812986134, 1359.5581436033328, 1365.688938618917, 1389.3400634698437, 1391.2278685329738, 916.5371487398954, 938.6339327662081, 944.3955868244192, 947.980920510454, 948.0045951750634, 5138.3833939927445, 5143.765496280866, 5182.844514664566, 5195.740212989335, 5199.818006369835, 5392.40683524812, 5402.972985135049, 5410.702411367412, 5435.537979271727, 5441.782328706887, 4894.437139728905, 5076.18780995039, 5102.744862756847, 5150.742462876841, 5170.457102004236, 2558.2453176313034, 2563.2950938492063, 2565.320190149612, 2576.6263891735593, 2588.404666926617, 5018.372703412074, 5027.824026159067, 5057.0, 5068.518490743373, 5070.518300761421, 4711.293306004127, 4902.803887844518, 4958.504149585085, 4959.528844759742, 4970.602351811846, 5006.696919417109, 5013.994402239134, 5038.722870242099, 5048.823291184791, 5077.365329333833, 4832.371791667061, 4835.419749629927, 4842.709437433765, 4859.0, 4890.070886531547, 4503.459584849839, 4794.489735733233, 4804.6876952997945, 4829.106615276185, 4836.758162091952, 5043.5460808527405, 5052.393712754493, 5052.469490703424, 5070.467600901852, 5114.974425127851, 3579.7673151245085, 3590.7127429806073, 3595.9101022474647, 3618.7285953553064, 3644.2689722381656, 4543.909121817479, 4784.760761961818, 4924.852254432372, 4942.4316203637045, 4987.3017777511905, 4708.0, 4722.338872557776, 4735.83424580138, 4738.905221895474, 4759.119562880878, 4694.192735796674, 4746.050789841976, 4768.356271903387, 4863.805447782049, 4869.513048695244, 4535.79588918506, 4678.76606169697, 4681.859544213679, 4695.483496815279, 4707.340972263954, 4751.809927602857, 4756.571908528249, 4756.619470442425, 4766.428028636586, 4780.95219047819, 4642.628589712883, 4712.670113092051, 4714.316424118552, 4719.646026548091, 4744.288356746378], "value": 3946.2461446548677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.8419773946341, 781.1914668318288, 782.5422128055087, 783.5024759277857, 896.480041575886, 15250.237488125606, 16258.674826503478, 16269.186540672978, 17380.0, 17395.391161309355, 16787.580310492212, 16875.493735187934, 17059.658806823856, 17062.14689265538, 17084.487465376027, 685.1880521581942, 802.7350974178507, 821.0680877204371, 838.2413915406536, 839.5340585974812, 842.9662813487453, 849.5370023337265, 852.7058164933088, 852.8507511185549, 852.9872051919226, 882.6954700628305, 887.4497811356968, 889.8264838356523, 889.8798662180587, 890.2255038116847, 695.1172011545309, 708.5996412027188, 883.659790980474, 884.2439714044496, 884.8761173435724, 525.8396189162304, 612.3050337866554, 630.9242890853081, 634.2294112653149, 636.3572791480592, 15326.080435173813, 15337.769933451007, 15365.308561114776, 15374.308156132889, 15389.923050384788, 14074.0, 14401.279936003262, 14585.343659535347, 14665.780013299809, 15027.173505457196, 12370.62888113358, 12459.688507787287, 12548.498060077585, 12561.937190314082, 12668.746625067539, 4228.746275223496, 4266.253405654029, 4294.634956028742, 4450.888727781799, 4462.062966776981, 66692.99960500597, 70124.64937675279, 86376.56811715964, 86798.0, 86875.0, 10978.505967231495, 11169.83245251322, 11467.254628449124, 11538.423078846192, 11582.47878845454, 21665.67501487479, 21710.674339884914, 21989.23037693673, 22262.888685556467, 22383.664245036336, 8364.079951205362, 8368.20502052304, 8493.745187644381, 8523.48859068458, 9157.725268241964, 4665.720056796536, 4768.499307572724, 4785.928211076836, 4896.534829191221, 4898.975505122452, 3638.636136386393, 3791.6208379161862, 3798.3922572388287, 3812.0, 3820.6179382061573, 620.6617393520543, 621.3941407128104, 631.6147150238351, 632.3486808587163, 649.8505343770959, 693.2616763147232, 714.9714011439588, 715.9391451726557, 731.5939653492256, 735.8675438421028, 9663.46850923206, 9750.219982401391, 10312.896871031344, 10605.787884242272, 10615.628453004108, 543.7335705504274, 684.2029036172902, 694.2918223412091, 728.4964861922181, 748.7491690283816, 4809.350737650372, 4869.9269510957365, 4885.364902562644, 4946.604271658259, 4957.553820156203, 71063.2893671067, 92522.0, 96193.51903240579, 96846.0, 132221.0, 111676.0, 111846.0, 113755.03714740054, 115764.42355764356, 116915.0, 92023.0, 96923.51538242404, 96930.51534742423, 96936.51531742296, 98983.50508247556, 9173.266138708754, 9223.723288301362, 9404.623815047322, 9445.952770236105, 9553.140217380469, 55148.17277740757, 56294.0, 56303.71848140733, 56767.432325677866, 58467.0, 62235.6888215556, 76427.61786191033, 82598.0, 83237.0, 83599.5820020896, 13223.933880330536, 13246.20522768637, 13800.378982945993, 13862.514811981533, 13879.930600346934, 15344.232788360761, 15368.846311536741, 15548.844511555191, 16619.750703739697, 16769.07770072658, 14667.119972801665, 14701.41194352214, 14711.632209194428, 15626.218689065274, 15838.68322633564, 13769.793453098411, 14262.572122835916, 14466.05970611907, 14498.782518262024, 14593.708125837637, 13751.174929504261, 13815.79276310836, 14354.425822966965, 14762.704745905237, 15147.772783408038, 11320.547178112784, 11965.0, 12255.509779608716, 12388.161735719825, 12666.0, 12571.18287311322, 13115.868841311465, 13154.671133221364, 13273.269970151348, 13323.13399629021], "value": 7873.804377612585, "unit": "score"}], "name": "dromaeo_css", "value": 7276.334637186343, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 119.0, 182.0, 123.0, 125.0, 146.0, 117.0, 147.0, 116.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 163.0, 161.0, 163.0, 158.0, 159.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 109.0, 84.0, 76.0, 74.0, 75.0, 102.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 109.0, 84.0, 84.0, 83.0, 124.0, 83.0, 84.0, 132.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 176.0, 145.0, 146.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 50.0, 49.0, 50.0, 49.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 76.0, 75.0, 80.0, 76.0, 75.0, 75.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 122.0, 129.0, 121.0, 120.0, 120.0, 131.0, 197.0, 121.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 160.0, 153.0, 154.0, 155.0, 155.0, 160.0, 157.0, 157.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 63.0, 63.0, 66.0, 63.0, 62.0, 61.0, 61.0, 64.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1481.0, "alertThreshold": 2.0}]} 14:41:24 INFO - Return code: 0 14:41:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:41:24 INFO - # TBPL SUCCESS # 14:41:24 INFO - Running post-action listener: _resource_record_post_action 14:41:24 INFO - [mozharness: 2016-08-03 21:41:24.297003Z] Finished run-tests step (success) 14:41:24 INFO - Running post-run listener: _resource_record_post_run 14:41:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544276480; Read time: 228; Write time: 496616 14:41:24 INFO - TinderboxPrint: CPU usage
13.1% 14:41:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 228 14:41:24 INFO - TinderboxPrint: I/O write bytes / time
544,276,480 / 496,616 14:41:24 INFO - TinderboxPrint: CPU idle
8,277.4 (86.9%) 14:41:24 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 14:41:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:41:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251625472; Read time: 0; Write time: 317204 14:41:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292339712; Read time: 228; Write time: 179352 14:41:24 INFO - Running post-run listener: _upload_blobber_files 14:41:24 INFO - Blob upload gear active. 14:41:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:24 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 14:41:24 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'] 14:41:24 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 14:41:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:29 INFO - (blobuploader) - INFO - Done attempting. 14:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:29 INFO - (blobuploader) - INFO - Done attempting. 14:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:30 INFO - (blobuploader) - INFO - Done attempting. 14:41:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:41:30 INFO - Return code: 0 14:41:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:41:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:41:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36c3d131a3b2ff6f3db184a3a01065671b4ed32c14b3a881de29063830676dc2321af1eb4b4a1b3629b66acc7bfd1e64ce4fcd7ab3acbac81e3086a67ac2b8ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dab835e74c155e17870138ce5319461f5ce9dba59a71ff102855663965fe6d4af045ad99ee07858feb3cead12cfe002497bddb6c809d8128d0243a8dd6930fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e697d533bcb838520757e92e6751e8f78477c8f6452209246c5ad60de27b0b727b14b8b8ff2f1d910d036d0708a635af706a6a7b883474ff3db6c8d7abc126"} 14:41:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:41:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:41:30 INFO - Contents: 14:41:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36c3d131a3b2ff6f3db184a3a01065671b4ed32c14b3a881de29063830676dc2321af1eb4b4a1b3629b66acc7bfd1e64ce4fcd7ab3acbac81e3086a67ac2b8ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dab835e74c155e17870138ce5319461f5ce9dba59a71ff102855663965fe6d4af045ad99ee07858feb3cead12cfe002497bddb6c809d8128d0243a8dd6930fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e697d533bcb838520757e92e6751e8f78477c8f6452209246c5ad60de27b0b727b14b8b8ff2f1d910d036d0708a635af706a6a7b883474ff3db6c8d7abc126"} 14:41:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:41:30 INFO - Copying logs to upload dir... 14:41:30 INFO - mkdir: /builds/slave/test/build/upload/logs 14:41:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.226319 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-03 14:41:30.802821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 14:41:30.806576) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 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/36c3d131a3b2ff6f3db184a3a01065671b4ed32c14b3a881de29063830676dc2321af1eb4b4a1b3629b66acc7bfd1e64ce4fcd7ab3acbac81e3086a67ac2b8ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dab835e74c155e17870138ce5319461f5ce9dba59a71ff102855663965fe6d4af045ad99ee07858feb3cead12cfe002497bddb6c809d8128d0243a8dd6930fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e697d533bcb838520757e92e6751e8f78477c8f6452209246c5ad60de27b0b727b14b8b8ff2f1d910d036d0708a635af706a6a7b883474ff3db6c8d7abc126"} build_url:https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/AG655jLeQT-WwY5BPV27ZA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36c3d131a3b2ff6f3db184a3a01065671b4ed32c14b3a881de29063830676dc2321af1eb4b4a1b3629b66acc7bfd1e64ce4fcd7ab3acbac81e3086a67ac2b8ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dab835e74c155e17870138ce5319461f5ce9dba59a71ff102855663965fe6d4af045ad99ee07858feb3cead12cfe002497bddb6c809d8128d0243a8dd6930fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5e697d533bcb838520757e92e6751e8f78477c8f6452209246c5ad60de27b0b727b14b8b8ff2f1d910d036d0708a635af706a6a7b883474ff3db6c8d7abc126"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 14:41:30.832736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:41:30.833100) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470259258.947132-1184726568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 14:41:30.916833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 14:41:30.917220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 14:41:30.917548) ========= ========= Total master_lag: 0.17 =========