builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1463523118.8 results: success (0) buildid: 20160517135343 builduid: c58e1e44a4354b47ab2767257f634f34 revision: 991f249a6ffa07e1ccb87ab657d71c4522429058 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.800937) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.801405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.801700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.819840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.820116) ========= 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=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 15:11: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% 204M=0s 2016-05-17 15:11:59 (204 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102182 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.935236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.935544) ========= 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=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019832 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.984531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:58.984948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 991f249a6ffa07e1ccb87ab657d71c4522429058 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 991f249a6ffa07e1ccb87ab657d71c4522429058 --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=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 15:11:59,416 truncating revision to first 12 chars 2016-05-17 15:11:59,416 Setting DEBUG logging. 2016-05-17 15:11:59,416 attempt 1/10 2016-05-17 15:11:59,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/991f249a6ffa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 15:11:59,737 unpacking tar archive at: mozilla-central-991f249a6ffa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:59.586500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:59.586834) ========= script_repo_revision: 991f249a6ffa07e1ccb87ab657d71c4522429058 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:59.587362) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:59.587639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 15:11:59.596913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-17 15:11:59.597317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:12:00 INFO - MultiFileLogger online at 20160517 15:12:00 in /builds/slave/test 15:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:00 INFO - {'append_to_log': False, 15:12:00 INFO - 'base_work_dir': '/builds/slave/test', 15:12:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:00 INFO - 'branch': 'Firefox-Non-PGO', 15:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:00 INFO - 'config_files': ('talos/linux_config.py',), 15:12:00 INFO - 'default_actions': ('clobber', 15:12:00 INFO - 'read-buildbot-config', 15:12:00 INFO - 'download-and-extract', 15:12:00 INFO - 'populate-webroot', 15:12:00 INFO - 'create-virtualenv', 15:12:00 INFO - 'install', 15:12:00 INFO - 'run-tests'), 15:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:00 INFO - 'download_minidump_stackwalk': True, 15:12:00 INFO - 'download_symbols': 'ondemand', 15:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:00 INFO - 'installer_path': 'installer.exe', 15:12:00 INFO - 'log_level': 'info', 15:12:00 INFO - 'log_name': 'talos', 15:12:00 INFO - 'log_to_console': True, 15:12:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:12:00 INFO - 'opt_config_files': (), 15:12:00 INFO - 'pip_index': False, 15:12:00 INFO - 'sps_profile': False, 15:12:00 INFO - 'sps_profile_interval': 0, 15:12:00 INFO - 'suite': 'dromaeojs', 15:12:00 INFO - 'system_bits': '32', 15:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:00 INFO - 'title': 'talos-linux64-ix-023', 15:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:00 INFO - 'use_talos_json': True, 15:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:00 INFO - 'work_dir': 'build'} 15:12:00 INFO - ##### 15:12:00 INFO - ##### Running clobber step. 15:12:00 INFO - ##### 15:12:00 INFO - Running pre-action listener: _resource_record_pre_action 15:12:00 INFO - Running main action method: clobber 15:12:00 INFO - rmtree: /builds/slave/test/build 15:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:00 INFO - Running post-action listener: _resource_record_post_action 15:12:00 INFO - ##### 15:12:00 INFO - ##### Finished clobber step (success) 15:12:00 INFO - ##### 15:12:00 INFO - ##### 15:12:00 INFO - ##### Running read-buildbot-config step. 15:12:00 INFO - ##### 15:12:00 INFO - Running pre-action listener: _resource_record_pre_action 15:12:00 INFO - Running main action method: read_buildbot_config 15:12:00 INFO - Using buildbot properties: 15:12:00 INFO - { 15:12:00 INFO - "project": "", 15:12:00 INFO - "product": "firefox", 15:12:00 INFO - "script_repo_revision": "production", 15:12:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:12:00 INFO - "repository": "", 15:12:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:12:00 INFO - "buildid": "20160517135343", 15:12:00 INFO - "pgo_build": "False", 15:12:00 INFO - "basedir": "/builds/slave/test", 15:12:00 INFO - "buildnumber": 584, 15:12:00 INFO - "slavename": "talos-linux64-ix-023", 15:12:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:12:00 INFO - "platform": "ubuntu64_hw", 15:12:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:12:00 INFO - "branch": "mozilla-central", 15:12:00 INFO - "repo_path": "mozilla-central", 15:12:00 INFO - "revision": "991f249a6ffa07e1ccb87ab657d71c4522429058", 15:12:00 INFO - "stage_platform": "linux64", 15:12:00 INFO - "builduid": "c58e1e44a4354b47ab2767257f634f34", 15:12:00 INFO - "slavebuilddir": "test" 15:12:00 INFO - } 15:12:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:12:00 INFO - Running post-action listener: _resource_record_post_action 15:12:00 INFO - ##### 15:12:00 INFO - ##### Finished read-buildbot-config step (success) 15:12:00 INFO - ##### 15:12:00 INFO - ##### 15:12:00 INFO - ##### Running download-and-extract step. 15:12:00 INFO - ##### 15:12:00 INFO - Running pre-action listener: _resource_record_pre_action 15:12:00 INFO - Running main action method: download_and_extract 15:12:00 INFO - mkdir: /builds/slave/test/build/tests 15:12:00 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')]} 15:12:00 INFO - https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:12:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:12:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:12:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:12:01 INFO - Downloaded 1361 bytes. 15:12:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:12:01 INFO - Using the following test package requirements: 15:12:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:12:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:12:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'jsshell-linux-x86_64.zip'], 15:12:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:12:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:12:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:12:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:12:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:12:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:12: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')]} 15:12:01 INFO - https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:02 INFO - Downloaded 22450783 bytes. 15:12:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:03 INFO - Return code: 0 15:12:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:03 INFO - https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:04 INFO - Downloaded 22450783 bytes. 15:12:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:06 INFO - Return code: 0 15:12: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')]} 15:12:06 INFO - https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:12:07 INFO - Downloaded 10840194 bytes. 15:12:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:12:07 INFO - Return code: 0 15:12: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')]} 15:12:07 INFO - https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:12:08 INFO - Downloaded 54755470 bytes. 15:12:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:12:08 INFO - mkdir: /builds/slave/test/properties 15:12:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:12:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:12:08 INFO - Contents: 15:12:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:12:09 INFO - Running post-action listener: _resource_record_post_action 15:12:09 INFO - Running post-action listener: set_extra_try_arguments 15:12:09 INFO - ##### 15:12:09 INFO - ##### Finished download-and-extract step (success) 15:12:09 INFO - ##### 15:12:09 INFO - ##### 15:12:09 INFO - ##### Running populate-webroot step. 15:12:09 INFO - ##### 15:12:09 INFO - Running pre-action listener: _resource_record_pre_action 15:12:09 INFO - Running main action method: populate_webroot 15:12:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:09 INFO - '--tppagecycles', 15:12:09 INFO - '7'], 15:12:09 INFO - 'tests': ['tsvgm']}}, 15:12:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:12:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:12:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['damp', 'tps']}, 15:12:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'tests': ['damp', 'tps']}, 15:12:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['dromaeo_dom']}, 15:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:12:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['a11yr', 15:12:09 INFO - 'ts_paint', 15:12:09 INFO - 'tpaint', 15:12:09 INFO - 'sessionrestore', 15:12:09 INFO - 'sessionrestore_no_auto_restore', 15:12:09 INFO - 'tabpaint']}, 15:12:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['tsvgx', 15:12:09 INFO - 'tsvgr_opacity', 15:12:09 INFO - 'tart', 15:12:09 INFO - 'tscrollx', 15:12:09 INFO - 'cart']}, 15:12:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:12:09 INFO - 'tsvgr_opacity', 15:12:09 INFO - 'tart', 15:12:09 INFO - 'tscrollx', 15:12:09 INFO - 'cart']}, 15:12:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'talos_options': ['--disable-e10s'], 15:12:09 INFO - 'tests': ['tp5o']}, 15:12:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'tests': ['tp5o']}, 15:12:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'talos_options': ['--disable-e10s', 15:12:09 INFO - '--xperf_path', 15:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:09 INFO - 'tests': ['tp5n']}, 15:12:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:09 INFO - 'talos_options': ['--xperf_path', 15:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:09 INFO - 'tests': ['tp5n']}}, 15:12:09 INFO - 'talos.zip': {'path': '', 15:12:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:09 INFO - Running post-action listener: _resource_record_post_action 15:12:09 INFO - ##### 15:12:09 INFO - ##### Finished populate-webroot step (success) 15:12:09 INFO - ##### 15:12:09 INFO - ##### 15:12:09 INFO - ##### Running create-virtualenv step. 15:12:09 INFO - ##### 15:12:09 INFO - Running pre-action listener: _resource_record_pre_action 15:12:09 INFO - Running main action method: create_virtualenv 15:12:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:12: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 15:12:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:09 INFO - Using real prefix '/usr' 15:12:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:12:09 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:11 INFO - Installing pip.................done. 15:12:11 INFO - Return code: 0 15:12:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:12:11 INFO - Using env: {'DISPLAY': ':0', 15:12:11 INFO - 'HOME': '/home/cltbld', 15:12:11 INFO - 'LANG': 'en_US.UTF-8', 15:12:11 INFO - 'LANGUAGE': 'en_US:en', 15:12:11 INFO - 'LOGNAME': 'cltbld', 15:12:11 INFO - 'MAIL': '/var/mail/cltbld', 15:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:11 INFO - 'MOZ_NO_REMOTE': '1', 15:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:11 INFO - 'NO_EM_RESTART': '1', 15:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:11 INFO - 'PWD': '/builds/slave/test', 15:12:11 INFO - 'SHELL': '/bin/bash', 15:12:11 INFO - 'SHLVL': '1', 15:12:11 INFO - 'TERM': 'linux', 15:12:11 INFO - 'TMOUT': '86400', 15:12:11 INFO - 'USER': 'cltbld', 15:12:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:11 INFO - '_': '/tools/buildbot/bin/python'} 15:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12: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 15:12:12 INFO - Cleaning up... 15:12:12 INFO - Return code: 0 15:12:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12: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 15:12: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 15:12:12 INFO - Using env: {'DISPLAY': ':0', 15:12:12 INFO - 'HOME': '/home/cltbld', 15:12:12 INFO - 'LANG': 'en_US.UTF-8', 15:12:12 INFO - 'LANGUAGE': 'en_US:en', 15:12:12 INFO - 'LOGNAME': 'cltbld', 15:12:12 INFO - 'MAIL': '/var/mail/cltbld', 15:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:12 INFO - 'MOZ_NO_REMOTE': '1', 15:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:12 INFO - 'NO_EM_RESTART': '1', 15:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:12 INFO - 'PWD': '/builds/slave/test', 15:12:12 INFO - 'SHELL': '/bin/bash', 15:12:12 INFO - 'SHLVL': '1', 15:12:12 INFO - 'TERM': 'linux', 15:12:12 INFO - 'TMOUT': '86400', 15:12:12 INFO - 'USER': 'cltbld', 15:12:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:12 INFO - '_': '/tools/buildbot/bin/python'} 15:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:12 INFO - Downloading/unpacking psutil>=3.1.1 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:14 INFO - Installing collected packages: psutil 15:12:14 INFO - Running setup.py install for psutil 15:12:14 INFO - building 'psutil._psutil_linux' extension 15:12: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 15:12: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 15:12:14 INFO - building 'psutil._psutil_posix' extension 15:12: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 15:12: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 15:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:14 INFO - Successfully installed psutil 15:12:14 INFO - Cleaning up... 15:12:14 INFO - Return code: 0 15:12:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:14 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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:14 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 15:12:14 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 15:12:14 INFO - Using env: {'DISPLAY': ':0', 15:12:14 INFO - 'HOME': '/home/cltbld', 15:12:14 INFO - 'LANG': 'en_US.UTF-8', 15:12:14 INFO - 'LANGUAGE': 'en_US:en', 15:12:14 INFO - 'LOGNAME': 'cltbld', 15:12:14 INFO - 'MAIL': '/var/mail/cltbld', 15:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:14 INFO - 'MOZ_NO_REMOTE': '1', 15:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:14 INFO - 'NO_EM_RESTART': '1', 15:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:14 INFO - 'PWD': '/builds/slave/test', 15:12:14 INFO - 'SHELL': '/bin/bash', 15:12:14 INFO - 'SHLVL': '1', 15:12:14 INFO - 'TERM': 'linux', 15:12:14 INFO - 'TMOUT': '86400', 15:12:14 INFO - 'USER': 'cltbld', 15:12:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:14 INFO - '_': '/tools/buildbot/bin/python'} 15:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:12:17 INFO - Installing collected packages: mozsystemmonitor 15:12:17 INFO - Running setup.py install for mozsystemmonitor 15:12:17 INFO - Successfully installed mozsystemmonitor 15:12:17 INFO - Cleaning up... 15:12:17 INFO - Return code: 0 15:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', '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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:12: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 blobuploader==1.2.4 15:12:17 INFO - Using env: {'DISPLAY': ':0', 15:12:17 INFO - 'HOME': '/home/cltbld', 15:12:17 INFO - 'LANG': 'en_US.UTF-8', 15:12:17 INFO - 'LANGUAGE': 'en_US:en', 15:12:17 INFO - 'LOGNAME': 'cltbld', 15:12:17 INFO - 'MAIL': '/var/mail/cltbld', 15:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:17 INFO - 'MOZ_NO_REMOTE': '1', 15:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:17 INFO - 'NO_EM_RESTART': '1', 15:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:17 INFO - 'PWD': '/builds/slave/test', 15:12:17 INFO - 'SHELL': '/bin/bash', 15:12:17 INFO - 'SHLVL': '1', 15:12:17 INFO - 'TERM': 'linux', 15:12:17 INFO - 'TMOUT': '86400', 15:12:17 INFO - 'USER': 'cltbld', 15:12:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:17 INFO - '_': '/tools/buildbot/bin/python'} 15:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:20 INFO - Downloading docopt-0.6.1.tar.gz 15:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:20 INFO - Running setup.py install for blobuploader 15:12:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:20 INFO - Running setup.py install for requests 15:12:20 INFO - Running setup.py install for docopt 15:12:20 INFO - Successfully installed blobuploader requests docopt 15:12:20 INFO - Cleaning up... 15:12:20 INFO - Return code: 0 15:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:20 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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:20 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 15:12:20 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 15:12:20 INFO - Using env: {'DISPLAY': ':0', 15:12:20 INFO - 'HOME': '/home/cltbld', 15:12:20 INFO - 'LANG': 'en_US.UTF-8', 15:12:20 INFO - 'LANGUAGE': 'en_US:en', 15:12:20 INFO - 'LOGNAME': 'cltbld', 15:12:20 INFO - 'MAIL': '/var/mail/cltbld', 15:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:20 INFO - 'MOZ_NO_REMOTE': '1', 15:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:20 INFO - 'NO_EM_RESTART': '1', 15:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:20 INFO - 'PWD': '/builds/slave/test', 15:12:20 INFO - 'SHELL': '/bin/bash', 15:12:20 INFO - 'SHLVL': '1', 15:12:20 INFO - 'TERM': 'linux', 15:12:20 INFO - 'TMOUT': '86400', 15:12:20 INFO - 'USER': 'cltbld', 15:12:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:20 INFO - '_': '/tools/buildbot/bin/python'} 15:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:21 INFO - Running setup.py (path:/tmp/pip-r2DXCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:21 INFO - Running setup.py (path:/tmp/pip-IW5Os4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:21 INFO - Running setup.py (path:/tmp/pip-eswb8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:21 INFO - Running setup.py (path:/tmp/pip-CLHOKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:21 INFO - Running setup.py (path:/tmp/pip-z2maj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:21 INFO - Running setup.py (path:/tmp/pip-fU3gm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:21 INFO - Running setup.py (path:/tmp/pip-sDWJHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:21 INFO - Running setup.py (path:/tmp/pip-HKAVdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:21 INFO - Running setup.py (path:/tmp/pip-QKevDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:21 INFO - Running setup.py (path:/tmp/pip-BYLKb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:21 INFO - Running setup.py (path:/tmp/pip-V9Txnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:21 INFO - Running setup.py (path:/tmp/pip-hO5RJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:21 INFO - Running setup.py (path:/tmp/pip-nyHqXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:21 INFO - Running setup.py (path:/tmp/pip-DeJfiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:22 INFO - Running setup.py (path:/tmp/pip-4QkTte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:22 INFO - Running setup.py (path:/tmp/pip-jpgA4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:22 INFO - Running setup.py (path:/tmp/pip-Ax37ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:22 INFO - Running setup.py install for manifestparser 15:12:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:22 INFO - Running setup.py install for mozcrash 15:12:22 INFO - Running setup.py install for mozdebug 15:12:22 INFO - Running setup.py install for mozdevice 15:12:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:22 INFO - Running setup.py install for mozfile 15:12:22 INFO - Running setup.py install for mozhttpd 15:12:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:22 INFO - Running setup.py install for mozinfo 15:12:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:22 INFO - Running setup.py install for mozInstall 15:12:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Running setup.py install for mozleak 15:12:23 INFO - Running setup.py install for mozlog 15:12:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Running setup.py install for moznetwork 15:12:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Running setup.py install for mozprocess 15:12:23 INFO - Running setup.py install for mozprofile 15:12:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Running setup.py install for mozrunner 15:12:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:23 INFO - Running setup.py install for mozscreenshot 15:12:23 INFO - Running setup.py install for moztest 15:12:23 INFO - Running setup.py install for mozversion 15:12:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:24 INFO - Cleaning up... 15:12:24 INFO - Return code: 0 15:12:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:24 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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:24 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 15:12:24 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 15:12:24 INFO - Using env: {'DISPLAY': ':0', 15:12:24 INFO - 'HOME': '/home/cltbld', 15:12:24 INFO - 'LANG': 'en_US.UTF-8', 15:12:24 INFO - 'LANGUAGE': 'en_US:en', 15:12:24 INFO - 'LOGNAME': 'cltbld', 15:12:24 INFO - 'MAIL': '/var/mail/cltbld', 15:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:24 INFO - 'MOZ_NO_REMOTE': '1', 15:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:24 INFO - 'NO_EM_RESTART': '1', 15:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:24 INFO - 'PWD': '/builds/slave/test', 15:12:24 INFO - 'SHELL': '/bin/bash', 15:12:24 INFO - 'SHLVL': '1', 15:12:24 INFO - 'TERM': 'linux', 15:12:24 INFO - 'TMOUT': '86400', 15:12:24 INFO - 'USER': 'cltbld', 15:12:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:24 INFO - '_': '/tools/buildbot/bin/python'} 15:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:24 INFO - Running setup.py (path:/tmp/pip-VJiMUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:24 INFO - Running setup.py (path:/tmp/pip-RHthpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:24 INFO - Running setup.py (path:/tmp/pip-uY1v2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:24 INFO - Running setup.py (path:/tmp/pip-xmezkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:24 INFO - Running setup.py (path:/tmp/pip-10Ahc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:24 INFO - Running setup.py (path:/tmp/pip-Xoyww7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:24 INFO - Running setup.py (path:/tmp/pip-l2KZ4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:24 INFO - Running setup.py (path:/tmp/pip-4zQHjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:24 INFO - Running setup.py (path:/tmp/pip-Es7uCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:24 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:24 INFO - Running setup.py (path:/tmp/pip-ovkz1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:24 INFO - Running setup.py (path:/tmp/pip-dNDws1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:25 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:25 INFO - Running setup.py (path:/tmp/pip-kfDbvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:25 INFO - Running setup.py (path:/tmp/pip-rTHIqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:25 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:25 INFO - Running setup.py (path:/tmp/pip-AePmkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:25 INFO - Running setup.py (path:/tmp/pip-lCkh_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:25 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:25 INFO - Running setup.py (path:/tmp/pip-ttCEVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:25 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)) 15:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:25 INFO - Running setup.py (path:/tmp/pip-3KM7Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:25 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)) 15:12:25 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)) 15:12:25 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)) 15:12:25 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)) 15:12:25 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)) 15:12:25 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)) 15:12:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:25 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 15:12:25 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 15:12:25 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 15:12:25 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 15:12:25 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 15:12:25 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 15:12:27 INFO - Downloading blessings-1.6.tar.gz 15:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:27 INFO - Installing collected packages: blessings 15:12:27 INFO - Running setup.py install for blessings 15:12:27 INFO - Successfully installed blessings 15:12:27 INFO - Cleaning up... 15:12:27 INFO - Return code: 0 15:12:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:27 INFO - Reading from file tmpfile_stdout 15:12:27 INFO - Current package versions: 15:12:27 INFO - argparse == 1.2.1 15:12:27 INFO - blessings == 1.6 15:12:27 INFO - blobuploader == 1.2.4 15:12:27 INFO - docopt == 0.6.1 15:12:27 INFO - manifestparser == 1.1 15:12:27 INFO - mozInstall == 1.12 15:12:27 INFO - mozcrash == 0.17 15:12:27 INFO - mozdebug == 0.1 15:12:27 INFO - mozdevice == 0.48 15:12:27 INFO - mozfile == 1.2 15:12:27 INFO - mozhttpd == 0.7 15:12:27 INFO - mozinfo == 0.9 15:12:27 INFO - mozleak == 0.1 15:12:27 INFO - mozlog == 3.2 15:12:27 INFO - moznetwork == 0.27 15:12:27 INFO - mozprocess == 0.22 15:12:27 INFO - mozprofile == 0.28 15:12:27 INFO - mozrunner == 6.11 15:12:27 INFO - mozscreenshot == 0.1 15:12:27 INFO - mozsystemmonitor == 0.3 15:12:27 INFO - moztest == 0.7 15:12:27 INFO - mozversion == 1.4 15:12:27 INFO - psutil == 3.1.1 15:12:27 INFO - requests == 1.2.3 15:12:27 INFO - wsgiref == 0.1.2 15:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:27 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')]} 15:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:27 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')]} 15:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:27 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 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:27 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 15:12:27 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 15:12:27 INFO - Using env: {'DISPLAY': ':0', 15:12:27 INFO - 'HOME': '/home/cltbld', 15:12:27 INFO - 'LANG': 'en_US.UTF-8', 15:12:27 INFO - 'LANGUAGE': 'en_US:en', 15:12:27 INFO - 'LOGNAME': 'cltbld', 15:12:27 INFO - 'MAIL': '/var/mail/cltbld', 15:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:27 INFO - 'MOZ_NO_REMOTE': '1', 15:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:27 INFO - 'NO_EM_RESTART': '1', 15:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:27 INFO - 'PWD': '/builds/slave/test', 15:12:27 INFO - 'SHELL': '/bin/bash', 15:12:27 INFO - 'SHLVL': '1', 15:12:27 INFO - 'TERM': 'linux', 15:12:27 INFO - 'TMOUT': '86400', 15:12:27 INFO - 'USER': 'cltbld', 15:12:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:27 INFO - '_': '/tools/buildbot/bin/python'} 15:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 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)) 15:12:28 INFO - Cleaning up... 15:12:28 INFO - Return code: 0 15:12:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:12:28 INFO - Using env: {'DISPLAY': ':0', 15:12:28 INFO - 'HOME': '/home/cltbld', 15:12:28 INFO - 'LANG': 'en_US.UTF-8', 15:12:28 INFO - 'LANGUAGE': 'en_US:en', 15:12:28 INFO - 'LOGNAME': 'cltbld', 15:12:28 INFO - 'MAIL': '/var/mail/cltbld', 15:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:28 INFO - 'MOZ_NO_REMOTE': '1', 15:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:28 INFO - 'NO_EM_RESTART': '1', 15:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:28 INFO - 'PWD': '/builds/slave/test', 15:12:28 INFO - 'SHELL': '/bin/bash', 15:12:28 INFO - 'SHLVL': '1', 15:12:28 INFO - 'TERM': 'linux', 15:12:28 INFO - 'TMOUT': '86400', 15:12:28 INFO - 'USER': 'cltbld', 15:12:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:28 INFO - '_': '/tools/buildbot/bin/python'} 15:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:28 INFO - Downloading/unpacking jsonschema 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:30 INFO - Downloading/unpacking functools32 (from jsonschema) 15:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:30 INFO - warning: no files found matching '*.txt' 15:12:30 INFO - no previously-included directories found matching 'build' 15:12:30 INFO - no previously-included directories found matching 'dist' 15:12:30 INFO - no previously-included directories found matching '.git*' 15:12:30 INFO - Installing collected packages: jsonschema, functools32 15:12:30 INFO - Running setup.py install for functools32 15:12:30 INFO - warning: no files found matching '*.txt' 15:12:30 INFO - no previously-included directories found matching 'build' 15:12:30 INFO - no previously-included directories found matching 'dist' 15:12:30 INFO - no previously-included directories found matching '.git*' 15:12:30 INFO - Successfully installed jsonschema functools32 15:12:30 INFO - Cleaning up... 15:12:30 INFO - Return code: 0 15:12:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7041832f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2564770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', '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 15:12: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', 'flake8'] in /builds/slave/test/build 15:12: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 flake8 15:12:30 INFO - Using env: {'DISPLAY': ':0', 15:12:30 INFO - 'HOME': '/home/cltbld', 15:12:30 INFO - 'LANG': 'en_US.UTF-8', 15:12:30 INFO - 'LANGUAGE': 'en_US:en', 15:12:30 INFO - 'LOGNAME': 'cltbld', 15:12:30 INFO - 'MAIL': '/var/mail/cltbld', 15:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:30 INFO - 'MOZ_NO_REMOTE': '1', 15:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:30 INFO - 'NO_EM_RESTART': '1', 15:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:30 INFO - 'PWD': '/builds/slave/test', 15:12:30 INFO - 'SHELL': '/bin/bash', 15:12:30 INFO - 'SHLVL': '1', 15:12:30 INFO - 'TERM': 'linux', 15:12:30 INFO - 'TMOUT': '86400', 15:12:30 INFO - 'USER': 'cltbld', 15:12:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:30 INFO - '_': '/tools/buildbot/bin/python'} 15:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:30 INFO - Downloading/unpacking flake8 15:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:12:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:12:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:32 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 15:12:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:33 INFO - no previously-included directories found matching 'docs/_build' 15:12:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:12:33 INFO - Running setup.py install for pep8 15:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:33 INFO - no previously-included directories found matching 'docs/_build' 15:12:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:12:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:12:33 INFO - Cleaning up... 15:12:33 INFO - Return code: 0 15:12:33 INFO - Running post-action listener: _resource_record_post_action 15:12:33 INFO - Running post-action listener: _start_resource_monitoring 15:12:33 INFO - Starting resource monitoring. 15:12:33 INFO - ##### 15:12:33 INFO - ##### Finished create-virtualenv step (success) 15:12:33 INFO - ##### 15:12:33 INFO - ##### 15:12:33 INFO - ##### Running install step. 15:12:33 INFO - ##### 15:12:33 INFO - Running pre-action listener: _resource_record_pre_action 15:12:33 INFO - Running main action method: install 15:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:33 INFO - Reading from file tmpfile_stdout 15:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:34 INFO - Reading from file tmpfile_stdout 15:12:34 INFO - Output received: 15:12:34 INFO - Usage: mozinstall [options] installer 15:12:34 INFO - Options: 15:12:34 INFO - -h, --help show this help message and exit 15:12:34 INFO - -d DEST, --destination=DEST 15:12:34 INFO - Directory to install application into. [default: 15:12:34 INFO - "/builds/slave/test"] 15:12:34 INFO - --app=APP Application being installed. [default: firefox] 15:12:34 INFO - mkdir: /builds/slave/test/build/application 15:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:12:49 INFO - Reading from file tmpfile_stdout 15:12:49 INFO - Output received: 15:12:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:12:49 INFO - Running post-action listener: _resource_record_post_action 15:12:49 INFO - ##### 15:12:49 INFO - ##### Finished install step (success) 15:12:49 INFO - ##### 15:12:49 INFO - ##### 15:12:49 INFO - ##### Running run-tests step. 15:12:49 INFO - ##### 15:12:49 INFO - Running pre-action listener: _resource_record_pre_action 15:12:49 INFO - Running main action method: run_tests 15:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:12:49 INFO - Python 2.7.3 15:12:49 INFO - Return code: 0 15:12:49 INFO - grabbing minidump binary from tooltool 15:12:49 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')]} 15:12:49 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 0x25f39c0>, '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 0x25f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:12:49 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 15:12:49 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 15:12:49 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 15:12:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:12:49 INFO - Return code: 0 15:12:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:12:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:12:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:12:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:12:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:12:50 INFO - Return code: 0 15:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 15:12:50 INFO - Using env: {'DISPLAY': ':0', 15:12:50 INFO - 'HOME': '/home/cltbld', 15:12:50 INFO - 'LANG': 'en_US.UTF-8', 15:12:50 INFO - 'LANGUAGE': 'en_US:en', 15:12:50 INFO - 'LOGNAME': 'cltbld', 15:12:50 INFO - 'MAIL': '/var/mail/cltbld', 15:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:50 INFO - 'MOZ_NO_REMOTE': '1', 15:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:50 INFO - 'NO_EM_RESTART': '1', 15:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:50 INFO - 'PWD': '/builds/slave/test', 15:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:50 INFO - 'SHELL': '/bin/bash', 15:12:50 INFO - 'SHLVL': '1', 15:12:50 INFO - 'TERM': 'linux', 15:12:50 INFO - 'TMOUT': '86400', 15:12:50 INFO - 'USER': 'cltbld', 15:12:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011', 15:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:50 INFO - '_': '/tools/buildbot/bin/python'} 15:12:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:12:51 INFO - mozversion application_buildid: 20160517135343 15:12:51 INFO - mozversion application_changeset: 991f249a6ffa07e1ccb87ab657d71c4522429058 15:12:51 INFO - mozversion application_display_name: Nightly 15:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:12:51 INFO - mozversion application_name: Firefox 15:12:51 INFO - mozversion application_remotingname: firefox 15:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:12:51 INFO - mozversion application_vendor: Mozilla 15:12:51 INFO - mozversion application_version: 49.0a1 15:12:51 INFO - mozversion platform_buildid: 20160517135343 15:12:51 INFO - mozversion platform_changeset: 991f249a6ffa07e1ccb87ab657d71c4522429058 15:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:12:51 INFO - mozversion platform_version: 49.0a1 15:12:51 INFO - using testdate: 1463523171 15:12:51 INFO - actual date: 1463523171 15:12:51 INFO - starting webserver on 'localhost:33518' 15:12:51 INFO - SUITE-START | Running 2 tests 15:12:51 INFO - TEST-START | dromaeo_css 15:12:51 INFO - operating with platform_type : linux_ 15:12:51 INFO - Initialising browser for dromaeo_css test... 15:12:51 INFO - TEST-INFO | started process 12628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCv6qbn/profile http://localhost:33518/getInfo.html) 15:12:55 INFO - PROCESS | 12628 | __metrics Screen width/height:1600/1200 15:12:55 INFO - PROCESS | 12628 | colorDepth:24 15:12:55 INFO - PROCESS | 12628 | Browser inner width/height: 1024/697 15:12:55 INFO - PROCESS | 12628 | __metrics 15:12:56 ERROR - PROCESS | 12628 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:12:56 INFO - TEST-INFO | 12628: exit 0 15:12:56 INFO - Browser initialized. 15:12:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:12:56 INFO - TEST-INFO | started process 12712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCv6qbn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:08 INFO - PROCESS | 12712 | RSS: Main: 153788416 15:13:08 INFO - PROCESS | 12712 | 15:13:59 INFO - PROCESS | 12712 | 1463523239968 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] 15:16:12 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33518/tests/dromaeo/cssquery-ext.html) 15:16:13 INFO - PROCESS | 12712 | RSS: Main: 230715392 15:16:13 INFO - PROCESS | 12712 | 15:19:16 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-ext.html (next: http://localhost:33518/tests/dromaeo/cssquery-jquery.html) 15:19:17 INFO - PROCESS | 12712 | RSS: Main: 236335104 15:19:17 INFO - PROCESS | 12712 | 15:22:19 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33518/tests/dromaeo/cssquery-mootools.html) 15:22:19 INFO - PROCESS | 12712 | RSS: Main: 242970624 15:22:19 INFO - PROCESS | 12712 | 15:25:21 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33518/tests/dromaeo/cssquery-prototype.html) 15:25:22 INFO - PROCESS | 12712 | RSS: Main: 227463168 15:25:22 INFO - PROCESS | 12712 | 15:28:25 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33518/tests/dromaeo/cssquery-yui.html) 15:28:26 INFO - PROCESS | 12712 | RSS: Main: 223711232 15:28:26 INFO - PROCESS | 12712 | 15:31:28 INFO - PROCESS | 12712 | Cycle 1(1): loaded http://localhost:33518/tests/dromaeo/cssquery-yui.html (next: http://localhost:33518/tests/dromaeo/cssquery-dojo.html) 15:31:29 INFO - PROCESS | 12712 | RSS: Main: 240676864 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | __start_tp_report 15:31:29 INFO - PROCESS | 12712 | _x_x_mozilla_page_load 15:31:29 INFO - PROCESS | 12712 | _x_x_mozilla_page_load_details 15:31:29 INFO - PROCESS | 12712 | |i|pagename|runs| 15:31:29 INFO - PROCESS | 12712 | |0;dojo.html;2657.813953023288;2670.612761149632;2701.9459610807785;2704.743049410306;2707.0660622085375;4659.534046595339;4725.929111063332;4748.477667456577;4806.711597304165;4870.24511200764;4750.97624511877;4773.069251495951;4823.107725070864;4829.251466022763;4887.804487820483;4334.111507141037;4336.046069864625;4413.911721765563;4479.596836284733;4582.037772067853;4478.0596074824325;4520.434945631796;4545.568171023748;4550.522195169509;4556.703814252063;4282.272013757669;4335.674824388184;4340.934885976713;4346.847860324905;4424.491183513905;4361.498427680825;4363.847265345729;4374.562543745632;4408.316710909782;4419.4033805436175;4397.934030989538;4417.182821178092;4420.138073075752;4446.088551846864;4465.508794032654;4591.265397536412;4685.554872287127;4710.646701497401;4737.455192652855;4790.065937142259;5208.218767184915;5219.765110569995;5227.60792940531;5234.7644356004075;5235.110031294651;5185.118529849935;5211;5211.348581427322;5215.58275337972;5217.973910130425;4660.743659098782;4745.3593764842;4801.975990120027;4803.159447096814;4835.226363781813;5274.446183150791;5306.7611957462;5321.946780532223;5331.973340133274;5335.599830012765;5039.924401133986;5087.033463641897;5093.0577843099145;5094.796208151706;5097.796088156507;4948.480409557017;5080.974595127001;5108.846734597968;5135.35808023997;5178.197379406198;5089.134847076006;5112.105381558287;5120.769565369493;5123.3339665843205;5186.144286192736;4947.554720075211;5107.41264754558;5111;5112.130937740593;5119.411267704188;4241.27898257297;4265.637420819203;4295.806688699016;4306.784660766949;4320.611144996902;3732.1789206374556;3764.3412402829395;3772.660460558563;3808.409696497047;3815.8473661053804;4308.202982448257;4441.644668426518;4443.622292105208;4493.707908985971;4500.122476117192;5102.183650615883;5149.588032957429;5161.612879034087;5165.070287348238;5178.844634660966;4437.489688685842;4441.489228738672;4441.777911104432;4445.599896009375;4467.084247729208;4482.058767658763;4525.592696657251;4584.4498660161;4589;4626.051659409813;4866.464688884149;4870.683405578555;4892.902141957212;4902.509749025069;4938.728369939688;5116.539511443988;5151.5106064923775;5167.58659307262;5172.586193104467;5222.242774797709;4717.551832575899;4830.855074347775;4863.076015557032;4871.293662419001;4948.653594248368;5051.570616497639;5059.367579052619;5080.847574572768;5084.771185296597;5119.027384797026;5143.074246635641;5154.458781827854;5154.587632989277;5159.432462429055;5190.429052804113;4890.462049174517;4965.45380008206;4982.427020892499;4984.476629953802;5019.222020586815;5011.09800235961;5023.196288593954;5029.874253143701;5037.546620803999;5058.3929928408825;4938.901221975612;4950.6782059166035;4991.575716064175;4995.500449954975;5000.4749501303295;4895.069936712013;4960.082384758831;4988.102141614544;5027.748612569284;5096.566791822736;4944.777485013111;4972.8508144755715;4973.726445045557;4980.153373926369;5027.84916452507 15:31:29 INFO - PROCESS | 12712 | |1;ext.html;579.7304253522111;595.7259660556144;611.7063809371499;615.0804547201931;628.8585068359622;28546.714532854665;29041.56437653434;31074.22314442143;31141.532877006863;41576.37635435471;42488.787556062176;43945.78027109868;44037.33943990835;44594.55405445945;47947.520524794745;7783.92216077839;7941.36469082472;7942.086660034083;7943.920560794405;7944.086430060559;7473.3647639950395;7741.341985931174;7845.607719614025;9981.850272245922;10232.488375581228;10350.430726310049;10354.637587684432;10409.791804163911;10418.333066709329;10422.687319380431;10135.391876487398;10254.179665626732;10279.640212592523;10289.27975041751;10299;10035.59857605695;10139.493025348704;10139.746506337327;10144;10151.187904967584;40281.79859100715;40628.59371406278;40629.59370406317;40637.18725625471;40728;3214.694604012615;3216.8713251469912;3244.3511297740547;3398.793428332931;3545.8758943437115;27207;27254;29736.8513157435;30553;31499;3545.3618348697223;3580.8925732228076;3594.281143771256;3595.352836489431;3680.907977300562;265431;267076.6400183982;267223;267366;267546.66226668935;56910.430895691345;57534.7123264381;57569.71215143897;57715.422845771005;57826.71086644624;59950;60024.39975600276;60049.399506005255;60077.69961150167;60240.698796505734;12816.166949148275;13209.07536472457;13210.933945330213;13211;13217.537386191629;9427.104425079606;9443.669471568463;9447.433154010781;9451.243900487945;9601.903980960102;16695.165241737865;17262.482125536255;17324.133793310284;17631.64736705259;17824.3761468348;6268.968655156787;6285.43431091204;6312.747490100436;6450.161479007699;6608.107905432801;904.4618452021037;951.1059603972244;1039.5633833789827;1047.9999999999848;1074.006543946846;28866.711332886403;28875.278118047216;28914.85542572316;29038;29427.85286073556;1018.7504061504978;1047.664747280863;1053.952572134256;1072.3940973350032;1092.470151976291;15284;15359.769603455958;15421.845781542266;15636.140012299433;15762.448314308944;402756;403963;406125;408605;408935;52159;52169.2174617381;52317;52376.47623523716;52405.973313068724;1142.348861149137;1234.2409418207917;1261.8485781706254;1264.3994102801096;1265.3483456020158;28771.712282876902;29966.70033299726;30230.697693022787;30280.394392112474;30764.538531921593;44224.33663494986;44545.77727111344;44706.55293447154;44891.326630101226;44905.77547112243;249625;249892;250209;250269;250828;31922;33065.338693226484;37076;38111.04722381962;38142;43954.780226098665;44223;44257;44535.55464445314;45586.31620525761;36851;36993.63006369902;37606.62393376031;37798.62201378061;37998.43002355022;36010.578994995434;36372.45441318435;37417.81291093636;37849.24301514009;41745;37312;37774.811125944194;38253.42619860649;38354.23291534098;38565.22869542649;33393.83303083469;33849.3230135391;34249.65750342465;34441;34462.48306275358;26573.468530629667;27602.723972760014;27901.162965111078;27946.58080128759;28022.719772802826 15:31:29 INFO - PROCESS | 12712 | |2;jquery.html;373.7738668105796;379.5218025288138;383.20102586107964;388.9649931506164;390.59378246623515;16304.755428668579;17449.389271375505;18213.81786182138;18377;18383.632327353444;16775.91612041941;16810.663786724257;16868.578285542866;17671.823281767178;17687.82312176878;4951.851444456672;5305.973470132663;5330.600204984622;5339.759710813023;5366.731663416833;3700.463432802242;3827.54069511659;3890.6498415142632;5578.24693666356;6307.936920630781;6213.937860621381;6234.251889773233;6243.125962365272;6253.906191407133;6261.592996455239;5386.73066346683;5391.24522566839;5875.441833025856;6088.299845517778;6256.092866534373;3414.6756058174433;5121.078205922932;5424.810131645373;5428.022955867942;5478.096114141202;20609.484762880897;21174.258900938392;21214.36356909295;21635.350939471842;21653;2100.7479102507646;2106.6313395155785;2287.1194590082773;2395.568797616428;2601.9089331873292;12872.485100595964;13430.664233394244;13529.864701352959;13998.860011399858;14082.788758168635;1766.3994241957669;1796.4520821149545;1846.2984066054814;1885.981140188608;1912.407153782332;58337.416625833626;59456.40543594552;59797.7010114951;68004.9999999995;68307.3169268306;10188.796224075626;10400.531976061095;10537.157027437786;10569.414587811736;10620.681379558471;14540.709185816437;14593.270336483345;14632.268386580841;14641.194734289717;14655.706885862437;6808.5914845109455;7069.974853646192;7070.151581810215;7169.605671688108;7192.31672991065;6405.519586031066;6438.678066096676;6461.483081353481;6516.283208847023;6562.475001999828;4353.73877567347;4417.116576684676;4563.817447302137;4587.7017993830295;4588.977055114703;1832.2945665918717;1867.310084373644;1882.510547257723;1907.6661584222707;1945.114972687424;837.5602808525573;858.3991206155716;872.8908886389202;894.9821003579892;944.7024187380953;16588.58528536796;17306.740398894028;17415.129243537773;17707.46877593674;17792;890.2388457868559;907.9228265597499;909.3907082254905;911.48956584313;918.6968300460832;8563.400561960603;9730;9946;9949.159405510003;9958.900410995942;369054;376175.59561011195;407947;412617;413291;77932;84007.57996210102;84077.92207792208;84208;85748;934.8130373925242;968.1625394034251;987.3659094199112;989.2202909823276;990.9058639429243;15509.457168999032;15965.28156232949;16303.59241018984;16353.100579468244;16384.75422868682;36264;36326.27347453089;37256.25487490181;37268.440973385965;38265.617343826205;49740.50259497359;51276.48723512866;52037.47962520326;52394.214086787964;52808.73595631997;7522.285382888617;7551.018367612175;7898.723544675909;7953.8409231813885;8066.475679080841;10234.283600147919;11744.29534227949;11808.055355571705;12201.20692155007;12304.876951230373;9984.700458986243;10380.792384152124;10627.202959777893;10820;11329.943350283196;10694.037536621741;11069.944650276697;11078.501467434146;11088.833667494833;11352.54589816398;10680.83978740335;10952.34285942846;11277.830832537355;11345.659630211107;11623.070154387799;8108.716194933149;8173.223543763333;8233.711820086508;8353.791155221168;8358.582070896553;8127.878081828895;10687.198460115678;10743.301685390425;10785.676429707122;10820.080293175168 15:31:29 INFO - PROCESS | 12712 | |3;mootools.html;1301.9804702929464;1436.253148362851;1501.8648321651049;1604.9759253611192;1811.5652243461566;6713.765018224363;7646.541207527553;7861.606919654023;7872.9212707872975;8163.877541836877;7817.335526480256;8007.19928007199;8007.359411247101;8018.599070046504;8022.318102961255;2292.7363353214387;2330.0563271874835;2334.241371554243;2337.31049340445;2339.3215967369442;2264.4904896398343;2286.314105768263;2321.0599707118645;2322.7909488146065;2324.9883750581225;2274.1812947338944;2286.7713228677167;2295.8622482651094;2305.250793492113;2308.2959697292317;2247.381969958258;2261.8529795563236;2263.7283525976986;2267.693861328716;2267.841251112423;2225.5326381459913;2230.375494861425;2232.631615783394;2233.7877901599322;2233.9218127365625;7737.961310193469;7920.445568810185;7981.840363192761;7983.12185659577;8005.839883202303;4610.838620648295;4750.168720473937;4751.501092385319;4753;4757.215059515176;3026.44407744195;3089.1968088297203;3113.3306339136966;3132.1699749566383;3147.5750773645495;890.0609856601283;901.6753968571309;907.2152588011388;914.4604683236922;974.8294048541477;10979.451027448675;11050.392228427352;11060.22578419511;11070.28043177191;11084.279521831137;4168.979155104205;4262;4351.82592696295;4352.73883566987;4363.192809330284;8735.039145693969;8783.121687831293;8788.121187881161;8791.560421978875;8824.91175088241;4633.30500424939;4643.814247430132;4644.094401591725;4644.303354496852;4653.022865198346;3781.1303400218103;4007.1785284016705;4178.12259425518;4181.853635122756;4213;3534.6288639692975;3568.518250036212;3592.2276710507367;3640.6541378568995;3662.1393972416463;1051.8737751469873;1058.629479682105;1065.6909496246158;1067.0449947297125;1079.422508957704;718.5150023733959;775.1744392222265;874.6763697431991;893.5666201892207;897.6902968475865;5295.920561191509;5485.890282194414;5591.329040515083;5647.717614119278;5708.029634962067;924.912133347331;950.0736781637847;973.1387721866058;992.0476342711078;999.7800483893532;3700.278445703062;3768.6796622286865;3773.4339849022867;3787.4697542344093;3934.940975885364;9407.811843763224;9836.704898853046;9864.161546268648;9864.704058878246;9870.851937220947;9613.663521776703;9722.465264410524;9730.12428881404;9744.07431294026;9747.268954828416;7215.206327303992;7342.302481264378;7350.852982940311;7359.264073592705;7364.153122390993;5248.081585722407;5374.704391258519;5402.216678581663;5474.972625136849;5646.407127251744;8723.389362744547;9218.585163667785;9233.49215793111;9240.445573265626;9243.075692430702;8864.512451815212;9261.53692315395;9344.766380840534;9459.243260539002;9468.242540596599;6443.484521238383;6477.352264773485;6522.249941256816;6525.510586705921;6585.473162147113;7386.2613738625705;7553.395728341829;7560.773176804704;7565.773026809205;7568.508046976929;6120.846978825387;6359.332270111571;6779.542398384371;6982.301769822977;7238.167610724623;6877.140357455318;6958.79123626292;6992.615406152507;7013.4038606719005;7105.076340075757;6489.123968264413;6687.531872768859;6691.732330706717;6698.330166983457;6713.496487763339;4613.907721845611;4621.537846215351;4673.158831410379;4677.368555244999;4721.952780472151;4720.976395118002;4802.087603355351;4849.830255941025;4863.10032643962;4929.630277729257 15:31:29 INFO - PROCESS | 12712 | |4;prototype.html;295.6275093382338;302.87582091342546;303.39775545542096;320.40884567972086;320.6008519393354;4874.7082023263865;4947.03532811102;4965.677230979988;4967.155583550796;4992.700437973725;4636.582707556319;4692.97653511732;4771.665983381165;4815.3258543803895;4870.780814863339;3858;3885.5531613864414;3890.9416358754643;3894.9610503894883;3898.902527436808;3868.7485313454536;3890.8054597270166;3892.3188442022674;3894.5131858517684;3898.5126859142606;3533.4699795030824;3660.7437479376454;3749.137698329386;3767.6232376762377;3865.6907447404283;3850.9229815403814;3855.652991230803;3856.3444214483325;3863.903402414934;3867.439221312908;3432.1591210153424;3432.8970130896114;3435.209901722593;3448.2413868948793;3452.913677158066;4453.332000199964;4660.790264438108;4667.043256132485;4674.579287864074;4700.811967521295;4303.784810759481;4319.4816622005565;4339.153864996327;4345.608895199415;4352.477702675667;5078.695278283315;5093.516115969014;5111.258867464197;5117.7185254810975;5127.615428842814;3569.214772749991;3620.837062332175;3630.8729194478333;3645.434957581579;3666.5966743658178;5232.2413250078525;5344.759485823109;5350.598705097094;5350.732463376816;5352.4915133062295;3688.9077773055888;3701.0939366226416;3703.6851867591017;3720.2001569662652;3730.235301763132;3755.5916531300763;3761.9247615047548;3765.981170094132;3793.6585707286476;3795.1271207622403;4142.855000074983;4299.892502687395;4306.20335237982;4361.760103194355;4391.956080439219;5029.346184995927;5057.696538207646;5070.594352451795;5105.668131571436;5106.259592359087;1291.7933130699043;1304.6673098359859;1306.288073000217;1310.1287643717012;1313.1989486413281;836.9874451883227;878.2359347367703;903.846346121161;904.213334399077;908.5684299957468;4508.797104130322;4522.841700540531;4531.546845315508;4557.817687292471;4566.292224705176;5250.3962044364625;5250.947490525123;5252.579793616502;5267.26258323835;5267.920981185285;4344.147247080873;4519.0058187198765;4522.932156017597;4529.369427006275;4539.341795439643;2808.4383123375405;2810.761085307731;2813.563897595876;2818.3236023354248;2822.802403831753;4962.751862406937;4963.45402005779;4977.278294647256;5011.346255735599;5014.172661510883;5219.973900130475;5346.331708536433;5366.792471693916;5375.193720941812;5395.3525576931015;4907.141250281258;4944.381952255968;4958.9008219835405;4994.275830004629;4994.400671919393;5104.3619547556555;5104.489551045014;5151.793928242828;5166.483351664803;5200.739963001911;4875.7074575525585;5080.771365288645;5106.642535022513;5112.3865136183895;5117;4898.387701537308;4915.21356582945;4916.803327866988;4938.888500244822;4947.579455746158;3691.4831923531265;3709.9072523187137;3718.8326525305883;3741.0834345585504;3741.85032598693;4905.313256144072;5140.408852981955;5141.71720555373;5142.562882155059;5211.895762084661;4967.975160124176;4980.427250866197;4989.476105009067;4991.677205540607;5010.824621138243;5016.423111342242;5018.974905125451;5038.647294689336;5042.647014708935;5047.697138171721;4782.306565548046;4798.640101992295;4959.528844759742;5069.518395752545;5076.923846142385;5015.673981191211;5020.874478138076;5026.296318515484;5040.697558146523;5051.06555287273;4897.2654101885;4987.825426110068;4998.225275082368;5021.171506701354;5037.294778730908 15:31:29 INFO - PROCESS | 12712 | |5;yui.html;685.4756111574645;719.8236432074143;734.0823970037453;739.2201227704769;739.5156172706876;11490.942545287273;11580.305181689104;11606.535738570457;11613.419329033535;11760.647180584585;11494.885051149486;11512.654620361382;11566.826497602522;11576.768464630703;11586.942065289682;673.135021497376;835.9582020898961;858.6694122762719;859.6948083430386;869.3610196505564;848.5248260973874;852.3820230333021;854.2824027816632;854.6239654551978;855.8673405622108;714.8034290570109;904.5567671840784;906.3927168796922;906.4787747045442;906.60109551797;725.2855936902173;730.2879692300019;730.7625021867888;866;889.87096870954;664.6344510519195;665.3479590001825;666.2438132719399;666.3569655282676;666.5467482112161;11156;11183.888161118448;11184.944075279653;11204.495797689042;11219.270747401475;11415.25800822952;11621.825672614917;11678.649640510714;11812.940935295268;11919;11063.446827658665;11067.778644427066;11097.334159950347;11098.500567474483;11160.162987775868;4094.6724262058965;4097.610726980932;4103.610157035077;4119.855805046809;4185.853495127656;43787;43908.341374879405;44007.339889901676;44935.10129797386;45533.544664553265;9354.906450935403;9377.531123443801;9446.102620251202;9485.525723713925;9508.619655213852;16647.667046659;17205.56986075358;17347.392841250497;17429.12854357277;17430.65138697219;6641.966790166019;6693.698783554752;6776.186857577024;6918;6935.237123916365;3866.2267546490816;3887.37801951692;3897.2205558888336;3966.0679740261016;3986.123052928351;2824.491591513547;2894.7105289470883;2895.5077636801793;2899.275181204699;2900.0429858146763;511.1999720437578;532.6670830730793;540.645876950598;546.710243570908;546.8004178474828;454.6749074411811;467.37138548652007;598.2521847690386;600.5195843325322;608.6165715599144;7542.47202695806;7861.724839630586;7973.242541958504;8021.558814265155;8191.50850948933;574.5231457889942;580.9419058094242;583.7635757518212;591.9230500034968;596.6604971838165;3576.8211589420425;3682.779033258013;3857.2092720992127;3914.9608503915165;3927.5286965563746;53343.73328133412;53480.73259633677;53523.19715204275;53681.463185368426;54454;46403.76798115988;46569.30146047812;46897.53102468931;48120.518794812306;48807.26789098166;44542.77728611336;44607;44880.77559612246;44993.325100123526;45438.772806135756;7389.298016688406;7410.629468526445;7412.295831895961;7416.295451932057;7509.85780857929;30770.538441923836;30831.84584077155;31087.222819429695;31401.685983139876;31460.528092079094;37611.2477750438;38500.42249366206;40967.590324096374;41154;41587.7920610395;8914.37599368038;9117.407368521024;9154.40496367734;9208.03315651847;9464.050474935724;10103.09072183507;10365.274430790074;10581.52383142745;10939.781204376028;11024.724381890517;9210.815783684155;9658.661946831828;10970.835437468604;11076.446177691245;11251.49368278413;11399.316041037564;11597.130215233723;11811.409429528661;12180.269183848997;12238.082143839425;10835.783284334111;10988.780224395627;11057.447127643425;11325.207235493437;11691.883081169079;9312.860307095534;9338.206252468617;9380.29647776406;9667.661631842851;10023.69928902134;8924.196822286025;9048.230900373279;9053.864192037256;9127.543622818699;9384.718458446258 15:31:29 INFO - PROCESS | 12712 | __end_tp_report 15:31:29 INFO - PROCESS | 12712 | __start_cc_report 15:31:29 INFO - PROCESS | 12712 | _x_x_mozilla_cycle_collect,1058 15:31:29 INFO - PROCESS | 12712 | __end_cc_report 15:31:29 INFO - PROCESS | 12712 | __startTimestamp1463524289210__endTimestamp 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | ------- Summary: start ------- 15:31:29 INFO - PROCESS | 12712 | Number of tests: 6 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#0] dojo.html Cycles:165 Average:4749.68 Median:4892.90 stddev:506.67 (10.4%) stddev-sans-first:480.91 15:31:29 INFO - PROCESS | 12712 | Values: 2657.8 2670.6 2701.9 2704.7 2707.1 4659.5 4725.9 4748.5 4806.7 4870.2 4751.0 4773.1 4823.1 4829.3 4887.8 4334.1 4336.0 4413.9 4479.6 4582.0 4478.1 4520.4 4545.6 4550.5 4556.7 4282.3 4335.7 4340.9 4346.8 4424.5 4361.5 4363.8 4374.6 4408.3 4419.4 4397.9 4417.2 4420.1 4446.1 4465.5 4591.3 4685.6 4710.6 4737.5 4790.1 5208.2 5219.8 5227.6 5234.8 5235.1 5185.1 5211.0 5211.3 5215.6 5218.0 4660.7 4745.4 4802.0 4803.2 4835.2 5274.4 5306.8 5321.9 5332.0 5335.6 5039.9 5087.0 5093.1 5094.8 5097.8 4948.5 5081.0 5108.8 5135.4 5178.2 5089.1 5112.1 5120.8 5123.3 5186.1 4947.6 5107.4 5111.0 5112.1 5119.4 4241.3 4265.6 4295.8 4306.8 4320.6 3732.2 3764.3 3772.7 3808.4 3815.8 4308.2 4441.6 4443.6 4493.7 4500.1 5102.2 5149.6 5161.6 5165.1 5178.8 4437.5 4441.5 4441.8 4445.6 4467.1 4482.1 4525.6 4584.4 4589.0 4626.1 4866.5 4870.7 4892.9 4902.5 4938.7 5116.5 5151.5 5167.6 5172.6 5222.2 4717.6 4830.9 4863.1 4871.3 4948.7 5051.6 5059.4 5080.8 5084.8 5119.0 5143.1 5154.5 5154.6 5159.4 5190.4 4890.5 4965.5 4982.4 4984.5 5019.2 5011.1 5023.2 5029.9 5037.5 5058.4 4938.9 4950.7 4991.6 4995.5 5000.5 4895.1 4960.1 4988.1 5027.7 5096.6 4944.8 4972.9 4973.7 4980.2 5027.8 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#1] ext.html Cycles:180 Average:47740.51 Median:3563.38 stddev:82968.54 (2328.4%) stddev-sans-first:83125.73 15:31:29 INFO - PROCESS | 12712 | Values: 579.7 595.7 611.7 615.1 628.9 28546.7 29041.6 31074.2 31141.5 41576.4 42488.8 43945.8 44037.3 44594.6 47947.5 7783.9 7941.4 7942.1 7943.9 7944.1 7473.4 7741.3 7845.6 9981.9 10232.5 10350.4 10354.6 10409.8 10418.3 10422.7 10135.4 10254.2 10279.6 10289.3 10299.0 10035.6 10139.5 10139.7 10144.0 10151.2 40281.8 40628.6 40629.6 40637.2 40728.0 3214.7 3216.9 3244.4 3398.8 3545.9 27207.0 27254.0 29736.9 30553.0 31499.0 3545.4 3580.9 3594.3 3595.4 3680.9 265431.0 267076.6 267223.0 267366.0 267546.7 56910.4 57534.7 57569.7 57715.4 57826.7 59950.0 60024.4 60049.4 60077.7 60240.7 12816.2 13209.1 13210.9 13211.0 13217.5 9427.1 9443.7 9447.4 9451.2 9601.9 16695.2 17262.5 17324.1 17631.6 17824.4 6269.0 6285.4 6312.7 6450.2 6608.1 904.5 951.1 1039.6 1048.0 1074.0 28866.7 28875.3 28914.9 29038.0 29427.9 1018.8 1047.7 1054.0 1072.4 1092.5 15284.0 15359.8 15421.8 15636.1 15762.4 402756.0 403963.0 406125.0 408605.0 408935.0 52159.0 52169.2 52317.0 52376.5 52406.0 1142.3 1234.2 1261.8 1264.4 1265.3 28771.7 29966.7 30230.7 30280.4 30764.5 44224.3 44545.8 44706.6 44891.3 44905.8 249625.0 249892.0 250209.0 250269.0 250828.0 31922.0 33065.3 37076.0 38111.0 38142.0 43954.8 44223.0 44257.0 44535.6 45586.3 36851.0 36993.6 37606.6 37798.6 37998.4 36010.6 36372.5 37417.8 37849.2 41745.0 37312.0 37774.8 38253.4 38354.2 38565.2 33393.8 33849.3 34249.7 34441.0 34462.5 26573.5 27602.7 27901.2 27946.6 28022.7 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#2] jquery.html Cycles:180 Average:24816.26 Median:386.08 stddev:65380.97 (16934.4%) stddev-sans-first:65538.62 15:31:29 INFO - PROCESS | 12712 | Values: 373.8 379.5 383.2 389.0 390.6 16304.8 17449.4 18213.8 18377.0 18383.6 16775.9 16810.7 16868.6 17671.8 17687.8 4951.9 5306.0 5330.6 5339.8 5366.7 3700.5 3827.5 3890.6 5578.2 6307.9 6213.9 6234.3 6243.1 6253.9 6261.6 5386.7 5391.2 5875.4 6088.3 6256.1 3414.7 5121.1 5424.8 5428.0 5478.1 20609.5 21174.3 21214.4 21635.4 21653.0 2100.7 2106.6 2287.1 2395.6 2601.9 12872.5 13430.7 13529.9 13998.9 14082.8 1766.4 1796.5 1846.3 1886.0 1912.4 58337.4 59456.4 59797.7 68005.0 68307.3 10188.8 10400.5 10537.2 10569.4 10620.7 14540.7 14593.3 14632.3 14641.2 14655.7 6808.6 7070.0 7070.2 7169.6 7192.3 6405.5 6438.7 6461.5 6516.3 6562.5 4353.7 4417.1 4563.8 4587.7 4589.0 1832.3 1867.3 1882.5 1907.7 1945.1 837.6 858.4 872.9 895.0 944.7 16588.6 17306.7 17415.1 17707.5 17792.0 890.2 907.9 909.4 911.5 918.7 8563.4 9730.0 9946.0 9949.2 9958.9 369054.0 376175.6 407947.0 412617.0 413291.0 77932.0 84007.6 84077.9 84208.0 85748.0 934.8 968.2 987.4 989.2 990.9 15509.5 15965.3 16303.6 16353.1 16384.8 36264.0 36326.3 37256.3 37268.4 38265.6 49740.5 51276.5 52037.5 52394.2 52808.7 7522.3 7551.0 7898.7 7953.8 8066.5 10234.3 11744.3 11808.1 12201.2 12304.9 9984.7 10380.8 10627.2 10820.0 11329.9 10694.0 11069.9 11078.5 11088.8 11352.5 10680.8 10952.3 11277.8 11345.7 11623.1 8108.7 8173.2 8233.7 8353.8 8358.6 8127.9 10687.2 10743.3 10785.7 10820.1 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#3] mootools.html Cycles:180 Average:5233.85 Median:5538.61 stddev:2904.39 (52.4%) stddev-sans-first:2897.51 15:31:29 INFO - PROCESS | 12712 | Values: 1302.0 1436.3 1501.9 1605.0 1811.6 6713.8 7646.5 7861.6 7872.9 8163.9 7817.3 8007.2 8007.4 8018.6 8022.3 2292.7 2330.1 2334.2 2337.3 2339.3 2264.5 2286.3 2321.1 2322.8 2325.0 2274.2 2286.8 2295.9 2305.3 2308.3 2247.4 2261.9 2263.7 2267.7 2267.8 2225.5 2230.4 2232.6 2233.8 2233.9 7738.0 7920.4 7981.8 7983.1 8005.8 4610.8 4750.2 4751.5 4753.0 4757.2 3026.4 3089.2 3113.3 3132.2 3147.6 890.1 901.7 907.2 914.5 974.8 10979.5 11050.4 11060.2 11070.3 11084.3 4169.0 4262.0 4351.8 4352.7 4363.2 8735.0 8783.1 8788.1 8791.6 8824.9 4633.3 4643.8 4644.1 4644.3 4653.0 3781.1 4007.2 4178.1 4181.9 4213.0 3534.6 3568.5 3592.2 3640.7 3662.1 1051.9 1058.6 1065.7 1067.0 1079.4 718.5 775.2 874.7 893.6 897.7 5295.9 5485.9 5591.3 5647.7 5708.0 924.9 950.1 973.1 992.0 999.8 3700.3 3768.7 3773.4 3787.5 3934.9 9407.8 9836.7 9864.2 9864.7 9870.9 9613.7 9722.5 9730.1 9744.1 9747.3 7215.2 7342.3 7350.9 7359.3 7364.2 5248.1 5374.7 5402.2 5475.0 5646.4 8723.4 9218.6 9233.5 9240.4 9243.1 8864.5 9261.5 9344.8 9459.2 9468.2 6443.5 6477.4 6522.2 6525.5 6585.5 7386.3 7553.4 7560.8 7565.8 7568.5 6120.8 6359.3 6779.5 6982.3 7238.2 6877.1 6958.8 6992.6 7013.4 7105.1 6489.1 6687.5 6691.7 6698.3 6713.5 4613.9 4621.5 4673.2 4677.4 4722.0 4721.0 4802.1 4849.8 4863.1 4929.6 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#4] prototype.html Cycles:180 Average:4227.70 Median:4843.05 stddev:1210.94 (25.0%) stddev-sans-first:1177.83 15:31:29 INFO - PROCESS | 12712 | Values: 295.6 302.9 303.4 320.4 320.6 4874.7 4947.0 4965.7 4967.2 4992.7 4636.6 4693.0 4771.7 4815.3 4870.8 3858.0 3885.6 3890.9 3895.0 3898.9 3868.7 3890.8 3892.3 3894.5 3898.5 3533.5 3660.7 3749.1 3767.6 3865.7 3850.9 3855.7 3856.3 3863.9 3867.4 3432.2 3432.9 3435.2 3448.2 3452.9 4453.3 4660.8 4667.0 4674.6 4700.8 4303.8 4319.5 4339.2 4345.6 4352.5 5078.7 5093.5 5111.3 5117.7 5127.6 3569.2 3620.8 3630.9 3645.4 3666.6 5232.2 5344.8 5350.6 5350.7 5352.5 3688.9 3701.1 3703.7 3720.2 3730.2 3755.6 3761.9 3766.0 3793.7 3795.1 4142.9 4299.9 4306.2 4361.8 4392.0 5029.3 5057.7 5070.6 5105.7 5106.3 1291.8 1304.7 1306.3 1310.1 1313.2 837.0 878.2 903.8 904.2 908.6 4508.8 4522.8 4531.5 4557.8 4566.3 5250.4 5250.9 5252.6 5267.3 5267.9 4344.1 4519.0 4522.9 4529.4 4539.3 2808.4 2810.8 2813.6 2818.3 2822.8 4962.8 4963.5 4977.3 5011.3 5014.2 5220.0 5346.3 5366.8 5375.2 5395.4 4907.1 4944.4 4958.9 4994.3 4994.4 5104.4 5104.5 5151.8 5166.5 5200.7 4875.7 5080.8 5106.6 5112.4 5117.0 4898.4 4915.2 4916.8 4938.9 4947.6 3691.5 3709.9 3718.8 3741.1 3741.9 4905.3 5140.4 5141.7 5142.6 5211.9 4968.0 4980.4 4989.5 4991.7 5010.8 5016.4 5019.0 5038.6 5042.6 5047.7 4782.3 4798.6 4959.5 5069.5 5076.9 5015.7 5020.9 5026.3 5040.7 5051.1 4897.3 4987.8 4998.2 5021.2 5037.3 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - PROCESS | 12712 | [#5] yui.html Cycles:180 Average:12787.89 Median:46486.53 stddev:14766.73 (31.8%) stddev-sans-first:14780.19 15:31:29 INFO - PROCESS | 12712 | Values: 685.5 719.8 734.1 739.2 739.5 11490.9 11580.3 11606.5 11613.4 11760.6 11494.9 11512.7 11566.8 11576.8 11586.9 673.1 836.0 858.7 859.7 869.4 848.5 852.4 854.3 854.6 855.9 714.8 904.6 906.4 906.5 906.6 725.3 730.3 730.8 866.0 889.9 664.6 665.3 666.2 666.4 666.5 11156.0 11183.9 11184.9 11204.5 11219.3 11415.3 11621.8 11678.6 11812.9 11919.0 11063.4 11067.8 11097.3 11098.5 11160.2 4094.7 4097.6 4103.6 4119.9 4185.9 43787.0 43908.3 44007.3 44935.1 45533.5 9354.9 9377.5 9446.1 9485.5 9508.6 16647.7 17205.6 17347.4 17429.1 17430.7 6642.0 6693.7 6776.2 6918.0 6935.2 3866.2 3887.4 3897.2 3966.1 3986.1 2824.5 2894.7 2895.5 2899.3 2900.0 511.2 532.7 540.6 546.7 546.8 454.7 467.4 598.3 600.5 608.6 7542.5 7861.7 7973.2 8021.6 8191.5 574.5 580.9 583.8 591.9 596.7 3576.8 3682.8 3857.2 3915.0 3927.5 53343.7 53480.7 53523.2 53681.5 54454.0 46403.8 46569.3 46897.5 48120.5 48807.3 44542.8 44607.0 44880.8 44993.3 45438.8 7389.3 7410.6 7412.3 7416.3 7509.9 30770.5 30831.8 31087.2 31401.7 31460.5 37611.2 38500.4 40967.6 41154.0 41587.8 8914.4 9117.4 9154.4 9208.0 9464.1 10103.1 10365.3 10581.5 10939.8 11024.7 9210.8 9658.7 10970.8 11076.4 11251.5 11399.3 11597.1 11811.4 12180.3 12238.1 10835.8 10988.8 11057.4 11325.2 11691.9 9312.9 9338.2 9380.3 9667.7 10023.7 8924.2 9048.2 9053.9 9127.5 9384.7 15:31:29 INFO - PROCESS | 12712 | -------- Summary: end -------- 15:31:29 INFO - PROCESS | 12712 | 15:31:29 INFO - TEST-INFO | 12712: exit 0 15:31:29 INFO - TEST-OK | dromaeo_css | took 1118951ms 15:31:29 INFO - TEST-START | kraken 15:31:29 INFO - operating with platform_type : linux_ 15:31:29 INFO - Initialising browser for kraken test... 15:31:29 INFO - TEST-INFO | started process 12891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdusM4S/profile http://localhost:33518/getInfo.html) 15:31:34 INFO - PROCESS | 12891 | __metrics Screen width/height:1600/1200 15:31:34 INFO - PROCESS | 12891 | colorDepth:24 15:31:34 INFO - PROCESS | 12891 | Browser inner width/height: 1024/697 15:31:34 INFO - PROCESS | 12891 | __metrics 15:31:34 ERROR - PROCESS | 12891 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:31:35 INFO - TEST-INFO | 12891: exit 0 15:31:35 INFO - Browser initialized. 15:31:35 INFO - Running cycle 1/1 for kraken test... 15:31:35 INFO - TEST-INFO | started process 12970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdusM4S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:47 INFO - PROCESS | 12970 | RSS: Main: 153899008 15:31:47 INFO - PROCESS | 12970 | 15:31:50 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33518/tests/kraken/driver.html?testName=audio-beat-detection) 15:31:51 INFO - PROCESS | 12970 | RSS: Main: 209403904 15:31:51 INFO - PROCESS | 12970 | 15:31:54 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33518/tests/kraken/driver.html?testName=audio-dft) 15:31:54 INFO - PROCESS | 12970 | RSS: Main: 198209536 15:31:54 INFO - PROCESS | 12970 | 15:31:58 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33518/tests/kraken/driver.html?testName=audio-fft) 15:31:58 INFO - PROCESS | 12970 | RSS: Main: 267337728 15:31:58 INFO - PROCESS | 12970 | 15:32:01 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33518/tests/kraken/driver.html?testName=audio-oscillator) 15:32:01 INFO - PROCESS | 12970 | RSS: Main: 175939584 15:32:01 INFO - PROCESS | 12970 | 15:32:04 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:04 INFO - PROCESS | 12970 | RSS: Main: 179859456 15:32:04 INFO - PROCESS | 12970 | 15:32:07 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33518/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:08 INFO - PROCESS | 12970 | RSS: Main: 216739840 15:32:08 INFO - PROCESS | 12970 | 15:32:12 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33518/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:12 INFO - PROCESS | 12970 | RSS: Main: 215019520 15:32:12 INFO - PROCESS | 12970 | 15:32:15 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33518/tests/kraken/driver.html?testName=json-parse-financial) 15:32:16 INFO - PROCESS | 12970 | RSS: Main: 214609920 15:32:16 INFO - PROCESS | 12970 | 15:32:18 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:19 INFO - PROCESS | 12970 | RSS: Main: 208633856 15:32:19 INFO - PROCESS | 12970 | 15:32:20 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:21 INFO - PROCESS | 12970 | RSS: Main: 210755584 15:32:21 INFO - PROCESS | 12970 | 15:32:23 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:24 INFO - PROCESS | 12970 | RSS: Main: 216961024 15:32:24 INFO - PROCESS | 12970 | 15:32:27 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:28 INFO - PROCESS | 12970 | RSS: Main: 219971584 15:32:28 INFO - PROCESS | 12970 | 15:32:30 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:31 INFO - PROCESS | 12970 | RSS: Main: 218148864 15:32:31 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:33518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33518/tests/kraken/driver.html?testName=ai-astar) 15:32:33 INFO - PROCESS | 12970 | RSS: Main: 264589312 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | __start_tp_report 15:32:33 INFO - PROCESS | 12970 | _x_x_mozilla_page_load 15:32:33 INFO - PROCESS | 12970 | _x_x_mozilla_page_load_details 15:32:33 INFO - PROCESS | 12970 | |i|pagename|runs| 15:32:33 INFO - PROCESS | 12970 | |0;ai-astar;112;108;113;113;113;112;113;113;111;112 15:32:33 INFO - PROCESS | 12970 | |1;audio-beat-detection;159;129;155;216;128;159;151;130;197;131 15:32:33 INFO - PROCESS | 12970 | |2;audio-dft;161;162;161;161;161;162;161;161;160;161 15:32:33 INFO - PROCESS | 12970 | |3;audio-fft;76;75;77;153;76;76;77;74;133;76 15:32:33 INFO - PROCESS | 12970 | |4;audio-oscillator;92;92;145;91;92;93;125;92;93;120 15:32:33 INFO - PROCESS | 12970 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;116;117;117 15:32:33 INFO - PROCESS | 12970 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;145 15:32:33 INFO - PROCESS | 12970 | |7;imaging-desaturate;94;95;94;95;95;94;95;95;94;95 15:32:33 INFO - PROCESS | 12970 | |8;json-parse-financial;65;65;66;64;74;65;65;66;66;65 15:32:33 INFO - PROCESS | 12970 | |9;json-stringify-tinderbox;64;64;65;64;65;64;66;65;65;65 15:32:33 INFO - PROCESS | 12970 | |10;stanford-crypto-aes;83;83;83;82;92;85;83;83;163;84 15:32:33 INFO - PROCESS | 12970 | |11;stanford-crypto-ccm;137;131;132;133;126;127;129;129;153;130 15:32:33 INFO - PROCESS | 12970 | |12;stanford-crypto-pbkdf2;175;167;165;166;166;166;165;166;165;165 15:32:33 INFO - PROCESS | 12970 | |13;stanford-crypto-sha256-iterative;66;66;68;66;66;65;66;64;64;65 15:32:33 INFO - PROCESS | 12970 | __end_tp_report 15:32:33 INFO - PROCESS | 12970 | __start_cc_report 15:32:33 INFO - PROCESS | 12970 | _x_x_mozilla_cycle_collect,2116 15:32:33 INFO - PROCESS | 12970 | __end_cc_report 15:32:33 INFO - PROCESS | 12970 | __startTimestamp1463524353623__endTimestamp 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | ------- Summary: start ------- 15:32:33 INFO - PROCESS | 12970 | Number of tests: 14 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:1.56 (1.4%) stddev-sans-first:1.66 15:32:33 INFO - PROCESS | 12970 | Values: 112.0 108.0 113.0 113.0 113.0 112.0 113.0 113.0 111.0 112.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:157.00 stddev:30.07 (19.2%) stddev-sans-first:31.86 15:32:33 INFO - PROCESS | 12970 | Values: 159.0 129.0 155.0 216.0 128.0 159.0 151.0 130.0 197.0 131.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:32:33 INFO - PROCESS | 12970 | Values: 161.0 162.0 161.0 161.0 161.0 162.0 161.0 161.0 160.0 161.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:28.71 (37.8%) stddev-sans-first:30.04 15:32:33 INFO - PROCESS | 12970 | Values: 76.0 75.0 77.0 153.0 76.0 76.0 77.0 74.0 133.0 76.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:92.00 stddev:19.33 (21.0%) stddev-sans-first:20.05 15:32:33 INFO - PROCESS | 12970 | Values: 92.0 92.0 145.0 91.0 92.0 93.0 125.0 92.0 93.0 120.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:32:33 INFO - PROCESS | 12970 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 15:32:33 INFO - PROCESS | 12970 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:32:33 INFO - PROCESS | 12970 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.50 stddev:2.85 (4.3%) stddev-sans-first:2.99 15:32:33 INFO - PROCESS | 12970 | Values: 65.0 65.0 66.0 64.0 74.0 65.0 65.0 66.0 66.0 65.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 15:32:33 INFO - PROCESS | 12970 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 66.0 65.0 65.0 65.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:83.00 stddev:25.08 (30.2%) stddev-sans-first:26.38 15:32:33 INFO - PROCESS | 12970 | Values: 83.0 83.0 83.0 82.0 92.0 85.0 83.0 83.0 163.0 84.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:131.50 stddev:7.79 (5.9%) stddev-sans-first:8.11 15:32:33 INFO - PROCESS | 12970 | Values: 137.0 131.0 132.0 133.0 126.0 127.0 129.0 129.0 153.0 130.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:166.00 stddev:3.03 (1.8%) stddev-sans-first:0.71 15:32:33 INFO - PROCESS | 12970 | Values: 175.0 167.0 165.0 166.0 166.0 166.0 165.0 166.0 165.0 165.0 15:32:33 INFO - PROCESS | 12970 | 15:32:33 INFO - PROCESS | 12970 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 15:32:33 INFO - PROCESS | 12970 | Values: 66.0 66.0 68.0 66.0 66.0 65.0 66.0 64.0 64.0 65.0 15:32:33 INFO - PROCESS | 12970 | -------- Summary: end -------- 15:32:33 INFO - PROCESS | 12970 | 15:32:34 INFO - TEST-INFO | 12970: exit 0 15:32:34 INFO - TEST-OK | kraken | took 64879ms 15:32:34 INFO - SUITE-END | took 1183s 15:32:35 INFO - Completed test suite (00:19:44) 15:32:35 INFO - javascript benchmark 15:32:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.813953023288, 2670.612761149632, 2701.9459610807785, 2704.743049410306, 2707.0660622085375, 4659.534046595339, 4725.929111063332, 4748.477667456577, 4806.711597304165, 4870.24511200764, 4750.97624511877, 4773.069251495951, 4823.107725070864, 4829.251466022763, 4887.804487820483, 4334.111507141037, 4336.046069864625, 4413.911721765563, 4479.596836284733, 4582.037772067853, 4478.0596074824325, 4520.434945631796, 4545.568171023748, 4550.522195169509, 4556.703814252063, 4282.272013757669, 4335.674824388184, 4340.934885976713, 4346.847860324905, 4424.491183513905, 4361.498427680825, 4363.847265345729, 4374.562543745632, 4408.316710909782, 4419.4033805436175, 4397.934030989538, 4417.182821178092, 4420.138073075752, 4446.088551846864, 4465.508794032654, 4591.265397536412, 4685.554872287127, 4710.646701497401, 4737.455192652855, 4790.065937142259, 5208.218767184915, 5219.765110569995, 5227.60792940531, 5234.7644356004075, 5235.110031294651, 5185.118529849935, 5211.0, 5211.348581427322, 5215.58275337972, 5217.973910130425, 4660.743659098782, 4745.3593764842, 4801.975990120027, 4803.159447096814, 4835.226363781813, 5274.446183150791, 5306.7611957462, 5321.946780532223, 5331.973340133274, 5335.599830012765, 5039.924401133986, 5087.033463641897, 5093.0577843099145, 5094.796208151706, 5097.796088156507, 4948.480409557017, 5080.974595127001, 5108.846734597968, 5135.35808023997, 5178.197379406198, 5089.134847076006, 5112.105381558287, 5120.769565369493, 5123.3339665843205, 5186.144286192736, 4947.554720075211, 5107.41264754558, 5111.0, 5112.130937740593, 5119.411267704188, 4241.27898257297, 4265.637420819203, 4295.806688699016, 4306.784660766949, 4320.611144996902, 3732.1789206374556, 3764.3412402829395, 3772.660460558563, 3808.409696497047, 3815.8473661053804, 4308.202982448257, 4441.644668426518, 4443.622292105208, 4493.707908985971, 4500.122476117192, 5102.183650615883, 5149.588032957429, 5161.612879034087, 5165.070287348238, 5178.844634660966, 4437.489688685842, 4441.489228738672, 4441.777911104432, 4445.599896009375, 4467.084247729208, 4482.058767658763, 4525.592696657251, 4584.4498660161, 4589.0, 4626.051659409813, 4866.464688884149, 4870.683405578555, 4892.902141957212, 4902.509749025069, 4938.728369939688, 5116.539511443988, 5151.5106064923775, 5167.58659307262, 5172.586193104467, 5222.242774797709, 4717.551832575899, 4830.855074347775, 4863.076015557032, 4871.293662419001, 4948.653594248368, 5051.570616497639, 5059.367579052619, 5080.847574572768, 5084.771185296597, 5119.027384797026, 5143.074246635641, 5154.458781827854, 5154.587632989277, 5159.432462429055, 5190.429052804113, 4890.462049174517, 4965.45380008206, 4982.427020892499, 4984.476629953802, 5019.222020586815, 5011.09800235961, 5023.196288593954, 5029.874253143701, 5037.546620803999, 5058.3929928408825, 4938.901221975612, 4950.6782059166035, 4991.575716064175, 4995.500449954975, 5000.4749501303295, 4895.069936712013, 4960.082384758831, 4988.102141614544, 5027.748612569284, 5096.566791822736, 4944.777485013111, 4972.8508144755715, 4973.726445045557, 4980.153373926369, 5027.84916452507], "value": 4716.967089861474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7304253522111, 595.7259660556144, 611.7063809371499, 615.0804547201931, 628.8585068359622, 28546.714532854665, 29041.56437653434, 31074.22314442143, 31141.532877006863, 41576.37635435471, 42488.787556062176, 43945.78027109868, 44037.33943990835, 44594.55405445945, 47947.520524794745, 7783.92216077839, 7941.36469082472, 7942.086660034083, 7943.920560794405, 7944.086430060559, 7473.3647639950395, 7741.341985931174, 7845.607719614025, 9981.850272245922, 10232.488375581228, 10350.430726310049, 10354.637587684432, 10409.791804163911, 10418.333066709329, 10422.687319380431, 10135.391876487398, 10254.179665626732, 10279.640212592523, 10289.27975041751, 10299.0, 10035.59857605695, 10139.493025348704, 10139.746506337327, 10144.0, 10151.187904967584, 40281.79859100715, 40628.59371406278, 40629.59370406317, 40637.18725625471, 40728.0, 3214.694604012615, 3216.8713251469912, 3244.3511297740547, 3398.793428332931, 3545.8758943437115, 27207.0, 27254.0, 29736.8513157435, 30553.0, 31499.0, 3545.3618348697223, 3580.8925732228076, 3594.281143771256, 3595.352836489431, 3680.907977300562, 265431.0, 267076.6400183982, 267223.0, 267366.0, 267546.66226668935, 56910.430895691345, 57534.7123264381, 57569.71215143897, 57715.422845771005, 57826.71086644624, 59950.0, 60024.39975600276, 60049.399506005255, 60077.69961150167, 60240.698796505734, 12816.166949148275, 13209.07536472457, 13210.933945330213, 13211.0, 13217.537386191629, 9427.104425079606, 9443.669471568463, 9447.433154010781, 9451.243900487945, 9601.903980960102, 16695.165241737865, 17262.482125536255, 17324.133793310284, 17631.64736705259, 17824.3761468348, 6268.968655156787, 6285.43431091204, 6312.747490100436, 6450.161479007699, 6608.107905432801, 904.4618452021037, 951.1059603972244, 1039.5633833789827, 1047.9999999999848, 1074.006543946846, 28866.711332886403, 28875.278118047216, 28914.85542572316, 29038.0, 29427.85286073556, 1018.7504061504978, 1047.664747280863, 1053.952572134256, 1072.3940973350032, 1092.470151976291, 15284.0, 15359.769603455958, 15421.845781542266, 15636.140012299433, 15762.448314308944, 402756.0, 403963.0, 406125.0, 408605.0, 408935.0, 52159.0, 52169.2174617381, 52317.0, 52376.47623523716, 52405.973313068724, 1142.348861149137, 1234.2409418207917, 1261.8485781706254, 1264.3994102801096, 1265.3483456020158, 28771.712282876902, 29966.70033299726, 30230.697693022787, 30280.394392112474, 30764.538531921593, 44224.33663494986, 44545.77727111344, 44706.55293447154, 44891.326630101226, 44905.77547112243, 249625.0, 249892.0, 250209.0, 250269.0, 250828.0, 31922.0, 33065.338693226484, 37076.0, 38111.04722381962, 38142.0, 43954.780226098665, 44223.0, 44257.0, 44535.55464445314, 45586.31620525761, 36851.0, 36993.63006369902, 37606.62393376031, 37798.62201378061, 37998.43002355022, 36010.578994995434, 36372.45441318435, 37417.81291093636, 37849.24301514009, 41745.0, 37312.0, 37774.811125944194, 38253.42619860649, 38354.23291534098, 38565.22869542649, 33393.83303083469, 33849.3230135391, 34249.65750342465, 34441.0, 34462.48306275358, 26573.468530629667, 27602.723972760014, 27901.162965111078, 27946.58080128759, 28022.719772802826], "value": 18473.61543220905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7738668105796, 379.5218025288138, 383.20102586107964, 388.9649931506164, 390.59378246623515, 16304.755428668579, 17449.389271375505, 18213.81786182138, 18377.0, 18383.632327353444, 16775.91612041941, 16810.663786724257, 16868.578285542866, 17671.823281767178, 17687.82312176878, 4951.851444456672, 5305.973470132663, 5330.600204984622, 5339.759710813023, 5366.731663416833, 3700.463432802242, 3827.54069511659, 3890.6498415142632, 5578.24693666356, 6307.936920630781, 6213.937860621381, 6234.251889773233, 6243.125962365272, 6253.906191407133, 6261.592996455239, 5386.73066346683, 5391.24522566839, 5875.441833025856, 6088.299845517778, 6256.092866534373, 3414.6756058174433, 5121.078205922932, 5424.810131645373, 5428.022955867942, 5478.096114141202, 20609.484762880897, 21174.258900938392, 21214.36356909295, 21635.350939471842, 21653.0, 2100.7479102507646, 2106.6313395155785, 2287.1194590082773, 2395.568797616428, 2601.9089331873292, 12872.485100595964, 13430.664233394244, 13529.864701352959, 13998.860011399858, 14082.788758168635, 1766.3994241957669, 1796.4520821149545, 1846.2984066054814, 1885.981140188608, 1912.407153782332, 58337.416625833626, 59456.40543594552, 59797.7010114951, 68004.9999999995, 68307.3169268306, 10188.796224075626, 10400.531976061095, 10537.157027437786, 10569.414587811736, 10620.681379558471, 14540.709185816437, 14593.270336483345, 14632.268386580841, 14641.194734289717, 14655.706885862437, 6808.5914845109455, 7069.974853646192, 7070.151581810215, 7169.605671688108, 7192.31672991065, 6405.519586031066, 6438.678066096676, 6461.483081353481, 6516.283208847023, 6562.475001999828, 4353.73877567347, 4417.116576684676, 4563.817447302137, 4587.7017993830295, 4588.977055114703, 1832.2945665918717, 1867.310084373644, 1882.510547257723, 1907.6661584222707, 1945.114972687424, 837.5602808525573, 858.3991206155716, 872.8908886389202, 894.9821003579892, 944.7024187380953, 16588.58528536796, 17306.740398894028, 17415.129243537773, 17707.46877593674, 17792.0, 890.2388457868559, 907.9228265597499, 909.3907082254905, 911.48956584313, 918.6968300460832, 8563.400561960603, 9730.0, 9946.0, 9949.159405510003, 9958.900410995942, 369054.0, 376175.59561011195, 407947.0, 412617.0, 413291.0, 77932.0, 84007.57996210102, 84077.92207792208, 84208.0, 85748.0, 934.8130373925242, 968.1625394034251, 987.3659094199112, 989.2202909823276, 990.9058639429243, 15509.457168999032, 15965.28156232949, 16303.59241018984, 16353.100579468244, 16384.75422868682, 36264.0, 36326.27347453089, 37256.25487490181, 37268.440973385965, 38265.617343826205, 49740.50259497359, 51276.48723512866, 52037.47962520326, 52394.214086787964, 52808.73595631997, 7522.285382888617, 7551.018367612175, 7898.723544675909, 7953.8409231813885, 8066.475679080841, 10234.283600147919, 11744.29534227949, 11808.055355571705, 12201.20692155007, 12304.876951230373, 9984.700458986243, 10380.792384152124, 10627.202959777893, 10820.0, 11329.943350283196, 10694.037536621741, 11069.944650276697, 11078.501467434146, 11088.833667494833, 11352.54589816398, 10680.83978740335, 10952.34285942846, 11277.830832537355, 11345.659630211107, 11623.070154387799, 8108.716194933149, 8173.223543763333, 8233.711820086508, 8353.791155221168, 8358.582070896553, 8127.878081828895, 10687.198460115678, 10743.301685390425, 10785.676429707122, 10820.080293175168], "value": 8521.29171993122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.9804702929464, 1436.253148362851, 1501.8648321651049, 1604.9759253611192, 1811.5652243461566, 6713.765018224363, 7646.541207527553, 7861.606919654023, 7872.9212707872975, 8163.877541836877, 7817.335526480256, 8007.19928007199, 8007.359411247101, 8018.599070046504, 8022.318102961255, 2292.7363353214387, 2330.0563271874835, 2334.241371554243, 2337.31049340445, 2339.3215967369442, 2264.4904896398343, 2286.314105768263, 2321.0599707118645, 2322.7909488146065, 2324.9883750581225, 2274.1812947338944, 2286.7713228677167, 2295.8622482651094, 2305.250793492113, 2308.2959697292317, 2247.381969958258, 2261.8529795563236, 2263.7283525976986, 2267.693861328716, 2267.841251112423, 2225.5326381459913, 2230.375494861425, 2232.631615783394, 2233.7877901599322, 2233.9218127365625, 7737.961310193469, 7920.445568810185, 7981.840363192761, 7983.12185659577, 8005.839883202303, 4610.838620648295, 4750.168720473937, 4751.501092385319, 4753.0, 4757.215059515176, 3026.44407744195, 3089.1968088297203, 3113.3306339136966, 3132.1699749566383, 3147.5750773645495, 890.0609856601283, 901.6753968571309, 907.2152588011388, 914.4604683236922, 974.8294048541477, 10979.451027448675, 11050.392228427352, 11060.22578419511, 11070.28043177191, 11084.279521831137, 4168.979155104205, 4262.0, 4351.82592696295, 4352.73883566987, 4363.192809330284, 8735.039145693969, 8783.121687831293, 8788.121187881161, 8791.560421978875, 8824.91175088241, 4633.30500424939, 4643.814247430132, 4644.094401591725, 4644.303354496852, 4653.022865198346, 3781.1303400218103, 4007.1785284016705, 4178.12259425518, 4181.853635122756, 4213.0, 3534.6288639692975, 3568.518250036212, 3592.2276710507367, 3640.6541378568995, 3662.1393972416463, 1051.8737751469873, 1058.629479682105, 1065.6909496246158, 1067.0449947297125, 1079.422508957704, 718.5150023733959, 775.1744392222265, 874.6763697431991, 893.5666201892207, 897.6902968475865, 5295.920561191509, 5485.890282194414, 5591.329040515083, 5647.717614119278, 5708.029634962067, 924.912133347331, 950.0736781637847, 973.1387721866058, 992.0476342711078, 999.7800483893532, 3700.278445703062, 3768.6796622286865, 3773.4339849022867, 3787.4697542344093, 3934.940975885364, 9407.811843763224, 9836.704898853046, 9864.161546268648, 9864.704058878246, 9870.851937220947, 9613.663521776703, 9722.465264410524, 9730.12428881404, 9744.07431294026, 9747.268954828416, 7215.206327303992, 7342.302481264378, 7350.852982940311, 7359.264073592705, 7364.153122390993, 5248.081585722407, 5374.704391258519, 5402.216678581663, 5474.972625136849, 5646.407127251744, 8723.389362744547, 9218.585163667785, 9233.49215793111, 9240.445573265626, 9243.075692430702, 8864.512451815212, 9261.53692315395, 9344.766380840534, 9459.243260539002, 9468.242540596599, 6443.484521238383, 6477.352264773485, 6522.249941256816, 6525.510586705921, 6585.473162147113, 7386.2613738625705, 7553.395728341829, 7560.773176804704, 7565.773026809205, 7568.508046976929, 6120.846978825387, 6359.332270111571, 6779.542398384371, 6982.301769822977, 7238.167610724623, 6877.140357455318, 6958.79123626292, 6992.615406152507, 7013.4038606719005, 7105.076340075757, 6489.123968264413, 6687.531872768859, 6691.732330706717, 6698.330166983457, 6713.496487763339, 4613.907721845611, 4621.537846215351, 4673.158831410379, 4677.368555244999, 4721.952780472151, 4720.976395118002, 4802.087603355351, 4849.830255941025, 4863.10032643962, 4929.630277729257], "value": 4228.626302653095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.6275093382338, 302.87582091342546, 303.39775545542096, 320.40884567972086, 320.6008519393354, 4874.7082023263865, 4947.03532811102, 4965.677230979988, 4967.155583550796, 4992.700437973725, 4636.582707556319, 4692.97653511732, 4771.665983381165, 4815.3258543803895, 4870.780814863339, 3858.0, 3885.5531613864414, 3890.9416358754643, 3894.9610503894883, 3898.902527436808, 3868.7485313454536, 3890.8054597270166, 3892.3188442022674, 3894.5131858517684, 3898.5126859142606, 3533.4699795030824, 3660.7437479376454, 3749.137698329386, 3767.6232376762377, 3865.6907447404283, 3850.9229815403814, 3855.652991230803, 3856.3444214483325, 3863.903402414934, 3867.439221312908, 3432.1591210153424, 3432.8970130896114, 3435.209901722593, 3448.2413868948793, 3452.913677158066, 4453.332000199964, 4660.790264438108, 4667.043256132485, 4674.579287864074, 4700.811967521295, 4303.784810759481, 4319.4816622005565, 4339.153864996327, 4345.608895199415, 4352.477702675667, 5078.695278283315, 5093.516115969014, 5111.258867464197, 5117.7185254810975, 5127.615428842814, 3569.214772749991, 3620.837062332175, 3630.8729194478333, 3645.434957581579, 3666.5966743658178, 5232.2413250078525, 5344.759485823109, 5350.598705097094, 5350.732463376816, 5352.4915133062295, 3688.9077773055888, 3701.0939366226416, 3703.6851867591017, 3720.2001569662652, 3730.235301763132, 3755.5916531300763, 3761.9247615047548, 3765.981170094132, 3793.6585707286476, 3795.1271207622403, 4142.855000074983, 4299.892502687395, 4306.20335237982, 4361.760103194355, 4391.956080439219, 5029.346184995927, 5057.696538207646, 5070.594352451795, 5105.668131571436, 5106.259592359087, 1291.7933130699043, 1304.6673098359859, 1306.288073000217, 1310.1287643717012, 1313.1989486413281, 836.9874451883227, 878.2359347367703, 903.846346121161, 904.213334399077, 908.5684299957468, 4508.797104130322, 4522.841700540531, 4531.546845315508, 4557.817687292471, 4566.292224705176, 5250.3962044364625, 5250.947490525123, 5252.579793616502, 5267.26258323835, 5267.920981185285, 4344.147247080873, 4519.0058187198765, 4522.932156017597, 4529.369427006275, 4539.341795439643, 2808.4383123375405, 2810.761085307731, 2813.563897595876, 2818.3236023354248, 2822.802403831753, 4962.751862406937, 4963.45402005779, 4977.278294647256, 5011.346255735599, 5014.172661510883, 5219.973900130475, 5346.331708536433, 5366.792471693916, 5375.193720941812, 5395.3525576931015, 4907.141250281258, 4944.381952255968, 4958.9008219835405, 4994.275830004629, 4994.400671919393, 5104.3619547556555, 5104.489551045014, 5151.793928242828, 5166.483351664803, 5200.739963001911, 4875.7074575525585, 5080.771365288645, 5106.642535022513, 5112.3865136183895, 5117.0, 4898.387701537308, 4915.21356582945, 4916.803327866988, 4938.888500244822, 4947.579455746158, 3691.4831923531265, 3709.9072523187137, 3718.8326525305883, 3741.0834345585504, 3741.85032598693, 4905.313256144072, 5140.408852981955, 5141.71720555373, 5142.562882155059, 5211.895762084661, 4967.975160124176, 4980.427250866197, 4989.476105009067, 4991.677205540607, 5010.824621138243, 5016.423111342242, 5018.974905125451, 5038.647294689336, 5042.647014708935, 5047.697138171721, 4782.306565548046, 4798.640101992295, 4959.528844759742, 5069.518395752545, 5076.923846142385, 5015.673981191211, 5020.874478138076, 5026.296318515484, 5040.697558146523, 5051.06555287273, 4897.2654101885, 4987.825426110068, 4998.225275082368, 5021.171506701354, 5037.294778730908], "value": 3845.7599464199457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4756111574645, 719.8236432074143, 734.0823970037453, 739.2201227704769, 739.5156172706876, 11490.942545287273, 11580.305181689104, 11606.535738570457, 11613.419329033535, 11760.647180584585, 11494.885051149486, 11512.654620361382, 11566.826497602522, 11576.768464630703, 11586.942065289682, 673.135021497376, 835.9582020898961, 858.6694122762719, 859.6948083430386, 869.3610196505564, 848.5248260973874, 852.3820230333021, 854.2824027816632, 854.6239654551978, 855.8673405622108, 714.8034290570109, 904.5567671840784, 906.3927168796922, 906.4787747045442, 906.60109551797, 725.2855936902173, 730.2879692300019, 730.7625021867888, 866.0, 889.87096870954, 664.6344510519195, 665.3479590001825, 666.2438132719399, 666.3569655282676, 666.5467482112161, 11156.0, 11183.888161118448, 11184.944075279653, 11204.495797689042, 11219.270747401475, 11415.25800822952, 11621.825672614917, 11678.649640510714, 11812.940935295268, 11919.0, 11063.446827658665, 11067.778644427066, 11097.334159950347, 11098.500567474483, 11160.162987775868, 4094.6724262058965, 4097.610726980932, 4103.610157035077, 4119.855805046809, 4185.853495127656, 43787.0, 43908.341374879405, 44007.339889901676, 44935.10129797386, 45533.544664553265, 9354.906450935403, 9377.531123443801, 9446.102620251202, 9485.525723713925, 9508.619655213852, 16647.667046659, 17205.56986075358, 17347.392841250497, 17429.12854357277, 17430.65138697219, 6641.966790166019, 6693.698783554752, 6776.186857577024, 6918.0, 6935.237123916365, 3866.2267546490816, 3887.37801951692, 3897.2205558888336, 3966.0679740261016, 3986.123052928351, 2824.491591513547, 2894.7105289470883, 2895.5077636801793, 2899.275181204699, 2900.0429858146763, 511.1999720437578, 532.6670830730793, 540.645876950598, 546.710243570908, 546.8004178474828, 454.6749074411811, 467.37138548652007, 598.2521847690386, 600.5195843325322, 608.6165715599144, 7542.47202695806, 7861.724839630586, 7973.242541958504, 8021.558814265155, 8191.50850948933, 574.5231457889942, 580.9419058094242, 583.7635757518212, 591.9230500034968, 596.6604971838165, 3576.8211589420425, 3682.779033258013, 3857.2092720992127, 3914.9608503915165, 3927.5286965563746, 53343.73328133412, 53480.73259633677, 53523.19715204275, 53681.463185368426, 54454.0, 46403.76798115988, 46569.30146047812, 46897.53102468931, 48120.518794812306, 48807.26789098166, 44542.77728611336, 44607.0, 44880.77559612246, 44993.325100123526, 45438.772806135756, 7389.298016688406, 7410.629468526445, 7412.295831895961, 7416.295451932057, 7509.85780857929, 30770.538441923836, 30831.84584077155, 31087.222819429695, 31401.685983139876, 31460.528092079094, 37611.2477750438, 38500.42249366206, 40967.590324096374, 41154.0, 41587.7920610395, 8914.37599368038, 9117.407368521024, 9154.40496367734, 9208.03315651847, 9464.050474935724, 10103.09072183507, 10365.274430790074, 10581.52383142745, 10939.781204376028, 11024.724381890517, 9210.815783684155, 9658.661946831828, 10970.835437468604, 11076.446177691245, 11251.49368278413, 11399.316041037564, 11597.130215233723, 11811.409429528661, 12180.269183848997, 12238.082143839425, 10835.783284334111, 10988.780224395627, 11057.447127643425, 11325.207235493437, 11691.883081169079, 9312.860307095534, 9338.206252468617, 9380.29647776406, 9667.661631842851, 10023.69928902134, 8924.196822286025, 9048.230900373279, 9053.864192037256, 9127.543622818699, 9384.718458446258], "value": 5924.660252330829, "unit": "score"}], "name": "dromaeo_css", "value": 6443.216020043975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 111.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 155.0, 216.0, 128.0, 159.0, 151.0, 130.0, 197.0, 131.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 153.0, 76.0, 76.0, 77.0, 74.0, 133.0, 76.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 145.0, 91.0, 92.0, 93.0, 125.0, 92.0, 93.0, 120.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 74.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 92.0, 85.0, 83.0, 83.0, 163.0, 84.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 132.0, 133.0, 126.0, 127.0, 129.0, 129.0, 153.0, 130.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 165.0, 166.0, 166.0, 166.0, 165.0, 166.0, 165.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 66.0, 66.0, 65.0, 66.0, 64.0, 64.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1566.3999999999999, "alertThreshold": 2.0}]} 15:32:35 INFO - Return code: 0 15:32:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:32:35 ERROR - # TBPL SUCCESS # 15:32:35 INFO - Running post-action listener: _resource_record_post_action 15:32:35 INFO - ##### 15:32:35 INFO - ##### Finished run-tests step (success) 15:32:35 INFO - ##### 15:32:35 INFO - Running post-run listener: _resource_record_post_run 15:32:35 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 532021248; Read time: 0; Write time: 373632 15:32:35 INFO - TinderboxPrint: CPU usage
13.1% 15:32:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:32:35 INFO - TinderboxPrint: I/O write bytes / time
532,021,248 / 373,632 15:32:35 INFO - TinderboxPrint: CPU idle
8,330.5 (86.9%) 15:32:35 INFO - TinderboxPrint: CPU user
1,213.1 (12.7%) 15:32:35 INFO - TinderboxPrint: Swap in / out
0 / 0 15:32:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236511232; Read time: 0; Write time: 190384 15:32:35 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 295510016; Read time: 0; Write time: 183248 15:32:36 INFO - Running post-run listener: _upload_blobber_files 15:32:36 INFO - Blob upload gear active. 15:32:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:36 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 15:32:36 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:32:36 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:32:36 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:37 INFO - (blobuploader) - INFO - Done attempting. 15:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:32:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:38 INFO - (blobuploader) - INFO - Done attempting. 15:32:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:32:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:41 INFO - (blobuploader) - INFO - Done attempting. 15:32:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:41 INFO - Return code: 0 15:32:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:32:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6af5ac59e6c5c95f1c18aa790edcf37604a79b6cc14f8893546cd72c36518490a25a3f72a953f49bd9bb28fa80a46c4bce9bab0dabfd891fc337821124a892ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3758b9110c0ad9cf4e479402b63c0f3f4d98f1c16059aa51571165abb781c1b72abb93f4802f7629b25e68951cb6fd3ae3119968d192a4f92109b6ac5e2f8e1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06768a5a5a089ce9a66e99faa9c899161ffc1f03b6d89a4994614e32802c17fd62c6f9e181512473c118c60111aff12d9d5c9f12134d5f4f3117d0c2f7de9c55"} 15:32:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:32:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:32:41 INFO - Contents: 15:32:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6af5ac59e6c5c95f1c18aa790edcf37604a79b6cc14f8893546cd72c36518490a25a3f72a953f49bd9bb28fa80a46c4bce9bab0dabfd891fc337821124a892ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3758b9110c0ad9cf4e479402b63c0f3f4d98f1c16059aa51571165abb781c1b72abb93f4802f7629b25e68951cb6fd3ae3119968d192a4f92109b6ac5e2f8e1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06768a5a5a089ce9a66e99faa9c899161ffc1f03b6d89a4994614e32802c17fd62c6f9e181512473c118c60111aff12d9d5c9f12134d5f4f3117d0c2f7de9c55"} 15:32:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:41 INFO - Copying logs to upload dir... 15:32:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:32:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.743245 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-17 15:32:41.347510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 15:32:41.351138) ========= 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=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6af5ac59e6c5c95f1c18aa790edcf37604a79b6cc14f8893546cd72c36518490a25a3f72a953f49bd9bb28fa80a46c4bce9bab0dabfd891fc337821124a892ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3758b9110c0ad9cf4e479402b63c0f3f4d98f1c16059aa51571165abb781c1b72abb93f4802f7629b25e68951cb6fd3ae3119968d192a4f92109b6ac5e2f8e1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06768a5a5a089ce9a66e99faa9c899161ffc1f03b6d89a4994614e32802c17fd62c6f9e181512473c118c60111aff12d9d5c9f12134d5f4f3117d0c2f7de9c55"} build_url:https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/NVEg4AqYTeWi9TtsTlKECw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6af5ac59e6c5c95f1c18aa790edcf37604a79b6cc14f8893546cd72c36518490a25a3f72a953f49bd9bb28fa80a46c4bce9bab0dabfd891fc337821124a892ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3758b9110c0ad9cf4e479402b63c0f3f4d98f1c16059aa51571165abb781c1b72abb93f4802f7629b25e68951cb6fd3ae3119968d192a4f92109b6ac5e2f8e1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06768a5a5a089ce9a66e99faa9c899161ffc1f03b6d89a4994614e32802c17fd62c6f9e181512473c118c60111aff12d9d5c9f12134d5f4f3117d0c2f7de9c55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 15:32:41.378771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:32:41.379137) ========= 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=6d15e502d8e29d5d2676d664000001c3-1463523117.340495-2014307011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:32:41.463825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 15:32:41.464176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 15:32:41.464526) ========= ========= Total master_lag: 0.16 =========