builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1464706799.1 results: success (0) buildid: 20160531053004 builduid: ca5d78058aac4173aab7f23709994b6f revision: 8bf67bdad00282eed87c14a08c166a0ca90bf621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.103460) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.104019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.104329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.127241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.127833) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 07:59: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-05-31 07:59:59 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.234240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.234582) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.283937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.284290) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8bf67bdad00282eed87c14a08c166a0ca90bf621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8bf67bdad00282eed87c14a08c166a0ca90bf621 --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=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 07:59:59,359 truncating revision to first 12 chars 2016-05-31 07:59:59,359 Setting DEBUG logging. 2016-05-31 07:59:59,359 attempt 1/10 2016-05-31 07:59:59,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8bf67bdad002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 07:59:59,675 unpacking tar archive at: fx-team-8bf67bdad002/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637392 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.935029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.935338) ========= script_repo_revision: 8bf67bdad00282eed87c14a08c166a0ca90bf621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.935770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.936040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 07:59:59.946071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 07:59:59.946340) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:00 INFO - MultiFileLogger online at 20160531 08:00:00 in /builds/slave/test 08:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:00 INFO - {'append_to_log': False, 08:00:00 INFO - 'base_work_dir': '/builds/slave/test', 08:00:00 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:00 INFO - 'branch': 'Fx-Team', 08:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:00 INFO - 'config_files': ('talos/linux_config.py',), 08:00:00 INFO - 'default_actions': ('clobber', 08:00:00 INFO - 'read-buildbot-config', 08:00:00 INFO - 'download-and-extract', 08:00:00 INFO - 'populate-webroot', 08:00:00 INFO - 'create-virtualenv', 08:00:00 INFO - 'install', 08:00:00 INFO - 'run-tests'), 08:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:00 INFO - 'download_minidump_stackwalk': True, 08:00:00 INFO - 'download_symbols': 'ondemand', 08:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:00 INFO - 'installer_path': 'installer.exe', 08:00:00 INFO - 'log_level': 'info', 08:00:00 INFO - 'log_name': 'talos', 08:00:00 INFO - 'log_to_console': True, 08:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:00 INFO - 'opt_config_files': (), 08:00:00 INFO - 'pip_index': False, 08:00:00 INFO - 'sps_profile': False, 08:00:00 INFO - 'sps_profile_interval': 0, 08:00:00 INFO - 'suite': 'dromaeojs', 08:00:00 INFO - 'system_bits': '32', 08:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:00 INFO - 'title': 'talos-linux64-ix-030', 08:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:00 INFO - 'use_talos_json': True, 08:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:00 INFO - 'work_dir': 'build'} 08:00:00 INFO - ##### 08:00:00 INFO - ##### Running clobber step. 08:00:00 INFO - ##### 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: clobber 08:00:00 INFO - rmtree: /builds/slave/test/build 08:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:00 INFO - Running post-action listener: _resource_record_post_action 08:00:00 INFO - ##### 08:00:00 INFO - ##### Finished clobber step (success) 08:00:00 INFO - ##### 08:00:00 INFO - ##### 08:00:00 INFO - ##### Running read-buildbot-config step. 08:00:00 INFO - ##### 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: read_buildbot_config 08:00:00 INFO - Using buildbot properties: 08:00:00 INFO - { 08:00:00 INFO - "project": "", 08:00:00 INFO - "product": "firefox", 08:00:00 INFO - "script_repo_revision": "production", 08:00:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:00 INFO - "repository": "", 08:00:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:00 INFO - "buildid": "20160531053004", 08:00:00 INFO - "pgo_build": "True", 08:00:00 INFO - "basedir": "/builds/slave/test", 08:00:00 INFO - "buildnumber": 746, 08:00:00 INFO - "slavename": "talos-linux64-ix-030", 08:00:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:00 INFO - "platform": "ubuntu64_hw", 08:00:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:00 INFO - "branch": "fx-team", 08:00:00 INFO - "repo_path": "integration/fx-team", 08:00:00 INFO - "revision": "8bf67bdad00282eed87c14a08c166a0ca90bf621", 08:00:00 INFO - "stage_platform": "linux64-pgo", 08:00:00 INFO - "builduid": "ca5d78058aac4173aab7f23709994b6f", 08:00:00 INFO - "slavebuilddir": "test" 08:00:00 INFO - } 08:00:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:00:00 INFO - Running post-action listener: _resource_record_post_action 08:00:00 INFO - ##### 08:00:00 INFO - ##### Finished read-buildbot-config step (success) 08:00:00 INFO - ##### 08:00:00 INFO - ##### 08:00:00 INFO - ##### Running download-and-extract step. 08:00:00 INFO - ##### 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: download_and_extract 08:00:00 INFO - mkdir: /builds/slave/test/build/tests 08:00: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')]} 08:00:00 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:01 INFO - Downloaded 1361 bytes. 08:00:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - Using the following test package requirements: 08:00:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'jsshell-linux-x86_64.zip'], 08:00:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00: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')]} 08:00:01 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:02 INFO - Downloaded 24410458 bytes. 08:00: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'] 08:00: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 08:00:03 INFO - Return code: 0 08:00: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 08:00: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')]} 08:00:03 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:06 INFO - Downloaded 24410458 bytes. 08:00:06 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'] 08:00:06 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 08:00:07 INFO - Return code: 0 08:00: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')]} 08:00:07 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:08 INFO - Downloaded 10834055 bytes. 08:00:08 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'] 08:00:08 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 08:00:08 INFO - Return code: 0 08:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:08 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 08:00:10 INFO - Downloaded 58938764 bytes. 08:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:10 INFO - mkdir: /builds/slave/test/properties 08:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:10 INFO - Contents: 08:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:10 INFO - Running post-action listener: _resource_record_post_action 08:00:11 INFO - Running post-action listener: set_extra_try_arguments 08:00:11 INFO - ##### 08:00:11 INFO - ##### Finished download-and-extract step (success) 08:00:11 INFO - ##### 08:00:11 INFO - ##### 08:00:11 INFO - ##### Running populate-webroot step. 08:00:11 INFO - ##### 08:00:11 INFO - Running pre-action listener: _resource_record_pre_action 08:00:11 INFO - Running main action method: populate_webroot 08:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:11 INFO - '--tppagecycles', 08:00:11 INFO - '7'], 08:00:11 INFO - 'tests': ['tsvgm']}}, 08:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['damp', 'tps']}, 08:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'tests': ['damp', 'tps']}, 08:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['dromaeo_dom']}, 08:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['a11yr', 08:00:11 INFO - 'ts_paint', 08:00:11 INFO - 'tpaint', 08:00:11 INFO - 'sessionrestore', 08:00:11 INFO - 'sessionrestore_no_auto_restore', 08:00:11 INFO - 'tabpaint']}, 08:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['tsvgx', 08:00:11 INFO - 'tsvgr_opacity', 08:00:11 INFO - 'tart', 08:00:11 INFO - 'tscrollx', 08:00:11 INFO - 'cart']}, 08:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:11 INFO - 'tsvgr_opacity', 08:00:11 INFO - 'tart', 08:00:11 INFO - 'tscrollx', 08:00:11 INFO - 'cart']}, 08:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'talos_options': ['--disable-e10s'], 08:00:11 INFO - 'tests': ['tp5o']}, 08:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'tests': ['tp5o']}, 08:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'talos_options': ['--disable-e10s', 08:00:11 INFO - '--xperf_path', 08:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:11 INFO - 'tests': ['tp5n']}, 08:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:11 INFO - 'talos_options': ['--xperf_path', 08:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:11 INFO - 'tests': ['tp5n']}}, 08:00:11 INFO - 'talos.zip': {'path': '', 08:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:11 INFO - Running post-action listener: _resource_record_post_action 08:00:11 INFO - ##### 08:00:11 INFO - ##### Finished populate-webroot step (success) 08:00:11 INFO - ##### 08:00:11 INFO - ##### 08:00:11 INFO - ##### Running create-virtualenv step. 08:00:11 INFO - ##### 08:00:11 INFO - Running pre-action listener: _resource_record_pre_action 08:00:11 INFO - Running main action method: create_virtualenv 08:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:11 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 08:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:11 INFO - Using real prefix '/usr' 08:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:13 INFO - Installing pip.................done. 08:00:13 INFO - Return code: 0 08:00:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00:13 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')]} 08:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:13 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')]} 08:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:13 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:13 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 08:00:13 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 08:00:13 INFO - Using env: {'DISPLAY': ':0', 08:00:13 INFO - 'HOME': '/home/cltbld', 08:00:13 INFO - 'LANG': 'en_US.UTF-8', 08:00:13 INFO - 'LANGUAGE': 'en_US:en', 08:00:13 INFO - 'LOGNAME': 'cltbld', 08:00:13 INFO - 'MAIL': '/var/mail/cltbld', 08:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:13 INFO - 'MOZ_NO_REMOTE': '1', 08:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:13 INFO - 'NO_EM_RESTART': '1', 08:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:13 INFO - 'PWD': '/builds/slave/test', 08:00:13 INFO - 'SHELL': '/bin/bash', 08:00:13 INFO - 'SHLVL': '1', 08:00:13 INFO - 'TERM': 'linux', 08:00:13 INFO - 'TMOUT': '86400', 08:00:13 INFO - 'USER': 'cltbld', 08:00:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:13 INFO - '_': '/tools/buildbot/bin/python'} 08:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:13 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 08:00:13 INFO - Cleaning up... 08:00:13 INFO - Return code: 0 08:00:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00:13 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')]} 08:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:13 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')]} 08:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:13 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:13 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 08:00:13 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 08:00:13 INFO - Using env: {'DISPLAY': ':0', 08:00:13 INFO - 'HOME': '/home/cltbld', 08:00:13 INFO - 'LANG': 'en_US.UTF-8', 08:00:13 INFO - 'LANGUAGE': 'en_US:en', 08:00:13 INFO - 'LOGNAME': 'cltbld', 08:00:13 INFO - 'MAIL': '/var/mail/cltbld', 08:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:13 INFO - 'MOZ_NO_REMOTE': '1', 08:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:13 INFO - 'NO_EM_RESTART': '1', 08:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:13 INFO - 'PWD': '/builds/slave/test', 08:00:13 INFO - 'SHELL': '/bin/bash', 08:00:13 INFO - 'SHLVL': '1', 08:00:13 INFO - 'TERM': 'linux', 08:00:13 INFO - 'TMOUT': '86400', 08:00:13 INFO - 'USER': 'cltbld', 08:00:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:13 INFO - '_': '/tools/buildbot/bin/python'} 08:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:14 INFO - Downloading/unpacking psutil>=3.1.1 08:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:14 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 08:00:14 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 08:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:16 INFO - Installing collected packages: psutil 08:00:16 INFO - Running setup.py install for psutil 08:00:16 INFO - building 'psutil._psutil_linux' extension 08:00:16 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 08:00:16 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 08:00:16 INFO - building 'psutil._psutil_posix' extension 08:00:16 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 08:00:16 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 08:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:16 INFO - Successfully installed psutil 08:00:16 INFO - Cleaning up... 08:00:16 INFO - Return code: 0 08:00:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:16 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 08:00:16 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 08:00:16 INFO - Using env: {'DISPLAY': ':0', 08:00:16 INFO - 'HOME': '/home/cltbld', 08:00:16 INFO - 'LANG': 'en_US.UTF-8', 08:00:16 INFO - 'LANGUAGE': 'en_US:en', 08:00:16 INFO - 'LOGNAME': 'cltbld', 08:00:16 INFO - 'MAIL': '/var/mail/cltbld', 08:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:16 INFO - 'MOZ_NO_REMOTE': '1', 08:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:16 INFO - 'NO_EM_RESTART': '1', 08:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:16 INFO - 'PWD': '/builds/slave/test', 08:00:16 INFO - 'SHELL': '/bin/bash', 08:00:16 INFO - 'SHLVL': '1', 08:00:16 INFO - 'TERM': 'linux', 08:00:16 INFO - 'TMOUT': '86400', 08:00:16 INFO - 'USER': 'cltbld', 08:00:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:16 INFO - '_': '/tools/buildbot/bin/python'} 08:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00:16 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 08:00:16 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 08:00:16 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 08:00:16 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 08:00:16 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 08:00:16 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 08:00:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:18 INFO - Installing collected packages: mozsystemmonitor 08:00:18 INFO - Running setup.py install for mozsystemmonitor 08:00:18 INFO - Successfully installed mozsystemmonitor 08:00:18 INFO - Cleaning up... 08:00:18 INFO - Return code: 0 08:00:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:18 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:18 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 08:00:18 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 08:00:18 INFO - Using env: {'DISPLAY': ':0', 08:00:18 INFO - 'HOME': '/home/cltbld', 08:00:18 INFO - 'LANG': 'en_US.UTF-8', 08:00:18 INFO - 'LANGUAGE': 'en_US:en', 08:00:18 INFO - 'LOGNAME': 'cltbld', 08:00:18 INFO - 'MAIL': '/var/mail/cltbld', 08:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:18 INFO - 'MOZ_NO_REMOTE': '1', 08:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:18 INFO - 'NO_EM_RESTART': '1', 08:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:18 INFO - 'PWD': '/builds/slave/test', 08:00:18 INFO - 'SHELL': '/bin/bash', 08:00:18 INFO - 'SHLVL': '1', 08:00:18 INFO - 'TERM': 'linux', 08:00:18 INFO - 'TMOUT': '86400', 08:00:18 INFO - 'USER': 'cltbld', 08:00:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:18 INFO - '_': '/tools/buildbot/bin/python'} 08:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 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 08:00:21 INFO - Downloading docopt-0.6.1.tar.gz 08:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:21 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:21 INFO - Running setup.py install for blobuploader 08:00:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:21 INFO - Running setup.py install for requests 08:00:22 INFO - Running setup.py install for docopt 08:00:22 INFO - Successfully installed blobuploader requests docopt 08:00:22 INFO - Cleaning up... 08:00:22 INFO - Return code: 0 08:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:22 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:22 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 08:00:22 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 08:00:22 INFO - Using env: {'DISPLAY': ':0', 08:00:22 INFO - 'HOME': '/home/cltbld', 08:00:22 INFO - 'LANG': 'en_US.UTF-8', 08:00:22 INFO - 'LANGUAGE': 'en_US:en', 08:00:22 INFO - 'LOGNAME': 'cltbld', 08:00:22 INFO - 'MAIL': '/var/mail/cltbld', 08:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:22 INFO - 'MOZ_NO_REMOTE': '1', 08:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:22 INFO - 'NO_EM_RESTART': '1', 08:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:22 INFO - 'PWD': '/builds/slave/test', 08:00:22 INFO - 'SHELL': '/bin/bash', 08:00:22 INFO - 'SHLVL': '1', 08:00:22 INFO - 'TERM': 'linux', 08:00:22 INFO - 'TMOUT': '86400', 08:00:22 INFO - 'USER': 'cltbld', 08:00:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:22 INFO - '_': '/tools/buildbot/bin/python'} 08:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:22 INFO - Running setup.py (path:/tmp/pip-4LmBpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:22 INFO - Running setup.py (path:/tmp/pip-AYJ4IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:22 INFO - Running setup.py (path:/tmp/pip-Aucw7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:22 INFO - Running setup.py (path:/tmp/pip-pvbon0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:22 INFO - Running setup.py (path:/tmp/pip-riSxV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:23 INFO - Running setup.py (path:/tmp/pip-JHxlzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:23 INFO - Running setup.py (path:/tmp/pip-9dZ9cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:23 INFO - Running setup.py (path:/tmp/pip-5WXHh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:23 INFO - Running setup.py (path:/tmp/pip-hC5fqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:23 INFO - Running setup.py (path:/tmp/pip-zCH3Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:23 INFO - Running setup.py (path:/tmp/pip-tjSWqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:23 INFO - Running setup.py (path:/tmp/pip-_kTNrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:23 INFO - Running setup.py (path:/tmp/pip-BCQAj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:23 INFO - Running setup.py (path:/tmp/pip-s4lRHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:23 INFO - Running setup.py (path:/tmp/pip-ESUP5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:23 INFO - Running setup.py (path:/tmp/pip-dagBlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:23 INFO - Running setup.py (path:/tmp/pip-HJ_h0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:23 INFO - Running setup.py install for manifestparser 08:00:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:23 INFO - Running setup.py install for mozcrash 08:00:24 INFO - Running setup.py install for mozdebug 08:00:24 INFO - Running setup.py install for mozdevice 08:00:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for mozfile 08:00:24 INFO - Running setup.py install for mozhttpd 08:00:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for mozinfo 08:00:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for mozInstall 08:00:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for mozleak 08:00:24 INFO - Running setup.py install for mozlog 08:00:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for moznetwork 08:00:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:24 INFO - Running setup.py install for mozprocess 08:00:25 INFO - Running setup.py install for mozprofile 08:00:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:25 INFO - Running setup.py install for mozrunner 08:00:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:25 INFO - Running setup.py install for mozscreenshot 08:00:25 INFO - Running setup.py install for moztest 08:00:25 INFO - Running setup.py install for mozversion 08:00:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:25 INFO - Cleaning up... 08:00:25 INFO - Return code: 0 08:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:25 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')]} 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 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')]} 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:25 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 08:00:25 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 08:00:25 INFO - Using env: {'DISPLAY': ':0', 08:00:25 INFO - 'HOME': '/home/cltbld', 08:00:25 INFO - 'LANG': 'en_US.UTF-8', 08:00:25 INFO - 'LANGUAGE': 'en_US:en', 08:00:25 INFO - 'LOGNAME': 'cltbld', 08:00:25 INFO - 'MAIL': '/var/mail/cltbld', 08:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:25 INFO - 'MOZ_NO_REMOTE': '1', 08:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:25 INFO - 'NO_EM_RESTART': '1', 08:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:25 INFO - 'PWD': '/builds/slave/test', 08:00:25 INFO - 'SHELL': '/bin/bash', 08:00:25 INFO - 'SHLVL': '1', 08:00:25 INFO - 'TERM': 'linux', 08:00:25 INFO - 'TMOUT': '86400', 08:00:25 INFO - 'USER': 'cltbld', 08:00:25 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:25 INFO - '_': '/tools/buildbot/bin/python'} 08:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:25 INFO - Running setup.py (path:/tmp/pip-Xqe9X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:25 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)) 08:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:25 INFO - Running setup.py (path:/tmp/pip-PKU0om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:26 INFO - Running setup.py (path:/tmp/pip-ojIyL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:26 INFO - Running setup.py (path:/tmp/pip-Hrzod8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:26 INFO - Running setup.py (path:/tmp/pip-f8epMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:26 INFO - Running setup.py (path:/tmp/pip-c4mhtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:26 INFO - Running setup.py (path:/tmp/pip-fHQPO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:26 INFO - Running setup.py (path:/tmp/pip-VeI0H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:26 INFO - Running setup.py (path:/tmp/pip-CqGZSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:26 INFO - Running setup.py (path:/tmp/pip-qFSNj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:26 INFO - Running setup.py (path:/tmp/pip-cBT7wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:26 INFO - Running setup.py (path:/tmp/pip-SaabPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:26 INFO - Running setup.py (path:/tmp/pip-CiAHMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:26 INFO - Running setup.py (path:/tmp/pip-S4uCNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:26 INFO - Running setup.py (path:/tmp/pip-_ST9nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:26 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)) 08:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:26 INFO - Running setup.py (path:/tmp/pip-7_Djww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:27 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)) 08:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:27 INFO - Running setup.py (path:/tmp/pip-3hXYSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:27 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)) 08:00:27 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)) 08:00:27 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)) 08:00:27 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)) 08:00:27 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)) 08:00:27 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)) 08:00:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:27 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 08:00:28 INFO - Downloading blessings-1.6.tar.gz 08:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:29 INFO - Installing collected packages: blessings 08:00:29 INFO - Running setup.py install for blessings 08:00:29 INFO - Successfully installed blessings 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:29 INFO - Reading from file tmpfile_stdout 08:00:29 INFO - Current package versions: 08:00:29 INFO - argparse == 1.2.1 08:00:29 INFO - blessings == 1.6 08:00:29 INFO - blobuploader == 1.2.4 08:00:29 INFO - docopt == 0.6.1 08:00:29 INFO - manifestparser == 1.1 08:00:29 INFO - mozInstall == 1.12 08:00:29 INFO - mozcrash == 0.17 08:00:29 INFO - mozdebug == 0.1 08:00:29 INFO - mozdevice == 0.48 08:00:29 INFO - mozfile == 1.2 08:00:29 INFO - mozhttpd == 0.7 08:00:29 INFO - mozinfo == 0.9 08:00:29 INFO - mozleak == 0.1 08:00:29 INFO - mozlog == 3.2 08:00:29 INFO - moznetwork == 0.27 08:00:29 INFO - mozprocess == 0.22 08:00:29 INFO - mozprofile == 0.28 08:00:29 INFO - mozrunner == 6.11 08:00:29 INFO - mozscreenshot == 0.1 08:00:29 INFO - mozsystemmonitor == 0.3 08:00:29 INFO - moztest == 0.7 08:00:29 INFO - mozversion == 1.4 08:00:29 INFO - psutil == 3.1.1 08:00:29 INFO - requests == 1.2.3 08:00:29 INFO - wsgiref == 0.1.2 08:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:29 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')]} 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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')]} 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:29 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 08:00:29 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 08:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 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)) 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:29 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')]} 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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')]} 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:29 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 08:00:29 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 08:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:29 INFO - Downloading/unpacking jsonschema 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:31 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:32 INFO - warning: no files found matching '*.txt' 08:00:32 INFO - no previously-included directories found matching 'build' 08:00:32 INFO - no previously-included directories found matching 'dist' 08:00:32 INFO - no previously-included directories found matching '.git*' 08:00:32 INFO - Installing collected packages: jsonschema, functools32 08:00:32 INFO - Running setup.py install for functools32 08:00:32 INFO - warning: no files found matching '*.txt' 08:00:32 INFO - no previously-included directories found matching 'build' 08:00:32 INFO - no previously-included directories found matching 'dist' 08:00:32 INFO - no previously-included directories found matching '.git*' 08:00:32 INFO - Successfully installed jsonschema functools32 08:00:32 INFO - Cleaning up... 08:00:32 INFO - Return code: 0 08:00:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:00:32 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')]} 08:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:32 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')]} 08:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:32 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 0x7f0d0ab82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', '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 08:00:32 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 08:00:32 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 08:00:32 INFO - Using env: {'DISPLAY': ':0', 08:00:32 INFO - 'HOME': '/home/cltbld', 08:00:32 INFO - 'LANG': 'en_US.UTF-8', 08:00:32 INFO - 'LANGUAGE': 'en_US:en', 08:00:32 INFO - 'LOGNAME': 'cltbld', 08:00:32 INFO - 'MAIL': '/var/mail/cltbld', 08:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:32 INFO - 'MOZ_NO_REMOTE': '1', 08:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:32 INFO - 'NO_EM_RESTART': '1', 08:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:32 INFO - 'PWD': '/builds/slave/test', 08:00:32 INFO - 'SHELL': '/bin/bash', 08:00:32 INFO - 'SHLVL': '1', 08:00:32 INFO - 'TERM': 'linux', 08:00:32 INFO - 'TMOUT': '86400', 08:00:32 INFO - 'USER': 'cltbld', 08:00:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:32 INFO - '_': '/tools/buildbot/bin/python'} 08:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:32 INFO - Downloading/unpacking flake8 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:35 INFO - no previously-included directories found matching 'docs/_build' 08:00:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:35 INFO - Running setup.py install for pep8 08:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:35 INFO - no previously-included directories found matching 'docs/_build' 08:00:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:35 INFO - Cleaning up... 08:00:35 INFO - Return code: 0 08:00:35 INFO - Running post-action listener: _resource_record_post_action 08:00:35 INFO - Running post-action listener: _start_resource_monitoring 08:00:35 INFO - Starting resource monitoring. 08:00:35 INFO - ##### 08:00:35 INFO - ##### Finished create-virtualenv step (success) 08:00:35 INFO - ##### 08:00:35 INFO - ##### 08:00:35 INFO - ##### Running install step. 08:00:35 INFO - ##### 08:00:35 INFO - Running pre-action listener: _resource_record_pre_action 08:00:35 INFO - Running main action method: install 08:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:35 INFO - Reading from file tmpfile_stdout 08:00:35 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:35 INFO - Reading from file tmpfile_stdout 08:00:35 INFO - Output received: 08:00:35 INFO - Usage: mozinstall [options] installer 08:00:35 INFO - Options: 08:00:35 INFO - -h, --help show this help message and exit 08:00:35 INFO - -d DEST, --destination=DEST 08:00:35 INFO - Directory to install application into. [default: 08:00:35 INFO - "/builds/slave/test"] 08:00:35 INFO - --app=APP Application being installed. [default: firefox] 08:00:35 INFO - mkdir: /builds/slave/test/build/application 08:00:35 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'] 08:00:35 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 08:00:52 INFO - Reading from file tmpfile_stdout 08:00:52 INFO - Output received: 08:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:52 INFO - Running post-action listener: _resource_record_post_action 08:00:52 INFO - ##### 08:00:52 INFO - ##### Finished install step (success) 08:00:52 INFO - ##### 08:00:52 INFO - ##### 08:00:52 INFO - ##### Running run-tests step. 08:00:52 INFO - ##### 08:00:52 INFO - Running pre-action listener: _resource_record_pre_action 08:00:52 INFO - Running main action method: run_tests 08:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:52 INFO - Python 2.7.3 08:00:52 INFO - Return code: 0 08:00:52 INFO - grabbing minidump binary from tooltool 08:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:52 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 0x10379c0>, '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 0x10388c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:52 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 08:00:52 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 08:00:52 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 08:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:52 INFO - Return code: 0 08:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:00:53 INFO - Return code: 0 08:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 08:00:53 INFO - Using env: {'DISPLAY': ':0', 08:00:53 INFO - 'HOME': '/home/cltbld', 08:00:53 INFO - 'LANG': 'en_US.UTF-8', 08:00:53 INFO - 'LANGUAGE': 'en_US:en', 08:00:53 INFO - 'LOGNAME': 'cltbld', 08:00:53 INFO - 'MAIL': '/var/mail/cltbld', 08:00:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:53 INFO - 'MOZ_NO_REMOTE': '1', 08:00:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:53 INFO - 'NO_EM_RESTART': '1', 08:00:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:53 INFO - 'PWD': '/builds/slave/test', 08:00:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:53 INFO - 'SHELL': '/bin/bash', 08:00:53 INFO - 'SHLVL': '1', 08:00:53 INFO - 'TERM': 'linux', 08:00:53 INFO - 'TMOUT': '86400', 08:00:53 INFO - 'USER': 'cltbld', 08:00:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430', 08:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:53 INFO - '_': '/tools/buildbot/bin/python'} 08:00:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:00:53 INFO - mozversion application_buildid: 20160531053004 08:00:53 INFO - mozversion application_changeset: 8bf67bdad00282eed87c14a08c166a0ca90bf621 08:00:53 INFO - mozversion application_display_name: Nightly 08:00:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:53 INFO - mozversion application_name: Firefox 08:00:53 INFO - mozversion application_remotingname: firefox 08:00:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:00:53 INFO - mozversion application_vendor: Mozilla 08:00:53 INFO - mozversion application_version: 49.0a1 08:00:53 INFO - mozversion platform_buildid: 20160531053004 08:00:53 INFO - mozversion platform_changeset: 8bf67bdad00282eed87c14a08c166a0ca90bf621 08:00:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:00:53 INFO - mozversion platform_version: 49.0a1 08:00:53 INFO - using testdate: 1464706853 08:00:53 INFO - actual date: 1464706853 08:00:53 INFO - starting webserver on 'localhost:48466' 08:00:53 INFO - SUITE-START | Running 2 tests 08:00:53 INFO - TEST-START | dromaeo_css 08:00:53 INFO - operating with platform_type : linux_ 08:00:53 INFO - Initialising browser for dromaeo_css test... 08:00:53 INFO - TEST-INFO | started process 17865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxvUNvj/profile http://localhost:48466/getInfo.html) 08:00:58 INFO - PROCESS | 17865 | __metrics Screen width/height:1600/1200 08:00:58 INFO - PROCESS | 17865 | colorDepth:24 08:00:58 INFO - PROCESS | 17865 | Browser inner width/height: 1024/697 08:00:58 INFO - PROCESS | 17865 | __metrics 08:00:59 ERROR - PROCESS | 17865 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:00 INFO - TEST-INFO | 17865: exit 0 08:01:00 INFO - Browser initialized. 08:01:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:00 INFO - TEST-INFO | started process 17946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxvUNvj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:11 INFO - PROCESS | 17946 | RSS: Main: 155381760 08:01:11 INFO - PROCESS | 17946 | 08:02:03 INFO - PROCESS | 17946 | 1464706923030 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] 08:04:11 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48466/tests/dromaeo/cssquery-ext.html) 08:04:12 INFO - PROCESS | 17946 | RSS: Main: 246882304 08:04:12 INFO - PROCESS | 17946 | 08:07:14 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-ext.html (next: http://localhost:48466/tests/dromaeo/cssquery-jquery.html) 08:07:15 INFO - PROCESS | 17946 | RSS: Main: 258396160 08:07:15 INFO - PROCESS | 17946 | 08:10:17 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48466/tests/dromaeo/cssquery-mootools.html) 08:10:17 INFO - PROCESS | 17946 | RSS: Main: 250179584 08:10:17 INFO - PROCESS | 17946 | 08:13:19 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48466/tests/dromaeo/cssquery-prototype.html) 08:13:20 INFO - PROCESS | 17946 | RSS: Main: 242479104 08:13:20 INFO - PROCESS | 17946 | 08:16:22 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48466/tests/dromaeo/cssquery-yui.html) 08:16:23 INFO - PROCESS | 17946 | RSS: Main: 226381824 08:16:23 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | Cycle 1(1): loaded http://localhost:48466/tests/dromaeo/cssquery-yui.html (next: http://localhost:48466/tests/dromaeo/cssquery-dojo.html) 08:19:26 INFO - PROCESS | 17946 | RSS: Main: 270487552 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | __start_tp_report 08:19:26 INFO - PROCESS | 17946 | _x_x_mozilla_page_load 08:19:26 INFO - PROCESS | 17946 | _x_x_mozilla_page_load_details 08:19:26 INFO - PROCESS | 17946 | |i|pagename|runs| 08:19:26 INFO - PROCESS | 17946 | |0;dojo.html;3141.9999999999995;3152.464081106213;3170.413473507401;3182.8249446280447;3221.613406391232;5219.791208351671;5311.814086506973;5355.892882142355;5376.220448035033;5425.83722488325;5339.172428273614;5349.652272602288;5369.140937450009;5417.3770016448125;5423.538999185064;4811.687240329376;4907.533784290505;4928.285398617199;4932.556069953704;5043.5965122790085;4990.47600002;5021.799128034892;5038.748062596874;5053.5451809337155;5097.108006098918;4784.928226076611;4847.07905497956;4874.268859671042;4896.632752543574;4905.558499735023;4874.439439464436;4885.511448855122;4899.681520701143;4974.37820272466;5004;4913.213885778258;4922.704637721748;4947.060058588857;4963.032208719301;5015.022070696215;5182.144946083929;5308.9469105308835;5378.273933019071;5416.431274716177;5452.154915988028;5861.296644402656;5881.382454842223;5898.911516327258;5908.320543137551;5922.58541902067;5524.419935906712;5878.2064421303;5914.2311499504785;5937.7921772737745;5940.495057920082;5305.7612407441375;5362.329708786402;5366.409694933554;5443.401225865112;5443.482869127427;5952.791652292149;5953;5956.493698035715;5956.791512297049;5958.731857066442;5476.151196564539;5733.913991290134;5737.713114344266;5743.339515955635;5746.166805813217;5617;5668.319801623831;5670.404607516234;5753.079507278815;5756.625819321731;5627.971860140673;5675.5459563234845;5680;5680.062789639664;5683.346415162227;5517.834464966058;5684.516816070598;5698.515626171822;5704.657720536781;5705.942940570624;4316.676249281317;4331.675124365685;4338.566143385636;4366.628836548865;4379.5182529921685;3888.7861167635488;3890.8832735017995;3892.1826416452295;3897.279003384383;3933.9606603933594;5258.2375555544995;5303.522682958553;5490.0941344677685;5524.806631767869;5539.224508568804;5828;5842.707864606753;5878;5915.3788852170765;5962.970185149134;5560.193771903132;5579.079451890474;5580.944190558123;5581.469760372758;5595.244641973363;4786.138495070851;4883.682560633548;4945.530174633404;4961.355023846949;4967.1517465354245;6063.878722425527;6065;6078.817635470943;6081.513478921675;6084.330723620398;5845.678487683048;5851.941480585139;5859.9121013183985;5862.501687356623;5868.882622347614;5761.942380576141;5969.850753731192;5995.280566332068;6021.367756385516;6030.939690603213;5702.287214098238;5703.173039909273;5711.514521265739;5714.20001199824;5720.256366672306;5740;5764.07774756037;5811.27359080115;5818.7090645466715;5828.825135245949;5494.120940649477;5520.641158324696;5576.079946808731;5586.636868603528;5652.265205523256;5579.302587176603;5601.103823388238;5604;5606.775728970795;5616.466435688603;5366.731663416892;5494.1758736189895;5509.917351239815;5516.641418307797;5562.833115006556;5557.610967232255;5594.3286805581965;5608.831735047955;5724.284464441945;5728.971355143198;5498.560115190855;5542.3349198094875;5545.3622833374675;5552.5557955362665;5592.5525957922455 08:19:26 INFO - PROCESS | 17946 | |1;ext.html;631.9526035547335;636.9076483909834;643.6395618453666;652.6475703120316;657.7763560389467;30630.38739225217;33975.320493590116;33978;34001.48997765035;42741;41335.37996930041;45625.54374456254;46056.76971615146;46109.30836037462;46122;8752.168543988328;8975.192232699088;8976.640934362618;8978.730638080835;8981.730548083535;8768.824623507526;8943.150400711955;8945.284377249804;8949.776255593597;8957.686480973134;8893.42192757472;8963.058878817728;8963.238124759404;8964.731058068235;8964.775880603005;8867.866981995243;8906.198442140174;8927.821443571092;8930.285577153812;8934.4192627479;8788.121187881161;8836.425632333941;8856.51289179095;8856.955715221447;8862.025177230564;42367.7881610593;42696.14607707829;42836.78581607072;42956.3556546652;43030.78484607557;3379.7186898843183;3981.6814654827544;4187.644050255702;4329.610335069828;4334;32174.678253217637;32509.674903251136;32525.349493010242;32560;33883.83058084694;3992.960070399317;4099.549049604541;4219.683523735732;4311.935320970188;4342.826286948518;354794;355419;355450;355989;356389;58283.542911427554;58584.70707646434;58851.23210830724;58854.7057264711;58885.116723249186;61777.691111544154;61902;62146.68926655338;62245.688771555855;62393.68803155955;16999.575010624587;17140.228689708743;17203.913980430018;17218.397356092475;17220.569485762706;12973.156744811557;13006.414711337824;13011.934940325427;13012.089153759336;13019.47922083125;15098.698026039418;16643.084630345445;16698.916505417394;16703.33186672544;16826.747598786027;5584.4434787386;6342.5243106767175;6538.071268975568;6565.441937435276;6692.899606505906;954.928380371461;1000.5347513406301;1020.2603112743202;1056.392574269798;1057.1014637558014;32098.358032839213;32616.347673046406;32617.67382326194;32980.340393192004;33419.66580334214;1157.8552680914886;1159.0693705002932;1165.5337864854125;1192.1476144556684;1215.4530461292454;16826.990380577205;17172.82827171737;17375.82624173742;17436.91281543584;17679.20443580042;532338;533880;536880;537350;538395;59367.703161483914;59689.806203875676;59759.40240597625;59767.70116149391;59817.40182598205;1283.146707439561;1385.0443194195973;1389.3400634698437;1415.688548519324;1434.8923830712738;29810.552841707824;33943.8729651457;34096.31807363789;34227.82886085554;34468.48297275493;50573.241401379746;50876.236856447926;51022.48977510177;51186.488135118176;51216.487835121174;402837;403830;405372;405731;405963;34036.48945265872;35182.65916023929;42333.57666423296;42544;45856.541434586565;45754;47887.281690775366;49640;50523.74738126286;50626;38377.232455350175;41929.580704192565;42441.24131931415;43338.34992475178;43502.782486087366;41194.38208426816;41923.7903810479;42019.57980420157;42256.36615450832;42436.575634243265;40708;41663.7916810414;41814.58185418229;41846.58153418548;44642.3303650439;34106.48840267348;37752.433713494866;37896.62103379041;38441.80779096198;38553.614463855;28546.714532854407;28897.42205155843;28953.98661046853;29060.56409153822;29118.56322155212 08:19:26 INFO - PROCESS | 17946 | |2;jquery.html;367.2984599415117;374.22535351821705;381.4164328577276;383.8675656898371;391.0653538044073;17960.640787184264;19132.90433547832;19662.508437289074;19669;19798.505037374074;17479.650406991852;18332.816671833276;18720.90639546804;19523.609527809436;19528.511787205327;5177;5259.6055295852775;5282.630215884889;5324.627276090675;5326.041312563737;5153.484651534835;5230;5245.082110630643;5269.841904742864;5274.472552744714;5208.322918020671;5229.163333866582;5254.238135470355;5256.947430525704;5258.316418865542;5124.103281925685;5203.557697595709;5236.162214045772;5265.3155089838265;5270.183121616155;5073.086844368012;5077.847664570032;5078.873028174288;5087.516685914869;5088.23676448532;13572.389242484112;13886;14050.227237501933;14107.36516856744;14119.435222591084;2237.183428048767;2247.0899285789283;2259.344790010895;2318.5594736999915;2361.5867223235864;9666.371685840399;9786.90213097867;9899.257555683353;10405.739856503573;10543.94728026355;1839.7700287464068;1893.602343507865;1907.7043058325983;1931.8164774346415;1936.9225230990744;57831.71084144552;62410.37589624091;77211.61394192993;79809.60095199545;82670;11050.557977680803;11236;11248.26886252391;11362.261453005529;11421.486033128529;15636.140012299205;15733.44932927342;15834;15851.524454266391;15862.206889655472;7351.191368949411;7668.769936901902;8107.270345668918;8333.66665333392;8558.871616925626;7710.344620707303;7860.921390786133;7865.056193256732;7907.327877130393;7930.048394192619;4765.69023013503;4788.569028787426;4808.2547205183255;4826.831060912921;4943.777530011158;1872.6910059839975;1880.6332765110672;1882.2941396976134;1937.409090227494;1997.7003449482693;986.5807032011367;994.5027486256871;1029.7425643589104;1060.0989159214605;1077.256692881909;18602.720959185623;18967.525811854815;19235.326763563207;19296.4211073668;19443.611127777363;995.3430735714394;999.8000399920045;1000.9199264058858;1006.1950439648252;1032.87605487342;10480.947595262127;10867.184961127947;10950.083735346283;11030.338179709242;11040.668779936615;468346;470998;491196;493325;496491;82689;87655.56172219098;88182.55908720415;98872;99155;1026.2508368890751;1036.8237399641928;1068.9251752377415;1074.6023971130576;1077.4451157653814;13927.512537061155;16566.66866662684;17124.828751712324;17836.910815446357;17887.552811179823;41585.58414415817;41858.790706046275;41900.37149442822;42523.574764251964;43229.351559726;52904;55544;56130.05463934493;56465;56907.14639280331;7539.095308563007;7794.337481313925;8601.913980860112;8807.559622018745;8986.281097512314;10244.692659220234;10669.679909602724;13417.262050587311;13484.662883427993;14162;11594.71013224676;11760.411979400824;11830;11854.044082726254;12147.331896745764;11361.886381136082;11873.168878178445;11954.521819127138;11973.144162654802;12226.816597751218;11755.177137600285;11958.222715523463;12107.213031152947;12280.201786883825;12289.56986505468;7925.920740792519;8034.35725141999;8070.677172913018;8106.716264930935;8162.632681529227;11816.70458238551;11999.76000480003;12068.879311207127;12108;12128.090393220367 08:19:26 INFO - PROCESS | 17946 | |3;mootools.html;1316.289203829932;1508.8189417269925;1544.1661502788493;1689.7380905959574;1852.981470185297;8488.320934325255;9018.278537716984;9020.594073266695;9229.723108306745;9246.90753092469;8976.461412315266;9160;9199.264058875291;9210.171084602385;9219.631214751402;2092.2886218685644;2139.518608313125;2261.683364328995;2376.2158487699103;2402.9759702402926;2405.1461731085474;2444.327809852287;2459.5449841779327;2465.1125594785863;2465.2973902437807;2348.635961425982;2378.7264464586533;2380.7262164851004;2383.0467812874904;2385.5586716457424;2046.6827641715558;2304.4584522637165;2306.630939049744;2373.97626023741;2380.202632118225;2347.9060837566476;2353.5645905507536;2379.3694670912223;2380.940476488084;2382.0590866607768;8931.553422328858;8958.148975847349;8988.146126118008;8999.910000900038;9001.684941027033;5306.124489459235;5438.075527160353;5450.264214331054;5450.345958484968;5453.863653408657;3204.7916885402606;3392.1010932103013;3435.914102147441;3447.0692912913373;3463.3246516929207;1088.1947358954396;1123.359684979562;1123.5168877382803;1127.8984891359817;1128.0806142993433;12227.510899564008;12401.565945191966;12448.62654120378;12454.626361209088;12456.128071035031;4506.369108324837;4654.069186162781;4678.508756580578;4751.358566593465;4752.049590081998;10507.684769456928;10517.316374435637;10527.368357898551;10528;10535.631252906265;5309.469053094737;5411.269478620415;5411.5129638331955;5413.756380962866;5415.458454154553;4414.4702635683925;4830.686005409637;4949.034938187091;4972.154733695281;5043.167877300204;4033.4353190553347;4036.164662966469;4109.938350924738;4141.109661422808;4155;1230.8215308780357;1235.7034311765112;1236.6908272931767;1243.7823380908305;1258.0753146437362;933.6312156698066;966.9371490853072;970.5777986575862;981.4896253947907;1001.834697274956;5829.44620261083;5897.705114744245;5938.376470470625;5948.67282299469;5995.820125396245;433.5252898076601;436.8209034295987;443.691634314155;445.69692609025526;448.5716141085256;4085.264652362544;4170.874873753793;4174.478190226222;4200.6219440249915;4259.829606815692;10916.454177291103;11075.446227688582;11295.887041129648;11303.660890173307;11445.599404020986;11239.269447485887;11284.21010529255;11324;11325.716857078474;11340.036096931854;8311.33509319253;8572.228499435081;8581.914180858237;8588.441751286146;8597.398182127192;5900.262467191601;6005.579609427298;6010.489108425658;6101.9389806103145;6103.23709536308;10097.899021009696;10582.153427725918;10609.257351985287;10654.946725266323;10702.518386672462;10507.78984420292;10698.572057117939;10702.83945740799;10782.460876955964;10862.34825910448;7183.389411900047;7326;7830.41271904598;8042.67829286822;8137.104918459083;8701.17338852808;8758.649654014023;8823.514706691194;8836;8847.46915185091;7570.004627993854;7867.685292588232;7874.291313781787;7931.405144614062;8116.350691944512;7698.34564062061;7744.380449564134;7810.960945195237;7908.644111015134;7912.248336408032;7134.571925684268;7165.319294666998;7238.782836514913;7242.275772422716;7250.238724933806;5193.272941788077;5238.790448382022;5250.789968401221;5292.285541451854;5295.364556253275;5187.351581052369;5202.3497062867145;5226.764795584284;5446.782128714965;5465.234867118686 08:19:26 INFO - PROCESS | 17946 | |4;prototype.html;310.70172634271114;319.2099553604828;323.85912128224226;327.81806097615845;328.6040321412698;5146.3309769729885;5196.714180720069;5277.155655095181;5299.867503312415;5306.92039619406;5174.896502069966;5290.285811415458;5290.867728306795;5300.231466437364;5315.920261196085;4057.7565346079255;4095.0990782027907;4097.201045796056;4097.446844675976;4097.897552561195;3873.4383514390397;3924.4505769192338;4069.0641152534786;4076.4700588923397;4113.403556484308;4082.4284600156;4106.9794651026705;4117.794110294488;4119.8970025749295;4128.8348466061325;4068.2677118118727;4087.3255912774357;4088.897777555555;4103.158852435274;4114.629683328515;3389.4237979543536;3628.3468975584383;3628.600853906068;3650.379435495972;3662.249238906018;5057.367829021372;5058.266551350033;5063.139266324733;5069.493050694901;5081.2632168335385;4627.490975992638;4645.558671926162;4670.95329046712;4671.205894997858;4679.859604211879;5116.258142569344;5330.653507521999;5421.864453388697;5460.836174914759;5476.397596264408;3828.1960788234505;3830.4445855351096;3836.693064554829;3844.653981141683;3845.692344612424;5597.412271711493;5610.7194640268235;5622.91565626516;5624.55003599711;5629.943700563023;3931.5478719947573;3948.822302996372;3958.3270843956598;3962.8018599069933;3963.147923196527;3850.441685955521;3979.7015223858325;3993.4625169310025;3996.800159991989;4008.4187792770467;4564.794584243717;4569.697636173674;4581.908361832745;4590.495045544987;4595.172868883633;5335.813246536352;5390.784368625211;5392;5410.540104091197;5441.727913604304;1275.4451813461174;1306.477409036393;1351.9188848669112;1370.8690330477395;1381.9239941803096;866.1425189062909;870.3776799588325;879;886.534569351083;888.7822483491457;4722.480527142012;4726.976365118221;4743.786529606176;4751.289535767121;4768.904621907543;4827.3345695734915;4895.8041678332465;4945.629077819178;5003.949960500421;5009.822691667455;4403.295472724349;4701.858944231679;4704.565107642134;4721.787519561628;4752.5485078917445;2563.500117477074;2592.727763584834;2643.960340594893;2654;2668.5196664600558;5083.38999320084;5093.719845408464;5101.51535604117;5110.8466745997675;5123.5644970177955;4739.748619405824;4909.705417674951;4947.158982972904;4974.17926042199;5055;5063.443021267584;5109.897802043938;5112.309838171874;5115.616328775357;5188.481151884781;4917.336159618549;4953.405591329064;4959.429665588504;4993.775280112331;4997.750112494434;4619.676622636383;4808.735519546459;4811.615070794398;4844.903101938012;4937.8271760488215;5109.64232503736;5111.878570393245;5134.974325128351;5138.3577052868395;5153.742312884266;3575.8390872411323;3589.2283159120916;3594.928101438009;3603.891883243507;3623.438367053111;4751.976240118777;4950.678205916748;4977.153883839828;4988.176950803077;5267.552258058108;5084.567811736044;5487.917681234705;5496.615236933376;5506.91739623914;5519.282493276009;5419.160030195326;5432.755526001419;5443.7822487100075;5465.590080744039;5480.3971563127225;5158.0199762045095;5327.680339179662;5331.494197727062;5331.680099194061;5379.220013098157;5476.72616369172;5488.039593071277;5496.966122534688;5503.504684578407;5544.698949935892;5363.946360536344;5373.489518495737;5381.2197231402015;5386.919196211981;5397.730113494388 08:19:26 INFO - PROCESS | 17946 | |5;yui.html;805.6012273924406;845.9957700211498;846.6655671009955;854.3677678517898;858.7080392666492;15251.466198683049;16528.752068718964;17084.914575427138;17136.228869700863;17174.656506869855;16205.027698338108;16294.348226070942;16302.755458668129;16323.83676163241;16372.918135409336;830.485099238473;839.7270886961732;840.1892174052039;840.2647683277132;840.2983508770184;700.1283402164313;808.308895894011;839.3704721458906;848.5714714069417;848.9108643592426;877.398981697536;880.898696649887;881.8853549038648;883.8320719063357;884.7920738626418;719.3094629156017;869.5565261716507;871.172386233078;871.233314683078;871.3682580129419;616.3959319866511;637.9043143528462;639.0510092512615;640.2029473305764;642.2581917884851;15300.08199508022;15317;15386.692266154614;15411.768823467657;15463.5360939172;13226.470941162439;13796.655083622889;13801.51694690681;13812.723745525134;13843.792343114761;12531.74936501274;12539.811902821464;12558.372081395893;12681.936590317082;12720.936395317964;4400.44994375703;4463;4485.887852803673;4526.88682782933;4689.39037925071;61321.080183797276;62421.68789156071;62957.37042629561;63103;63115;10857.131429485622;10894.291871028357;11087.667369978913;11100;11257.324560526395;19636.607267854564;19693.40919772409;19709.901450492656;19761.110750016283;19847.30534431288;8215.219554142346;8246.670133194724;8377.916220837835;8403.201695838885;8404.369672274604;4694.554017368345;4737.502562230985;4820.71075735457;4914.582260507826;4953.678010929278;3475.878344257939;3559.555055618048;3566.6076731559506;3567.7502574819514;3579.6957258632788;661.1702313596405;664.6975626090117;667.5427332277405;676.0535250649033;684.8630273945231;592.848823549992;599.9800339422911;637.2384999925046;670.3464122480542;709.5423451873615;9502.762430939281;9906.900930990598;9918.80162396748;9923.60305587783;9923.851142232872;625.9734036180668;661.5865084322298;707.2220557386936;717.5085066729307;742.5581778841581;4596.88507787308;4651.651126165551;4677.321788340671;4695.16888413519;4774.976125119421;71919;72339;72893;73083.26916730871;75182;62643.6867815658;63285.8763386325;63613.36386636167;63724.36275637277;65932;58900;59209;59252.40747592469;60166.09750853741;60302;8950.23922966555;9019.594118264562;9032.63869445215;9148.45109293418;9152.835459865879;39265.214695705356;39272.80363598164;39623.207535848545;39938.2012359757;40501.594984050964;53191.46808531865;53661.731691341294;53721.19418208808;53784.92430151453;54132.458675412745;10636.787264254517;10841.349519028883;10862.402567858528;10913.18151138652;11197.272177308774;12362.81455778182;12684.112112152061;12695.80956285638;12824.615261542169;12877.935610321889;8661.480311181349;12039.819402709141;13033.15284506504;13319.667008324483;13359.866401335863;13569.686419839469;13631;13723.588292351245;13887.861121388656;13909.791353129509;13238.735225295248;13253.13854599448;13261.66845828862;13417.127886687334;13719.176849389069;10884.891151088388;11141;11252.718682033015;11274.549018039186;11379;11027.22809403334;11293;11482.655520334403;11534.423278835857;11538.423078846192 08:19:26 INFO - PROCESS | 17946 | __end_tp_report 08:19:26 INFO - PROCESS | 17946 | __start_cc_report 08:19:26 INFO - PROCESS | 17946 | _x_x_mozilla_cycle_collect,803 08:19:26 INFO - PROCESS | 17946 | __end_cc_report 08:19:26 INFO - PROCESS | 17946 | __startTimestamp1464707966341__endTimestamp 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | ------- Summary: start ------- 08:19:26 INFO - PROCESS | 17946 | Number of tests: 6 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#0] dojo.html Cycles:165 Average:5364.03 Median:5552.56 stddev:615.26 (11.1%) stddev-sans-first:591.94 08:19:26 INFO - PROCESS | 17946 | Values: 3142.0 3152.5 3170.4 3182.8 3221.6 5219.8 5311.8 5355.9 5376.2 5425.8 5339.2 5349.7 5369.1 5417.4 5423.5 4811.7 4907.5 4928.3 4932.6 5043.6 4990.5 5021.8 5038.7 5053.5 5097.1 4784.9 4847.1 4874.3 4896.6 4905.6 4874.4 4885.5 4899.7 4974.4 5004.0 4913.2 4922.7 4947.1 4963.0 5015.0 5182.1 5308.9 5378.3 5416.4 5452.2 5861.3 5881.4 5898.9 5908.3 5922.6 5524.4 5878.2 5914.2 5937.8 5940.5 5305.8 5362.3 5366.4 5443.4 5443.5 5952.8 5953.0 5956.5 5956.8 5958.7 5476.2 5733.9 5737.7 5743.3 5746.2 5617.0 5668.3 5670.4 5753.1 5756.6 5628.0 5675.5 5680.0 5680.1 5683.3 5517.8 5684.5 5698.5 5704.7 5705.9 4316.7 4331.7 4338.6 4366.6 4379.5 3888.8 3890.9 3892.2 3897.3 3934.0 5258.2 5303.5 5490.1 5524.8 5539.2 5828.0 5842.7 5878.0 5915.4 5963.0 5560.2 5579.1 5580.9 5581.5 5595.2 4786.1 4883.7 4945.5 4961.4 4967.2 6063.9 6065.0 6078.8 6081.5 6084.3 5845.7 5851.9 5859.9 5862.5 5868.9 5761.9 5969.9 5995.3 6021.4 6030.9 5702.3 5703.2 5711.5 5714.2 5720.3 5740.0 5764.1 5811.3 5818.7 5828.8 5494.1 5520.6 5576.1 5586.6 5652.3 5579.3 5601.1 5604.0 5606.8 5616.5 5366.7 5494.2 5509.9 5516.6 5562.8 5557.6 5594.3 5608.8 5724.3 5729.0 5498.6 5542.3 5545.4 5552.6 5592.6 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#1] ext.html Cycles:180 Average:59933.61 Median:23238.02 stddev:116141.36 (499.8%) stddev-sans-first:116381.82 08:19:26 INFO - PROCESS | 17946 | Values: 632.0 636.9 643.6 652.6 657.8 30630.4 33975.3 33978.0 34001.5 42741.0 41335.4 45625.5 46056.8 46109.3 46122.0 8752.2 8975.2 8976.6 8978.7 8981.7 8768.8 8943.2 8945.3 8949.8 8957.7 8893.4 8963.1 8963.2 8964.7 8964.8 8867.9 8906.2 8927.8 8930.3 8934.4 8788.1 8836.4 8856.5 8857.0 8862.0 42367.8 42696.1 42836.8 42956.4 43030.8 3379.7 3981.7 4187.6 4329.6 4334.0 32174.7 32509.7 32525.3 32560.0 33883.8 3993.0 4099.5 4219.7 4311.9 4342.8 354794.0 355419.0 355450.0 355989.0 356389.0 58283.5 58584.7 58851.2 58854.7 58885.1 61777.7 61902.0 62146.7 62245.7 62393.7 16999.6 17140.2 17203.9 17218.4 17220.6 12973.2 13006.4 13011.9 13012.1 13019.5 15098.7 16643.1 16698.9 16703.3 16826.7 5584.4 6342.5 6538.1 6565.4 6692.9 954.9 1000.5 1020.3 1056.4 1057.1 32098.4 32616.3 32617.7 32980.3 33419.7 1157.9 1159.1 1165.5 1192.1 1215.5 16827.0 17172.8 17375.8 17436.9 17679.2 532338.0 533880.0 536880.0 537350.0 538395.0 59367.7 59689.8 59759.4 59767.7 59817.4 1283.1 1385.0 1389.3 1415.7 1434.9 29810.6 33943.9 34096.3 34227.8 34468.5 50573.2 50876.2 51022.5 51186.5 51216.5 402837.0 403830.0 405372.0 405731.0 405963.0 34036.5 35182.7 42333.6 42544.0 45856.5 45754.0 47887.3 49640.0 50523.7 50626.0 38377.2 41929.6 42441.2 43338.3 43502.8 41194.4 41923.8 42019.6 42256.4 42436.6 40708.0 41663.8 41814.6 41846.6 44642.3 34106.5 37752.4 37896.6 38441.8 38553.6 28546.7 28897.4 28954.0 29060.6 29118.6 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#2] jquery.html Cycles:180 Average:28160.44 Median:2288.95 stddev:79765.09 (3484.8%) stddev-sans-first:79961.55 08:19:26 INFO - PROCESS | 17946 | Values: 367.3 374.2 381.4 383.9 391.1 17960.6 19132.9 19662.5 19669.0 19798.5 17479.7 18332.8 18720.9 19523.6 19528.5 5177.0 5259.6 5282.6 5324.6 5326.0 5153.5 5230.0 5245.1 5269.8 5274.5 5208.3 5229.2 5254.2 5256.9 5258.3 5124.1 5203.6 5236.2 5265.3 5270.2 5073.1 5077.8 5078.9 5087.5 5088.2 13572.4 13886.0 14050.2 14107.4 14119.4 2237.2 2247.1 2259.3 2318.6 2361.6 9666.4 9786.9 9899.3 10405.7 10543.9 1839.8 1893.6 1907.7 1931.8 1936.9 57831.7 62410.4 77211.6 79809.6 82670.0 11050.6 11236.0 11248.3 11362.3 11421.5 15636.1 15733.4 15834.0 15851.5 15862.2 7351.2 7668.8 8107.3 8333.7 8558.9 7710.3 7860.9 7865.1 7907.3 7930.0 4765.7 4788.6 4808.3 4826.8 4943.8 1872.7 1880.6 1882.3 1937.4 1997.7 986.6 994.5 1029.7 1060.1 1077.3 18602.7 18967.5 19235.3 19296.4 19443.6 995.3 999.8 1000.9 1006.2 1032.9 10480.9 10867.2 10950.1 11030.3 11040.7 468346.0 470998.0 491196.0 493325.0 496491.0 82689.0 87655.6 88182.6 98872.0 99155.0 1026.3 1036.8 1068.9 1074.6 1077.4 13927.5 16566.7 17124.8 17836.9 17887.6 41585.6 41858.8 41900.4 42523.6 43229.4 52904.0 55544.0 56130.1 56465.0 56907.1 7539.1 7794.3 8601.9 8807.6 8986.3 10244.7 10669.7 13417.3 13484.7 14162.0 11594.7 11760.4 11830.0 11854.0 12147.3 11361.9 11873.2 11954.5 11973.1 12226.8 11755.2 11958.2 12107.2 12280.2 12289.6 7925.9 8034.4 8070.7 8106.7 8162.6 11816.7 11999.8 12068.9 12108.0 12128.1 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#3] mootools.html Cycles:180 Average:5924.86 Median:447.13 stddev:3427.04 (766.4%) stddev-sans-first:3419.16 08:19:26 INFO - PROCESS | 17946 | Values: 1316.3 1508.8 1544.2 1689.7 1853.0 8488.3 9018.3 9020.6 9229.7 9246.9 8976.5 9160.0 9199.3 9210.2 9219.6 2092.3 2139.5 2261.7 2376.2 2403.0 2405.1 2444.3 2459.5 2465.1 2465.3 2348.6 2378.7 2380.7 2383.0 2385.6 2046.7 2304.5 2306.6 2374.0 2380.2 2347.9 2353.6 2379.4 2380.9 2382.1 8931.6 8958.1 8988.1 8999.9 9001.7 5306.1 5438.1 5450.3 5450.3 5453.9 3204.8 3392.1 3435.9 3447.1 3463.3 1088.2 1123.4 1123.5 1127.9 1128.1 12227.5 12401.6 12448.6 12454.6 12456.1 4506.4 4654.1 4678.5 4751.4 4752.0 10507.7 10517.3 10527.4 10528.0 10535.6 5309.5 5411.3 5411.5 5413.8 5415.5 4414.5 4830.7 4949.0 4972.2 5043.2 4033.4 4036.2 4109.9 4141.1 4155.0 1230.8 1235.7 1236.7 1243.8 1258.1 933.6 966.9 970.6 981.5 1001.8 5829.4 5897.7 5938.4 5948.7 5995.8 433.5 436.8 443.7 445.7 448.6 4085.3 4170.9 4174.5 4200.6 4259.8 10916.5 11075.4 11295.9 11303.7 11445.6 11239.3 11284.2 11324.0 11325.7 11340.0 8311.3 8572.2 8581.9 8588.4 8597.4 5900.3 6005.6 6010.5 6101.9 6103.2 10097.9 10582.2 10609.3 10654.9 10702.5 10507.8 10698.6 10702.8 10782.5 10862.3 7183.4 7326.0 7830.4 8042.7 8137.1 8701.2 8758.6 8823.5 8836.0 8847.5 7570.0 7867.7 7874.3 7931.4 8116.4 7698.3 7744.4 7811.0 7908.6 7912.2 7134.6 7165.3 7238.8 7242.3 7250.2 5193.3 5238.8 5250.8 5292.3 5295.4 5187.4 5202.3 5226.8 5446.8 5465.2 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#4] prototype.html Cycles:180 Average:4389.78 Median:4941.73 stddev:1270.82 (25.7%) stddev-sans-first:1236.95 08:19:26 INFO - PROCESS | 17946 | Values: 310.7 319.2 323.9 327.8 328.6 5146.3 5196.7 5277.2 5299.9 5306.9 5174.9 5290.3 5290.9 5300.2 5315.9 4057.8 4095.1 4097.2 4097.4 4097.9 3873.4 3924.5 4069.1 4076.5 4113.4 4082.4 4107.0 4117.8 4119.9 4128.8 4068.3 4087.3 4088.9 4103.2 4114.6 3389.4 3628.3 3628.6 3650.4 3662.2 5057.4 5058.3 5063.1 5069.5 5081.3 4627.5 4645.6 4671.0 4671.2 4679.9 5116.3 5330.7 5421.9 5460.8 5476.4 3828.2 3830.4 3836.7 3844.7 3845.7 5597.4 5610.7 5622.9 5624.6 5629.9 3931.5 3948.8 3958.3 3962.8 3963.1 3850.4 3979.7 3993.5 3996.8 4008.4 4564.8 4569.7 4581.9 4590.5 4595.2 5335.8 5390.8 5392.0 5410.5 5441.7 1275.4 1306.5 1351.9 1370.9 1381.9 866.1 870.4 879.0 886.5 888.8 4722.5 4727.0 4743.8 4751.3 4768.9 4827.3 4895.8 4945.6 5003.9 5009.8 4403.3 4701.9 4704.6 4721.8 4752.5 2563.5 2592.7 2644.0 2654.0 2668.5 5083.4 5093.7 5101.5 5110.8 5123.6 4739.7 4909.7 4947.2 4974.2 5055.0 5063.4 5109.9 5112.3 5115.6 5188.5 4917.3 4953.4 4959.4 4993.8 4997.8 4619.7 4808.7 4811.6 4844.9 4937.8 5109.6 5111.9 5135.0 5138.4 5153.7 3575.8 3589.2 3594.9 3603.9 3623.4 4752.0 4950.7 4977.2 4988.2 5267.6 5084.6 5487.9 5496.6 5506.9 5519.3 5419.2 5432.8 5443.8 5465.6 5480.4 5158.0 5327.7 5331.5 5331.7 5379.2 5476.7 5488.0 5497.0 5503.5 5544.7 5363.9 5373.5 5381.2 5386.9 5397.7 08:19:26 INFO - PROCESS | 17946 | 08:19:26 INFO - PROCESS | 17946 | [#5] yui.html Cycles:180 Average:16523.95 Median:4797.84 stddev:20150.95 (420.0%) stddev-sans-first:20172.91 08:19:26 INFO - PROCESS | 17946 | Values: 805.6 846.0 846.7 854.4 858.7 15251.5 16528.8 17084.9 17136.2 17174.7 16205.0 16294.3 16302.8 16323.8 16372.9 830.5 839.7 840.2 840.3 840.3 700.1 808.3 839.4 848.6 848.9 877.4 880.9 881.9 883.8 884.8 719.3 869.6 871.2 871.2 871.4 616.4 637.9 639.1 640.2 642.3 15300.1 15317.0 15386.7 15411.8 15463.5 13226.5 13796.7 13801.5 13812.7 13843.8 12531.7 12539.8 12558.4 12681.9 12720.9 4400.4 4463.0 4485.9 4526.9 4689.4 61321.1 62421.7 62957.4 63103.0 63115.0 10857.1 10894.3 11087.7 11100.0 11257.3 19636.6 19693.4 19709.9 19761.1 19847.3 8215.2 8246.7 8377.9 8403.2 8404.4 4694.6 4737.5 4820.7 4914.6 4953.7 3475.9 3559.6 3566.6 3567.8 3579.7 661.2 664.7 667.5 676.1 684.9 592.8 600.0 637.2 670.3 709.5 9502.8 9906.9 9918.8 9923.6 9923.9 626.0 661.6 707.2 717.5 742.6 4596.9 4651.7 4677.3 4695.2 4775.0 71919.0 72339.0 72893.0 73083.3 75182.0 62643.7 63285.9 63613.4 63724.4 65932.0 58900.0 59209.0 59252.4 60166.1 60302.0 8950.2 9019.6 9032.6 9148.5 9152.8 39265.2 39272.8 39623.2 39938.2 40501.6 53191.5 53661.7 53721.2 53784.9 54132.5 10636.8 10841.3 10862.4 10913.2 11197.3 12362.8 12684.1 12695.8 12824.6 12877.9 8661.5 12039.8 13033.2 13319.7 13359.9 13569.7 13631.0 13723.6 13887.9 13909.8 13238.7 13253.1 13261.7 13417.1 13719.2 10884.9 11141.0 11252.7 11274.5 11379.0 11027.2 11293.0 11482.7 11534.4 11538.4 08:19:26 INFO - PROCESS | 17946 | -------- Summary: end -------- 08:19:26 INFO - PROCESS | 17946 | 08:19:27 INFO - TEST-INFO | 17946: exit 0 08:19:27 INFO - TEST-OK | dromaeo_css | took 1113304ms 08:19:27 INFO - TEST-START | kraken 08:19:27 INFO - operating with platform_type : linux_ 08:19:27 INFO - Initialising browser for kraken test... 08:19:27 INFO - TEST-INFO | started process 18131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjGP8PH/profile http://localhost:48466/getInfo.html) 08:19:31 INFO - PROCESS | 18131 | __metrics Screen width/height:1600/1200 08:19:31 INFO - PROCESS | 18131 | colorDepth:24 08:19:31 INFO - PROCESS | 18131 | Browser inner width/height: 1024/697 08:19:31 INFO - PROCESS | 18131 | __metrics 08:19:32 ERROR - PROCESS | 18131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:19:32 INFO - TEST-INFO | 18131: exit 0 08:19:32 INFO - Browser initialized. 08:19:32 INFO - Running cycle 1/1 for kraken test... 08:19:32 INFO - TEST-INFO | started process 18211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjGP8PH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:44 INFO - PROCESS | 18211 | RSS: Main: 155475968 08:19:44 INFO - PROCESS | 18211 | 08:19:47 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:48 INFO - PROCESS | 18211 | RSS: Main: 214142976 08:19:48 INFO - PROCESS | 18211 | 08:19:50 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-dft) 08:19:51 INFO - PROCESS | 18211 | RSS: Main: 198508544 08:19:51 INFO - PROCESS | 18211 | 08:19:54 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-fft) 08:19:55 INFO - PROCESS | 18211 | RSS: Main: 268443648 08:19:55 INFO - PROCESS | 18211 | 08:19:57 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48466/tests/kraken/driver.html?testName=audio-oscillator) 08:19:57 INFO - PROCESS | 18211 | RSS: Main: 178978816 08:19:57 INFO - PROCESS | 18211 | 08:19:59 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:00 INFO - PROCESS | 18211 | RSS: Main: 183627776 08:20:00 INFO - PROCESS | 18211 | 08:20:03 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:04 INFO - PROCESS | 18211 | RSS: Main: 217485312 08:20:04 INFO - PROCESS | 18211 | 08:20:07 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48466/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:08 INFO - PROCESS | 18211 | RSS: Main: 219516928 08:20:08 INFO - PROCESS | 18211 | 08:20:10 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48466/tests/kraken/driver.html?testName=json-parse-financial) 08:20:11 INFO - PROCESS | 18211 | RSS: Main: 220336128 08:20:11 INFO - PROCESS | 18211 | 08:20:12 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:13 INFO - PROCESS | 18211 | RSS: Main: 209223680 08:20:13 INFO - PROCESS | 18211 | 08:20:15 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:16 INFO - PROCESS | 18211 | RSS: Main: 211329024 08:20:16 INFO - PROCESS | 18211 | 08:20:18 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:18 INFO - PROCESS | 18211 | RSS: Main: 216776704 08:20:18 INFO - PROCESS | 18211 | 08:20:21 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:21 INFO - PROCESS | 18211 | RSS: Main: 221331456 08:20:21 INFO - PROCESS | 18211 | 08:20:24 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:25 INFO - PROCESS | 18211 | RSS: Main: 223137792 08:20:25 INFO - PROCESS | 18211 | 08:20:26 INFO - PROCESS | 18211 | Cycle 1(1): loaded http://localhost:48466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48466/tests/kraken/driver.html?testName=ai-astar) 08:20:27 INFO - PROCESS | 18211 | RSS: Main: 265580544 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | __start_tp_report 08:20:27 INFO - PROCESS | 18211 | _x_x_mozilla_page_load 08:20:27 INFO - PROCESS | 18211 | _x_x_mozilla_page_load_details 08:20:27 INFO - PROCESS | 18211 | |i|pagename|runs| 08:20:27 INFO - PROCESS | 18211 | |0;ai-astar;111;106;111;111;110;113;110;111;111;110 08:20:27 INFO - PROCESS | 18211 | |1;audio-beat-detection;157;131;126;176;125;126;148;125;156;125 08:20:27 INFO - PROCESS | 18211 | |2;audio-dft;160;163;160;159;160;163;160;161;162;160 08:20:27 INFO - PROCESS | 18211 | |3;audio-fft;74;73;76;132;74;76;75;74;112;75 08:20:27 INFO - PROCESS | 18211 | |4;audio-oscillator;83;83;115;83;83;84;120;84;84;128 08:20:27 INFO - PROCESS | 18211 | |5;imaging-gaussian-blur;118;117;116;116;119;117;117;116;117;116 08:20:27 INFO - PROCESS | 18211 | |6;imaging-darkroom;146;145;145;145;145;146;145;145;145;144 08:20:27 INFO - PROCESS | 18211 | |7;imaging-desaturate;95;94;95;96;94;95;95;95;97;95 08:20:27 INFO - PROCESS | 18211 | |8;json-parse-financial;60;55;54;56;56;56;54;54;54;54 08:20:27 INFO - PROCESS | 18211 | |9;json-stringify-tinderbox;62;63;61;63;63;62;63;62;63;62 08:20:27 INFO - PROCESS | 18211 | |10;stanford-crypto-aes;78;84;82;78;79;80;79;83;113;80 08:20:27 INFO - PROCESS | 18211 | |11;stanford-crypto-ccm;128;124;121;126;118;117;118;120;122;121 08:20:27 INFO - PROCESS | 18211 | |12;stanford-crypto-pbkdf2;159;158;163;161;159;158;163;165;162;157 08:20:27 INFO - PROCESS | 18211 | |13;stanford-crypto-sha256-iterative;63;62;64;61;61;61;62;62;60;61 08:20:27 INFO - PROCESS | 18211 | __end_tp_report 08:20:27 INFO - PROCESS | 18211 | __start_cc_report 08:20:27 INFO - PROCESS | 18211 | _x_x_mozilla_cycle_collect,1648 08:20:27 INFO - PROCESS | 18211 | __end_cc_report 08:20:27 INFO - PROCESS | 18211 | __startTimestamp1464708027083__endTimestamp 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | ------- Summary: start ------- 08:20:27 INFO - PROCESS | 18211 | Number of tests: 14 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.87 08:20:27 INFO - PROCESS | 18211 | Values: 111.0 106.0 111.0 111.0 110.0 113.0 110.0 111.0 111.0 110.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:139.50 stddev:18.41 (13.2%) stddev-sans-first:18.41 08:20:27 INFO - PROCESS | 18211 | Values: 157.0 131.0 126.0 176.0 125.0 126.0 148.0 125.0 156.0 125.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#2] audio-dft Cycles:10 Average:160.80 Median:160.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 08:20:27 INFO - PROCESS | 18211 | Values: 160.0 163.0 160.0 159.0 160.0 163.0 160.0 161.0 162.0 160.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#3] audio-fft Cycles:10 Average:84.10 Median:74.50 stddev:20.55 (27.6%) stddev-sans-first:21.46 08:20:27 INFO - PROCESS | 18211 | Values: 74.0 73.0 76.0 132.0 74.0 76.0 75.0 74.0 112.0 75.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.00 stddev:18.42 (22.2%) stddev-sans-first:19.04 08:20:27 INFO - PROCESS | 18211 | Values: 83.0 83.0 115.0 83.0 83.0 84.0 120.0 84.0 84.0 128.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 08:20:27 INFO - PROCESS | 18211 | Values: 118.0 117.0 116.0 116.0 119.0 117.0 117.0 116.0 117.0 116.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 08:20:27 INFO - PROCESS | 18211 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 144.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 08:20:27 INFO - PROCESS | 18211 | Values: 95.0 94.0 95.0 96.0 94.0 95.0 95.0 95.0 97.0 95.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.89 (3.4%) stddev-sans-first:0.97 08:20:27 INFO - PROCESS | 18211 | Values: 60.0 55.0 54.0 56.0 56.0 56.0 54.0 54.0 54.0 54.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:20:27 INFO - PROCESS | 18211 | Values: 62.0 63.0 61.0 63.0 63.0 62.0 63.0 62.0 63.0 62.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:80.00 stddev:10.53 (13.2%) stddev-sans-first:10.97 08:20:27 INFO - PROCESS | 18211 | Values: 78.0 84.0 82.0 78.0 79.0 80.0 79.0 83.0 113.0 80.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.50 stddev:3.60 (3.0%) stddev-sans-first:2.95 08:20:27 INFO - PROCESS | 18211 | Values: 128.0 124.0 121.0 126.0 118.0 117.0 118.0 120.0 122.0 121.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:2.68 (1.7%) stddev-sans-first:2.78 08:20:27 INFO - PROCESS | 18211 | Values: 159.0 158.0 163.0 161.0 159.0 158.0 163.0 165.0 162.0 157.0 08:20:27 INFO - PROCESS | 18211 | 08:20:27 INFO - PROCESS | 18211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:1.13 08:20:27 INFO - PROCESS | 18211 | Values: 63.0 62.0 64.0 61.0 61.0 61.0 62.0 62.0 60.0 61.0 08:20:27 INFO - PROCESS | 18211 | -------- Summary: end -------- 08:20:27 INFO - PROCESS | 18211 | 08:20:28 INFO - TEST-INFO | 18211: exit 0 08:20:28 INFO - TEST-OK | kraken | took 60973ms 08:20:28 INFO - SUITE-END | took 1174s 08:20:28 INFO - Completed test suite (00:19:34) 08:20:28 INFO - javascript benchmark 08:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.9999999999995, 3152.464081106213, 3170.413473507401, 3182.8249446280447, 3221.613406391232, 5219.791208351671, 5311.814086506973, 5355.892882142355, 5376.220448035033, 5425.83722488325, 5339.172428273614, 5349.652272602288, 5369.140937450009, 5417.3770016448125, 5423.538999185064, 4811.687240329376, 4907.533784290505, 4928.285398617199, 4932.556069953704, 5043.5965122790085, 4990.47600002, 5021.799128034892, 5038.748062596874, 5053.5451809337155, 5097.108006098918, 4784.928226076611, 4847.07905497956, 4874.268859671042, 4896.632752543574, 4905.558499735023, 4874.439439464436, 4885.511448855122, 4899.681520701143, 4974.37820272466, 5004.0, 4913.213885778258, 4922.704637721748, 4947.060058588857, 4963.032208719301, 5015.022070696215, 5182.144946083929, 5308.9469105308835, 5378.273933019071, 5416.431274716177, 5452.154915988028, 5861.296644402656, 5881.382454842223, 5898.911516327258, 5908.320543137551, 5922.58541902067, 5524.419935906712, 5878.2064421303, 5914.2311499504785, 5937.7921772737745, 5940.495057920082, 5305.7612407441375, 5362.329708786402, 5366.409694933554, 5443.401225865112, 5443.482869127427, 5952.791652292149, 5953.0, 5956.493698035715, 5956.791512297049, 5958.731857066442, 5476.151196564539, 5733.913991290134, 5737.713114344266, 5743.339515955635, 5746.166805813217, 5617.0, 5668.319801623831, 5670.404607516234, 5753.079507278815, 5756.625819321731, 5627.971860140673, 5675.5459563234845, 5680.0, 5680.062789639664, 5683.346415162227, 5517.834464966058, 5684.516816070598, 5698.515626171822, 5704.657720536781, 5705.942940570624, 4316.676249281317, 4331.675124365685, 4338.566143385636, 4366.628836548865, 4379.5182529921685, 3888.7861167635488, 3890.8832735017995, 3892.1826416452295, 3897.279003384383, 3933.9606603933594, 5258.2375555544995, 5303.522682958553, 5490.0941344677685, 5524.806631767869, 5539.224508568804, 5828.0, 5842.707864606753, 5878.0, 5915.3788852170765, 5962.970185149134, 5560.193771903132, 5579.079451890474, 5580.944190558123, 5581.469760372758, 5595.244641973363, 4786.138495070851, 4883.682560633548, 4945.530174633404, 4961.355023846949, 4967.1517465354245, 6063.878722425527, 6065.0, 6078.817635470943, 6081.513478921675, 6084.330723620398, 5845.678487683048, 5851.941480585139, 5859.9121013183985, 5862.501687356623, 5868.882622347614, 5761.942380576141, 5969.850753731192, 5995.280566332068, 6021.367756385516, 6030.939690603213, 5702.287214098238, 5703.173039909273, 5711.514521265739, 5714.20001199824, 5720.256366672306, 5740.0, 5764.07774756037, 5811.27359080115, 5818.7090645466715, 5828.825135245949, 5494.120940649477, 5520.641158324696, 5576.079946808731, 5586.636868603528, 5652.265205523256, 5579.302587176603, 5601.103823388238, 5604.0, 5606.775728970795, 5616.466435688603, 5366.731663416892, 5494.1758736189895, 5509.917351239815, 5516.641418307797, 5562.833115006556, 5557.610967232255, 5594.3286805581965, 5608.831735047955, 5724.284464441945, 5728.971355143198, 5498.560115190855, 5542.3349198094875, 5545.3622833374675, 5552.5557955362665, 5592.5525957922455], "value": 5322.6165615536365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.9526035547335, 636.9076483909834, 643.6395618453666, 652.6475703120316, 657.7763560389467, 30630.38739225217, 33975.320493590116, 33978.0, 34001.48997765035, 42741.0, 41335.37996930041, 45625.54374456254, 46056.76971615146, 46109.30836037462, 46122.0, 8752.168543988328, 8975.192232699088, 8976.640934362618, 8978.730638080835, 8981.730548083535, 8768.824623507526, 8943.150400711955, 8945.284377249804, 8949.776255593597, 8957.686480973134, 8893.42192757472, 8963.058878817728, 8963.238124759404, 8964.731058068235, 8964.775880603005, 8867.866981995243, 8906.198442140174, 8927.821443571092, 8930.285577153812, 8934.4192627479, 8788.121187881161, 8836.425632333941, 8856.51289179095, 8856.955715221447, 8862.025177230564, 42367.7881610593, 42696.14607707829, 42836.78581607072, 42956.3556546652, 43030.78484607557, 3379.7186898843183, 3981.6814654827544, 4187.644050255702, 4329.610335069828, 4334.0, 32174.678253217637, 32509.674903251136, 32525.349493010242, 32560.0, 33883.83058084694, 3992.960070399317, 4099.549049604541, 4219.683523735732, 4311.935320970188, 4342.826286948518, 354794.0, 355419.0, 355450.0, 355989.0, 356389.0, 58283.542911427554, 58584.70707646434, 58851.23210830724, 58854.7057264711, 58885.116723249186, 61777.691111544154, 61902.0, 62146.68926655338, 62245.688771555855, 62393.68803155955, 16999.575010624587, 17140.228689708743, 17203.913980430018, 17218.397356092475, 17220.569485762706, 12973.156744811557, 13006.414711337824, 13011.934940325427, 13012.089153759336, 13019.47922083125, 15098.698026039418, 16643.084630345445, 16698.916505417394, 16703.33186672544, 16826.747598786027, 5584.4434787386, 6342.5243106767175, 6538.071268975568, 6565.441937435276, 6692.899606505906, 954.928380371461, 1000.5347513406301, 1020.2603112743202, 1056.392574269798, 1057.1014637558014, 32098.358032839213, 32616.347673046406, 32617.67382326194, 32980.340393192004, 33419.66580334214, 1157.8552680914886, 1159.0693705002932, 1165.5337864854125, 1192.1476144556684, 1215.4530461292454, 16826.990380577205, 17172.82827171737, 17375.82624173742, 17436.91281543584, 17679.20443580042, 532338.0, 533880.0, 536880.0, 537350.0, 538395.0, 59367.703161483914, 59689.806203875676, 59759.40240597625, 59767.70116149391, 59817.40182598205, 1283.146707439561, 1385.0443194195973, 1389.3400634698437, 1415.688548519324, 1434.8923830712738, 29810.552841707824, 33943.8729651457, 34096.31807363789, 34227.82886085554, 34468.48297275493, 50573.241401379746, 50876.236856447926, 51022.48977510177, 51186.488135118176, 51216.487835121174, 402837.0, 403830.0, 405372.0, 405731.0, 405963.0, 34036.48945265872, 35182.65916023929, 42333.57666423296, 42544.0, 45856.541434586565, 45754.0, 47887.281690775366, 49640.0, 50523.74738126286, 50626.0, 38377.232455350175, 41929.580704192565, 42441.24131931415, 43338.34992475178, 43502.782486087366, 41194.38208426816, 41923.7903810479, 42019.57980420157, 42256.36615450832, 42436.575634243265, 40708.0, 41663.7916810414, 41814.58185418229, 41846.58153418548, 44642.3303650439, 34106.48840267348, 37752.433713494866, 37896.62103379041, 38441.80779096198, 38553.614463855, 28546.714532854407, 28897.42205155843, 28953.98661046853, 29060.56409153822, 29118.56322155212], "value": 20367.066423304088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.2984599415117, 374.22535351821705, 381.4164328577276, 383.8675656898371, 391.0653538044073, 17960.640787184264, 19132.90433547832, 19662.508437289074, 19669.0, 19798.505037374074, 17479.650406991852, 18332.816671833276, 18720.90639546804, 19523.609527809436, 19528.511787205327, 5177.0, 5259.6055295852775, 5282.630215884889, 5324.627276090675, 5326.041312563737, 5153.484651534835, 5230.0, 5245.082110630643, 5269.841904742864, 5274.472552744714, 5208.322918020671, 5229.163333866582, 5254.238135470355, 5256.947430525704, 5258.316418865542, 5124.103281925685, 5203.557697595709, 5236.162214045772, 5265.3155089838265, 5270.183121616155, 5073.086844368012, 5077.847664570032, 5078.873028174288, 5087.516685914869, 5088.23676448532, 13572.389242484112, 13886.0, 14050.227237501933, 14107.36516856744, 14119.435222591084, 2237.183428048767, 2247.0899285789283, 2259.344790010895, 2318.5594736999915, 2361.5867223235864, 9666.371685840399, 9786.90213097867, 9899.257555683353, 10405.739856503573, 10543.94728026355, 1839.7700287464068, 1893.602343507865, 1907.7043058325983, 1931.8164774346415, 1936.9225230990744, 57831.71084144552, 62410.37589624091, 77211.61394192993, 79809.60095199545, 82670.0, 11050.557977680803, 11236.0, 11248.26886252391, 11362.261453005529, 11421.486033128529, 15636.140012299205, 15733.44932927342, 15834.0, 15851.524454266391, 15862.206889655472, 7351.191368949411, 7668.769936901902, 8107.270345668918, 8333.66665333392, 8558.871616925626, 7710.344620707303, 7860.921390786133, 7865.056193256732, 7907.327877130393, 7930.048394192619, 4765.69023013503, 4788.569028787426, 4808.2547205183255, 4826.831060912921, 4943.777530011158, 1872.6910059839975, 1880.6332765110672, 1882.2941396976134, 1937.409090227494, 1997.7003449482693, 986.5807032011367, 994.5027486256871, 1029.7425643589104, 1060.0989159214605, 1077.256692881909, 18602.720959185623, 18967.525811854815, 19235.326763563207, 19296.4211073668, 19443.611127777363, 995.3430735714394, 999.8000399920045, 1000.9199264058858, 1006.1950439648252, 1032.87605487342, 10480.947595262127, 10867.184961127947, 10950.083735346283, 11030.338179709242, 11040.668779936615, 468346.0, 470998.0, 491196.0, 493325.0, 496491.0, 82689.0, 87655.56172219098, 88182.55908720415, 98872.0, 99155.0, 1026.2508368890751, 1036.8237399641928, 1068.9251752377415, 1074.6023971130576, 1077.4451157653814, 13927.512537061155, 16566.66866662684, 17124.828751712324, 17836.910815446357, 17887.552811179823, 41585.58414415817, 41858.790706046275, 41900.37149442822, 42523.574764251964, 43229.351559726, 52904.0, 55544.0, 56130.05463934493, 56465.0, 56907.14639280331, 7539.095308563007, 7794.337481313925, 8601.913980860112, 8807.559622018745, 8986.281097512314, 10244.692659220234, 10669.679909602724, 13417.262050587311, 13484.662883427993, 14162.0, 11594.71013224676, 11760.411979400824, 11830.0, 11854.044082726254, 12147.331896745764, 11361.886381136082, 11873.168878178445, 11954.521819127138, 11973.144162654802, 12226.816597751218, 11755.177137600285, 11958.222715523463, 12107.213031152947, 12280.201786883825, 12289.56986505468, 7925.920740792519, 8034.35725141999, 8070.677172913018, 8106.716264930935, 8162.632681529227, 11816.70458238551, 11999.76000480003, 12068.879311207127, 12108.0, 12128.090393220367], "value": 8915.409381519592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.289203829932, 1508.8189417269925, 1544.1661502788493, 1689.7380905959574, 1852.981470185297, 8488.320934325255, 9018.278537716984, 9020.594073266695, 9229.723108306745, 9246.90753092469, 8976.461412315266, 9160.0, 9199.264058875291, 9210.171084602385, 9219.631214751402, 2092.2886218685644, 2139.518608313125, 2261.683364328995, 2376.2158487699103, 2402.9759702402926, 2405.1461731085474, 2444.327809852287, 2459.5449841779327, 2465.1125594785863, 2465.2973902437807, 2348.635961425982, 2378.7264464586533, 2380.7262164851004, 2383.0467812874904, 2385.5586716457424, 2046.6827641715558, 2304.4584522637165, 2306.630939049744, 2373.97626023741, 2380.202632118225, 2347.9060837566476, 2353.5645905507536, 2379.3694670912223, 2380.940476488084, 2382.0590866607768, 8931.553422328858, 8958.148975847349, 8988.146126118008, 8999.910000900038, 9001.684941027033, 5306.124489459235, 5438.075527160353, 5450.264214331054, 5450.345958484968, 5453.863653408657, 3204.7916885402606, 3392.1010932103013, 3435.914102147441, 3447.0692912913373, 3463.3246516929207, 1088.1947358954396, 1123.359684979562, 1123.5168877382803, 1127.8984891359817, 1128.0806142993433, 12227.510899564008, 12401.565945191966, 12448.62654120378, 12454.626361209088, 12456.128071035031, 4506.369108324837, 4654.069186162781, 4678.508756580578, 4751.358566593465, 4752.049590081998, 10507.684769456928, 10517.316374435637, 10527.368357898551, 10528.0, 10535.631252906265, 5309.469053094737, 5411.269478620415, 5411.5129638331955, 5413.756380962866, 5415.458454154553, 4414.4702635683925, 4830.686005409637, 4949.034938187091, 4972.154733695281, 5043.167877300204, 4033.4353190553347, 4036.164662966469, 4109.938350924738, 4141.109661422808, 4155.0, 1230.8215308780357, 1235.7034311765112, 1236.6908272931767, 1243.7823380908305, 1258.0753146437362, 933.6312156698066, 966.9371490853072, 970.5777986575862, 981.4896253947907, 1001.834697274956, 5829.44620261083, 5897.705114744245, 5938.376470470625, 5948.67282299469, 5995.820125396245, 433.5252898076601, 436.8209034295987, 443.691634314155, 445.69692609025526, 448.5716141085256, 4085.264652362544, 4170.874873753793, 4174.478190226222, 4200.6219440249915, 4259.829606815692, 10916.454177291103, 11075.446227688582, 11295.887041129648, 11303.660890173307, 11445.599404020986, 11239.269447485887, 11284.21010529255, 11324.0, 11325.716857078474, 11340.036096931854, 8311.33509319253, 8572.228499435081, 8581.914180858237, 8588.441751286146, 8597.398182127192, 5900.262467191601, 6005.579609427298, 6010.489108425658, 6101.9389806103145, 6103.23709536308, 10097.899021009696, 10582.153427725918, 10609.257351985287, 10654.946725266323, 10702.518386672462, 10507.78984420292, 10698.572057117939, 10702.83945740799, 10782.460876955964, 10862.34825910448, 7183.389411900047, 7326.0, 7830.41271904598, 8042.67829286822, 8137.104918459083, 8701.17338852808, 8758.649654014023, 8823.514706691194, 8836.0, 8847.46915185091, 7570.004627993854, 7867.685292588232, 7874.291313781787, 7931.405144614062, 8116.350691944512, 7698.34564062061, 7744.380449564134, 7810.960945195237, 7908.644111015134, 7912.248336408032, 7134.571925684268, 7165.319294666998, 7238.782836514913, 7242.275772422716, 7250.238724933806, 5193.272941788077, 5238.790448382022, 5250.789968401221, 5292.285541451854, 5295.364556253275, 5187.351581052369, 5202.3497062867145, 5226.764795584284, 5446.782128714965, 5465.234867118686], "value": 4628.177985742421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.70172634271114, 319.2099553604828, 323.85912128224226, 327.81806097615845, 328.6040321412698, 5146.3309769729885, 5196.714180720069, 5277.155655095181, 5299.867503312415, 5306.92039619406, 5174.896502069966, 5290.285811415458, 5290.867728306795, 5300.231466437364, 5315.920261196085, 4057.7565346079255, 4095.0990782027907, 4097.201045796056, 4097.446844675976, 4097.897552561195, 3873.4383514390397, 3924.4505769192338, 4069.0641152534786, 4076.4700588923397, 4113.403556484308, 4082.4284600156, 4106.9794651026705, 4117.794110294488, 4119.8970025749295, 4128.8348466061325, 4068.2677118118727, 4087.3255912774357, 4088.897777555555, 4103.158852435274, 4114.629683328515, 3389.4237979543536, 3628.3468975584383, 3628.600853906068, 3650.379435495972, 3662.249238906018, 5057.367829021372, 5058.266551350033, 5063.139266324733, 5069.493050694901, 5081.2632168335385, 4627.490975992638, 4645.558671926162, 4670.95329046712, 4671.205894997858, 4679.859604211879, 5116.258142569344, 5330.653507521999, 5421.864453388697, 5460.836174914759, 5476.397596264408, 3828.1960788234505, 3830.4445855351096, 3836.693064554829, 3844.653981141683, 3845.692344612424, 5597.412271711493, 5610.7194640268235, 5622.91565626516, 5624.55003599711, 5629.943700563023, 3931.5478719947573, 3948.822302996372, 3958.3270843956598, 3962.8018599069933, 3963.147923196527, 3850.441685955521, 3979.7015223858325, 3993.4625169310025, 3996.800159991989, 4008.4187792770467, 4564.794584243717, 4569.697636173674, 4581.908361832745, 4590.495045544987, 4595.172868883633, 5335.813246536352, 5390.784368625211, 5392.0, 5410.540104091197, 5441.727913604304, 1275.4451813461174, 1306.477409036393, 1351.9188848669112, 1370.8690330477395, 1381.9239941803096, 866.1425189062909, 870.3776799588325, 879.0, 886.534569351083, 888.7822483491457, 4722.480527142012, 4726.976365118221, 4743.786529606176, 4751.289535767121, 4768.904621907543, 4827.3345695734915, 4895.8041678332465, 4945.629077819178, 5003.949960500421, 5009.822691667455, 4403.295472724349, 4701.858944231679, 4704.565107642134, 4721.787519561628, 4752.5485078917445, 2563.500117477074, 2592.727763584834, 2643.960340594893, 2654.0, 2668.5196664600558, 5083.38999320084, 5093.719845408464, 5101.51535604117, 5110.8466745997675, 5123.5644970177955, 4739.748619405824, 4909.705417674951, 4947.158982972904, 4974.17926042199, 5055.0, 5063.443021267584, 5109.897802043938, 5112.309838171874, 5115.616328775357, 5188.481151884781, 4917.336159618549, 4953.405591329064, 4959.429665588504, 4993.775280112331, 4997.750112494434, 4619.676622636383, 4808.735519546459, 4811.615070794398, 4844.903101938012, 4937.8271760488215, 5109.64232503736, 5111.878570393245, 5134.974325128351, 5138.3577052868395, 5153.742312884266, 3575.8390872411323, 3589.2283159120916, 3594.928101438009, 3603.891883243507, 3623.438367053111, 4751.976240118777, 4950.678205916748, 4977.153883839828, 4988.176950803077, 5267.552258058108, 5084.567811736044, 5487.917681234705, 5496.615236933376, 5506.91739623914, 5519.282493276009, 5419.160030195326, 5432.755526001419, 5443.7822487100075, 5465.590080744039, 5480.3971563127225, 5158.0199762045095, 5327.680339179662, 5331.494197727062, 5331.680099194061, 5379.220013098157, 5476.72616369172, 5488.039593071277, 5496.966122534688, 5503.504684578407, 5544.698949935892, 5363.946360536344, 5373.489518495737, 5381.2197231402015, 5386.919196211981, 5397.730113494388], "value": 3984.806985195575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.6012273924406, 845.9957700211498, 846.6655671009955, 854.3677678517898, 858.7080392666492, 15251.466198683049, 16528.752068718964, 17084.914575427138, 17136.228869700863, 17174.656506869855, 16205.027698338108, 16294.348226070942, 16302.755458668129, 16323.83676163241, 16372.918135409336, 830.485099238473, 839.7270886961732, 840.1892174052039, 840.2647683277132, 840.2983508770184, 700.1283402164313, 808.308895894011, 839.3704721458906, 848.5714714069417, 848.9108643592426, 877.398981697536, 880.898696649887, 881.8853549038648, 883.8320719063357, 884.7920738626418, 719.3094629156017, 869.5565261716507, 871.172386233078, 871.233314683078, 871.3682580129419, 616.3959319866511, 637.9043143528462, 639.0510092512615, 640.2029473305764, 642.2581917884851, 15300.08199508022, 15317.0, 15386.692266154614, 15411.768823467657, 15463.5360939172, 13226.470941162439, 13796.655083622889, 13801.51694690681, 13812.723745525134, 13843.792343114761, 12531.74936501274, 12539.811902821464, 12558.372081395893, 12681.936590317082, 12720.936395317964, 4400.44994375703, 4463.0, 4485.887852803673, 4526.88682782933, 4689.39037925071, 61321.080183797276, 62421.68789156071, 62957.37042629561, 63103.0, 63115.0, 10857.131429485622, 10894.291871028357, 11087.667369978913, 11100.0, 11257.324560526395, 19636.607267854564, 19693.40919772409, 19709.901450492656, 19761.110750016283, 19847.30534431288, 8215.219554142346, 8246.670133194724, 8377.916220837835, 8403.201695838885, 8404.369672274604, 4694.554017368345, 4737.502562230985, 4820.71075735457, 4914.582260507826, 4953.678010929278, 3475.878344257939, 3559.555055618048, 3566.6076731559506, 3567.7502574819514, 3579.6957258632788, 661.1702313596405, 664.6975626090117, 667.5427332277405, 676.0535250649033, 684.8630273945231, 592.848823549992, 599.9800339422911, 637.2384999925046, 670.3464122480542, 709.5423451873615, 9502.762430939281, 9906.900930990598, 9918.80162396748, 9923.60305587783, 9923.851142232872, 625.9734036180668, 661.5865084322298, 707.2220557386936, 717.5085066729307, 742.5581778841581, 4596.88507787308, 4651.651126165551, 4677.321788340671, 4695.16888413519, 4774.976125119421, 71919.0, 72339.0, 72893.0, 73083.26916730871, 75182.0, 62643.6867815658, 63285.8763386325, 63613.36386636167, 63724.36275637277, 65932.0, 58900.0, 59209.0, 59252.40747592469, 60166.09750853741, 60302.0, 8950.23922966555, 9019.594118264562, 9032.63869445215, 9148.45109293418, 9152.835459865879, 39265.214695705356, 39272.80363598164, 39623.207535848545, 39938.2012359757, 40501.594984050964, 53191.46808531865, 53661.731691341294, 53721.19418208808, 53784.92430151453, 54132.458675412745, 10636.787264254517, 10841.349519028883, 10862.402567858528, 10913.18151138652, 11197.272177308774, 12362.81455778182, 12684.112112152061, 12695.80956285638, 12824.615261542169, 12877.935610321889, 8661.480311181349, 12039.819402709141, 13033.15284506504, 13319.667008324483, 13359.866401335863, 13569.686419839469, 13631.0, 13723.588292351245, 13887.861121388656, 13909.791353129509, 13238.735225295248, 13253.13854599448, 13261.66845828862, 13417.127886687334, 13719.176849389069, 10884.891151088388, 11141.0, 11252.718682033015, 11274.549018039186, 11379.0, 11027.22809403334, 11293.0, 11482.655520334403, 11534.423278835857, 11538.423078846192], "value": 7121.490439067053, "unit": "score"}], "name": "dromaeo_css", "value": 7089.329717098993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 110.0, 113.0, 110.0, 111.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 126.0, 176.0, 125.0, 126.0, 148.0, 125.0, 156.0, 125.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 159.0, 160.0, 163.0, 160.0, 161.0, 162.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 132.0, 74.0, 76.0, 75.0, 74.0, 112.0, 75.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 83.0, 84.0, 120.0, 84.0, 84.0, 128.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 119.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 97.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 54.0, 56.0, 56.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 82.0, 78.0, 79.0, 80.0, 79.0, 83.0, 113.0, 80.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 121.0, 126.0, 118.0, 117.0, 118.0, 120.0, 122.0, 121.0], "value": 121.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 163.0, 161.0, 159.0, 158.0, 163.0, 165.0, 162.0, 157.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 61.0, 61.0, 61.0, 62.0, 62.0, 60.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1491.6000000000001, "alertThreshold": 2.0}]} 08:20:28 INFO - Return code: 0 08:20:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:28 ERROR - # TBPL SUCCESS # 08:20:28 INFO - Running post-action listener: _resource_record_post_action 08:20:28 INFO - ##### 08:20:28 INFO - ##### Finished run-tests step (success) 08:20:28 INFO - ##### 08:20:28 INFO - Running post-run listener: _resource_record_post_run 08:20:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541122560; Read time: 16; Write time: 568476 08:20:28 INFO - TinderboxPrint: CPU usage
13.2% 08:20:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:20:28 INFO - TinderboxPrint: I/O write bytes / time
541,122,560 / 568,476 08:20:28 INFO - TinderboxPrint: CPU idle
8,254.5 (86.8%) 08:20:28 INFO - TinderboxPrint: CPU user
1,213.8 (12.8%) 08:20:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247644160; Read time: 0; Write time: 281636 08:20:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293478400; Read time: 16; Write time: 286840 08:20:29 INFO - Running post-run listener: _upload_blobber_files 08:20:29 INFO - Blob upload gear active. 08:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:29 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 08:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:30 INFO - (blobuploader) - INFO - Done attempting. 08:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:31 INFO - (blobuploader) - INFO - Done attempting. 08:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:35 INFO - (blobuploader) - INFO - Done attempting. 08:20:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:35 INFO - Return code: 0 08:20:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc4f7f62a08ce14e30798fdef7a83cdb1b83275b80355fc64a2b7ae6456a24f2603ef0d0162e46e72035dfcdcffe5ea4b37d4f49273c6efbd2e404da84bc7afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5526ea732a00935fa94240e5028c939c2be4ff36d0c421d7eaee5e926d6a64a3ef92a12853eebe9560d034c941ab88a650fd0c1c7986a290a471795aa14f7545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48e77ca5608330a4edc2a854fa88df8b30d6147c0a3ad88300b522eef8a7ac61d731d59e81e3e128338d95be0e6a92f926de607e6ef3902313fca3a2a09bf750"} 08:20:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:35 INFO - Contents: 08:20:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc4f7f62a08ce14e30798fdef7a83cdb1b83275b80355fc64a2b7ae6456a24f2603ef0d0162e46e72035dfcdcffe5ea4b37d4f49273c6efbd2e404da84bc7afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5526ea732a00935fa94240e5028c939c2be4ff36d0c421d7eaee5e926d6a64a3ef92a12853eebe9560d034c941ab88a650fd0c1c7986a290a471795aa14f7545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48e77ca5608330a4edc2a854fa88df8b30d6147c0a3ad88300b522eef8a7ac61d731d59e81e3e128338d95be0e6a92f926de607e6ef3902313fca3a2a09bf750"} 08:20:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:35 INFO - Copying logs to upload dir... 08:20:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.213217 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 08:20:35.184572) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 08:20:35.187911) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc4f7f62a08ce14e30798fdef7a83cdb1b83275b80355fc64a2b7ae6456a24f2603ef0d0162e46e72035dfcdcffe5ea4b37d4f49273c6efbd2e404da84bc7afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5526ea732a00935fa94240e5028c939c2be4ff36d0c421d7eaee5e926d6a64a3ef92a12853eebe9560d034c941ab88a650fd0c1c7986a290a471795aa14f7545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48e77ca5608330a4edc2a854fa88df8b30d6147c0a3ad88300b522eef8a7ac61d731d59e81e3e128338d95be0e6a92f926de607e6ef3902313fca3a2a09bf750"} build_url:https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/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/Fx-Team/sha512/bc4f7f62a08ce14e30798fdef7a83cdb1b83275b80355fc64a2b7ae6456a24f2603ef0d0162e46e72035dfcdcffe5ea4b37d4f49273c6efbd2e404da84bc7afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5526ea732a00935fa94240e5028c939c2be4ff36d0c421d7eaee5e926d6a64a3ef92a12853eebe9560d034c941ab88a650fd0c1c7986a290a471795aa14f7545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48e77ca5608330a4edc2a854fa88df8b30d6147c0a3ad88300b522eef8a7ac61d731d59e81e3e128338d95be0e6a92f926de607e6ef3902313fca3a2a09bf750"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 08:20:35.216761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 08:20:35.217501) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464706798.485276-1763931430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 08:20:35.300736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 08:20:35.301511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 08:20:35.302174) ========= ========= Total master_lag: 0.18 =========