builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1464729860.43 results: success (0) buildid: 20160531080244 builduid: 9e6fa5615c594d0084d665872c3723c9 revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.427809) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.428307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.428636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.465646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.465982) ========= 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=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 14:24:21-- 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.0M=0s 2016-05-31 14:24:21 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.575150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.575934) ========= 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=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014314 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.633080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:20.633477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6617e62776cdf01627f146087690cfc7c883508a --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 6617e62776cdf01627f146087690cfc7c883508a --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=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 14:24:21,659 truncating revision to first 12 chars 2016-05-31 14:24:21,659 Setting DEBUG logging. 2016-05-31 14:24:21,659 attempt 1/10 2016-05-31 14:24:21,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6617e62776cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 14:24:21,977 unpacking tar archive at: fx-team-6617e62776cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:21.299976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:21.300809) ========= script_repo_revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:21.301831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:21.302550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 14:24:21.316103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-31 14:24:21.316785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:24:22 INFO - MultiFileLogger online at 20160531 14:24:22 in /builds/slave/test 14:24:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:24:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:24:22 INFO - {'append_to_log': False, 14:24:22 INFO - 'base_work_dir': '/builds/slave/test', 14:24:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:24:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:24:22 INFO - 'branch': 'Fx-Team-Non-PGO', 14:24:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:22 INFO - 'config_files': ('talos/linux_config.py',), 14:24:22 INFO - 'default_actions': ('clobber', 14:24:22 INFO - 'read-buildbot-config', 14:24:22 INFO - 'download-and-extract', 14:24:22 INFO - 'populate-webroot', 14:24:22 INFO - 'create-virtualenv', 14:24:22 INFO - 'install', 14:24:22 INFO - 'run-tests'), 14:24:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:22 INFO - 'download_minidump_stackwalk': True, 14:24:22 INFO - 'download_symbols': 'ondemand', 14:24:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:24:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:24:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:24:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:24:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:22 INFO - 'installer_path': 'installer.exe', 14:24:22 INFO - 'log_level': 'info', 14:24:22 INFO - 'log_name': 'talos', 14:24:22 INFO - 'log_to_console': True, 14:24:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:24:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:24:22 INFO - 'opt_config_files': (), 14:24:22 INFO - 'pip_index': False, 14:24:22 INFO - 'sps_profile': False, 14:24:22 INFO - 'sps_profile_interval': 0, 14:24:22 INFO - 'suite': 'dromaeojs', 14:24:22 INFO - 'system_bits': '32', 14:24:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:22 INFO - 'title': 'talos-linux64-ix-048', 14:24:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:22 INFO - 'use_talos_json': True, 14:24:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:24:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:22 INFO - 'work_dir': 'build'} 14:24:22 INFO - ##### 14:24:22 INFO - ##### Running clobber step. 14:24:22 INFO - ##### 14:24:22 INFO - Running pre-action listener: _resource_record_pre_action 14:24:22 INFO - Running main action method: clobber 14:24:22 INFO - rmtree: /builds/slave/test/build 14:24:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:24:23 INFO - Running post-action listener: _resource_record_post_action 14:24:23 INFO - ##### 14:24:23 INFO - ##### Finished clobber step (success) 14:24:23 INFO - ##### 14:24:23 INFO - ##### 14:24:23 INFO - ##### Running read-buildbot-config step. 14:24:23 INFO - ##### 14:24:23 INFO - Running pre-action listener: _resource_record_pre_action 14:24:23 INFO - Running main action method: read_buildbot_config 14:24:23 INFO - Using buildbot properties: 14:24:23 INFO - { 14:24:23 INFO - "project": "", 14:24:23 INFO - "product": "firefox", 14:24:23 INFO - "script_repo_revision": "production", 14:24:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:24:23 INFO - "repository": "", 14:24:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:24:23 INFO - "buildid": "20160531080244", 14:24:23 INFO - "pgo_build": "False", 14:24:23 INFO - "basedir": "/builds/slave/test", 14:24:23 INFO - "buildnumber": 3023, 14:24:23 INFO - "slavename": "talos-linux64-ix-048", 14:24:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:24:23 INFO - "platform": "ubuntu64_hw", 14:24:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:24:23 INFO - "branch": "fx-team", 14:24:23 INFO - "repo_path": "integration/fx-team", 14:24:23 INFO - "revision": "6617e62776cdf01627f146087690cfc7c883508a", 14:24:23 INFO - "stage_platform": "linux64", 14:24:23 INFO - "builduid": "9e6fa5615c594d0084d665872c3723c9", 14:24:23 INFO - "slavebuilddir": "test" 14:24:23 INFO - } 14:24:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:24:23 INFO - Running post-action listener: _resource_record_post_action 14:24:23 INFO - ##### 14:24:23 INFO - ##### Finished read-buildbot-config step (success) 14:24:23 INFO - ##### 14:24:23 INFO - ##### 14:24:23 INFO - ##### Running download-and-extract step. 14:24:23 INFO - ##### 14:24:23 INFO - Running pre-action listener: _resource_record_pre_action 14:24:23 INFO - Running main action method: download_and_extract 14:24:23 INFO - mkdir: /builds/slave/test/build/tests 14:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:23 INFO - https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:24:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:24:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:24:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:24 INFO - Downloaded 1361 bytes. 14:24:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:24:24 INFO - Using the following test package requirements: 14:24:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:24:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:24:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:24:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'jsshell-linux-x86_64.zip'], 14:24:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:24:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:24:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:24:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:24:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:24:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:24:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:24 INFO - https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:25 INFO - Downloaded 22840449 bytes. 14:24:25 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'] 14:24:25 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 14:24:26 INFO - Return code: 0 14:24:26 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 14:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:26 INFO - https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:27 INFO - Downloaded 22840449 bytes. 14:24:27 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'] 14:24:27 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 14:24:29 INFO - Return code: 0 14:24: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')]} 14:24:29 INFO - https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:30 INFO - Downloaded 10834055 bytes. 14:24:30 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'] 14:24:30 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 14:24:30 INFO - Return code: 0 14:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:30 INFO - https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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 14:24:31 INFO - Downloaded 55035275 bytes. 14:24:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:24:31 INFO - mkdir: /builds/slave/test/properties 14:24:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:31 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:31 INFO - Contents: 14:24:31 INFO - build_url:https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:24:32 INFO - Running post-action listener: _resource_record_post_action 14:24:32 INFO - Running post-action listener: set_extra_try_arguments 14:24:32 INFO - ##### 14:24:32 INFO - ##### Finished download-and-extract step (success) 14:24:32 INFO - ##### 14:24:32 INFO - ##### 14:24:32 INFO - ##### Running populate-webroot step. 14:24:32 INFO - ##### 14:24:32 INFO - Running pre-action listener: _resource_record_pre_action 14:24:32 INFO - Running main action method: populate_webroot 14:24:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:32 INFO - '--tppagecycles', 14:24:32 INFO - '7'], 14:24:32 INFO - 'tests': ['tsvgm']}}, 14:24:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['damp', 'tps']}, 14:24:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'tests': ['damp', 'tps']}, 14:24:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['dromaeo_dom']}, 14:24:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['a11yr', 14:24:32 INFO - 'ts_paint', 14:24:32 INFO - 'tpaint', 14:24:32 INFO - 'sessionrestore', 14:24:32 INFO - 'sessionrestore_no_auto_restore', 14:24:32 INFO - 'tabpaint']}, 14:24:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['tsvgx', 14:24:32 INFO - 'tsvgr_opacity', 14:24:32 INFO - 'tart', 14:24:32 INFO - 'tscrollx', 14:24:32 INFO - 'cart']}, 14:24:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:32 INFO - 'tsvgr_opacity', 14:24:32 INFO - 'tart', 14:24:32 INFO - 'tscrollx', 14:24:32 INFO - 'cart']}, 14:24:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'talos_options': ['--disable-e10s'], 14:24:32 INFO - 'tests': ['tp5o']}, 14:24:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'tests': ['tp5o']}, 14:24:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'talos_options': ['--disable-e10s', 14:24:32 INFO - '--xperf_path', 14:24:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:32 INFO - 'tests': ['tp5n']}, 14:24:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:32 INFO - 'talos_options': ['--xperf_path', 14:24:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:32 INFO - 'tests': ['tp5n']}}, 14:24:32 INFO - 'talos.zip': {'path': '', 14:24:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:32 INFO - Running post-action listener: _resource_record_post_action 14:24:32 INFO - ##### 14:24:32 INFO - ##### Finished populate-webroot step (success) 14:24:32 INFO - ##### 14:24:32 INFO - ##### 14:24:32 INFO - ##### Running create-virtualenv step. 14:24:32 INFO - ##### 14:24:32 INFO - Running pre-action listener: _resource_record_pre_action 14:24:32 INFO - Running main action method: create_virtualenv 14:24:32 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:24:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:32 INFO - Using real prefix '/usr' 14:24:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:35 INFO - Installing pip.................done. 14:24:35 INFO - Return code: 0 14:24:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:24:35 INFO - Using env: {'DISPLAY': ':0', 14:24:35 INFO - 'HOME': '/home/cltbld', 14:24:35 INFO - 'LANG': 'en_US.UTF-8', 14:24:35 INFO - 'LANGUAGE': 'en_US:en', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MAIL': '/var/mail/cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SHLVL': '1', 14:24:35 INFO - 'TERM': 'linux', 14:24:35 INFO - 'TMOUT': '86400', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - '_': '/tools/buildbot/bin/python'} 14:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:24:35 INFO - Cleaning up... 14:24:35 INFO - Return code: 0 14:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:24:35 INFO - Using env: {'DISPLAY': ':0', 14:24:35 INFO - 'HOME': '/home/cltbld', 14:24:35 INFO - 'LANG': 'en_US.UTF-8', 14:24:35 INFO - 'LANGUAGE': 'en_US:en', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MAIL': '/var/mail/cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SHLVL': '1', 14:24:35 INFO - 'TERM': 'linux', 14:24:35 INFO - 'TMOUT': '86400', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - '_': '/tools/buildbot/bin/python'} 14:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:35 INFO - Downloading/unpacking psutil>=3.1.1 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:37 INFO - Installing collected packages: psutil 14:24:37 INFO - Running setup.py install for psutil 14:24:37 INFO - building 'psutil._psutil_linux' extension 14:24:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:24:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:24:38 INFO - building 'psutil._psutil_posix' extension 14:24:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:24:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:24:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:38 INFO - Successfully installed psutil 14:24:38 INFO - Cleaning up... 14:24:38 INFO - Return code: 0 14:24:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:38 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:24:38 INFO - Using env: {'DISPLAY': ':0', 14:24:38 INFO - 'HOME': '/home/cltbld', 14:24:38 INFO - 'LANG': 'en_US.UTF-8', 14:24:38 INFO - 'LANGUAGE': 'en_US:en', 14:24:38 INFO - 'LOGNAME': 'cltbld', 14:24:38 INFO - 'MAIL': '/var/mail/cltbld', 14:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:38 INFO - 'MOZ_NO_REMOTE': '1', 14:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:38 INFO - 'NO_EM_RESTART': '1', 14:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:38 INFO - 'PWD': '/builds/slave/test', 14:24:38 INFO - 'SHELL': '/bin/bash', 14:24:38 INFO - 'SHLVL': '1', 14:24:38 INFO - 'TERM': 'linux', 14:24:38 INFO - 'TMOUT': '86400', 14:24:38 INFO - 'USER': 'cltbld', 14:24:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:38 INFO - '_': '/tools/buildbot/bin/python'} 14:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:40 INFO - Installing collected packages: mozsystemmonitor 14:24:40 INFO - Running setup.py install for mozsystemmonitor 14:24:40 INFO - Successfully installed mozsystemmonitor 14:24:40 INFO - Cleaning up... 14:24:40 INFO - Return code: 0 14:24:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:24:40 INFO - Using env: {'DISPLAY': ':0', 14:24:40 INFO - 'HOME': '/home/cltbld', 14:24:40 INFO - 'LANG': 'en_US.UTF-8', 14:24:40 INFO - 'LANGUAGE': 'en_US:en', 14:24:40 INFO - 'LOGNAME': 'cltbld', 14:24:40 INFO - 'MAIL': '/var/mail/cltbld', 14:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:40 INFO - 'MOZ_NO_REMOTE': '1', 14:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:40 INFO - 'NO_EM_RESTART': '1', 14:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:40 INFO - 'PWD': '/builds/slave/test', 14:24:40 INFO - 'SHELL': '/bin/bash', 14:24:40 INFO - 'SHLVL': '1', 14:24:40 INFO - 'TERM': 'linux', 14:24:40 INFO - 'TMOUT': '86400', 14:24:40 INFO - 'USER': 'cltbld', 14:24:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:40 INFO - '_': '/tools/buildbot/bin/python'} 14:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:40 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:43 INFO - Downloading docopt-0.6.1.tar.gz 14:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:43 INFO - Running setup.py install for blobuploader 14:24:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:43 INFO - Running setup.py install for requests 14:24:43 INFO - Running setup.py install for docopt 14:24:44 INFO - Successfully installed blobuploader requests docopt 14:24:44 INFO - Cleaning up... 14:24:44 INFO - Return code: 0 14:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:44 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:24:44 INFO - Using env: {'DISPLAY': ':0', 14:24:44 INFO - 'HOME': '/home/cltbld', 14:24:44 INFO - 'LANG': 'en_US.UTF-8', 14:24:44 INFO - 'LANGUAGE': 'en_US:en', 14:24:44 INFO - 'LOGNAME': 'cltbld', 14:24:44 INFO - 'MAIL': '/var/mail/cltbld', 14:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:44 INFO - 'MOZ_NO_REMOTE': '1', 14:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:44 INFO - 'NO_EM_RESTART': '1', 14:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:44 INFO - 'PWD': '/builds/slave/test', 14:24:44 INFO - 'SHELL': '/bin/bash', 14:24:44 INFO - 'SHLVL': '1', 14:24:44 INFO - 'TERM': 'linux', 14:24:44 INFO - 'TMOUT': '86400', 14:24:44 INFO - 'USER': 'cltbld', 14:24:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:44 INFO - '_': '/tools/buildbot/bin/python'} 14:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:44 INFO - Running setup.py (path:/tmp/pip-4JliyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:44 INFO - Running setup.py (path:/tmp/pip-z1DAdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:44 INFO - Running setup.py (path:/tmp/pip-OoXGck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:44 INFO - Running setup.py (path:/tmp/pip-A5lQ5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:44 INFO - Running setup.py (path:/tmp/pip-WaGYPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:44 INFO - Running setup.py (path:/tmp/pip-U1BLR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:44 INFO - Running setup.py (path:/tmp/pip-Mlv2EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:44 INFO - Running setup.py (path:/tmp/pip-ZFxn7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:44 INFO - Running setup.py (path:/tmp/pip-1ggN4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:44 INFO - Running setup.py (path:/tmp/pip-pps6NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:45 INFO - Running setup.py (path:/tmp/pip-_n7RyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:45 INFO - Running setup.py (path:/tmp/pip-zL90l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:45 INFO - Running setup.py (path:/tmp/pip-QxRAJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:45 INFO - Running setup.py (path:/tmp/pip-7lPKeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:45 INFO - Running setup.py (path:/tmp/pip-pI5c5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:45 INFO - Running setup.py (path:/tmp/pip-EtYs39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:45 INFO - Running setup.py (path:/tmp/pip-IcgzTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:45 INFO - Running setup.py install for manifestparser 14:24:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Running setup.py install for mozcrash 14:24:45 INFO - Running setup.py install for mozdebug 14:24:45 INFO - Running setup.py install for mozdevice 14:24:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:45 INFO - Running setup.py install for mozfile 14:24:46 INFO - Running setup.py install for mozhttpd 14:24:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozinfo 14:24:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozInstall 14:24:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozleak 14:24:46 INFO - Running setup.py install for mozlog 14:24:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for moznetwork 14:24:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozprocess 14:24:46 INFO - Running setup.py install for mozprofile 14:24:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozrunner 14:24:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:46 INFO - Running setup.py install for mozscreenshot 14:24:47 INFO - Running setup.py install for moztest 14:24:47 INFO - Running setup.py install for mozversion 14:24:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:24:47 INFO - Using env: {'DISPLAY': ':0', 14:24:47 INFO - 'HOME': '/home/cltbld', 14:24:47 INFO - 'LANG': 'en_US.UTF-8', 14:24:47 INFO - 'LANGUAGE': 'en_US:en', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MAIL': '/var/mail/cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SHLVL': '1', 14:24:47 INFO - 'TERM': 'linux', 14:24:47 INFO - 'TMOUT': '86400', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - '_': '/tools/buildbot/bin/python'} 14:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:47 INFO - Running setup.py (path:/tmp/pip-bhJ9qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:47 INFO - Running setup.py (path:/tmp/pip-csyn42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:47 INFO - Running setup.py (path:/tmp/pip-RZ9mCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:47 INFO - Running setup.py (path:/tmp/pip-Vxe2h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:47 INFO - Running setup.py (path:/tmp/pip-4Ps654-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:47 INFO - Running setup.py (path:/tmp/pip-0U0ijM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:47 INFO - Running setup.py (path:/tmp/pip-xdJeIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:48 INFO - Running setup.py (path:/tmp/pip-old9_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:48 INFO - Running setup.py (path:/tmp/pip-rC4tXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:48 INFO - Running setup.py (path:/tmp/pip-SrxxOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:48 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)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:48 INFO - Running setup.py (path:/tmp/pip-hcC7Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:48 INFO - Running setup.py (path:/tmp/pip-9C9Rk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:48 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)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:48 INFO - Running setup.py (path:/tmp/pip-vWzO5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:48 INFO - Running setup.py (path:/tmp/pip-Myw6IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:48 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)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:48 INFO - Running setup.py (path:/tmp/pip-ah4Qtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:48 INFO - Running setup.py (path:/tmp/pip-9UbLGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:48 INFO - Running setup.py (path:/tmp/pip-fBVTa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:50 INFO - Downloading blessings-1.6.tar.gz 14:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:50 INFO - Installing collected packages: blessings 14:24:50 INFO - Running setup.py install for blessings 14:24:50 INFO - Successfully installed blessings 14:24:50 INFO - Cleaning up... 14:24:50 INFO - Return code: 0 14:24:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:51 INFO - Reading from file tmpfile_stdout 14:24:51 INFO - Current package versions: 14:24:51 INFO - argparse == 1.2.1 14:24:51 INFO - blessings == 1.6 14:24:51 INFO - blobuploader == 1.2.4 14:24:51 INFO - docopt == 0.6.1 14:24:51 INFO - manifestparser == 1.1 14:24:51 INFO - mozInstall == 1.12 14:24:51 INFO - mozcrash == 0.17 14:24:51 INFO - mozdebug == 0.1 14:24:51 INFO - mozdevice == 0.48 14:24:51 INFO - mozfile == 1.2 14:24:51 INFO - mozhttpd == 0.7 14:24:51 INFO - mozinfo == 0.9 14:24:51 INFO - mozleak == 0.1 14:24:51 INFO - mozlog == 3.2 14:24:51 INFO - moznetwork == 0.27 14:24:51 INFO - mozprocess == 0.22 14:24:51 INFO - mozprofile == 0.28 14:24:51 INFO - mozrunner == 6.11 14:24:51 INFO - mozscreenshot == 0.1 14:24:51 INFO - mozsystemmonitor == 0.3 14:24:51 INFO - moztest == 0.7 14:24:51 INFO - mozversion == 1.4 14:24:51 INFO - psutil == 3.1.1 14:24:51 INFO - requests == 1.2.3 14:24:51 INFO - wsgiref == 0.1.2 14:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:24:51 INFO - Using env: {'DISPLAY': ':0', 14:24:51 INFO - 'HOME': '/home/cltbld', 14:24:51 INFO - 'LANG': 'en_US.UTF-8', 14:24:51 INFO - 'LANGUAGE': 'en_US:en', 14:24:51 INFO - 'LOGNAME': 'cltbld', 14:24:51 INFO - 'MAIL': '/var/mail/cltbld', 14:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:51 INFO - 'MOZ_NO_REMOTE': '1', 14:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:51 INFO - 'NO_EM_RESTART': '1', 14:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:51 INFO - 'PWD': '/builds/slave/test', 14:24:51 INFO - 'SHELL': '/bin/bash', 14:24:51 INFO - 'SHLVL': '1', 14:24:51 INFO - 'TERM': 'linux', 14:24:51 INFO - 'TMOUT': '86400', 14:24:51 INFO - 'USER': 'cltbld', 14:24:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:51 INFO - '_': '/tools/buildbot/bin/python'} 14:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:24:51 INFO - Cleaning up... 14:24:51 INFO - Return code: 0 14:24:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:24:51 INFO - Using env: {'DISPLAY': ':0', 14:24:51 INFO - 'HOME': '/home/cltbld', 14:24:51 INFO - 'LANG': 'en_US.UTF-8', 14:24:51 INFO - 'LANGUAGE': 'en_US:en', 14:24:51 INFO - 'LOGNAME': 'cltbld', 14:24:51 INFO - 'MAIL': '/var/mail/cltbld', 14:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:51 INFO - 'MOZ_NO_REMOTE': '1', 14:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:51 INFO - 'NO_EM_RESTART': '1', 14:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:51 INFO - 'PWD': '/builds/slave/test', 14:24:51 INFO - 'SHELL': '/bin/bash', 14:24:51 INFO - 'SHLVL': '1', 14:24:51 INFO - 'TERM': 'linux', 14:24:51 INFO - 'TMOUT': '86400', 14:24:51 INFO - 'USER': 'cltbld', 14:24:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:51 INFO - '_': '/tools/buildbot/bin/python'} 14:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:51 INFO - Downloading/unpacking jsonschema 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:53 INFO - Downloading/unpacking functools32 (from jsonschema) 14:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:53 INFO - warning: no files found matching '*.txt' 14:24:53 INFO - no previously-included directories found matching 'build' 14:24:53 INFO - no previously-included directories found matching 'dist' 14:24:53 INFO - no previously-included directories found matching '.git*' 14:24:53 INFO - Installing collected packages: jsonschema, functools32 14:24:53 INFO - Running setup.py install for functools32 14:24:54 INFO - warning: no files found matching '*.txt' 14:24:54 INFO - no previously-included directories found matching 'build' 14:24:54 INFO - no previously-included directories found matching 'dist' 14:24:54 INFO - no previously-included directories found matching '.git*' 14:24:54 INFO - Successfully installed jsonschema functools32 14:24:54 INFO - Cleaning up... 14:24:54 INFO - Return code: 0 14:24:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:54 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 0x7fc1d0952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:24:54 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 14:24:54 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 14:24:54 INFO - Using env: {'DISPLAY': ':0', 14:24:54 INFO - 'HOME': '/home/cltbld', 14:24:54 INFO - 'LANG': 'en_US.UTF-8', 14:24:54 INFO - 'LANGUAGE': 'en_US:en', 14:24:54 INFO - 'LOGNAME': 'cltbld', 14:24:54 INFO - 'MAIL': '/var/mail/cltbld', 14:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:54 INFO - 'MOZ_NO_REMOTE': '1', 14:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:54 INFO - 'NO_EM_RESTART': '1', 14:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:54 INFO - 'PWD': '/builds/slave/test', 14:24:54 INFO - 'SHELL': '/bin/bash', 14:24:54 INFO - 'SHLVL': '1', 14:24:54 INFO - 'TERM': 'linux', 14:24:54 INFO - 'TMOUT': '86400', 14:24:54 INFO - 'USER': 'cltbld', 14:24:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:54 INFO - '_': '/tools/buildbot/bin/python'} 14:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:54 INFO - Downloading/unpacking flake8 14:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:24:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:24:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:57 INFO - no previously-included directories found matching 'docs/_build' 14:24:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:24:57 INFO - Running setup.py install for pep8 14:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:57 INFO - no previously-included directories found matching 'docs/_build' 14:24:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:24:57 INFO - Cleaning up... 14:24:57 INFO - Return code: 0 14:24:57 INFO - Running post-action listener: _resource_record_post_action 14:24:57 INFO - Running post-action listener: _start_resource_monitoring 14:24:57 INFO - Starting resource monitoring. 14:24:57 INFO - ##### 14:24:57 INFO - ##### Finished create-virtualenv step (success) 14:24:57 INFO - ##### 14:24:57 INFO - ##### 14:24:57 INFO - ##### Running install step. 14:24:57 INFO - ##### 14:24:57 INFO - Running pre-action listener: _resource_record_pre_action 14:24:57 INFO - Running main action method: install 14:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:57 INFO - Reading from file tmpfile_stdout 14:24:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:57 INFO - Reading from file tmpfile_stdout 14:24:57 INFO - Output received: 14:24:57 INFO - Usage: mozinstall [options] installer 14:24:57 INFO - Options: 14:24:57 INFO - -h, --help show this help message and exit 14:24:57 INFO - -d DEST, --destination=DEST 14:24:57 INFO - Directory to install application into. [default: 14:24:57 INFO - "/builds/slave/test"] 14:24:57 INFO - --app=APP Application being installed. [default: firefox] 14:24:57 INFO - mkdir: /builds/slave/test/build/application 14:24:57 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'] 14:24:57 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 14:25:13 INFO - Reading from file tmpfile_stdout 14:25:13 INFO - Output received: 14:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:25:13 INFO - Running post-action listener: _resource_record_post_action 14:25:13 INFO - ##### 14:25:13 INFO - ##### Finished install step (success) 14:25:13 INFO - ##### 14:25:13 INFO - ##### 14:25:13 INFO - ##### Running run-tests step. 14:25:13 INFO - ##### 14:25:13 INFO - Running pre-action listener: _resource_record_pre_action 14:25:13 INFO - Running main action method: run_tests 14:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:13 INFO - Python 2.7.3 14:25:13 INFO - Return code: 0 14:25:13 INFO - grabbing minidump binary from tooltool 14:25: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')]} 14:25:13 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 0x17349c0>, '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 0x17358c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1735d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:25:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:25:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:25:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:13 INFO - Return code: 0 14:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:25:14 INFO - Return code: 0 14:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:25:14 INFO - Using env: {'DISPLAY': ':0', 14:25:14 INFO - 'HOME': '/home/cltbld', 14:25:14 INFO - 'LANG': 'en_US.UTF-8', 14:25:14 INFO - 'LANGUAGE': 'en_US:en', 14:25:14 INFO - 'LOGNAME': 'cltbld', 14:25:14 INFO - 'MAIL': '/var/mail/cltbld', 14:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:14 INFO - 'MOZ_NO_REMOTE': '1', 14:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:14 INFO - 'NO_EM_RESTART': '1', 14:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:14 INFO - 'PWD': '/builds/slave/test', 14:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:14 INFO - 'SHELL': '/bin/bash', 14:25:14 INFO - 'SHLVL': '1', 14:25:14 INFO - 'TERM': 'linux', 14:25:14 INFO - 'TMOUT': '86400', 14:25:14 INFO - 'USER': 'cltbld', 14:25:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305', 14:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:14 INFO - '_': '/tools/buildbot/bin/python'} 14:25:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:25:14 INFO - mozversion application_buildid: 20160531080244 14:25:14 INFO - mozversion application_changeset: 6617e62776cdf01627f146087690cfc7c883508a 14:25:14 INFO - mozversion application_display_name: Nightly 14:25:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:14 INFO - mozversion application_name: Firefox 14:25:14 INFO - mozversion application_remotingname: firefox 14:25:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:25:14 INFO - mozversion application_vendor: Mozilla 14:25:14 INFO - mozversion application_version: 49.0a1 14:25:14 INFO - mozversion platform_buildid: 20160531080244 14:25:14 INFO - mozversion platform_changeset: 6617e62776cdf01627f146087690cfc7c883508a 14:25:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:25:14 INFO - mozversion platform_version: 49.0a1 14:25:14 INFO - using testdate: 1464729914 14:25:14 INFO - actual date: 1464729914 14:25:14 INFO - starting webserver on 'localhost:52965' 14:25:14 INFO - SUITE-START | Running 2 tests 14:25:14 INFO - TEST-START | dromaeo_css 14:25:14 INFO - operating with platform_type : linux_ 14:25:14 INFO - Initialising browser for dromaeo_css test... 14:25:14 INFO - TEST-INFO | started process 17286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFGQWm/profile http://localhost:52965/getInfo.html) 14:25:19 INFO - PROCESS | 17286 | __metrics Screen width/height:1600/1200 14:25:19 INFO - PROCESS | 17286 | colorDepth:24 14:25:19 INFO - PROCESS | 17286 | Browser inner width/height: 1024/697 14:25:19 INFO - PROCESS | 17286 | __metrics 14:25:20 ERROR - PROCESS | 17286 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:25:21 INFO - TEST-INFO | 17286: exit 0 14:25:21 INFO - Browser initialized. 14:25:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:21 INFO - TEST-INFO | started process 17368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFGQWm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:33 INFO - PROCESS | 17368 | RSS: Main: 157384704 14:25:33 INFO - PROCESS | 17368 | 14:26:24 INFO - PROCESS | 17368 | 1464729984902 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:28:36 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52965/tests/dromaeo/cssquery-ext.html) 14:28:37 INFO - PROCESS | 17368 | RSS: Main: 261582848 14:28:37 INFO - PROCESS | 17368 | 14:31:40 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-ext.html (next: http://localhost:52965/tests/dromaeo/cssquery-jquery.html) 14:31:40 INFO - PROCESS | 17368 | RSS: Main: 239464448 14:31:40 INFO - PROCESS | 17368 | 14:34:43 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52965/tests/dromaeo/cssquery-mootools.html) 14:34:43 INFO - PROCESS | 17368 | RSS: Main: 245653504 14:34:43 INFO - PROCESS | 17368 | 14:37:45 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52965/tests/dromaeo/cssquery-prototype.html) 14:37:46 INFO - PROCESS | 17368 | RSS: Main: 240013312 14:37:46 INFO - PROCESS | 17368 | 14:40:49 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52965/tests/dromaeo/cssquery-yui.html) 14:40:50 INFO - PROCESS | 17368 | RSS: Main: 203685888 14:40:50 INFO - PROCESS | 17368 | 14:43:52 INFO - PROCESS | 17368 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-yui.html (next: http://localhost:52965/tests/dromaeo/cssquery-dojo.html) 14:43:53 INFO - PROCESS | 17368 | RSS: Main: 265695232 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | __start_tp_report 14:43:53 INFO - PROCESS | 17368 | _x_x_mozilla_page_load 14:43:53 INFO - PROCESS | 17368 | _x_x_mozilla_page_load_details 14:43:53 INFO - PROCESS | 17368 | |i|pagename|runs| 14:43:53 INFO - PROCESS | 17368 | |0;dojo.html;2647.6028595710645;2682.0076571668487;2709.756121949025;2724.523208438523;2730.153652367766;4551.567601077901;4625.861224163272;4627.167109920213;4735.147673418779;4789.401324834395;4647.837325693601;4682.484926658065;4682.929756053653;4738.739369334694;4751.833685820997;4284.850030248942;4347.19576878277;4348.086901750637;4393.538678438757;4402.339649052636;4380.737155770664;4397.186520493703;4444.20004399208;4463.73217606943;4487.326900964848;4336.934945975781;4384.561543845622;4390.714603550759;4393.692441529094;4432.711873728197;4221.050263690676;4235.343521754133;4302.569743025703;4306.375575541529;4332.631726303268;4251.277282861921;4278.187144442546;4334.609885110355;4348.565143485658;4368.803403846835;4609.492955774862;4623.56076172763;4640.303954406832;4667.4632417272105;4678.7426691531955;4845.297431872394;4956.553910148104;5011.32347133136;5028.044671512437;5108.795648174068;5094.566961808251;5100.209467532539;5122.692638441706;5126.641135120543;5141.691498510101;4602.792874320664;4755.524447555217;4758.405199350082;4775.188218002948;4802.303665968415;5102.158143906214;5174.53429191367;5190.6107041972;5192.766325515361;5265.868353291198;4998.175301075282;5030.673006254582;5042.117629414838;5045.84862454127;5047.97476012625;4907.190313598217;4952.4057113146655;5046.142155833517;5066.695998240118;5105.2086926526445;4912.38595175603;4938.530839570235;4953.455119936804;4971.950280497149;4987.775550100254;4927;4942.752862356868;4949.406071271471;4966.081274964144;4999.825006124768;4010.578889216649;4041.797910104483;4149.564295748964;4159.750414975111;4222.619964203236;3616.367135751286;3639.47227651989;3646.5259516263245;3681.5582130144553;3725.1990821973404;4297.742135471882;4301.483821941387;4308.6983911126545;4309.612134907873;4356.237658409766;5041.445441001487;5041.82353617629;5043.672161309503;5049.116404629175;5078.619103567247;4185.602367775056;4207.053412982054;4256.914861702749;4261.488621365394;4282.828686852553;4403.471583409947;4443.533428989909;4450.1989641864775;4450.443694538183;4487;4653.092646933816;4765.451973023147;4769.594584460359;4775.4269487661;4807.158747219222;5025.698458092526;5046.243063540498;5054.140796064751;5088.542031217208;5095.974520127375;4811.446683631427;4821.2045012573935;4837.733924634179;4838.104950584153;4887.926681099715;4778.641601879804;4795.017021510512;4990.625703072212;4997.100521906092;5065.366829146356;4877.585405240594;4904.239842824368;4934.235193545006;4937.679050861682;4976.353074100344;4792.0895029944195;4796.05112874554;4799.256115302133;4806.399200099988;4845.370101886732;4753.429588449409;4794.161021821237;4801.567858892717;4827.010462855176;4829.73436460984;4813.542713442217;4832;4850.53919877611;4853.587445067067;4865.0756356292195;4898.681585696918;4904.068227036852;4908.6073114151495;4939.135651260943;4940.950590494049;4690.484046754923;4702.247640377524;4798.1123492154065;4841.95158048415;4843.24929635907 14:43:53 INFO - PROCESS | 17368 | |1;ext.html;556.5186114011378;581.4911952041963;585.519873703563;598.0759726222985;608.8873558391698;28972.85513572432;39855.80072099639;40610;40684.79657601715;43345.34981975273;40984.79507602458;41511.79244103775;41608.37587436183;41617.16765664685;41632;7616.7334143305;7802.531848089105;7807.4144439167;7809.765707028798;7810.648520816549;7707.845843083135;7817.257360550767;7848.68605255789;7853.293203611674;7856.371490280764;7460.216677248892;7875.645595948196;7886.6056697165195;7889.4871833330935;7891;7463.3283004529585;7878.4485086044;7884.329831964233;7904.565248911307;7912.129665736765;7767.37860971121;7884.487508311941;7888;7889.053313602404;7890.64492097857;37146.4428033577;37571.62428375708;37603.24793504142;37624;37635.43546846799;3022.9546556801447;3123.437781199383;3342.097633638904;3358.194033431959;3812.656860882506;29883.850580747174;30221.244468888453;30308;30392.088237352913;30594.235144121354;3308.338332333543;3314.171457135716;3329.30084682217;3375.780574262665;3416.0605833395766;277306;279215;279705;281043;281149;54246;54638;54645;54681;54759.726201368736;32806.83596582002;33690;33780.155496112304;35446.468302975474;57636.71181644065;14735.115893046452;14740.115593064236;14759.335829887681;14807.481738139113;14807.555773326818;10995.120390368751;11167.385793781257;11181.888181118085;11187.32876027441;11190.720231994264;17936;17953.551161221076;18048.9097554514;18079.36722214716;18117.18472668733;6827.214870289881;7078.292170782984;7102.3962963148715;7108.644567771694;7202.135743710788;805.6092794994423;874.9825003499894;904.615538396179;946.0397696338222;949.4777872170417;28262.293442664097;28320.43359132806;28707.71292287092;28908;28913.56629650557;974.3033730882312;975.3367709957297;999.3803841618098;1049.4647729657777;1082.1342925659442;14356;14795.63010924714;14956.551303460914;15224.238788060553;15305;118595;118720;119421;119763;120251;49820;50461.24308135381;50464.49535504671;50542.74728626407;50554;1195.611426286443;1213.7087099096154;1223.4922507159429;1223.6512593910693;1249.256692268099;26519.204423867315;27841;27916.16251512458;28231.57652635253;28444.288892777848;42737.358939616555;42767.5723242776;42942.57057429386;42972.35541466943;43078.569214307456;324031;324402;325712;326735;327404;24930;25040.874795626634;25423.491530169664;25471.872640636677;25643.230703078938;42344.5765542353;42651.36022959596;42954.78522607367;42984;43306.56693433025;34870;35788;35839.104022398606;36081.097972550895;36367.45448818217;36469.81765091157;36651.633483664824;36988.63011369852;36993;37061.62938370582;36113.27773444569;36495.27009459849;36920.63079369279;37263.813680931424;37276.44085338668;30924.845375772977;32709.836450817595;32790.34419311648;33135.50296745599;33243.66756332406;25003.87498062498;25371.87314063418;25429.491410172064;25703.485930281662;25850.224493265232 14:43:53 INFO - PROCESS | 17368 | |2;jquery.html;352.83240460781116;363.5782492308922;366.89176692875617;368.6442582907494;380.40656575741843;12611.243325400483;13153.934230328847;14465.34905929233;15985.600359991005;16695.582610434714;15631.452899148531;15678.137702426362;16228.918855405736;16238.675226495492;16926.576835579115;4605.286180641998;4758.738269395182;4762.071396077767;4764.499727528611;4769.666123371366;3447.6897079262862;5234.450382709818;5542.695151766651;5557.472040156179;5558.833235002957;5451.836444906639;5517.144842549411;5518.310211223597;5541.030319694058;5559.58303127265;5352.759125839347;5453.454654534555;5530.391656917735;5542.612017158801;5544.750486228129;5139.768710408003;5287.4448182941005;5296.788128474856;5310.230016647603;5311.336082989626;12367.75264494714;12407.069469789802;12423.565175218915;12505.374731263491;12534.498620055278;1887.7074053521726;2037.765656949455;2072.336852207294;2278.1912421090606;2332.918347857834;9015.459072455607;9543.141117299476;9679.467629280387;10625.574977000912;13450.730985380238;1573.559403367059;1618.9595260118474;1728.6715524050517;1728.809830918598;1855.8329750322537;65796.3420365795;66445.3355466444;67858.66070669664;68984;70302.29697703008;8233.006991609065;8842.867356989651;8915.955420222857;8981.191692747683;9228.077192280718;11817.172797904064;11821.408929553489;11865.288082715064;11899.762004759856;11908.225965312227;6738.191417029988;6820.283870193657;6832.180138383425;6872.518923675295;6908;6615.4046135848;6630.403263706289;6637.46900247979;6698.765543206062;6729.932700672931;3786.3563194257044;3815.3513902636064;3819.255245227154;3849.095462566295;3873.7288389812443;1789.9552511187323;1803.2516505650271;1805.4493379519372;1870.8690391672724;1920.174325040246;879.9560021998874;911.8632205169145;918.1874041473211;918.5315489100607;921.2675922641516;15885.285162167731;16043.759343609856;16208.675826483404;16491.34034638625;16781.83218167827;829.1708291708292;863.9222469977732;875.9781005474914;886.5124181700039;898.3397203055749;8978.461292322481;9006.954965225132;9032.006479287273;9281.164695177466;9445.338826282232;387641;389197;389409;390944;393412;58160.41839581635;73110.63444682742;77542.22457775463;78757;79542.6022869882;854.1458541458542;865.0441262404952;876.0626130040922;876.8202518483823;887.2591386192602;15192.46826361072;15433.382664693287;15553;15767.763483547986;16007.599810004844;34296.65703342934;34607.13482162966;34799.30401391907;35109.64890351166;35352.64647353494;44898.77550612226;46751.766241168574;47030;52256;52501.7374913123;6293.96853015732;6618.305077966937;6686.531942764154;6881.10545629065;6910;6496.642684652201;7873.921260787319;8191.754247372588;9607;9973.603695482783;8983.595738191927;9561.521923903916;9669.806603868024;9782.85325720129;9804.880483058208;9558;9713.70858874235;9723.416595004323;9793.510324483605;9860.16188623975;5952.940470595238;6183.783567575113;9597.28020398459;9761.902380976384;9914.950425247827;6750.426213771688;6808.659567021728;6907.20567134786;6921.204061532988;6964.825879353057;7492.550446973199;9395;9464.574094165917;9474.147326740627;9790.167835734042 14:43:53 INFO - PROCESS | 17368 | |3;mootools.html;1222.1261797814561;1392.7980442835792;1443.978340324895;1557.9143147126904;1797.4607617714692;6960.095187625608;7731.6907323707055;7838.490498117625;7883.960580197091;8191.098979112293;7949.76150715478;8005.479643823148;8068.515889046661;8069.1527389624125;8078.798030049252;2177.8911054447253;2200.933971980843;2205.867647941129;2208.8785116818567;2209.359285807114;2130.499332656832;2141.0365335598963;2155.202575047235;2160.9891950540227;2165.8050775430206;2132.818710409617;2149.376680762577;2150.4301360139575;2158;2210.6573481110454;2146.8175205107586;2150.193677370986;2151.6234658934623;2153.935381938544;2155.2564365293947;2085.270155445582;2155.805977462036;2157.834769224617;2158.1691048946113;2160.6975023496725;7904.130545639975;7940.086890007666;7942.6028698565415;7945.324647404977;7950.244726751007;4528.569785870337;4680.859574212779;4687.343771871941;4705.694129881546;4720.866991921914;2765.8798186734407;2936.7356937875693;2986.1937276935105;2989.566512855624;3000.729934305901;893.0489029183898;894.1058941058941;900.855912990505;911.4804561400005;915.5102020419043;10954.178436617205;11024.338539687644;11036.558537658484;11037.448127593589;11040.613578524793;4098.221337945781;4138.048248902709;4181.163767246563;4190.497140343117;4203.558626344251;8568.314534837198;8668.566571671392;8670.653173872974;8677.913220867837;8681.479111253346;4474.105178964221;4486.7756612169915;4491.685582009228;4494.595486406239;4500.819967201275;3762.9435558466644;4057.857974970921;4199.727017743898;4224.070704445017;4252.638525725286;3356.2280675444786;3375.4261775498226;3435.381631306339;3459.930801383958;3477.5305333779615;1000.9699709008742;1010.7473131717071;1011.4120830296364;1012.6911292055994;1024.109025148111;766.5400759544228;866.1208872993916;871.13322244366;942.9481378524247;949.5015117063597;5708.343540492813;5713.428657134254;5754.367019627837;5845.503132233723;5995.040793473024;827.0654160798259;842.8230071684892;845.9323254139654;863.4387648028832;887.7159309021051;4075.612816782401;4197.635768375229;4221.641160501392;4230.090530535949;4320.1143765527995;9640.566174522164;10008.849867251996;10015.499225038719;10040.64857729976;10056.145227655585;9093.090690930987;9776.804463910681;9883.406995580288;9889.109980101824;9920.305578609572;7322.121345438582;7611.858221266854;7679.116901556393;7681.078270607562;7695.038120234971;5629.240052592848;5852.268466441695;5854.121881717776;5902;5971.7611295547695;9224.631014759334;9262.120098590623;9388.389754666197;9390.718278451657;9428.340016199074;9229.446233226028;9325.766855828659;9420.481873496748;9562.18721408688;9564.473953932322;6252.187215661935;6696.899546506709;6856.348646878539;7010.719571217094;7133.5719856808755;7594.202608726005;7599.962000190185;7649.847003059796;7663.578503182155;7676.078870535572;6543.509236807354;6696.665166741741;6730.394264516021;6765.188177418544;6849.1438570178725;6579.736810527525;6591.703373348307;6626.4367528760595;6718.596884186964;6730.562513436611;6533.248676402274;6580.078788969452;6653.401193892573;6655.434288085567;6663.533552651268;4896.314515967696;4923.679960802537;4962.627802914723;5005.099082165245;5053.519915608012;4908.337374454403;4923.433805112458;4929.260610908393;4965.875853103701;4986.47641997585 14:43:53 INFO - PROCESS | 17368 | |4;prototype.html;291.23260209348376;302.23232988209946;308.51717062796706;309.7212508742131;313.5359667691816;4803.7357945313;4852.6603137780285;4855.271709243615;4873.902521949559;4889.853304400869;4519.209138400775;4664.3703100081475;4678.345031695565;4700.247960326348;4786.904261914759;3679.8344074516576;3726.6273372662654;3752.8686495972647;3770.868019619314;3831.2720583089263;3748.737588368815;3781.243751249747;3798.65812076913;3805.162864169892;3820.1595648957186;3598.623444947683;3763.379042457991;3772.849086036555;3778.1876896467256;3787.924241515168;3581.5881173665102;3673.595904450495;3765.2093060457064;3774.830132644038;3778.7543809652284;3318.933621327584;3340.897503823732;3344.7658663893535;3349.095744149066;3375.1562109472634;4588.416996136328;4590.196715574761;4616.722996620214;4621.69958952667;4628.83799067031;3955.3473676843287;4289.742615443083;4298.290782020963;4316.417283666696;4336.739795612273;4979.3526841510375;5011.148104822152;5030.899382012376;5032.47159048302;5033.295338652591;3560.608333083359;3585.121645196917;3592.4072528033103;3598.712103031751;3618.0050486116265;5078.2128770040335;5233.476652334774;5257.369115706101;5273.920891186635;5289.391719952217;3597.226596281812;3615.9819200904353;3618.9638103619154;3624.257027309395;3631.5097461842315;3669.522962014921;3673.779573225615;3674.889753307405;3679.35611268027;3700.703943684499;4228.767417792051;4235.33174100321;4240.194363071068;4244.745315281093;4247;4857.732824694675;5011.123053465629;5027.491752474243;5088.084144853888;5110.080185566634;1283.2492991599831;1291.5802364231474;1291.8320618319747;1295.9870401295866;1299.3633119771432;794.89666343375;812.5774597209418;815.4332738746633;829.274384913201;830.2403300979536;3978.3634618460906;3984.7808370539897;3995.9410756149646;4006.838016975103;4007.9599204007586;4608.470025947059;4619.521753039063;4625.1443482955765;4632;4640.303954406866;3979.3434083376496;4015.1768887378016;4021.8081145775623;4023.2556976959354;4253.064325848309;2514.8239623226564;2554.578682208824;2685.3555146765025;2730.235534050469;2755.6279902212946;4944.813244821217;4965.8013679452415;4968.22992436173;4970.204767237297;4985.252212168204;5295.947040529622;5300.6024548158275;5300.655457395257;5360.571154307646;5377.569794416438;4752.691075080178;4902.950970490249;4957.686213153517;4958.9008219835405;4975.378077740283;5161.993411284763;5172.586193104617;5218.947810521998;5229.660072095302;5231;5109.8978020438635;5111.258867464271;5112.36095488064;5122.359705036871;5143.588512919032;4836.830710925101;4975.726335051607;4984.800607975641;4991.42598601151;5004.5746111579465;3617.168051348152;3654.561452625702;3654.7076233901757;3667.908302292464;3678;5173.430922598436;5215.322008138917;5243.947560524346;5259.868503287448;5275.235090911719;4846.200376937766;5002.374703162105;5005.34930459038;5041.344625198701;5109.824740309676;4961.70229786214;4984.2025275955675;5015.648904576645;5017.67385119966;5030.4718004608985;4950.2079667253065;4964.6524743269065;4989.376327959005;4998.200287954055;5000.2499625056535;4809.591184749335;4842.370491836039;5082.491750824888;5088.898222035613;5091.66904151229;4842.539958703917;4941.950580494293;4966.205407134841;4977.178765503651;4989.25161225819 14:43:53 INFO - PROCESS | 17368 | |5;yui.html;608.9208402907622;635.936406359364;676.6481429656578;685.9588424694522;729.6424751871577;12159.57441489548;12563.937180314086;12597.622071337863;13646.38591263393;14117.78823317651;13771.104878182936;13844.238566878817;13844.723105537883;13868.237246951414;13871.653208669763;620.8447888027993;789.2620399926087;810.5744484145812;817.1950628630794;819.7008092046419;810.7608255564622;817.3992115794886;817.9979525081786;818.0469752738082;818.2063398503471;845.446232717571;851.6721062390963;851.7785375802274;852.1776485691306;852.3096292003466;652.2075678051191;829.7386323308199;846.4455781463121;846.6655671009978;853.0488505316589;610.1092405088576;611.400827189357;611.7736437518103;612.3386742318286;612.6354818882758;12640.178388404724;12652.936735316265;12661;12681.809772853414;12684.365781710878;11697.181197316191;12301.69245768854;12653.810192847115;12940.288284144368;13024.609261722164;10909;10970;11249.212555121145;11305.434728263635;11616.128790340674;4171.520275168364;4241.427407300006;4250.872473825791;4395.780210989437;4406.272964960777;43886.12227755427;43922;44280.557194427965;46747.29879051817;47232.291515627294;9621.27840411972;9972.351797133164;10107.241956853266;10145.898541014643;10641.5211315491;18547.72178417325;18932.053397330077;18947.810521894604;18965.62068758617;18994.14526346318;7073.434125269966;7111.502194846415;7163.498555101093;7176.246494118147;7183.281671832775;3652.36083685354;3699.1491956849536;3734.2531493701367;3761.9059523512133;3808.333541630259;2909.7817663674887;3000.2799328161086;3004.519276915683;3005.1435340927733;3005.3238021445;550.6145698011328;562.3111688181945;574.9626274292158;581.8283606336056;583.4020129367348;496.7541067171773;591.0572636644545;602.8101148138322;611.7950486586955;617.3641149615813;7688.654010569538;7781.572013539309;7867.763967080997;7916.795715898505;8038.557879316693;495.92065269556696;583.3029529712038;597.8774351257981;603.2941458493573;603.7072020070262;3779.527559055118;3857.691384689218;3863.517060367454;3982.6216509431556;3989.960100399017;52518;55188;55344;55662.165067524016;55668.44331556633;48081;49493.31840201599;49555.50444495581;49610.255846162334;50051.49948500541;45548;45639;46084.769576151906;46470.53529464662;46618.5338146621;7493.250674932681;7683.308502234826;7688.807779805549;7705.614719263902;7745.961270193613;30855.537166942064;31049.534256985713;31479.842600787764;31592.368152636358;32038.35923281568;37517.62482375251;40504.18991620092;41211.793941030104;41385;42246.155076898904;9648.555304515809;9831.655892043744;9837.163841073303;9887.159591434809;9963.053509916546;10239.795204096024;10281.897181028095;10310.226732994905;10437.634682786065;10459.68620941373;9224.723258302261;9377.202937750368;9619.230461562918;10710;10713.464326783474;9603.90396096058;10166.237532185263;10303.278770485995;10379.481025948522;10410.739731506774;10329.380237185793;10635.308704934154;10760.569577217137;10943;10955.068819150461;8559.443636163629;8560.871586926325;8819.823603528022;8915.974662913588;9198.310126740655;8444.746657600283;8739.737807865775;8749.825003499767;9110.271178305853;9171.266298696222 14:43:53 INFO - PROCESS | 17368 | __end_tp_report 14:43:53 INFO - PROCESS | 17368 | __start_cc_report 14:43:53 INFO - PROCESS | 17368 | _x_x_mozilla_cycle_collect,963 14:43:53 INFO - PROCESS | 17368 | __end_cc_report 14:43:53 INFO - PROCESS | 17368 | __startTimestamp1464731033206__endTimestamp 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | ------- Summary: start ------- 14:43:53 INFO - PROCESS | 17368 | Number of tests: 6 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#0] dojo.html Cycles:165 Average:4634.99 Median:4792.09 stddev:484.81 (10.1%) stddev-sans-first:460.55 14:43:53 INFO - PROCESS | 17368 | Values: 2647.6 2682.0 2709.8 2724.5 2730.2 4551.6 4625.9 4627.2 4735.1 4789.4 4647.8 4682.5 4682.9 4738.7 4751.8 4284.9 4347.2 4348.1 4393.5 4402.3 4380.7 4397.2 4444.2 4463.7 4487.3 4336.9 4384.6 4390.7 4393.7 4432.7 4221.1 4235.3 4302.6 4306.4 4332.6 4251.3 4278.2 4334.6 4348.6 4368.8 4609.5 4623.6 4640.3 4667.5 4678.7 4845.3 4956.6 5011.3 5028.0 5108.8 5094.6 5100.2 5122.7 5126.6 5141.7 4602.8 4755.5 4758.4 4775.2 4802.3 5102.2 5174.5 5190.6 5192.8 5265.9 4998.2 5030.7 5042.1 5045.8 5048.0 4907.2 4952.4 5046.1 5066.7 5105.2 4912.4 4938.5 4953.5 4972.0 4987.8 4927.0 4942.8 4949.4 4966.1 4999.8 4010.6 4041.8 4149.6 4159.8 4222.6 3616.4 3639.5 3646.5 3681.6 3725.2 4297.7 4301.5 4308.7 4309.6 4356.2 5041.4 5041.8 5043.7 5049.1 5078.6 4185.6 4207.1 4256.9 4261.5 4282.8 4403.5 4443.5 4450.2 4450.4 4487.0 4653.1 4765.5 4769.6 4775.4 4807.2 5025.7 5046.2 5054.1 5088.5 5096.0 4811.4 4821.2 4837.7 4838.1 4887.9 4778.6 4795.0 4990.6 4997.1 5065.4 4877.6 4904.2 4934.2 4937.7 4976.4 4792.1 4796.1 4799.3 4806.4 4845.4 4753.4 4794.2 4801.6 4827.0 4829.7 4813.5 4832.0 4850.5 4853.6 4865.1 4898.7 4904.1 4908.6 4939.1 4941.0 4690.5 4702.2 4798.1 4842.0 4843.2 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#1] ext.html Cycles:180 Average:40739.13 Median:36240.37 stddev:67751.00 (186.9%) stddev-sans-first:67873.88 14:43:53 INFO - PROCESS | 17368 | Values: 556.5 581.5 585.5 598.1 608.9 28972.9 39855.8 40610.0 40684.8 43345.3 40984.8 41511.8 41608.4 41617.2 41632.0 7616.7 7802.5 7807.4 7809.8 7810.6 7707.8 7817.3 7848.7 7853.3 7856.4 7460.2 7875.6 7886.6 7889.5 7891.0 7463.3 7878.4 7884.3 7904.6 7912.1 7767.4 7884.5 7888.0 7889.1 7890.6 37146.4 37571.6 37603.2 37624.0 37635.4 3023.0 3123.4 3342.1 3358.2 3812.7 29883.9 30221.2 30308.0 30392.1 30594.2 3308.3 3314.2 3329.3 3375.8 3416.1 277306.0 279215.0 279705.0 281043.0 281149.0 54246.0 54638.0 54645.0 54681.0 54759.7 32806.8 33690.0 33780.2 35446.5 57636.7 14735.1 14740.1 14759.3 14807.5 14807.6 10995.1 11167.4 11181.9 11187.3 11190.7 17936.0 17953.6 18048.9 18079.4 18117.2 6827.2 7078.3 7102.4 7108.6 7202.1 805.6 875.0 904.6 946.0 949.5 28262.3 28320.4 28707.7 28908.0 28913.6 974.3 975.3 999.4 1049.5 1082.1 14356.0 14795.6 14956.6 15224.2 15305.0 118595.0 118720.0 119421.0 119763.0 120251.0 49820.0 50461.2 50464.5 50542.7 50554.0 1195.6 1213.7 1223.5 1223.7 1249.3 26519.2 27841.0 27916.2 28231.6 28444.3 42737.4 42767.6 42942.6 42972.4 43078.6 324031.0 324402.0 325712.0 326735.0 327404.0 24930.0 25040.9 25423.5 25471.9 25643.2 42344.6 42651.4 42954.8 42984.0 43306.6 34870.0 35788.0 35839.1 36081.1 36367.5 36469.8 36651.6 36988.6 36993.0 37061.6 36113.3 36495.3 36920.6 37263.8 37276.4 30924.8 32709.8 32790.3 33135.5 33243.7 25003.9 25371.9 25429.5 25703.5 25850.2 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#2] jquery.html Cycles:180 Average:23362.48 Median:5541.82 stddev:64410.30 (1162.3%) stddev-sans-first:64567.82 14:43:53 INFO - PROCESS | 17368 | Values: 352.8 363.6 366.9 368.6 380.4 12611.2 13153.9 14465.3 15985.6 16695.6 15631.5 15678.1 16228.9 16238.7 16926.6 4605.3 4758.7 4762.1 4764.5 4769.7 3447.7 5234.5 5542.7 5557.5 5558.8 5451.8 5517.1 5518.3 5541.0 5559.6 5352.8 5453.5 5530.4 5542.6 5544.8 5139.8 5287.4 5296.8 5310.2 5311.3 12367.8 12407.1 12423.6 12505.4 12534.5 1887.7 2037.8 2072.3 2278.2 2332.9 9015.5 9543.1 9679.5 10625.6 13450.7 1573.6 1619.0 1728.7 1728.8 1855.8 65796.3 66445.3 67858.7 68984.0 70302.3 8233.0 8842.9 8916.0 8981.2 9228.1 11817.2 11821.4 11865.3 11899.8 11908.2 6738.2 6820.3 6832.2 6872.5 6908.0 6615.4 6630.4 6637.5 6698.8 6729.9 3786.4 3815.4 3819.3 3849.1 3873.7 1790.0 1803.3 1805.4 1870.9 1920.2 880.0 911.9 918.2 918.5 921.3 15885.3 16043.8 16208.7 16491.3 16781.8 829.2 863.9 876.0 886.5 898.3 8978.5 9007.0 9032.0 9281.2 9445.3 387641.0 389197.0 389409.0 390944.0 393412.0 58160.4 73110.6 77542.2 78757.0 79542.6 854.1 865.0 876.1 876.8 887.3 15192.5 15433.4 15553.0 15767.8 16007.6 34296.7 34607.1 34799.3 35109.6 35352.6 44898.8 46751.8 47030.0 52256.0 52501.7 6294.0 6618.3 6686.5 6881.1 6910.0 6496.6 7873.9 8191.8 9607.0 9973.6 8983.6 9561.5 9669.8 9782.9 9804.9 9558.0 9713.7 9723.4 9793.5 9860.2 5952.9 6183.8 9597.3 9761.9 9915.0 6750.4 6808.7 6907.2 6921.2 6964.8 7492.6 9395.0 9464.6 9474.1 9790.2 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#3] mootools.html Cycles:180 Average:5257.53 Median:5710.89 stddev:2958.92 (51.8%) stddev-sans-first:2951.68 14:43:53 INFO - PROCESS | 17368 | Values: 1222.1 1392.8 1444.0 1557.9 1797.5 6960.1 7731.7 7838.5 7884.0 8191.1 7949.8 8005.5 8068.5 8069.2 8078.8 2177.9 2200.9 2205.9 2208.9 2209.4 2130.5 2141.0 2155.2 2161.0 2165.8 2132.8 2149.4 2150.4 2158.0 2210.7 2146.8 2150.2 2151.6 2153.9 2155.3 2085.3 2155.8 2157.8 2158.2 2160.7 7904.1 7940.1 7942.6 7945.3 7950.2 4528.6 4680.9 4687.3 4705.7 4720.9 2765.9 2936.7 2986.2 2989.6 3000.7 893.0 894.1 900.9 911.5 915.5 10954.2 11024.3 11036.6 11037.4 11040.6 4098.2 4138.0 4181.2 4190.5 4203.6 8568.3 8668.6 8670.7 8677.9 8681.5 4474.1 4486.8 4491.7 4494.6 4500.8 3762.9 4057.9 4199.7 4224.1 4252.6 3356.2 3375.4 3435.4 3459.9 3477.5 1001.0 1010.7 1011.4 1012.7 1024.1 766.5 866.1 871.1 942.9 949.5 5708.3 5713.4 5754.4 5845.5 5995.0 827.1 842.8 845.9 863.4 887.7 4075.6 4197.6 4221.6 4230.1 4320.1 9640.6 10008.8 10015.5 10040.6 10056.1 9093.1 9776.8 9883.4 9889.1 9920.3 7322.1 7611.9 7679.1 7681.1 7695.0 5629.2 5852.3 5854.1 5902.0 5971.8 9224.6 9262.1 9388.4 9390.7 9428.3 9229.4 9325.8 9420.5 9562.2 9564.5 6252.2 6696.9 6856.3 7010.7 7133.6 7594.2 7600.0 7649.8 7663.6 7676.1 6543.5 6696.7 6730.4 6765.2 6849.1 6579.7 6591.7 6626.4 6718.6 6730.6 6533.2 6580.1 6653.4 6655.4 6663.5 4896.3 4923.7 4962.6 5005.1 5053.5 4908.3 4923.4 4929.3 4965.9 4986.5 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#4] prototype.html Cycles:180 Average:4142.52 Median:4652.34 stddev:1213.04 (26.1%) stddev-sans-first:1181.50 14:43:53 INFO - PROCESS | 17368 | Values: 291.2 302.2 308.5 309.7 313.5 4803.7 4852.7 4855.3 4873.9 4889.9 4519.2 4664.4 4678.3 4700.2 4786.9 3679.8 3726.6 3752.9 3770.9 3831.3 3748.7 3781.2 3798.7 3805.2 3820.2 3598.6 3763.4 3772.8 3778.2 3787.9 3581.6 3673.6 3765.2 3774.8 3778.8 3318.9 3340.9 3344.8 3349.1 3375.2 4588.4 4590.2 4616.7 4621.7 4628.8 3955.3 4289.7 4298.3 4316.4 4336.7 4979.4 5011.1 5030.9 5032.5 5033.3 3560.6 3585.1 3592.4 3598.7 3618.0 5078.2 5233.5 5257.4 5273.9 5289.4 3597.2 3616.0 3619.0 3624.3 3631.5 3669.5 3673.8 3674.9 3679.4 3700.7 4228.8 4235.3 4240.2 4244.7 4247.0 4857.7 5011.1 5027.5 5088.1 5110.1 1283.2 1291.6 1291.8 1296.0 1299.4 794.9 812.6 815.4 829.3 830.2 3978.4 3984.8 3995.9 4006.8 4008.0 4608.5 4619.5 4625.1 4632.0 4640.3 3979.3 4015.2 4021.8 4023.3 4253.1 2514.8 2554.6 2685.4 2730.2 2755.6 4944.8 4965.8 4968.2 4970.2 4985.3 5295.9 5300.6 5300.7 5360.6 5377.6 4752.7 4903.0 4957.7 4958.9 4975.4 5162.0 5172.6 5218.9 5229.7 5231.0 5109.9 5111.3 5112.4 5122.4 5143.6 4836.8 4975.7 4984.8 4991.4 5004.6 3617.2 3654.6 3654.7 3667.9 3678.0 5173.4 5215.3 5243.9 5259.9 5275.2 4846.2 5002.4 5005.3 5041.3 5109.8 4961.7 4984.2 5015.6 5017.7 5030.5 4950.2 4964.7 4989.4 4998.2 5000.2 4809.6 4842.4 5082.5 5088.9 5091.7 4842.5 4942.0 4966.2 4977.2 4989.3 14:43:53 INFO - PROCESS | 17368 | 14:43:53 INFO - PROCESS | 17368 | [#5] yui.html Cycles:180 Average:13116.90 Median:24994.62 stddev:15164.79 (60.7%) stddev-sans-first:15178.24 14:43:53 INFO - PROCESS | 17368 | Values: 608.9 635.9 676.6 686.0 729.6 12159.6 12563.9 12597.6 13646.4 14117.8 13771.1 13844.2 13844.7 13868.2 13871.7 620.8 789.3 810.6 817.2 819.7 810.8 817.4 818.0 818.0 818.2 845.4 851.7 851.8 852.2 852.3 652.2 829.7 846.4 846.7 853.0 610.1 611.4 611.8 612.3 612.6 12640.2 12652.9 12661.0 12681.8 12684.4 11697.2 12301.7 12653.8 12940.3 13024.6 10909.0 10970.0 11249.2 11305.4 11616.1 4171.5 4241.4 4250.9 4395.8 4406.3 43886.1 43922.0 44280.6 46747.3 47232.3 9621.3 9972.4 10107.2 10145.9 10641.5 18547.7 18932.1 18947.8 18965.6 18994.1 7073.4 7111.5 7163.5 7176.2 7183.3 3652.4 3699.1 3734.3 3761.9 3808.3 2909.8 3000.3 3004.5 3005.1 3005.3 550.6 562.3 575.0 581.8 583.4 496.8 591.1 602.8 611.8 617.4 7688.7 7781.6 7867.8 7916.8 8038.6 495.9 583.3 597.9 603.3 603.7 3779.5 3857.7 3863.5 3982.6 3990.0 52518.0 55188.0 55344.0 55662.2 55668.4 48081.0 49493.3 49555.5 49610.3 50051.5 45548.0 45639.0 46084.8 46470.5 46618.5 7493.3 7683.3 7688.8 7705.6 7746.0 30855.5 31049.5 31479.8 31592.4 32038.4 37517.6 40504.2 41211.8 41385.0 42246.2 9648.6 9831.7 9837.2 9887.2 9963.1 10239.8 10281.9 10310.2 10437.6 10459.7 9224.7 9377.2 9619.2 10710.0 10713.5 9603.9 10166.2 10303.3 10379.5 10410.7 10329.4 10635.3 10760.6 10943.0 10955.1 8559.4 8560.9 8819.8 8916.0 9198.3 8444.7 8739.7 8749.8 9110.3 9171.3 14:43:53 INFO - PROCESS | 17368 | -------- Summary: end -------- 14:43:53 INFO - PROCESS | 17368 | 14:43:54 INFO - TEST-INFO | 17368: exit 0 14:43:54 INFO - TEST-OK | dromaeo_css | took 1119188ms 14:43:54 INFO - TEST-START | kraken 14:43:54 INFO - operating with platform_type : linux_ 14:43:54 INFO - Initialising browser for kraken test... 14:43:54 INFO - TEST-INFO | started process 17547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL9NV9/profile http://localhost:52965/getInfo.html) 14:43:58 INFO - PROCESS | 17547 | __metrics Screen width/height:1600/1200 14:43:58 INFO - PROCESS | 17547 | colorDepth:24 14:43:58 INFO - PROCESS | 17547 | Browser inner width/height: 1024/697 14:43:58 INFO - PROCESS | 17547 | __metrics 14:43:59 ERROR - PROCESS | 17547 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:44:00 INFO - TEST-INFO | 17547: exit 0 14:44:00 INFO - Browser initialized. 14:44:00 INFO - Running cycle 1/1 for kraken test... 14:44:00 INFO - TEST-INFO | started process 17630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL9NV9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:12 INFO - PROCESS | 17630 | RSS: Main: 157638656 14:44:12 INFO - PROCESS | 17630 | 14:44:15 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:16 INFO - PROCESS | 17630 | RSS: Main: 214458368 14:44:16 INFO - PROCESS | 17630 | 14:44:18 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-dft) 14:44:19 INFO - PROCESS | 17630 | RSS: Main: 202276864 14:44:19 INFO - PROCESS | 17630 | 14:44:22 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-fft) 14:44:23 INFO - PROCESS | 17630 | RSS: Main: 269987840 14:44:23 INFO - PROCESS | 17630 | 14:44:25 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-oscillator) 14:44:26 INFO - PROCESS | 17630 | RSS: Main: 179937280 14:44:26 INFO - PROCESS | 17630 | 14:44:28 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:28 INFO - PROCESS | 17630 | RSS: Main: 183980032 14:44:28 INFO - PROCESS | 17630 | 14:44:32 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:32 INFO - PROCESS | 17630 | RSS: Main: 220340224 14:44:32 INFO - PROCESS | 17630 | 14:44:36 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:36 INFO - PROCESS | 17630 | RSS: Main: 216469504 14:44:36 INFO - PROCESS | 17630 | 14:44:39 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52965/tests/kraken/driver.html?testName=json-parse-financial) 14:44:40 INFO - PROCESS | 17630 | RSS: Main: 219262976 14:44:40 INFO - PROCESS | 17630 | 14:44:42 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:42 INFO - PROCESS | 17630 | RSS: Main: 209321984 14:44:42 INFO - PROCESS | 17630 | 14:44:44 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:45 INFO - PROCESS | 17630 | RSS: Main: 209739776 14:44:45 INFO - PROCESS | 17630 | 14:44:47 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:48 INFO - PROCESS | 17630 | RSS: Main: 217436160 14:44:48 INFO - PROCESS | 17630 | 14:44:51 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:51 INFO - PROCESS | 17630 | RSS: Main: 222339072 14:44:51 INFO - PROCESS | 17630 | 14:44:54 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:55 INFO - PROCESS | 17630 | RSS: Main: 220471296 14:44:55 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52965/tests/kraken/driver.html?testName=ai-astar) 14:44:57 INFO - PROCESS | 17630 | RSS: Main: 263180288 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | __start_tp_report 14:44:57 INFO - PROCESS | 17630 | _x_x_mozilla_page_load 14:44:57 INFO - PROCESS | 17630 | _x_x_mozilla_page_load_details 14:44:57 INFO - PROCESS | 17630 | |i|pagename|runs| 14:44:57 INFO - PROCESS | 17630 | |0;ai-astar;114;109;115;114;113;112;113;113;115;112 14:44:57 INFO - PROCESS | 17630 | |1;audio-beat-detection;158;130;132;190;131;131;159;134;202;129 14:44:57 INFO - PROCESS | 17630 | |2;audio-dft;164;162;162;161;162;161;163;163;164;162 14:44:57 INFO - PROCESS | 17630 | |3;audio-fft;77;76;76;110;75;76;76;76;99;75 14:44:57 INFO - PROCESS | 17630 | |4;audio-oscillator;85;84;111;85;85;85;117;85;84;125 14:44:57 INFO - PROCESS | 17630 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;117;117 14:44:57 INFO - PROCESS | 17630 | |6;imaging-darkroom;147;145;146;146;146;145;146;145;146;145 14:44:57 INFO - PROCESS | 17630 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 14:44:57 INFO - PROCESS | 17630 | |8;json-parse-financial;66;64;64;65;65;66;65;65;64;65 14:44:57 INFO - PROCESS | 17630 | |9;json-stringify-tinderbox;65;65;65;76;66;64;66;65;65;65 14:44:57 INFO - PROCESS | 17630 | |10;stanford-crypto-aes;83;83;83;83;84;85;84;85;119;90 14:44:57 INFO - PROCESS | 17630 | |11;stanford-crypto-ccm;142;149;142;142;133;134;138;139;137;142 14:44:57 INFO - PROCESS | 17630 | |12;stanford-crypto-pbkdf2;179;171;174;175;171;169;169;172;172;166 14:44:57 INFO - PROCESS | 17630 | |13;stanford-crypto-sha256-iterative;65;66;68;67;67;71;67;66;65;66 14:44:57 INFO - PROCESS | 17630 | __end_tp_report 14:44:57 INFO - PROCESS | 17630 | __start_cc_report 14:44:57 INFO - PROCESS | 17630 | _x_x_mozilla_cycle_collect,1880 14:44:57 INFO - PROCESS | 17630 | __end_cc_report 14:44:57 INFO - PROCESS | 17630 | __startTimestamp1464731097322__endTimestamp 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | ------- Summary: start ------- 14:44:57 INFO - PROCESS | 17630 | Number of tests: 14 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.76 (1.6%) stddev-sans-first:1.83 14:44:57 INFO - PROCESS | 17630 | Values: 114.0 109.0 115.0 114.0 113.0 112.0 113.0 113.0 115.0 112.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:146.00 stddev:27.06 (18.5%) stddev-sans-first:28.53 14:44:57 INFO - PROCESS | 17630 | Values: 158.0 130.0 132.0 190.0 131.0 131.0 159.0 134.0 202.0 129.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 14:44:57 INFO - PROCESS | 17630 | Values: 164.0 162.0 162.0 161.0 162.0 161.0 163.0 163.0 164.0 162.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.36 (16.3%) stddev-sans-first:12.99 14:44:57 INFO - PROCESS | 17630 | Values: 77.0 76.0 76.0 110.0 75.0 76.0 76.0 76.0 99.0 75.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:85.00 stddev:16.26 (19.1%) stddev-sans-first:16.87 14:44:57 INFO - PROCESS | 17630 | Values: 85.0 84.0 111.0 85.0 85.0 85.0 117.0 85.0 84.0 125.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:44:57 INFO - PROCESS | 17630 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 14:44:57 INFO - PROCESS | 17630 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:44:57 INFO - PROCESS | 17630 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 14:44:57 INFO - PROCESS | 17630 | Values: 66.0 64.0 64.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:65.00 stddev:3.49 (5.4%) stddev-sans-first:3.67 14:44:57 INFO - PROCESS | 17630 | Values: 65.0 65.0 65.0 76.0 66.0 64.0 66.0 65.0 65.0 65.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.00 stddev:11.13 (13.3%) stddev-sans-first:11.66 14:44:57 INFO - PROCESS | 17630 | Values: 83.0 83.0 83.0 83.0 84.0 85.0 84.0 85.0 119.0 90.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:142.00 stddev:4.66 (3.3%) stddev-sans-first:4.88 14:44:57 INFO - PROCESS | 17630 | Values: 142.0 149.0 142.0 142.0 133.0 134.0 138.0 139.0 137.0 142.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:3.61 (2.1%) stddev-sans-first:2.74 14:44:57 INFO - PROCESS | 17630 | Values: 179.0 171.0 174.0 175.0 171.0 169.0 169.0 172.0 172.0 166.0 14:44:57 INFO - PROCESS | 17630 | 14:44:57 INFO - PROCESS | 17630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.75 (2.6%) stddev-sans-first:1.73 14:44:57 INFO - PROCESS | 17630 | Values: 65.0 66.0 68.0 67.0 67.0 71.0 67.0 66.0 65.0 66.0 14:44:57 INFO - PROCESS | 17630 | -------- Summary: end -------- 14:44:57 INFO - PROCESS | 17630 | 14:44:58 INFO - TEST-INFO | 17630: exit 0 14:44:58 INFO - TEST-OK | kraken | took 64400ms 14:44:58 INFO - SUITE-END | took 1183s 14:44:58 INFO - Completed test suite (00:19:43) 14:44:58 INFO - javascript benchmark 14:44:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.6028595710645, 2682.0076571668487, 2709.756121949025, 2724.523208438523, 2730.153652367766, 4551.567601077901, 4625.861224163272, 4627.167109920213, 4735.147673418779, 4789.401324834395, 4647.837325693601, 4682.484926658065, 4682.929756053653, 4738.739369334694, 4751.833685820997, 4284.850030248942, 4347.19576878277, 4348.086901750637, 4393.538678438757, 4402.339649052636, 4380.737155770664, 4397.186520493703, 4444.20004399208, 4463.73217606943, 4487.326900964848, 4336.934945975781, 4384.561543845622, 4390.714603550759, 4393.692441529094, 4432.711873728197, 4221.050263690676, 4235.343521754133, 4302.569743025703, 4306.375575541529, 4332.631726303268, 4251.277282861921, 4278.187144442546, 4334.609885110355, 4348.565143485658, 4368.803403846835, 4609.492955774862, 4623.56076172763, 4640.303954406832, 4667.4632417272105, 4678.7426691531955, 4845.297431872394, 4956.553910148104, 5011.32347133136, 5028.044671512437, 5108.795648174068, 5094.566961808251, 5100.209467532539, 5122.692638441706, 5126.641135120543, 5141.691498510101, 4602.792874320664, 4755.524447555217, 4758.405199350082, 4775.188218002948, 4802.303665968415, 5102.158143906214, 5174.53429191367, 5190.6107041972, 5192.766325515361, 5265.868353291198, 4998.175301075282, 5030.673006254582, 5042.117629414838, 5045.84862454127, 5047.97476012625, 4907.190313598217, 4952.4057113146655, 5046.142155833517, 5066.695998240118, 5105.2086926526445, 4912.38595175603, 4938.530839570235, 4953.455119936804, 4971.950280497149, 4987.775550100254, 4927.0, 4942.752862356868, 4949.406071271471, 4966.081274964144, 4999.825006124768, 4010.578889216649, 4041.797910104483, 4149.564295748964, 4159.750414975111, 4222.619964203236, 3616.367135751286, 3639.47227651989, 3646.5259516263245, 3681.5582130144553, 3725.1990821973404, 4297.742135471882, 4301.483821941387, 4308.6983911126545, 4309.612134907873, 4356.237658409766, 5041.445441001487, 5041.82353617629, 5043.672161309503, 5049.116404629175, 5078.619103567247, 4185.602367775056, 4207.053412982054, 4256.914861702749, 4261.488621365394, 4282.828686852553, 4403.471583409947, 4443.533428989909, 4450.1989641864775, 4450.443694538183, 4487.0, 4653.092646933816, 4765.451973023147, 4769.594584460359, 4775.4269487661, 4807.158747219222, 5025.698458092526, 5046.243063540498, 5054.140796064751, 5088.542031217208, 5095.974520127375, 4811.446683631427, 4821.2045012573935, 4837.733924634179, 4838.104950584153, 4887.926681099715, 4778.641601879804, 4795.017021510512, 4990.625703072212, 4997.100521906092, 5065.366829146356, 4877.585405240594, 4904.239842824368, 4934.235193545006, 4937.679050861682, 4976.353074100344, 4792.0895029944195, 4796.05112874554, 4799.256115302133, 4806.399200099988, 4845.370101886732, 4753.429588449409, 4794.161021821237, 4801.567858892717, 4827.010462855176, 4829.73436460984, 4813.542713442217, 4832.0, 4850.53919877611, 4853.587445067067, 4865.0756356292195, 4898.681585696918, 4904.068227036852, 4908.6073114151495, 4939.135651260943, 4940.950590494049, 4690.484046754923, 4702.247640377524, 4798.1123492154065, 4841.95158048415, 4843.24929635907], "value": 4604.750783937293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5186114011378, 581.4911952041963, 585.519873703563, 598.0759726222985, 608.8873558391698, 28972.85513572432, 39855.80072099639, 40610.0, 40684.79657601715, 43345.34981975273, 40984.79507602458, 41511.79244103775, 41608.37587436183, 41617.16765664685, 41632.0, 7616.7334143305, 7802.531848089105, 7807.4144439167, 7809.765707028798, 7810.648520816549, 7707.845843083135, 7817.257360550767, 7848.68605255789, 7853.293203611674, 7856.371490280764, 7460.216677248892, 7875.645595948196, 7886.6056697165195, 7889.4871833330935, 7891.0, 7463.3283004529585, 7878.4485086044, 7884.329831964233, 7904.565248911307, 7912.129665736765, 7767.37860971121, 7884.487508311941, 7888.0, 7889.053313602404, 7890.64492097857, 37146.4428033577, 37571.62428375708, 37603.24793504142, 37624.0, 37635.43546846799, 3022.9546556801447, 3123.437781199383, 3342.097633638904, 3358.194033431959, 3812.656860882506, 29883.850580747174, 30221.244468888453, 30308.0, 30392.088237352913, 30594.235144121354, 3308.338332333543, 3314.171457135716, 3329.30084682217, 3375.780574262665, 3416.0605833395766, 277306.0, 279215.0, 279705.0, 281043.0, 281149.0, 54246.0, 54638.0, 54645.0, 54681.0, 54759.726201368736, 32806.83596582002, 33690.0, 33780.155496112304, 35446.468302975474, 57636.71181644065, 14735.115893046452, 14740.115593064236, 14759.335829887681, 14807.481738139113, 14807.555773326818, 10995.120390368751, 11167.385793781257, 11181.888181118085, 11187.32876027441, 11190.720231994264, 17936.0, 17953.551161221076, 18048.9097554514, 18079.36722214716, 18117.18472668733, 6827.214870289881, 7078.292170782984, 7102.3962963148715, 7108.644567771694, 7202.135743710788, 805.6092794994423, 874.9825003499894, 904.615538396179, 946.0397696338222, 949.4777872170417, 28262.293442664097, 28320.43359132806, 28707.71292287092, 28908.0, 28913.56629650557, 974.3033730882312, 975.3367709957297, 999.3803841618098, 1049.4647729657777, 1082.1342925659442, 14356.0, 14795.63010924714, 14956.551303460914, 15224.238788060553, 15305.0, 118595.0, 118720.0, 119421.0, 119763.0, 120251.0, 49820.0, 50461.24308135381, 50464.49535504671, 50542.74728626407, 50554.0, 1195.611426286443, 1213.7087099096154, 1223.4922507159429, 1223.6512593910693, 1249.256692268099, 26519.204423867315, 27841.0, 27916.16251512458, 28231.57652635253, 28444.288892777848, 42737.358939616555, 42767.5723242776, 42942.57057429386, 42972.35541466943, 43078.569214307456, 324031.0, 324402.0, 325712.0, 326735.0, 327404.0, 24930.0, 25040.874795626634, 25423.491530169664, 25471.872640636677, 25643.230703078938, 42344.5765542353, 42651.36022959596, 42954.78522607367, 42984.0, 43306.56693433025, 34870.0, 35788.0, 35839.104022398606, 36081.097972550895, 36367.45448818217, 36469.81765091157, 36651.633483664824, 36988.63011369852, 36993.0, 37061.62938370582, 36113.27773444569, 36495.27009459849, 36920.63079369279, 37263.813680931424, 37276.44085338668, 30924.845375772977, 32709.836450817595, 32790.34419311648, 33135.50296745599, 33243.66756332406, 25003.87498062498, 25371.87314063418, 25429.491410172064, 25703.485930281662, 25850.224493265232], "value": 17025.277154536423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.83240460781116, 363.5782492308922, 366.89176692875617, 368.6442582907494, 380.40656575741843, 12611.243325400483, 13153.934230328847, 14465.34905929233, 15985.600359991005, 16695.582610434714, 15631.452899148531, 15678.137702426362, 16228.918855405736, 16238.675226495492, 16926.576835579115, 4605.286180641998, 4758.738269395182, 4762.071396077767, 4764.499727528611, 4769.666123371366, 3447.6897079262862, 5234.450382709818, 5542.695151766651, 5557.472040156179, 5558.833235002957, 5451.836444906639, 5517.144842549411, 5518.310211223597, 5541.030319694058, 5559.58303127265, 5352.759125839347, 5453.454654534555, 5530.391656917735, 5542.612017158801, 5544.750486228129, 5139.768710408003, 5287.4448182941005, 5296.788128474856, 5310.230016647603, 5311.336082989626, 12367.75264494714, 12407.069469789802, 12423.565175218915, 12505.374731263491, 12534.498620055278, 1887.7074053521726, 2037.765656949455, 2072.336852207294, 2278.1912421090606, 2332.918347857834, 9015.459072455607, 9543.141117299476, 9679.467629280387, 10625.574977000912, 13450.730985380238, 1573.559403367059, 1618.9595260118474, 1728.6715524050517, 1728.809830918598, 1855.8329750322537, 65796.3420365795, 66445.3355466444, 67858.66070669664, 68984.0, 70302.29697703008, 8233.006991609065, 8842.867356989651, 8915.955420222857, 8981.191692747683, 9228.077192280718, 11817.172797904064, 11821.408929553489, 11865.288082715064, 11899.762004759856, 11908.225965312227, 6738.191417029988, 6820.283870193657, 6832.180138383425, 6872.518923675295, 6908.0, 6615.4046135848, 6630.403263706289, 6637.46900247979, 6698.765543206062, 6729.932700672931, 3786.3563194257044, 3815.3513902636064, 3819.255245227154, 3849.095462566295, 3873.7288389812443, 1789.9552511187323, 1803.2516505650271, 1805.4493379519372, 1870.8690391672724, 1920.174325040246, 879.9560021998874, 911.8632205169145, 918.1874041473211, 918.5315489100607, 921.2675922641516, 15885.285162167731, 16043.759343609856, 16208.675826483404, 16491.34034638625, 16781.83218167827, 829.1708291708292, 863.9222469977732, 875.9781005474914, 886.5124181700039, 898.3397203055749, 8978.461292322481, 9006.954965225132, 9032.006479287273, 9281.164695177466, 9445.338826282232, 387641.0, 389197.0, 389409.0, 390944.0, 393412.0, 58160.41839581635, 73110.63444682742, 77542.22457775463, 78757.0, 79542.6022869882, 854.1458541458542, 865.0441262404952, 876.0626130040922, 876.8202518483823, 887.2591386192602, 15192.46826361072, 15433.382664693287, 15553.0, 15767.763483547986, 16007.599810004844, 34296.65703342934, 34607.13482162966, 34799.30401391907, 35109.64890351166, 35352.64647353494, 44898.77550612226, 46751.766241168574, 47030.0, 52256.0, 52501.7374913123, 6293.96853015732, 6618.305077966937, 6686.531942764154, 6881.10545629065, 6910.0, 6496.642684652201, 7873.921260787319, 8191.754247372588, 9607.0, 9973.603695482783, 8983.595738191927, 9561.521923903916, 9669.806603868024, 9782.85325720129, 9804.880483058208, 9558.0, 9713.70858874235, 9723.416595004323, 9793.510324483605, 9860.16188623975, 5952.940470595238, 6183.783567575113, 9597.28020398459, 9761.902380976384, 9914.950425247827, 6750.426213771688, 6808.659567021728, 6907.20567134786, 6921.204061532988, 6964.825879353057, 7492.550446973199, 9395.0, 9464.574094165917, 9474.147326740627, 9790.167835734042], "value": 7682.127760795125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.1261797814561, 1392.7980442835792, 1443.978340324895, 1557.9143147126904, 1797.4607617714692, 6960.095187625608, 7731.6907323707055, 7838.490498117625, 7883.960580197091, 8191.098979112293, 7949.76150715478, 8005.479643823148, 8068.515889046661, 8069.1527389624125, 8078.798030049252, 2177.8911054447253, 2200.933971980843, 2205.867647941129, 2208.8785116818567, 2209.359285807114, 2130.499332656832, 2141.0365335598963, 2155.202575047235, 2160.9891950540227, 2165.8050775430206, 2132.818710409617, 2149.376680762577, 2150.4301360139575, 2158.0, 2210.6573481110454, 2146.8175205107586, 2150.193677370986, 2151.6234658934623, 2153.935381938544, 2155.2564365293947, 2085.270155445582, 2155.805977462036, 2157.834769224617, 2158.1691048946113, 2160.6975023496725, 7904.130545639975, 7940.086890007666, 7942.6028698565415, 7945.324647404977, 7950.244726751007, 4528.569785870337, 4680.859574212779, 4687.343771871941, 4705.694129881546, 4720.866991921914, 2765.8798186734407, 2936.7356937875693, 2986.1937276935105, 2989.566512855624, 3000.729934305901, 893.0489029183898, 894.1058941058941, 900.855912990505, 911.4804561400005, 915.5102020419043, 10954.178436617205, 11024.338539687644, 11036.558537658484, 11037.448127593589, 11040.613578524793, 4098.221337945781, 4138.048248902709, 4181.163767246563, 4190.497140343117, 4203.558626344251, 8568.314534837198, 8668.566571671392, 8670.653173872974, 8677.913220867837, 8681.479111253346, 4474.105178964221, 4486.7756612169915, 4491.685582009228, 4494.595486406239, 4500.819967201275, 3762.9435558466644, 4057.857974970921, 4199.727017743898, 4224.070704445017, 4252.638525725286, 3356.2280675444786, 3375.4261775498226, 3435.381631306339, 3459.930801383958, 3477.5305333779615, 1000.9699709008742, 1010.7473131717071, 1011.4120830296364, 1012.6911292055994, 1024.109025148111, 766.5400759544228, 866.1208872993916, 871.13322244366, 942.9481378524247, 949.5015117063597, 5708.343540492813, 5713.428657134254, 5754.367019627837, 5845.503132233723, 5995.040793473024, 827.0654160798259, 842.8230071684892, 845.9323254139654, 863.4387648028832, 887.7159309021051, 4075.612816782401, 4197.635768375229, 4221.641160501392, 4230.090530535949, 4320.1143765527995, 9640.566174522164, 10008.849867251996, 10015.499225038719, 10040.64857729976, 10056.145227655585, 9093.090690930987, 9776.804463910681, 9883.406995580288, 9889.109980101824, 9920.305578609572, 7322.121345438582, 7611.858221266854, 7679.116901556393, 7681.078270607562, 7695.038120234971, 5629.240052592848, 5852.268466441695, 5854.121881717776, 5902.0, 5971.7611295547695, 9224.631014759334, 9262.120098590623, 9388.389754666197, 9390.718278451657, 9428.340016199074, 9229.446233226028, 9325.766855828659, 9420.481873496748, 9562.18721408688, 9564.473953932322, 6252.187215661935, 6696.899546506709, 6856.348646878539, 7010.719571217094, 7133.5719856808755, 7594.202608726005, 7599.962000190185, 7649.847003059796, 7663.578503182155, 7676.078870535572, 6543.509236807354, 6696.665166741741, 6730.394264516021, 6765.188177418544, 6849.1438570178725, 6579.736810527525, 6591.703373348307, 6626.4367528760595, 6718.596884186964, 6730.562513436611, 6533.248676402274, 6580.078788969452, 6653.401193892573, 6655.434288085567, 6663.533552651268, 4896.314515967696, 4923.679960802537, 4962.627802914723, 5005.099082165245, 5053.519915608012, 4908.337374454403, 4923.433805112458, 4929.260610908393, 4965.875853103701, 4986.47641997585], "value": 4203.219917788864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.23260209348376, 302.23232988209946, 308.51717062796706, 309.7212508742131, 313.5359667691816, 4803.7357945313, 4852.6603137780285, 4855.271709243615, 4873.902521949559, 4889.853304400869, 4519.209138400775, 4664.3703100081475, 4678.345031695565, 4700.247960326348, 4786.904261914759, 3679.8344074516576, 3726.6273372662654, 3752.8686495972647, 3770.868019619314, 3831.2720583089263, 3748.737588368815, 3781.243751249747, 3798.65812076913, 3805.162864169892, 3820.1595648957186, 3598.623444947683, 3763.379042457991, 3772.849086036555, 3778.1876896467256, 3787.924241515168, 3581.5881173665102, 3673.595904450495, 3765.2093060457064, 3774.830132644038, 3778.7543809652284, 3318.933621327584, 3340.897503823732, 3344.7658663893535, 3349.095744149066, 3375.1562109472634, 4588.416996136328, 4590.196715574761, 4616.722996620214, 4621.69958952667, 4628.83799067031, 3955.3473676843287, 4289.742615443083, 4298.290782020963, 4316.417283666696, 4336.739795612273, 4979.3526841510375, 5011.148104822152, 5030.899382012376, 5032.47159048302, 5033.295338652591, 3560.608333083359, 3585.121645196917, 3592.4072528033103, 3598.712103031751, 3618.0050486116265, 5078.2128770040335, 5233.476652334774, 5257.369115706101, 5273.920891186635, 5289.391719952217, 3597.226596281812, 3615.9819200904353, 3618.9638103619154, 3624.257027309395, 3631.5097461842315, 3669.522962014921, 3673.779573225615, 3674.889753307405, 3679.35611268027, 3700.703943684499, 4228.767417792051, 4235.33174100321, 4240.194363071068, 4244.745315281093, 4247.0, 4857.732824694675, 5011.123053465629, 5027.491752474243, 5088.084144853888, 5110.080185566634, 1283.2492991599831, 1291.5802364231474, 1291.8320618319747, 1295.9870401295866, 1299.3633119771432, 794.89666343375, 812.5774597209418, 815.4332738746633, 829.274384913201, 830.2403300979536, 3978.3634618460906, 3984.7808370539897, 3995.9410756149646, 4006.838016975103, 4007.9599204007586, 4608.470025947059, 4619.521753039063, 4625.1443482955765, 4632.0, 4640.303954406866, 3979.3434083376496, 4015.1768887378016, 4021.8081145775623, 4023.2556976959354, 4253.064325848309, 2514.8239623226564, 2554.578682208824, 2685.3555146765025, 2730.235534050469, 2755.6279902212946, 4944.813244821217, 4965.8013679452415, 4968.22992436173, 4970.204767237297, 4985.252212168204, 5295.947040529622, 5300.6024548158275, 5300.655457395257, 5360.571154307646, 5377.569794416438, 4752.691075080178, 4902.950970490249, 4957.686213153517, 4958.9008219835405, 4975.378077740283, 5161.993411284763, 5172.586193104617, 5218.947810521998, 5229.660072095302, 5231.0, 5109.8978020438635, 5111.258867464271, 5112.36095488064, 5122.359705036871, 5143.588512919032, 4836.830710925101, 4975.726335051607, 4984.800607975641, 4991.42598601151, 5004.5746111579465, 3617.168051348152, 3654.561452625702, 3654.7076233901757, 3667.908302292464, 3678.0, 5173.430922598436, 5215.322008138917, 5243.947560524346, 5259.868503287448, 5275.235090911719, 4846.200376937766, 5002.374703162105, 5005.34930459038, 5041.344625198701, 5109.824740309676, 4961.70229786214, 4984.2025275955675, 5015.648904576645, 5017.67385119966, 5030.4718004608985, 4950.2079667253065, 4964.6524743269065, 4989.376327959005, 4998.200287954055, 5000.2499625056535, 4809.591184749335, 4842.370491836039, 5082.491750824888, 5088.898222035613, 5091.66904151229, 4842.539958703917, 4941.950580494293, 4966.205407134841, 4977.178765503651, 4989.25161225819], "value": 3759.084554910052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9208402907622, 635.936406359364, 676.6481429656578, 685.9588424694522, 729.6424751871577, 12159.57441489548, 12563.937180314086, 12597.622071337863, 13646.38591263393, 14117.78823317651, 13771.104878182936, 13844.238566878817, 13844.723105537883, 13868.237246951414, 13871.653208669763, 620.8447888027993, 789.2620399926087, 810.5744484145812, 817.1950628630794, 819.7008092046419, 810.7608255564622, 817.3992115794886, 817.9979525081786, 818.0469752738082, 818.2063398503471, 845.446232717571, 851.6721062390963, 851.7785375802274, 852.1776485691306, 852.3096292003466, 652.2075678051191, 829.7386323308199, 846.4455781463121, 846.6655671009978, 853.0488505316589, 610.1092405088576, 611.400827189357, 611.7736437518103, 612.3386742318286, 612.6354818882758, 12640.178388404724, 12652.936735316265, 12661.0, 12681.809772853414, 12684.365781710878, 11697.181197316191, 12301.69245768854, 12653.810192847115, 12940.288284144368, 13024.609261722164, 10909.0, 10970.0, 11249.212555121145, 11305.434728263635, 11616.128790340674, 4171.520275168364, 4241.427407300006, 4250.872473825791, 4395.780210989437, 4406.272964960777, 43886.12227755427, 43922.0, 44280.557194427965, 46747.29879051817, 47232.291515627294, 9621.27840411972, 9972.351797133164, 10107.241956853266, 10145.898541014643, 10641.5211315491, 18547.72178417325, 18932.053397330077, 18947.810521894604, 18965.62068758617, 18994.14526346318, 7073.434125269966, 7111.502194846415, 7163.498555101093, 7176.246494118147, 7183.281671832775, 3652.36083685354, 3699.1491956849536, 3734.2531493701367, 3761.9059523512133, 3808.333541630259, 2909.7817663674887, 3000.2799328161086, 3004.519276915683, 3005.1435340927733, 3005.3238021445, 550.6145698011328, 562.3111688181945, 574.9626274292158, 581.8283606336056, 583.4020129367348, 496.7541067171773, 591.0572636644545, 602.8101148138322, 611.7950486586955, 617.3641149615813, 7688.654010569538, 7781.572013539309, 7867.763967080997, 7916.795715898505, 8038.557879316693, 495.92065269556696, 583.3029529712038, 597.8774351257981, 603.2941458493573, 603.7072020070262, 3779.527559055118, 3857.691384689218, 3863.517060367454, 3982.6216509431556, 3989.960100399017, 52518.0, 55188.0, 55344.0, 55662.165067524016, 55668.44331556633, 48081.0, 49493.31840201599, 49555.50444495581, 49610.255846162334, 50051.49948500541, 45548.0, 45639.0, 46084.769576151906, 46470.53529464662, 46618.5338146621, 7493.250674932681, 7683.308502234826, 7688.807779805549, 7705.614719263902, 7745.961270193613, 30855.537166942064, 31049.534256985713, 31479.842600787764, 31592.368152636358, 32038.35923281568, 37517.62482375251, 40504.18991620092, 41211.793941030104, 41385.0, 42246.155076898904, 9648.555304515809, 9831.655892043744, 9837.163841073303, 9887.159591434809, 9963.053509916546, 10239.795204096024, 10281.897181028095, 10310.226732994905, 10437.634682786065, 10459.68620941373, 9224.723258302261, 9377.202937750368, 9619.230461562918, 10710.0, 10713.464326783474, 9603.90396096058, 10166.237532185263, 10303.278770485995, 10379.481025948522, 10410.739731506774, 10329.380237185793, 10635.308704934154, 10760.569577217137, 10943.0, 10955.068819150461, 8559.443636163629, 8560.871586926325, 8819.823603528022, 8915.974662913588, 9198.310126740655, 8444.746657600283, 8739.737807865775, 8749.825003499767, 9110.271178305853, 9171.266298696222], "value": 6000.245120499045, "unit": "score"}], "name": "dromaeo_css", "value": 6205.504840882256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 114.0, 113.0, 112.0, 113.0, 113.0, 115.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 132.0, 190.0, 131.0, 131.0, 159.0, 134.0, 202.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 163.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 110.0, 75.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 111.0, 85.0, 85.0, 85.0, 117.0, 85.0, 84.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 76.0, 66.0, 64.0, 66.0, 65.0, 65.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 85.0, 84.0, 85.0, 119.0, 90.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 149.0, 142.0, 142.0, 133.0, 134.0, 138.0, 139.0, 137.0, 142.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 171.0, 174.0, 175.0, 171.0, 169.0, 169.0, 172.0, 172.0, 166.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 67.0, 67.0, 71.0, 67.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1556.1, "alertThreshold": 2.0}]} 14:44:58 INFO - Return code: 0 14:44:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:44:58 ERROR - # TBPL SUCCESS # 14:44:58 INFO - Running post-action listener: _resource_record_post_action 14:44:58 INFO - ##### 14:44:58 INFO - ##### Finished run-tests step (success) 14:44:58 INFO - ##### 14:44:58 INFO - Running post-run listener: _resource_record_post_run 14:44:58 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 532770816; Read time: 0; Write time: 590360 14:44:58 INFO - TinderboxPrint: CPU usage
13.1% 14:44:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:44:58 INFO - TinderboxPrint: I/O write bytes / time
532,770,816 / 590,360 14:44:58 INFO - TinderboxPrint: CPU idle
8,325.1 (86.8%) 14:44:58 INFO - TinderboxPrint: CPU user
1,215.5 (12.7%) 14:44:58 INFO - TinderboxPrint: Swap in / out
0 / 0 14:44:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237101056; Read time: 0; Write time: 333668 14:44:58 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 293335040; Read time: 0; Write time: 256580 14:44:59 INFO - Running post-run listener: _upload_blobber_files 14:44:59 INFO - Blob upload gear active. 14:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:44:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:04 INFO - (blobuploader) - INFO - Done attempting. 14:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:05 INFO - (blobuploader) - INFO - Done attempting. 14:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:06 INFO - (blobuploader) - INFO - Done attempting. 14:45:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:06 INFO - Return code: 0 14:45:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03ae1636bfdf948501b18bf39338100326b05d2bc241728bd508e0afaa42549cf7a4685f70a23144dadca92db30f7200b285220e6f1353cf846f52ff4afec7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ae412149cf3f8b98bdf92b4c22f9833598753885ad388597eace87fd38a2b53d79f2b612b1f6c7d2100a87129374fd84c020deccaba3aca580ffd7818caa0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfb9a0f58e05086047d6cba00f5f29ee31db1c7799bfcfd1b1dae69a30a0f834f9566f3928ba3af511ebf009b51d6c24bfd16c99baf42e674f85c544d718cee9"} 14:45:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:06 INFO - Contents: 14:45:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03ae1636bfdf948501b18bf39338100326b05d2bc241728bd508e0afaa42549cf7a4685f70a23144dadca92db30f7200b285220e6f1353cf846f52ff4afec7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ae412149cf3f8b98bdf92b4c22f9833598753885ad388597eace87fd38a2b53d79f2b612b1f6c7d2100a87129374fd84c020deccaba3aca580ffd7818caa0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfb9a0f58e05086047d6cba00f5f29ee31db1c7799bfcfd1b1dae69a30a0f834f9566f3928ba3af511ebf009b51d6c24bfd16c99baf42e674f85c544d718cee9"} 14:45:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:06 INFO - Copying logs to upload dir... 14:45:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.111347 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-31 14:45:05.436551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 14:45:05.440194) ========= 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=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 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-Non-PGO/sha512/03ae1636bfdf948501b18bf39338100326b05d2bc241728bd508e0afaa42549cf7a4685f70a23144dadca92db30f7200b285220e6f1353cf846f52ff4afec7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ae412149cf3f8b98bdf92b4c22f9833598753885ad388597eace87fd38a2b53d79f2b612b1f6c7d2100a87129374fd84c020deccaba3aca580ffd7818caa0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfb9a0f58e05086047d6cba00f5f29ee31db1c7799bfcfd1b1dae69a30a0f834f9566f3928ba3af511ebf009b51d6c24bfd16c99baf42e674f85c544d718cee9"} build_url:https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/GnLsBgxZQryNJXi9iRg2cQ/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-Non-PGO/sha512/03ae1636bfdf948501b18bf39338100326b05d2bc241728bd508e0afaa42549cf7a4685f70a23144dadca92db30f7200b285220e6f1353cf846f52ff4afec7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ae412149cf3f8b98bdf92b4c22f9833598753885ad388597eace87fd38a2b53d79f2b612b1f6c7d2100a87129374fd84c020deccaba3aca580ffd7818caa0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfb9a0f58e05086047d6cba00f5f29ee31db1c7799bfcfd1b1dae69a30a0f834f9566f3928ba3af511ebf009b51d6c24bfd16c99baf42e674f85c544d718cee9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 14:45:05.466515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:45:05.466894) ========= 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=fa44defc139c4ba8574fe040000001db-1464729860.636670-1244597305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 14:45:05.550210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 14:45:05.550570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 14:45:05.550963) ========= ========= Total master_lag: 0.18 =========