builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1463172114.34 results: success (0) buildid: 20160513083005 builduid: 3a1d029a01394de4af1822c362c79d96 revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.340023) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.340562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.340902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.370559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.370907) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 13:41:54-- 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% 67.1M=0s 2016-05-13 13:41:54 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.505441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.505813) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.555669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:54.556064) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c7942b0606ada54b06f6c241e1431e9c677a443f --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 c7942b0606ada54b06f6c241e1431e9c677a443f --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=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 13:41:54,777 truncating revision to first 12 chars 2016-05-13 13:41:54,777 Setting DEBUG logging. 2016-05-13 13:41:54,777 attempt 1/10 2016-05-13 13:41:54,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c7942b0606ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 13:41:55,029 unpacking tar archive at: fx-team-c7942b0606ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:55.108255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:55.108907) ========= script_repo_revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:55.109871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:55.110510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:41:55.122411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-13 13:41:55.122731) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:41:55 INFO - MultiFileLogger online at 20160513 13:41:55 in /builds/slave/test 13:41:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:41:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:41:55 INFO - {'append_to_log': False, 13:41:55 INFO - 'base_work_dir': '/builds/slave/test', 13:41:55 INFO - 'blob_upload_branch': 'Fx-Team', 13:41:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:41:55 INFO - 'branch': 'Fx-Team', 13:41:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:41:55 INFO - 'config_files': ('talos/linux_config.py',), 13:41:55 INFO - 'default_actions': ('clobber', 13:41:55 INFO - 'read-buildbot-config', 13:41:55 INFO - 'download-and-extract', 13:41:55 INFO - 'populate-webroot', 13:41:55 INFO - 'create-virtualenv', 13:41:55 INFO - 'install', 13:41:55 INFO - 'run-tests'), 13:41:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:41:55 INFO - 'download_minidump_stackwalk': True, 13:41:55 INFO - 'download_symbols': 'ondemand', 13:41:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:41:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:41:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:41:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:41:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:41:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:41:55 INFO - 'installer_path': 'installer.exe', 13:41:55 INFO - 'log_level': 'info', 13:41:55 INFO - 'log_name': 'talos', 13:41:55 INFO - 'log_to_console': True, 13:41:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:41:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:41:55 INFO - 'opt_config_files': (), 13:41:55 INFO - 'pip_index': False, 13:41:55 INFO - 'sps_profile': False, 13:41:55 INFO - 'sps_profile_interval': 0, 13:41:55 INFO - 'suite': 'dromaeojs', 13:41:55 INFO - 'system_bits': '32', 13:41:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:41:55 INFO - 'title': 'talos-linux64-ix-022', 13:41:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:41:55 INFO - 'use_talos_json': True, 13:41:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:41:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:41:55 INFO - 'work_dir': 'build'} 13:41:55 INFO - ##### 13:41:55 INFO - ##### Running clobber step. 13:41:55 INFO - ##### 13:41:55 INFO - Running pre-action listener: _resource_record_pre_action 13:41:55 INFO - Running main action method: clobber 13:41:55 INFO - rmtree: /builds/slave/test/build 13:41:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:41:56 INFO - Running post-action listener: _resource_record_post_action 13:41:56 INFO - ##### 13:41:56 INFO - ##### Finished clobber step (success) 13:41:56 INFO - ##### 13:41:56 INFO - ##### 13:41:56 INFO - ##### Running read-buildbot-config step. 13:41:56 INFO - ##### 13:41:56 INFO - Running pre-action listener: _resource_record_pre_action 13:41:56 INFO - Running main action method: read_buildbot_config 13:41:56 INFO - Using buildbot properties: 13:41:56 INFO - { 13:41:56 INFO - "project": "", 13:41:56 INFO - "product": "firefox", 13:41:56 INFO - "script_repo_revision": "production", 13:41:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:41:56 INFO - "repository": "", 13:41:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:41:56 INFO - "buildid": "20160513083005", 13:41:56 INFO - "pgo_build": "True", 13:41:56 INFO - "basedir": "/builds/slave/test", 13:41:56 INFO - "buildnumber": 82, 13:41:56 INFO - "slavename": "talos-linux64-ix-022", 13:41:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:41:56 INFO - "platform": "ubuntu64_hw", 13:41:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:41:56 INFO - "branch": "fx-team", 13:41:56 INFO - "repo_path": "integration/fx-team", 13:41:56 INFO - "revision": "c7942b0606ada54b06f6c241e1431e9c677a443f", 13:41:56 INFO - "stage_platform": "linux64-pgo", 13:41:56 INFO - "builduid": "3a1d029a01394de4af1822c362c79d96", 13:41:56 INFO - "slavebuilddir": "test" 13:41:56 INFO - } 13:41:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:41:56 INFO - Running post-action listener: _resource_record_post_action 13:41:56 INFO - ##### 13:41:56 INFO - ##### Finished read-buildbot-config step (success) 13:41:56 INFO - ##### 13:41:56 INFO - ##### 13:41:56 INFO - ##### Running download-and-extract step. 13:41:56 INFO - ##### 13:41:56 INFO - Running pre-action listener: _resource_record_pre_action 13:41:56 INFO - Running main action method: download_and_extract 13:41:56 INFO - mkdir: /builds/slave/test/build/tests 13:41:56 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')]} 13:41:56 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:41:57 INFO - Downloaded 1361 bytes. 13:41:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:41:57 INFO - Using the following test package requirements: 13:41:57 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:57 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:41:57 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:41:57 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'jsshell-linux-x86_64.zip'], 13:41:57 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:41:57 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:57 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:41:57 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:41:57 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:41:57 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:41:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:41:57 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')]} 13:41:57 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:41:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:41:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:41:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:41:58 INFO - Downloaded 23910111 bytes. 13:41:58 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'] 13:41:58 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 13:41:59 INFO - Return code: 0 13:41:59 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 13:41:59 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')]} 13:41:59 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:42:00 INFO - Downloaded 23910111 bytes. 13:42:00 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'] 13:42:00 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 13:42:02 INFO - Return code: 0 13:42:02 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')]} 13:42:02 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:42:03 INFO - Downloaded 10840239 bytes. 13:42:03 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'] 13:42:03 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 13:42:03 INFO - Return code: 0 13:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:03 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:42:04 INFO - Downloaded 58400368 bytes. 13:42:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:42:04 INFO - mkdir: /builds/slave/test/properties 13:42:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:42:04 INFO - Writing to file /builds/slave/test/properties/build_url 13:42:04 INFO - Contents: 13:42:04 INFO - build_url:https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:42:05 INFO - Running post-action listener: _resource_record_post_action 13:42:05 INFO - Running post-action listener: set_extra_try_arguments 13:42:05 INFO - ##### 13:42:05 INFO - ##### Finished download-and-extract step (success) 13:42:05 INFO - ##### 13:42:05 INFO - ##### 13:42:05 INFO - ##### Running populate-webroot step. 13:42:05 INFO - ##### 13:42:05 INFO - Running pre-action listener: _resource_record_pre_action 13:42:05 INFO - Running main action method: populate_webroot 13:42:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:42:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:42:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:42:05 INFO - '--tppagecycles', 13:42:05 INFO - '7'], 13:42:05 INFO - 'tests': ['tsvgm']}}, 13:42:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:42:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:42:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:42:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:42:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['damp', 'tps']}, 13:42:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'tests': ['damp', 'tps']}, 13:42:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['dromaeo_dom']}, 13:42:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:42:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'other-e10s': {'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['a11yr', 13:42:05 INFO - 'ts_paint', 13:42:05 INFO - 'tpaint', 13:42:05 INFO - 'sessionrestore', 13:42:05 INFO - 'sessionrestore_no_auto_restore', 13:42:05 INFO - 'tabpaint']}, 13:42:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['tsvgx', 13:42:05 INFO - 'tsvgr_opacity', 13:42:05 INFO - 'tart', 13:42:05 INFO - 'tscrollx', 13:42:05 INFO - 'cart']}, 13:42:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:42:05 INFO - 'tsvgr_opacity', 13:42:05 INFO - 'tart', 13:42:05 INFO - 'tscrollx', 13:42:05 INFO - 'cart']}, 13:42:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'talos_options': ['--disable-e10s'], 13:42:05 INFO - 'tests': ['tp5o']}, 13:42:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'tests': ['tp5o']}, 13:42:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'talos_options': ['--disable-e10s', 13:42:05 INFO - '--xperf_path', 13:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:05 INFO - 'tests': ['tp5n']}, 13:42:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:05 INFO - 'talos_options': ['--xperf_path', 13:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:05 INFO - 'tests': ['tp5n']}}, 13:42:05 INFO - 'talos.zip': {'path': '', 13:42:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:42:05 INFO - Running post-action listener: _resource_record_post_action 13:42:05 INFO - ##### 13:42:05 INFO - ##### Finished populate-webroot step (success) 13:42:05 INFO - ##### 13:42:05 INFO - ##### 13:42:05 INFO - ##### Running create-virtualenv step. 13:42:05 INFO - ##### 13:42:05 INFO - Running pre-action listener: _resource_record_pre_action 13:42:05 INFO - Running main action method: create_virtualenv 13:42:05 INFO - Creating virtualenv /builds/slave/test/build/venv 13:42:05 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 13:42:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:42:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:42:05 INFO - Using real prefix '/usr' 13:42:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:42:06 INFO - Installing distribute.............................................................................................................................................................................................done. 13:42:08 INFO - Installing pip.................done. 13:42:08 INFO - Return code: 0 13:42:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:08 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 13:42:08 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 13:42:08 INFO - Using env: {'DISPLAY': ':0', 13:42:08 INFO - 'HOME': '/home/cltbld', 13:42:08 INFO - 'LANG': 'en_US.UTF-8', 13:42:08 INFO - 'LANGUAGE': 'en_US:en', 13:42:08 INFO - 'LOGNAME': 'cltbld', 13:42:08 INFO - 'MAIL': '/var/mail/cltbld', 13:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:08 INFO - 'MOZ_NO_REMOTE': '1', 13:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:08 INFO - 'NO_EM_RESTART': '1', 13:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:08 INFO - 'PWD': '/builds/slave/test', 13:42:08 INFO - 'SHELL': '/bin/bash', 13:42:08 INFO - 'SHLVL': '1', 13:42:08 INFO - 'TERM': 'linux', 13:42:08 INFO - 'TMOUT': '86400', 13:42:08 INFO - 'USER': 'cltbld', 13:42:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:08 INFO - '_': '/tools/buildbot/bin/python'} 13:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:08 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 13:42:08 INFO - Cleaning up... 13:42:08 INFO - Return code: 0 13:42:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:08 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 13:42:08 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 13:42:08 INFO - Using env: {'DISPLAY': ':0', 13:42:08 INFO - 'HOME': '/home/cltbld', 13:42:08 INFO - 'LANG': 'en_US.UTF-8', 13:42:08 INFO - 'LANGUAGE': 'en_US:en', 13:42:08 INFO - 'LOGNAME': 'cltbld', 13:42:08 INFO - 'MAIL': '/var/mail/cltbld', 13:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:08 INFO - 'MOZ_NO_REMOTE': '1', 13:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:08 INFO - 'NO_EM_RESTART': '1', 13:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:08 INFO - 'PWD': '/builds/slave/test', 13:42:08 INFO - 'SHELL': '/bin/bash', 13:42:08 INFO - 'SHLVL': '1', 13:42:08 INFO - 'TERM': 'linux', 13:42:08 INFO - 'TMOUT': '86400', 13:42:08 INFO - 'USER': 'cltbld', 13:42:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:08 INFO - '_': '/tools/buildbot/bin/python'} 13:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:08 INFO - Downloading/unpacking psutil>=3.1.1 13:42:08 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 13:42:08 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 13:42:08 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 13:42:08 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 13:42:08 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 13:42:08 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 13:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:10 INFO - Installing collected packages: psutil 13:42:10 INFO - Running setup.py install for psutil 13:42:10 INFO - building 'psutil._psutil_linux' extension 13:42:10 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 13:42:10 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 13:42:10 INFO - building 'psutil._psutil_posix' extension 13:42:10 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 13:42:10 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 13:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:11 INFO - Successfully installed psutil 13:42:11 INFO - Cleaning up... 13:42:11 INFO - Return code: 0 13:42:11 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 13:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 13:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 13:42:11 INFO - Using env: {'DISPLAY': ':0', 13:42:11 INFO - 'HOME': '/home/cltbld', 13:42:11 INFO - 'LANG': 'en_US.UTF-8', 13:42:11 INFO - 'LANGUAGE': 'en_US:en', 13:42:11 INFO - 'LOGNAME': 'cltbld', 13:42:11 INFO - 'MAIL': '/var/mail/cltbld', 13:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:11 INFO - 'MOZ_NO_REMOTE': '1', 13:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:11 INFO - 'NO_EM_RESTART': '1', 13:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:11 INFO - 'PWD': '/builds/slave/test', 13:42:11 INFO - 'SHELL': '/bin/bash', 13:42:11 INFO - 'SHLVL': '1', 13:42:11 INFO - 'TERM': 'linux', 13:42:11 INFO - 'TMOUT': '86400', 13:42:11 INFO - 'USER': 'cltbld', 13:42:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:11 INFO - '_': '/tools/buildbot/bin/python'} 13:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:11 INFO - Downloading/unpacking mozsystemmonitor==0.1 13:42:11 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 13:42:11 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 13:42:11 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 13:42:11 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 13:42:11 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 13:42:11 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 13:42:13 INFO - Downloading mozsystemmonitor-0.1.tar.gz 13:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 13:42:13 INFO - Installing collected packages: mozsystemmonitor 13:42:13 INFO - Running setup.py install for mozsystemmonitor 13:42:13 INFO - Successfully installed mozsystemmonitor 13:42:13 INFO - Cleaning up... 13:42:13 INFO - Return code: 0 13:42:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:42:13 INFO - Using env: {'DISPLAY': ':0', 13:42:13 INFO - 'HOME': '/home/cltbld', 13:42:13 INFO - 'LANG': 'en_US.UTF-8', 13:42:13 INFO - 'LANGUAGE': 'en_US:en', 13:42:13 INFO - 'LOGNAME': 'cltbld', 13:42:13 INFO - 'MAIL': '/var/mail/cltbld', 13:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:13 INFO - 'MOZ_NO_REMOTE': '1', 13:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:13 INFO - 'NO_EM_RESTART': '1', 13:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:13 INFO - 'PWD': '/builds/slave/test', 13:42:13 INFO - 'SHELL': '/bin/bash', 13:42:13 INFO - 'SHLVL': '1', 13:42:13 INFO - 'TERM': 'linux', 13:42:13 INFO - 'TMOUT': '86400', 13:42:13 INFO - 'USER': 'cltbld', 13:42:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:13 INFO - '_': '/tools/buildbot/bin/python'} 13:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:13 INFO - Downloading/unpacking blobuploader==1.2.4 13:42:13 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 13:42:13 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 13:42:13 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 13:42:13 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 13:42:13 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 13:42:13 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 13:42:15 INFO - Downloading blobuploader-1.2.4.tar.gz 13:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:42:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:42:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:16 INFO - Downloading docopt-0.6.1.tar.gz 13:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:42:16 INFO - Installing collected packages: blobuploader, requests, docopt 13:42:16 INFO - Running setup.py install for blobuploader 13:42:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:42:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:42:16 INFO - Running setup.py install for requests 13:42:16 INFO - Running setup.py install for docopt 13:42:16 INFO - Successfully installed blobuploader requests docopt 13:42:16 INFO - Cleaning up... 13:42:16 INFO - Return code: 0 13:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:16 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:16 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 13:42:16 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 13:42:16 INFO - Using env: {'DISPLAY': ':0', 13:42:16 INFO - 'HOME': '/home/cltbld', 13:42:16 INFO - 'LANG': 'en_US.UTF-8', 13:42:16 INFO - 'LANGUAGE': 'en_US:en', 13:42:16 INFO - 'LOGNAME': 'cltbld', 13:42:16 INFO - 'MAIL': '/var/mail/cltbld', 13:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:16 INFO - 'MOZ_NO_REMOTE': '1', 13:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:16 INFO - 'NO_EM_RESTART': '1', 13:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:16 INFO - 'PWD': '/builds/slave/test', 13:42:16 INFO - 'SHELL': '/bin/bash', 13:42:16 INFO - 'SHLVL': '1', 13:42:16 INFO - 'TERM': 'linux', 13:42:16 INFO - 'TMOUT': '86400', 13:42:16 INFO - 'USER': 'cltbld', 13:42:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:16 INFO - '_': '/tools/buildbot/bin/python'} 13:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:17 INFO - Running setup.py (path:/tmp/pip-adz2iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:17 INFO - Running setup.py (path:/tmp/pip-akjpjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:17 INFO - Running setup.py (path:/tmp/pip-lSOG3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:17 INFO - Running setup.py (path:/tmp/pip-8dL9zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:17 INFO - Running setup.py (path:/tmp/pip-TOzrB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:17 INFO - Running setup.py (path:/tmp/pip-U3x4HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:17 INFO - Running setup.py (path:/tmp/pip-kCeQcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:17 INFO - Running setup.py (path:/tmp/pip-xeOAUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:17 INFO - Running setup.py (path:/tmp/pip-I8ASn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:17 INFO - Running setup.py (path:/tmp/pip-7cbxxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:17 INFO - Running setup.py (path:/tmp/pip-2M3P4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:17 INFO - Running setup.py (path:/tmp/pip-R1puyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:17 INFO - Running setup.py (path:/tmp/pip-iPAlCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:18 INFO - Running setup.py (path:/tmp/pip-hKRwEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:18 INFO - Running setup.py (path:/tmp/pip-rn8yTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:18 INFO - Running setup.py (path:/tmp/pip-DpIpPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:18 INFO - Running setup.py (path:/tmp/pip-765JWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:42:18 INFO - Running setup.py install for manifestparser 13:42:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:42:18 INFO - Running setup.py install for mozcrash 13:42:18 INFO - Running setup.py install for mozdebug 13:42:18 INFO - Running setup.py install for mozdevice 13:42:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:42:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:42:18 INFO - Running setup.py install for mozfile 13:42:18 INFO - Running setup.py install for mozhttpd 13:42:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:42:18 INFO - Running setup.py install for mozinfo 13:42:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for mozInstall 13:42:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for mozleak 13:42:19 INFO - Running setup.py install for mozlog 13:42:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for moznetwork 13:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for mozprocess 13:42:19 INFO - Running setup.py install for mozprofile 13:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for mozrunner 13:42:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:42:19 INFO - Running setup.py install for mozscreenshot 13:42:19 INFO - Running setup.py install for moztest 13:42:19 INFO - Running setup.py install for mozversion 13:42:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:42:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:42:20 INFO - Cleaning up... 13:42:20 INFO - Return code: 0 13:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:20 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:20 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 13:42:20 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 13:42:20 INFO - Using env: {'DISPLAY': ':0', 13:42:20 INFO - 'HOME': '/home/cltbld', 13:42:20 INFO - 'LANG': 'en_US.UTF-8', 13:42:20 INFO - 'LANGUAGE': 'en_US:en', 13:42:20 INFO - 'LOGNAME': 'cltbld', 13:42:20 INFO - 'MAIL': '/var/mail/cltbld', 13:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:20 INFO - 'MOZ_NO_REMOTE': '1', 13:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:20 INFO - 'NO_EM_RESTART': '1', 13:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:20 INFO - 'PWD': '/builds/slave/test', 13:42:20 INFO - 'SHELL': '/bin/bash', 13:42:20 INFO - 'SHLVL': '1', 13:42:20 INFO - 'TERM': 'linux', 13:42:20 INFO - 'TMOUT': '86400', 13:42:20 INFO - 'USER': 'cltbld', 13:42:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:20 INFO - '_': '/tools/buildbot/bin/python'} 13:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:20 INFO - Running setup.py (path:/tmp/pip-2xNgZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:20 INFO - Running setup.py (path:/tmp/pip-4zSvln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:20 INFO - Running setup.py (path:/tmp/pip-HE2GPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:20 INFO - Running setup.py (path:/tmp/pip-GMKcro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:20 INFO - Running setup.py (path:/tmp/pip-xBNiiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:20 INFO - Running setup.py (path:/tmp/pip-mC8sLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:20 INFO - Running setup.py (path:/tmp/pip-G0m9ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:20 INFO - Running setup.py (path:/tmp/pip-hvXhww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:20 INFO - Running setup.py (path:/tmp/pip-G3sps6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:20 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)) 13:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:20 INFO - Running setup.py (path:/tmp/pip-VvZ7Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:21 INFO - Running setup.py (path:/tmp/pip-7wFkTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:21 INFO - Running setup.py (path:/tmp/pip-FfZevX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:21 INFO - Running setup.py (path:/tmp/pip-6p2vl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:21 INFO - Running setup.py (path:/tmp/pip-TH6c_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:21 INFO - Running setup.py (path:/tmp/pip-XjyHaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:21 INFO - Running setup.py (path:/tmp/pip-kK4KFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:21 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)) 13:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:21 INFO - Running setup.py (path:/tmp/pip-d1PTPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:21 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)) 13:42:21 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)) 13:42:21 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)) 13:42:21 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)) 13:42:21 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)) 13:42:21 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)) 13:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:23 INFO - Downloading blessings-1.6.tar.gz 13:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:42:23 INFO - Installing collected packages: blessings 13:42:23 INFO - Running setup.py install for blessings 13:42:23 INFO - Successfully installed blessings 13:42:23 INFO - Cleaning up... 13:42:23 INFO - Return code: 0 13:42:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:23 INFO - Reading from file tmpfile_stdout 13:42:23 INFO - Current package versions: 13:42:23 INFO - argparse == 1.2.1 13:42:23 INFO - blessings == 1.6 13:42:23 INFO - blobuploader == 1.2.4 13:42:23 INFO - docopt == 0.6.1 13:42:23 INFO - manifestparser == 1.1 13:42:23 INFO - mozInstall == 1.12 13:42:23 INFO - mozcrash == 0.17 13:42:23 INFO - mozdebug == 0.1 13:42:23 INFO - mozdevice == 0.48 13:42:23 INFO - mozfile == 1.2 13:42:23 INFO - mozhttpd == 0.7 13:42:23 INFO - mozinfo == 0.9 13:42:23 INFO - mozleak == 0.1 13:42:23 INFO - mozlog == 3.2 13:42:23 INFO - moznetwork == 0.27 13:42:23 INFO - mozprocess == 0.22 13:42:23 INFO - mozprofile == 0.28 13:42:23 INFO - mozrunner == 6.11 13:42:23 INFO - mozscreenshot == 0.1 13:42:23 INFO - mozsystemmonitor == 0.1 13:42:23 INFO - moztest == 0.7 13:42:23 INFO - mozversion == 1.4 13:42:23 INFO - psutil == 3.1.1 13:42:23 INFO - requests == 1.2.3 13:42:23 INFO - wsgiref == 0.1.2 13:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:23 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:23 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 13:42:23 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 13:42:23 INFO - Using env: {'DISPLAY': ':0', 13:42:23 INFO - 'HOME': '/home/cltbld', 13:42:23 INFO - 'LANG': 'en_US.UTF-8', 13:42:23 INFO - 'LANGUAGE': 'en_US:en', 13:42:23 INFO - 'LOGNAME': 'cltbld', 13:42:23 INFO - 'MAIL': '/var/mail/cltbld', 13:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:23 INFO - 'MOZ_NO_REMOTE': '1', 13:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:23 INFO - 'NO_EM_RESTART': '1', 13:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:23 INFO - 'PWD': '/builds/slave/test', 13:42:23 INFO - 'SHELL': '/bin/bash', 13:42:23 INFO - 'SHLVL': '1', 13:42:23 INFO - 'TERM': 'linux', 13:42:23 INFO - 'TMOUT': '86400', 13:42:23 INFO - 'USER': 'cltbld', 13:42:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:23 INFO - '_': '/tools/buildbot/bin/python'} 13:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 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)) 13:42:24 INFO - Cleaning up... 13:42:24 INFO - Return code: 0 13:42:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:24 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:24 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 13:42:24 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 13:42:24 INFO - Using env: {'DISPLAY': ':0', 13:42:24 INFO - 'HOME': '/home/cltbld', 13:42:24 INFO - 'LANG': 'en_US.UTF-8', 13:42:24 INFO - 'LANGUAGE': 'en_US:en', 13:42:24 INFO - 'LOGNAME': 'cltbld', 13:42:24 INFO - 'MAIL': '/var/mail/cltbld', 13:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:24 INFO - 'MOZ_NO_REMOTE': '1', 13:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:24 INFO - 'NO_EM_RESTART': '1', 13:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:24 INFO - 'PWD': '/builds/slave/test', 13:42:24 INFO - 'SHELL': '/bin/bash', 13:42:24 INFO - 'SHLVL': '1', 13:42:24 INFO - 'TERM': 'linux', 13:42:24 INFO - 'TMOUT': '86400', 13:42:24 INFO - 'USER': 'cltbld', 13:42:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:24 INFO - '_': '/tools/buildbot/bin/python'} 13:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:24 INFO - Downloading/unpacking jsonschema 13:42:24 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 13:42:24 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 13:42:24 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 13:42:24 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 13:42:24 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 13:42:24 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 13:42:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:42:26 INFO - Downloading/unpacking functools32 (from jsonschema) 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:42:26 INFO - warning: no files found matching '*.txt' 13:42:26 INFO - no previously-included directories found matching 'build' 13:42:26 INFO - no previously-included directories found matching 'dist' 13:42:26 INFO - no previously-included directories found matching '.git*' 13:42:26 INFO - Installing collected packages: jsonschema, functools32 13:42:26 INFO - Running setup.py install for functools32 13:42:26 INFO - warning: no files found matching '*.txt' 13:42:26 INFO - no previously-included directories found matching 'build' 13:42:26 INFO - no previously-included directories found matching 'dist' 13:42:26 INFO - no previously-included directories found matching '.git*' 13:42:26 INFO - Successfully installed jsonschema functools32 13:42:26 INFO - Cleaning up... 13:42:26 INFO - Return code: 0 13:42:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:26 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 0x7f9cb70f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', '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 13:42:26 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 13:42:26 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 13:42:26 INFO - Using env: {'DISPLAY': ':0', 13:42:26 INFO - 'HOME': '/home/cltbld', 13:42:26 INFO - 'LANG': 'en_US.UTF-8', 13:42:26 INFO - 'LANGUAGE': 'en_US:en', 13:42:26 INFO - 'LOGNAME': 'cltbld', 13:42:26 INFO - 'MAIL': '/var/mail/cltbld', 13:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:26 INFO - 'MOZ_NO_REMOTE': '1', 13:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:26 INFO - 'NO_EM_RESTART': '1', 13:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:26 INFO - 'PWD': '/builds/slave/test', 13:42:26 INFO - 'SHELL': '/bin/bash', 13:42:26 INFO - 'SHLVL': '1', 13:42:26 INFO - 'TERM': 'linux', 13:42:26 INFO - 'TMOUT': '86400', 13:42:26 INFO - 'USER': 'cltbld', 13:42:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:26 INFO - '_': '/tools/buildbot/bin/python'} 13:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:26 INFO - Downloading/unpacking flake8 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:26 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 13:42:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:42:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:42:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:42:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:29 INFO - no previously-included directories found matching 'docs/_build' 13:42:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:42:29 INFO - Running setup.py install for pep8 13:42:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:29 INFO - no previously-included directories found matching 'docs/_build' 13:42:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:42:29 INFO - Cleaning up... 13:42:29 INFO - Return code: 0 13:42:29 INFO - Running post-action listener: _resource_record_post_action 13:42:29 INFO - Running post-action listener: _start_resource_monitoring 13:42:29 INFO - Starting resource monitoring. 13:42:29 INFO - ##### 13:42:29 INFO - ##### Finished create-virtualenv step (success) 13:42:29 INFO - ##### 13:42:29 INFO - ##### 13:42:29 INFO - ##### Running install step. 13:42:29 INFO - ##### 13:42:29 INFO - Running pre-action listener: _resource_record_pre_action 13:42:29 INFO - Running main action method: install 13:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:30 INFO - Reading from file tmpfile_stdout 13:42:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:42:30 INFO - Reading from file tmpfile_stdout 13:42:30 INFO - Output received: 13:42:30 INFO - Usage: mozinstall [options] installer 13:42:30 INFO - Options: 13:42:30 INFO - -h, --help show this help message and exit 13:42:30 INFO - -d DEST, --destination=DEST 13:42:30 INFO - Directory to install application into. [default: 13:42:30 INFO - "/builds/slave/test"] 13:42:30 INFO - --app=APP Application being installed. [default: firefox] 13:42:30 INFO - mkdir: /builds/slave/test/build/application 13:42:30 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'] 13:42:30 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 13:42:46 INFO - Reading from file tmpfile_stdout 13:42:46 INFO - Output received: 13:42:46 INFO - /builds/slave/test/build/application/firefox/firefox 13:42:46 INFO - Running post-action listener: _resource_record_post_action 13:42:46 INFO - ##### 13:42:46 INFO - ##### Finished install step (success) 13:42:46 INFO - ##### 13:42:46 INFO - ##### 13:42:46 INFO - ##### Running run-tests step. 13:42:46 INFO - ##### 13:42:46 INFO - Running pre-action listener: _resource_record_pre_action 13:42:46 INFO - Running main action method: run_tests 13:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:42:46 INFO - Python 2.7.3 13:42:46 INFO - Return code: 0 13:42:46 INFO - grabbing minidump binary from tooltool 13:42:46 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')]} 13:42:46 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 0x2cb09c0>, '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 0x2cb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:42:46 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 13:42:46 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 13:42:46 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 13:42:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:42:46 INFO - Return code: 0 13:42:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:42:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:42:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:42:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:42:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:42:47 INFO - Return code: 0 13:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:42:47 INFO - Using env: {'DISPLAY': ':0', 13:42:47 INFO - 'HOME': '/home/cltbld', 13:42:47 INFO - 'LANG': 'en_US.UTF-8', 13:42:47 INFO - 'LANGUAGE': 'en_US:en', 13:42:47 INFO - 'LOGNAME': 'cltbld', 13:42:47 INFO - 'MAIL': '/var/mail/cltbld', 13:42:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:42:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:47 INFO - 'MOZ_NO_REMOTE': '1', 13:42:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:47 INFO - 'NO_EM_RESTART': '1', 13:42:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:47 INFO - 'PWD': '/builds/slave/test', 13:42:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:42:47 INFO - 'SHELL': '/bin/bash', 13:42:47 INFO - 'SHLVL': '1', 13:42:47 INFO - 'TERM': 'linux', 13:42:47 INFO - 'TMOUT': '86400', 13:42:47 INFO - 'USER': 'cltbld', 13:42:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518', 13:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:47 INFO - '_': '/tools/buildbot/bin/python'} 13:42:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:42:47 INFO - mozversion application_buildid: 20160513083005 13:42:47 INFO - mozversion application_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 13:42:47 INFO - mozversion application_display_name: Nightly 13:42:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:42:47 INFO - mozversion application_name: Firefox 13:42:47 INFO - mozversion application_remotingname: firefox 13:42:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:42:47 INFO - mozversion application_vendor: Mozilla 13:42:47 INFO - mozversion application_version: 49.0a1 13:42:47 INFO - mozversion platform_buildid: 20160513083005 13:42:47 INFO - mozversion platform_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 13:42:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:42:47 INFO - mozversion platform_version: 49.0a1 13:42:47 INFO - using testdate: 1463172167 13:42:47 INFO - actual date: 1463172167 13:42:47 INFO - starting webserver on 'localhost:47159' 13:42:47 INFO - SUITE-START | Running 2 tests 13:42:47 INFO - TEST-START | dromaeo_css 13:42:47 INFO - operating with platform_type : linux_ 13:42:47 INFO - Initialising browser for dromaeo_css test... 13:42:47 INFO - TEST-INFO | started process 3022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGN2G3G/profile http://localhost:47159/getInfo.html) 13:42:51 INFO - PROCESS | 3022 | __metrics Screen width/height:1600/1200 13:42:51 INFO - PROCESS | 3022 | colorDepth:24 13:42:51 INFO - PROCESS | 3022 | Browser inner width/height: 1024/697 13:42:51 INFO - PROCESS | 3022 | __metrics 13:42:53 ERROR - PROCESS | 3022 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:42:53 INFO - TEST-INFO | 3022: exit 0 13:42:53 INFO - Browser initialized. 13:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:42:53 INFO - TEST-INFO | started process 3103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGN2G3G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:43:05 INFO - PROCESS | 3103 | RSS: Main: 152764416 13:43:05 INFO - PROCESS | 3103 | 13:43:56 INFO - PROCESS | 3103 | 1463172236845 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] 13:46:05 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47159/tests/dromaeo/cssquery-ext.html) 13:46:06 INFO - PROCESS | 3103 | RSS: Main: 255401984 13:46:06 INFO - PROCESS | 3103 | 13:49:08 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-ext.html (next: http://localhost:47159/tests/dromaeo/cssquery-jquery.html) 13:49:09 INFO - PROCESS | 3103 | RSS: Main: 243507200 13:49:09 INFO - PROCESS | 3103 | 13:52:11 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47159/tests/dromaeo/cssquery-mootools.html) 13:52:11 INFO - PROCESS | 3103 | RSS: Main: 244490240 13:52:11 INFO - PROCESS | 3103 | 13:55:13 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47159/tests/dromaeo/cssquery-prototype.html) 13:55:14 INFO - PROCESS | 3103 | RSS: Main: 237330432 13:55:14 INFO - PROCESS | 3103 | 13:58:16 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47159/tests/dromaeo/cssquery-yui.html) 13:58:17 INFO - PROCESS | 3103 | RSS: Main: 224542720 13:58:17 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | Cycle 1(1): loaded http://localhost:47159/tests/dromaeo/cssquery-yui.html (next: http://localhost:47159/tests/dromaeo/cssquery-dojo.html) 14:01:20 INFO - PROCESS | 3103 | RSS: Main: 267046912 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | __start_tp_report 14:01:20 INFO - PROCESS | 3103 | _x_x_mozilla_page_load 14:01:20 INFO - PROCESS | 3103 | _x_x_mozilla_page_load_details 14:01:20 INFO - PROCESS | 3103 | |i|pagename|runs| 14:01:20 INFO - PROCESS | 3103 | |0;dojo.html;3185.554022436859;3198.9360212795746;3243.1243564237666;3250.3661785951736;3250.902472925813;5307.628466007372;5359.651622644526;5470.7538160782815;5510.531604813591;5531.668099914003;5328.813491527797;5360.517553420192;5368.409474957752;5388.78444862205;5410.053240682884;4824.324594556756;4871.342368780222;4978.153713868651;5042.697438153704;5071.366079240095;5018.021485810268;5041.8235361762345;5064.594832413398;5068.1890897456415;5072.898542029157;4836.202026665614;4887.047025829965;4919.827806026772;4938.012397520511;4997.175466048097;4954.182559877616;4955.975220123876;4956.578690811285;4970.801167953277;4999.775010124553;4810.639202059824;4923.138450771101;4937.481564435754;4963.106640804654;4992.850214493571;5279.70961597112;5333;5363.115086010804;5371.409144994048;5372.54333381663;5727.541796656257;5765.1352297155345;5767.336756272998;5769.394213607595;5771.624844385102;5790.826275211751;5802.535797136261;5860.062390017577;5865.58940874139;5939.70301484924;5388.326459192601;5402.054640437947;5433.972830135824;5446.91829622556;5496.670199787985;6005.309389420186;6043.909341359883;6056.424639659225;6059.303180134253;6068.8786224276155;5532.419095994863;5707.686077265707;5757.884842303214;5781.768729250783;5804.187413762077;5886.646801191942;5890.087036509348;5901.911471327933;5914.083317085859;5964.31410387811;5865.090910908816;5872.17789509469;5873.706314684248;5874.030784920526;5877.177195192677;5645.915311270334;5709.971450142806;5734.856628584319;5735.0250457422335;5801.8549536261935;4391.143726973273;4400.4939431965095;4404.185225733249;4409.691321607456;4434.800433980478;3843.788591627487;3923.6861051115843;3935.4293627423863;3959.40608908666;3975.980120099381;5407.567394608422;5424.918626220609;5431.83704488866;5475.151351540518;5477.4796394342475;5812.3025236971835;5834.795782147605;5837.591368604157;5846.327672317738;5847.122931560215;5310.548603368757;5405.810796622178;5457.99027179965;5459.181122831527;5464.644798088191;4964.106460837084;5017.949820501822;5019.7490125494305;5021.046001259822;5059.974700126476;6011.3086994995265;6024.096385542116;6032;6038.33578306386;6044.576879618385;5660.29246344207;5778.94221057784;5809.970950145223;5841.094630332305;5850.034744267148;6073.817785466443;6091.919257029749;6091.994469032087;6123.908141377972;6144.78493252734;5740.339860916049;5750.338711048115;5786.132080188006;5794.739236734273;5796.159556864147;5665.858353541194;5715.199872017838;5760.567957403127;5865.472107510174;5886.146508756292;5649.6327738696855;5656.123300888369;5658.886822263614;5663.377028526941;5691.914621280767;5589.245451864109;5624.943750562442;5625.943740562542;5635.323761148688;5635.520980716685;5438.646487978269;5522.972385138049;5538.418466061005;5552.750126244248;5586.357568879631;5745.6552606843725;5789.768409263583;5792.073268277056;5797.449242321973;5806.477417032487;5560.833175004756;5580.693061881636;5621.072523033654;5623.100303951348;5630.915536267041 14:01:20 INFO - PROCESS | 3103 | |1;ext.html;604.7913469852899;625.2309659119284;643.4273496588035;656.2059907511909;659.0476761080238;34793.826030869845;37797.62202377975;37877.62122378779;37905.241895162115;44044.55955440445;47958.52041479584;48373;48386;48418.75790621051;48504.02991940168;8876.68931587393;8916.465012099296;9012.68455604054;9026.187643112118;9029.142231488031;8734.781630459225;8811.295096392305;8828.558572071372;8834.911650883505;8837.29301655866;8886.688965886195;8939.55302234889;8946.64213431462;8957.731268061969;8960.865587016167;8835.95582022089;8899.555022248926;8905.599248033854;8905.732828015138;8918.241949434307;8923.598438070303;8951.507667078307;8979.506127163004;8999.325050621164;9002.234810041155;43305;43816.123677526586;43836;43858.780706096266;43875.341869871976;3762.4920635714375;3849.095462566295;3856.3058649443087;3916.3929590913453;4228.830846766125;33038.6696133038;33322.3335533288;33909.6609033909;33964.32071358559;33966.1508462288;3672.889813305605;3766.472693822867;3786.9431958520645;3826.942595861064;3868.941965870514;340673;360347;367549;368296;513519.4324028393;62623.6868815653;62858.02848729363;63027.36972630307;63107.368926311065;63364;48469.27296090561;64536.677316614056;64847;66861.33138668648;67144;17432.38986635487;17543.035133067802;17570.209340579448;17625.647487050443;17664.470065898044;13461.125026873222;13547;13571.1857288563;13572.117812342363;13573.321333933462;17999.550011249823;19563.241126462377;20419.591608167753;20621.89689051545;20717.27489537859;7189.676464559003;7270.946692049081;7322;7416.517926334771;7422.290863834662;1046.2728403759465;1095.4139535348709;1125.4935279124427;1165.7843298989715;1220.8767933501201;32864;34033;34153;34189.82905085458;34378.82810585931;1117.3966058328574;1120.7926533591312;1152.2049785647876;1163.7265242667966;1175.4769127738075;17262.741058884127;17906.373276935246;18206.817931820777;18216.81783182151;18248.635027299646;524914;526048;526343;529363;529939;59817.40182598205;61152.38847611556;61429.69285153635;61437.38562614406;61458;1380.9792853107213;1418.8935829812806;1432.6991331820227;1434.2613554019688;1451.5790420778067;31886.202844928135;32815;32905.83547082345;33302.335813135374;33868.49197262093;53565.732171338896;53845.46154538561;53943;53972.19041714456;54000.729996349764;333778;338144;338796;339660;340969;27153.456930861666;27734.722652773213;29077.854610727656;29393.853030735565;29820.254493637833;48941.755291223315;50232;50834.23748643699;54858.72570637121;55540;43569;44649.55350446584;44662.77668611636;45395.54604454045;45952.31071533997;44021.77989110034;44165.558344416146;44184.33723494215;44886;45458;44071.55928440674;44261;45639.771801140785;45673.77163114163;45795.771021146014;37610;38475.230495389376;39170.2165956685;39344.80327598344;39452.605473944895;29821.552676709434;29894.701052989192;30136.547951780303;30254.84872575711;30260 14:01:20 INFO - PROCESS | 3103 | |2;jquery.html;376.75699174032735;386.98452061917527;396.8055652730162;409.0816117815504;412.75853625629003;14549.345279462423;18256.81743182568;18416;19962.50093747657;20048.799512004876;17824.910875445603;18141.81858181418;18633;18922.810771892313;19066.523336916584;5606.831795046155;5784.161296611988;5807.593468457209;5815.47660710536;5841.941580584204;4126.298529250034;5709.029464990941;5727.34135574408;5814.563907706939;6071.635701857903;6080.574359794816;6099.7865074722395;6120.602160859552;6133.969330153343;6136.140940268344;6036.305824830135;6069.817905462844;6207.162033125538;6213;6219.222597175353;5313.548348390392;5400.945990540084;5408.107662235727;5417.404085550586;5424.728763561806;23230.30309090713;23384.18155364571;23427.88286058559;23556.7644323558;23981.88009059961;2438.878056097188;2486.552420564298;2683.892644294226;2701.972980270192;2808.003158878589;13849.792253116211;14245.934339520814;14785.852141478555;15138.80487329342;15286.159261240628;1982.5836574319267;1988.801119888014;2003.8998050097582;2038.2152871144567;2056.938291851247;63810.68094659497;70074.64962675155;71597.64201179013;77568;78858;10815.40515271652;10981.945090274497;11014.614488492864;11032.669019929415;11205.607803726993;15053.473128440672;15151.545453636409;15215;15228.46700365482;15243.466478673416;8059.234372734698;8331.750047498585;8385.874211886827;8426.620802063799;8476.194761497647;7942.285194332538;8295.62669679866;8323.95838020806;8446.155384461628;8517.06312305646;6684.131062961881;6769.120014398097;6825.453963682893;6877.1747390313485;7067.575945443187;1898.8955607441724;1957.4421289932302;2004.2183548416128;2036.3483685220588;2041.765197002334;947.1617618407621;987.5407935310116;1014.1734486393566;1053.204830353094;1095.27164435651;18312.542186445444;18852.905735471235;19172.90413547923;19568.90215548913;20739.688904666444;1009.7021378693303;1018.034754630724;1018.5263852308713;1021.7343490692474;1028.6554004408458;10840.783184336427;11418.486168122454;11443;11586.826197607043;11641.359725215194;345956;354303;355520;470886;494437;88920.5553972226;95685;96991;99745;99905;973.1096047116808;1074.9408782517037;1085.6960051185522;1107.0977153619774;1110.9166812489095;16253.756193656867;16859.662806744043;18014.909925450287;18032.6557547518;18211.635767284846;36285.27429451343;37583.43624845684;38922.61077389303;42392.1521569573;42992.57007430011;55939.72030139986;56303.43696563146;58298;59062;59321.70339148277;8572;8687.478751274944;8771.605277762388;9027.819443610959;9129.360944733804;12457.314847683101;12523.93738031304;12656.936715316364;12864.807027894401;12868.227906325275;11520.884791152317;11581.13141514373;11681.941590291994;11773.587924422603;11832.230904991147;11086.944565277123;11096.944515277371;11305.604303849326;11320.26418282809;11462.770744584896;11854.110941679237;11908.702282442662;12129.150959433107;12198.085143614087;12649;8768.298536117223;8812.867806982773;8844.690435834715;8933.731988040368;9025.593848276712;9133.45199288045;11706.356150411468;11849.170558060852;12131.636050918487;12492.875071249171 14:01:20 INFO - PROCESS | 3103 | |3;mootools.html;1359.8300212473441;1511.501204602481;1550.426342253366;1680.6638672265542;1826.844718198953;8653.653853845846;9056.818863622724;9069.13843184898;9376.156145946863;9385.483798391086;9118.81762364754;9349.579268932897;9355.812883742321;9356.25149988001;9360.344775865693;2400.4238982644215;2426.46617744096;2430.8176886733477;2431.1247950737807;2432.063655492639;2311.572359113561;2343.086196383412;2347.495288512969;2350.576896158691;2375.180562705864;2376.0970831084164;2389.3309873235435;2399.5800734871414;2405.5429468401035;2422.5760491913934;2258.864468131901;2282.429392651837;2288.39357570244;2301.436148143707;2308.503671710582;2238;2301.7813307735737;2304.884755762222;2306.5041016181603;2308.180595888469;7752.496087754334;8771.78070548235;8940.821183576358;8984.371094023421;8985.910140898639;5268.92096618551;5341.252224688546;5357.624966252364;5361.169018802092;5366.195070739382;3405.880794172192;3503.1417302760733;3525.8589656413715;3540.309639620275;3541.38025845476;1102.1458369763418;1112.4382186995597;1129.7627498225384;1141.2068612314445;1156.0462618339902;12868.356582170854;12981.610551683465;13031.674208144777;13044.28256445895;13064.477420903153;4872.098661747588;4872.3909511311085;4892.902141957212;4916.606671466274;5005.524475174852;10754.838677419844;10843.240973131962;10897.019268265894;10915.56337746497;10918.344899306067;5434.212039254286;5435.4237271191705;5438.2386465894015;5439.646422982493;5441.428649991773;4929.926051109236;4993.201087825931;5047.848564543069;5086.364204474441;5106.617003724736;3794.430835374716;3806.1245913440066;3892.980535097363;3894.6105389460827;3909.8045097745;1250.987490125087;1258.4777317413354;1262.6590820478602;1272.7327261275236;1288.4459682336685;883.1874675298741;984.7488890333062;998.2812375090069;1015.9434188444084;1028.4651980969854;6170.6914654268;6245.656488893063;6253.78111766086;6303.558750887394;6398.520110991694;419.8488544124113;420.8653230966061;430.3609140426464;433.3348310343607;433.70074648492437;4328.8268469260875;4338.783060846945;4342.261815491374;4377.802998865059;4386.8903277417685;11256.718582035515;11551.191416600925;11769.764604708029;11769.823452648217;11789.941050294694;11585.478653460614;11594.362310073027;11598;11600.245984011011;11600.419979001017;7891.6054197289905;8175.3459723222;8180.141085186089;8371.623276952552;8375.916240837514;6211.627302361872;6498.122753428416;6512.153420055362;6575.704093315908;6623.304553021863;10679.786404272027;10799.838002430128;10826.02565769053;10895.182861285593;10903.509342079784;10869.347839129678;10933.398663073289;11009.339439633648;11071.225014249247;11169.88830111721;7767.300942915164;7805.765827025199;7857.332126769289;7889.3294070004695;7890.644920978455;8380.163071832158;8639.092895245909;8662.090480499457;8675.82648347017;8698.956505217686;7761.185075566984;7858.528488290721;7911.683532658629;7978.960105199437;8046.396520261121;7205.279472052753;7261.273872612696;7446.441516886363;7463.626818659154;7614.505057171487;6995.510314277952;7017.508774385744;7028.929710702828;7074.540154889915;7077.363037326665;5312.654677445954;5357.1696387060065;5385.973070134624;5432.18517222404;5437.700926449083;5471.644343117685;5516.668999860021;5546.500814926676;5681.971590142023;5735.942640573541 14:01:20 INFO - PROCESS | 3103 | |4;prototype.html;313.2638299995012;322.22344150597064;322.3601151713849;336.74743942043466;340.4671688807017;5330.626856120069;5351.545118664909;5392.703401312921;5395.571992603334;5400.648957817744;5301.946980530193;5333.706646134461;5352;5356.1697936819855;5381.973090134544;3885.1841113366227;4011.5587285398583;4143.011354549818;4151.481064866892;4168.749375187447;4198.790060496978;4206.537280899099;4213.536510983789;4227.175700738358;4229.873103806891;4123.216588848124;4182.16356728654;4183.874483765492;4188.308929026707;4189.141226048653;4016.136530645896;4043.818028188709;4119.176164767058;4185.832566697329;4201.978990105061;3658.5426821647293;3676.2721520885143;3684.9815750921075;3689.1883785567134;3704.573973992998;5119.462456442057;5121.513456221653;5135.255387968724;5147.845564633029;5171.198464238049;4547.749873756942;4767.213409787381;4774.474807771142;4816.373871396696;4844;5601.29983752031;5627.831165065055;5628.859278518029;5633.633813802131;5654;4014.4379786829577;4026.094128821021;4070.6336429721173;4096.160287141129;4110.445089912853;5698.031334673115;5775.797847075374;5801.795317779259;5832.387599302097;5868.501177399926;4107.856225032169;4111.753294802322;4114.547399786021;4132.194222126656;4137.54487006429;4199.769012704331;4231.301835197158;4236.788160591958;4239.173361194599;4263.126059157865;4684.718916864931;4795.160846851787;4875.512448755097;4890.779914903838;4901.926471102936;5602.467765562265;5639.915401268984;5648.943510564924;5661.490465858093;5666.838298148952;1426.7574512332928;1446.24795106544;1447.4499690117689;1455.3669153917867;1462.349254581701;898.9955050224838;927.7216834949623;938.5870217104589;939.9906000939903;951.6526467839188;4725.645576581702;4737.2183589708;4747.240441529339;4756.904861902743;4758.809647614056;5085.3134826797905;5124.487551244845;5126.385188665633;5134.766376626105;5154.742262886915;4584.014436896084;4790.760461976957;4815.22956326986;4816.349792778;4834.20235661112;2723.8832078847577;2741.917742467729;2757.786573907474;2760.7929405294685;2790.4279622677304;5100.7959681613065;5353.250544923714;5391.51733273353;5423.7830486780085;5425.891482170335;4797.832075877328;5191.662541934762;5226.451222621646;5229.424763276036;5617.43825617435;5816.651000939873;5907.2911250650195;5939.990201665727;5950.2264705587995;5961.4038596140035;5740.856478588069;5783.652980821164;5786.566007549366;5809.128630705428;5876.531856620315;5518.751656175402;5762.567807414544;5769.5576105973505;5774.56690748204;5774.740136693775;5978.372270911492;5984.13230081627;5993.460588547052;6003.249593800775;6005.249343832021;4145;4149.958500414958;4157.521884983265;4186.644135248416;4187.806475154566;5561.416051314553;5821.650700957956;5827.24245848054;5830.2129212555765;5835.620684655484;5551.19664569406;5580.35825880029;5645.858853528694;5651;5662.980663480613;5255.973720131375;5512.747478987417;5562.582806289625;5629.521490673339;5641.605087643826;5528.364238112668;5538.584606154635;5545.916811247916;5550.861228469321;5602.4957753802355;5727.856803579777;5758.3090029196765;5765.971170144123;5817.272840894888;5821.243238378984;5466.289382380265;5568.387477377404;5584.860378490408;5586.273784408001;5616.38219795814 14:01:20 INFO - PROCESS | 3103 | |5;yui.html;785.2030189357799;808.8907997420347;815.0708192660364;858.8711693246013;888.3293113699157;15049.62375940602;15183.39266429343;15354.923225383858;15407.38370465183;15409.152496612696;14133.081349712262;14202.644933876632;14203.502877399293;14205.218712970782;14225.359858806352;697.5152269172927;809.0049239435498;810.720301495983;813.5688085314792;817.9100298967109;811.4765975945542;815.8980127484065;817.4931542443693;817.7873752824249;818.2104269380047;726.3862036579109;859.1666083898608;859.7334826203866;859.9183077607618;860.311750599521;858.8368210040104;862.1507814802414;864.3733293362325;866.7746385939638;869.7086476030537;633.8003528888386;634.1154090044408;634.5462993959295;634.7461015593753;634.9206349206349;12468.501259949591;12493.500259989589;12520.373981300989;12536.874631253662;12557.372131393393;13441.193528388329;13597.866220802345;13616.591502254949;13627.931860340734;13631.318434078257;12203.45084471201;12557.74884502314;12564.937175314157;12654.620361389081;12709.046821488333;4453.9109217815785;4454.443194600675;4482.910341793178;4524.728516289033;4557.817687292504;57316.42683573152;58389.12416313759;59106.40893591052;60068;60317.6984115081;11023.338599684044;11078;11098;11186.32882027081;11215.831762523569;19800.306989255307;19834.404967850987;20156.395308140487;20255.392338229878;20277;8244.670213191524;8270.545120018456;8274;8287.088420273765;8611.39720219591;4927.236278376858;4949.876253093701;4961.2558116282125;5028.622853285945;5096.108181068373;3633.291508155937;3754.1928485375774;3755.3240416724707;3762.341590221755;3768.5666148393284;603.4960807725511;694.447913908444;708.9787306380714;730.777112980546;732.7984804178786;762.4815125714567;776.9883451748228;783.2637320918318;786.4612740272931;792.5500297206192;10231.897681023243;10384.792304153874;10428.322159059637;10485.737856553495;10506.317089389166;795.3393116338253;798.5847359373093;807.2855522862309;810.6392655268467;820.3765138494667;4781.187198176319;4884.5603895649565;4920;4922.1140194765285;4969.378827646544;60737;62540;62591.6870415645;73958.63020684863;74993.62503187449;61735;62301.68849155725;63354;63611.36388636147;64244.357556423834;57939.8412031757;57957.420425796045;58360.41639583635;58404;59160;9446.149846513847;9488.715338539854;9525.476098814632;9665.081817227352;9701.417914925127;37114;38001.42997854979;38365.61634383732;38695.419568705925;39230;47906.76046619745;50974.23538646849;51635.48364516307;51733.7413312931;52420;12583.559575414816;12621.87378126207;12933.159344642945;13011.609651710463;13268.93365533166;13139.60581182566;14555.636109097357;15004.924975375054;15027.173505456867;15417.69164616679;14174.291285435893;14310.785338219726;14392.136471811726;14590.85409145895;14672.926635366755;13507.459701612219;14082.436702531784;14228.928855355656;14844.851551484779;14931.178785166485;13770;13807.516736914562;13895.791563126764;14414.279286035866;14466.493672721404;9591.664291749756;9696.75758106053;9733.513324333613;9822.165115965223;10054.296199266273;10182.33743409488;10184.898151018395;10228.289503281785;10263.640772573222;10328.328658637165 14:01:20 INFO - PROCESS | 3103 | __end_tp_report 14:01:20 INFO - PROCESS | 3103 | __start_cc_report 14:01:20 INFO - PROCESS | 3103 | _x_x_mozilla_cycle_collect,889 14:01:20 INFO - PROCESS | 3103 | __end_cc_report 14:01:20 INFO - PROCESS | 3103 | __startTimestamp1463173280586__endTimestamp 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | ------- Summary: start ------- 14:01:20 INFO - PROCESS | 3103 | Number of tests: 6 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#0] dojo.html Cycles:165 Average:5401.36 Median:5586.36 stddev:613.72 (11.0%) stddev-sans-first:590.48 14:01:20 INFO - PROCESS | 3103 | Values: 3185.6 3198.9 3243.1 3250.4 3250.9 5307.6 5359.7 5470.8 5510.5 5531.7 5328.8 5360.5 5368.4 5388.8 5410.1 4824.3 4871.3 4978.2 5042.7 5071.4 5018.0 5041.8 5064.6 5068.2 5072.9 4836.2 4887.0 4919.8 4938.0 4997.2 4954.2 4956.0 4956.6 4970.8 4999.8 4810.6 4923.1 4937.5 4963.1 4992.9 5279.7 5333.0 5363.1 5371.4 5372.5 5727.5 5765.1 5767.3 5769.4 5771.6 5790.8 5802.5 5860.1 5865.6 5939.7 5388.3 5402.1 5434.0 5446.9 5496.7 6005.3 6043.9 6056.4 6059.3 6068.9 5532.4 5707.7 5757.9 5781.8 5804.2 5886.6 5890.1 5901.9 5914.1 5964.3 5865.1 5872.2 5873.7 5874.0 5877.2 5645.9 5710.0 5734.9 5735.0 5801.9 4391.1 4400.5 4404.2 4409.7 4434.8 3843.8 3923.7 3935.4 3959.4 3976.0 5407.6 5424.9 5431.8 5475.2 5477.5 5812.3 5834.8 5837.6 5846.3 5847.1 5310.5 5405.8 5458.0 5459.2 5464.6 4964.1 5017.9 5019.7 5021.0 5060.0 6011.3 6024.1 6032.0 6038.3 6044.6 5660.3 5778.9 5810.0 5841.1 5850.0 6073.8 6091.9 6092.0 6123.9 6144.8 5740.3 5750.3 5786.1 5794.7 5796.2 5665.9 5715.2 5760.6 5865.5 5886.1 5649.6 5656.1 5658.9 5663.4 5691.9 5589.2 5624.9 5625.9 5635.3 5635.5 5438.6 5523.0 5538.4 5552.8 5586.4 5745.7 5789.8 5792.1 5797.4 5806.5 5560.8 5580.7 5621.1 5623.1 5630.9 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#1] ext.html Cycles:180 Average:59555.74 Median:43826.06 stddev:113133.32 (258.1%) stddev-sans-first:113364.10 14:01:20 INFO - PROCESS | 3103 | Values: 604.8 625.2 643.4 656.2 659.0 34793.8 37797.6 37877.6 37905.2 44044.6 47958.5 48373.0 48386.0 48418.8 48504.0 8876.7 8916.5 9012.7 9026.2 9029.1 8734.8 8811.3 8828.6 8834.9 8837.3 8886.7 8939.6 8946.6 8957.7 8960.9 8836.0 8899.6 8905.6 8905.7 8918.2 8923.6 8951.5 8979.5 8999.3 9002.2 43305.0 43816.1 43836.0 43858.8 43875.3 3762.5 3849.1 3856.3 3916.4 4228.8 33038.7 33322.3 33909.7 33964.3 33966.2 3672.9 3766.5 3786.9 3826.9 3868.9 340673.0 360347.0 367549.0 368296.0 513519.4 62623.7 62858.0 63027.4 63107.4 63364.0 48469.3 64536.7 64847.0 66861.3 67144.0 17432.4 17543.0 17570.2 17625.6 17664.5 13461.1 13547.0 13571.2 13572.1 13573.3 17999.6 19563.2 20419.6 20621.9 20717.3 7189.7 7270.9 7322.0 7416.5 7422.3 1046.3 1095.4 1125.5 1165.8 1220.9 32864.0 34033.0 34153.0 34189.8 34378.8 1117.4 1120.8 1152.2 1163.7 1175.5 17262.7 17906.4 18206.8 18216.8 18248.6 524914.0 526048.0 526343.0 529363.0 529939.0 59817.4 61152.4 61429.7 61437.4 61458.0 1381.0 1418.9 1432.7 1434.3 1451.6 31886.2 32815.0 32905.8 33302.3 33868.5 53565.7 53845.5 53943.0 53972.2 54000.7 333778.0 338144.0 338796.0 339660.0 340969.0 27153.5 27734.7 29077.9 29393.9 29820.3 48941.8 50232.0 50834.2 54858.7 55540.0 43569.0 44649.6 44662.8 45395.5 45952.3 44021.8 44165.6 44184.3 44886.0 45458.0 44071.6 44261.0 45639.8 45673.8 45795.8 37610.0 38475.2 39170.2 39344.8 39452.6 29821.6 29894.7 30136.5 30254.8 30260.0 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#2] jquery.html Cycles:180 Average:26640.51 Median:13210.38 stddev:67955.67 (514.4%) stddev-sans-first:68117.69 14:01:20 INFO - PROCESS | 3103 | Values: 376.8 387.0 396.8 409.1 412.8 14549.3 18256.8 18416.0 19962.5 20048.8 17824.9 18141.8 18633.0 18922.8 19066.5 5606.8 5784.2 5807.6 5815.5 5841.9 4126.3 5709.0 5727.3 5814.6 6071.6 6080.6 6099.8 6120.6 6134.0 6136.1 6036.3 6069.8 6207.2 6213.0 6219.2 5313.5 5400.9 5408.1 5417.4 5424.7 23230.3 23384.2 23427.9 23556.8 23981.9 2438.9 2486.6 2683.9 2702.0 2808.0 13849.8 14245.9 14785.9 15138.8 15286.2 1982.6 1988.8 2003.9 2038.2 2056.9 63810.7 70074.6 71597.6 77568.0 78858.0 10815.4 10981.9 11014.6 11032.7 11205.6 15053.5 15151.5 15215.0 15228.5 15243.5 8059.2 8331.8 8385.9 8426.6 8476.2 7942.3 8295.6 8324.0 8446.2 8517.1 6684.1 6769.1 6825.5 6877.2 7067.6 1898.9 1957.4 2004.2 2036.3 2041.8 947.2 987.5 1014.2 1053.2 1095.3 18312.5 18852.9 19172.9 19568.9 20739.7 1009.7 1018.0 1018.5 1021.7 1028.7 10840.8 11418.5 11443.0 11586.8 11641.4 345956.0 354303.0 355520.0 470886.0 494437.0 88920.6 95685.0 96991.0 99745.0 99905.0 973.1 1074.9 1085.7 1107.1 1110.9 16253.8 16859.7 18014.9 18032.7 18211.6 36285.3 37583.4 38922.6 42392.2 42992.6 55939.7 56303.4 58298.0 59062.0 59321.7 8572.0 8687.5 8771.6 9027.8 9129.4 12457.3 12523.9 12656.9 12864.8 12868.2 11520.9 11581.1 11681.9 11773.6 11832.2 11086.9 11096.9 11305.6 11320.3 11462.8 11854.1 11908.7 12129.2 12198.1 12649.0 8768.3 8812.9 8844.7 8933.7 9025.6 9133.5 11706.4 11849.2 12131.6 12492.9 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#3] mootools.html Cycles:180 Average:6009.31 Median:4382.35 stddev:3505.03 (80.0%) stddev-sans-first:3497.45 14:01:20 INFO - PROCESS | 3103 | Values: 1359.8 1511.5 1550.4 1680.7 1826.8 8653.7 9056.8 9069.1 9376.2 9385.5 9118.8 9349.6 9355.8 9356.3 9360.3 2400.4 2426.5 2430.8 2431.1 2432.1 2311.6 2343.1 2347.5 2350.6 2375.2 2376.1 2389.3 2399.6 2405.5 2422.6 2258.9 2282.4 2288.4 2301.4 2308.5 2238.0 2301.8 2304.9 2306.5 2308.2 7752.5 8771.8 8940.8 8984.4 8985.9 5268.9 5341.3 5357.6 5361.2 5366.2 3405.9 3503.1 3525.9 3540.3 3541.4 1102.1 1112.4 1129.8 1141.2 1156.0 12868.4 12981.6 13031.7 13044.3 13064.5 4872.1 4872.4 4892.9 4916.6 5005.5 10754.8 10843.2 10897.0 10915.6 10918.3 5434.2 5435.4 5438.2 5439.6 5441.4 4929.9 4993.2 5047.8 5086.4 5106.6 3794.4 3806.1 3893.0 3894.6 3909.8 1251.0 1258.5 1262.7 1272.7 1288.4 883.2 984.7 998.3 1015.9 1028.5 6170.7 6245.7 6253.8 6303.6 6398.5 419.8 420.9 430.4 433.3 433.7 4328.8 4338.8 4342.3 4377.8 4386.9 11256.7 11551.2 11769.8 11769.8 11789.9 11585.5 11594.4 11598.0 11600.2 11600.4 7891.6 8175.3 8180.1 8371.6 8375.9 6211.6 6498.1 6512.2 6575.7 6623.3 10679.8 10799.8 10826.0 10895.2 10903.5 10869.3 10933.4 11009.3 11071.2 11169.9 7767.3 7805.8 7857.3 7889.3 7890.6 8380.2 8639.1 8662.1 8675.8 8699.0 7761.2 7858.5 7911.7 7979.0 8046.4 7205.3 7261.3 7446.4 7463.6 7614.5 6995.5 7017.5 7028.9 7074.5 7077.4 5312.7 5357.2 5386.0 5432.2 5437.7 5471.6 5516.7 5546.5 5682.0 5735.9 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#4] prototype.html Cycles:180 Average:4645.42 Median:5162.97 stddev:1367.02 (26.5%) stddev-sans-first:1331.62 14:01:20 INFO - PROCESS | 3103 | Values: 313.3 322.2 322.4 336.7 340.5 5330.6 5351.5 5392.7 5395.6 5400.6 5301.9 5333.7 5352.0 5356.2 5382.0 3885.2 4011.6 4143.0 4151.5 4168.7 4198.8 4206.5 4213.5 4227.2 4229.9 4123.2 4182.2 4183.9 4188.3 4189.1 4016.1 4043.8 4119.2 4185.8 4202.0 3658.5 3676.3 3685.0 3689.2 3704.6 5119.5 5121.5 5135.3 5147.8 5171.2 4547.7 4767.2 4774.5 4816.4 4844.0 5601.3 5627.8 5628.9 5633.6 5654.0 4014.4 4026.1 4070.6 4096.2 4110.4 5698.0 5775.8 5801.8 5832.4 5868.5 4107.9 4111.8 4114.5 4132.2 4137.5 4199.8 4231.3 4236.8 4239.2 4263.1 4684.7 4795.2 4875.5 4890.8 4901.9 5602.5 5639.9 5648.9 5661.5 5666.8 1426.8 1446.2 1447.4 1455.4 1462.3 899.0 927.7 938.6 940.0 951.7 4725.6 4737.2 4747.2 4756.9 4758.8 5085.3 5124.5 5126.4 5134.8 5154.7 4584.0 4790.8 4815.2 4816.3 4834.2 2723.9 2741.9 2757.8 2760.8 2790.4 5100.8 5353.3 5391.5 5423.8 5425.9 4797.8 5191.7 5226.5 5229.4 5617.4 5816.7 5907.3 5940.0 5950.2 5961.4 5740.9 5783.7 5786.6 5809.1 5876.5 5518.8 5762.6 5769.6 5774.6 5774.7 5978.4 5984.1 5993.5 6003.2 6005.2 4145.0 4150.0 4157.5 4186.6 4187.8 5561.4 5821.7 5827.2 5830.2 5835.6 5551.2 5580.4 5645.9 5651.0 5663.0 5256.0 5512.7 5562.6 5629.5 5641.6 5528.4 5538.6 5545.9 5550.9 5602.5 5727.9 5758.3 5766.0 5817.3 5821.2 5466.3 5568.4 5584.9 5586.3 5616.4 14:01:20 INFO - PROCESS | 3103 | 14:01:20 INFO - PROCESS | 3103 | [#5] yui.html Cycles:180 Average:16104.30 Median:4924.68 stddev:19149.89 (388.9%) stddev-sans-first:19169.05 14:01:20 INFO - PROCESS | 3103 | Values: 785.2 808.9 815.1 858.9 888.3 15049.6 15183.4 15354.9 15407.4 15409.2 14133.1 14202.6 14203.5 14205.2 14225.4 697.5 809.0 810.7 813.6 817.9 811.5 815.9 817.5 817.8 818.2 726.4 859.2 859.7 859.9 860.3 858.8 862.2 864.4 866.8 869.7 633.8 634.1 634.5 634.7 634.9 12468.5 12493.5 12520.4 12536.9 12557.4 13441.2 13597.9 13616.6 13627.9 13631.3 12203.5 12557.7 12564.9 12654.6 12709.0 4453.9 4454.4 4482.9 4524.7 4557.8 57316.4 58389.1 59106.4 60068.0 60317.7 11023.3 11078.0 11098.0 11186.3 11215.8 19800.3 19834.4 20156.4 20255.4 20277.0 8244.7 8270.5 8274.0 8287.1 8611.4 4927.2 4949.9 4961.3 5028.6 5096.1 3633.3 3754.2 3755.3 3762.3 3768.6 603.5 694.4 709.0 730.8 732.8 762.5 777.0 783.3 786.5 792.6 10231.9 10384.8 10428.3 10485.7 10506.3 795.3 798.6 807.3 810.6 820.4 4781.2 4884.6 4920.0 4922.1 4969.4 60737.0 62540.0 62591.7 73958.6 74993.6 61735.0 62301.7 63354.0 63611.4 64244.4 57939.8 57957.4 58360.4 58404.0 59160.0 9446.1 9488.7 9525.5 9665.1 9701.4 37114.0 38001.4 38365.6 38695.4 39230.0 47906.8 50974.2 51635.5 51733.7 52420.0 12583.6 12621.9 12933.2 13011.6 13268.9 13139.6 14555.6 15004.9 15027.2 15417.7 14174.3 14310.8 14392.1 14590.9 14672.9 13507.5 14082.4 14228.9 14844.9 14931.2 13770.0 13807.5 13895.8 14414.3 14466.5 9591.7 9696.8 9733.5 9822.2 10054.3 10182.3 10184.9 10228.3 10263.6 10328.3 14:01:20 INFO - PROCESS | 3103 | -------- Summary: end -------- 14:01:20 INFO - PROCESS | 3103 | 14:01:21 INFO - TEST-INFO | 3103: exit 0 14:01:21 INFO - TEST-OK | dromaeo_css | took 1113301ms 14:01:21 INFO - TEST-START | kraken 14:01:21 INFO - operating with platform_type : linux_ 14:01:21 INFO - Initialising browser for kraken test... 14:01:21 INFO - TEST-INFO | started process 3287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SUFwE/profile http://localhost:47159/getInfo.html) 14:01:25 INFO - PROCESS | 3287 | __metrics Screen width/height:1600/1200 14:01:25 INFO - PROCESS | 3287 | colorDepth:24 14:01:25 INFO - PROCESS | 3287 | Browser inner width/height: 1024/697 14:01:25 INFO - PROCESS | 3287 | __metrics 14:01:26 ERROR - PROCESS | 3287 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:01:27 INFO - TEST-INFO | 3287: exit 0 14:01:27 INFO - Browser initialized. 14:01:27 INFO - Running cycle 1/1 for kraken test... 14:01:27 INFO - TEST-INFO | started process 3369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SUFwE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:39 INFO - PROCESS | 3369 | RSS: Main: 152416256 14:01:39 INFO - PROCESS | 3369 | 14:01:41 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47159/tests/kraken/driver.html?testName=audio-beat-detection) 14:01:42 INFO - PROCESS | 3369 | RSS: Main: 209203200 14:01:42 INFO - PROCESS | 3369 | 14:01:45 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47159/tests/kraken/driver.html?testName=audio-dft) 14:01:45 INFO - PROCESS | 3369 | RSS: Main: 197242880 14:01:45 INFO - PROCESS | 3369 | 14:01:49 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47159/tests/kraken/driver.html?testName=audio-fft) 14:01:49 INFO - PROCESS | 3369 | RSS: Main: 265621504 14:01:49 INFO - PROCESS | 3369 | 14:01:51 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47159/tests/kraken/driver.html?testName=audio-oscillator) 14:01:52 INFO - PROCESS | 3369 | RSS: Main: 174075904 14:01:52 INFO - PROCESS | 3369 | 14:01:54 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:01:55 INFO - PROCESS | 3369 | RSS: Main: 178880512 14:01:55 INFO - PROCESS | 3369 | 14:01:58 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47159/tests/kraken/driver.html?testName=imaging-darkroom) 14:01:59 INFO - PROCESS | 3369 | RSS: Main: 214528000 14:01:59 INFO - PROCESS | 3369 | 14:02:02 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47159/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:03 INFO - PROCESS | 3369 | RSS: Main: 215011328 14:02:03 INFO - PROCESS | 3369 | 14:02:06 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47159/tests/kraken/driver.html?testName=json-parse-financial) 14:02:06 INFO - PROCESS | 3369 | RSS: Main: 215330816 14:02:06 INFO - PROCESS | 3369 | 14:02:08 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:02:08 INFO - PROCESS | 3369 | RSS: Main: 203960320 14:02:08 INFO - PROCESS | 3369 | 14:02:10 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:02:11 INFO - PROCESS | 3369 | RSS: Main: 208150528 14:02:11 INFO - PROCESS | 3369 | 14:02:13 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:02:14 INFO - PROCESS | 3369 | RSS: Main: 217972736 14:02:14 INFO - PROCESS | 3369 | 14:02:16 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:02:17 INFO - PROCESS | 3369 | RSS: Main: 223928320 14:02:17 INFO - PROCESS | 3369 | 14:02:20 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:02:20 INFO - PROCESS | 3369 | RSS: Main: 220094464 14:02:20 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:47159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47159/tests/kraken/driver.html?testName=ai-astar) 14:02:22 INFO - PROCESS | 3369 | RSS: Main: 265936896 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | __start_tp_report 14:02:22 INFO - PROCESS | 3369 | _x_x_mozilla_page_load 14:02:22 INFO - PROCESS | 3369 | _x_x_mozilla_page_load_details 14:02:22 INFO - PROCESS | 3369 | |i|pagename|runs| 14:02:22 INFO - PROCESS | 3369 | |0;ai-astar;110;105;111;110;112;109;109;110;108;109 14:02:22 INFO - PROCESS | 3369 | |1;audio-beat-detection;151;125;150;205;124;149;153;126;177;131 14:02:22 INFO - PROCESS | 3369 | |2;audio-dft;161;160;160;162;160;160;159;161;162;162 14:02:22 INFO - PROCESS | 3369 | |3;audio-fft;75;74;74;153;74;74;76;76;149;75 14:02:22 INFO - PROCESS | 3369 | |4;audio-oscillator;90;91;145;91;92;91;118;91;90;123 14:02:22 INFO - PROCESS | 3369 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;118;116 14:02:22 INFO - PROCESS | 3369 | |6;imaging-darkroom;144;146;146;145;145;145;146;145;144;145 14:02:22 INFO - PROCESS | 3369 | |7;imaging-desaturate;95;95;94;96;94;95;94;95;95;95 14:02:22 INFO - PROCESS | 3369 | |8;json-parse-financial;54;53;55;55;55;56;55;113;53;51 14:02:22 INFO - PROCESS | 3369 | |9;json-stringify-tinderbox;60;61;60;59;60;59;60;60;60;59 14:02:22 INFO - PROCESS | 3369 | |10;stanford-crypto-aes;77;77;77;77;78;79;79;84;79;79 14:02:22 INFO - PROCESS | 3369 | |11;stanford-crypto-ccm;132;130;118;119;120;118;118;121;197;126 14:02:22 INFO - PROCESS | 3369 | |12;stanford-crypto-pbkdf2;162;160;164;160;163;161;159;164;159;159 14:02:22 INFO - PROCESS | 3369 | |13;stanford-crypto-sha256-iterative;63;64;66;64;63;63;62;63;62;62 14:02:22 INFO - PROCESS | 3369 | __end_tp_report 14:02:22 INFO - PROCESS | 3369 | __start_cc_report 14:02:22 INFO - PROCESS | 3369 | _x_x_mozilla_cycle_collect,1830 14:02:22 INFO - PROCESS | 3369 | __end_cc_report 14:02:22 INFO - PROCESS | 3369 | __startTimestamp1463173342802__endTimestamp 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | ------- Summary: start ------- 14:02:22 INFO - PROCESS | 3369 | Number of tests: 14 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 14:02:22 INFO - PROCESS | 3369 | Values: 110.0 105.0 111.0 110.0 112.0 109.0 109.0 110.0 108.0 109.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:150.50 stddev:25.81 (17.1%) stddev-sans-first:27.37 14:02:22 INFO - PROCESS | 3369 | Values: 151.0 125.0 150.0 205.0 124.0 149.0 153.0 126.0 177.0 131.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 14:02:22 INFO - PROCESS | 3369 | Values: 161.0 160.0 160.0 162.0 160.0 160.0 159.0 161.0 162.0 162.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#3] audio-fft Cycles:10 Average:90.00 Median:74.50 stddev:32.17 (43.2%) stddev-sans-first:33.66 14:02:22 INFO - PROCESS | 3369 | Values: 75.0 74.0 74.0 153.0 74.0 74.0 76.0 76.0 149.0 75.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:91.00 stddev:19.49 (21.4%) stddev-sans-first:20.16 14:02:22 INFO - PROCESS | 3369 | Values: 90.0 91.0 145.0 91.0 92.0 91.0 118.0 91.0 90.0 123.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:02:22 INFO - PROCESS | 3369 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 118.0 116.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 14:02:22 INFO - PROCESS | 3369 | Values: 144.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 144.0 145.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:02:22 INFO - PROCESS | 3369 | Values: 95.0 95.0 94.0 96.0 94.0 95.0 94.0 95.0 95.0 95.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:55.00 stddev:18.68 (34.0%) stddev-sans-first:19.69 14:02:22 INFO - PROCESS | 3369 | Values: 54.0 53.0 55.0 55.0 55.0 56.0 55.0 113.0 53.0 51.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 14:02:22 INFO - PROCESS | 3369 | Values: 60.0 61.0 60.0 59.0 60.0 59.0 60.0 60.0 60.0 59.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.17 14:02:22 INFO - PROCESS | 3369 | Values: 77.0 77.0 77.0 77.0 78.0 79.0 79.0 84.0 79.0 79.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:123.50 stddev:24.14 (19.5%) stddev-sans-first:25.59 14:02:22 INFO - PROCESS | 3369 | Values: 132.0 130.0 118.0 119.0 120.0 118.0 118.0 121.0 197.0 126.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.02 (1.3%) stddev-sans-first:2.12 14:02:22 INFO - PROCESS | 3369 | Values: 162.0 160.0 164.0 160.0 163.0 161.0 159.0 164.0 159.0 159.0 14:02:22 INFO - PROCESS | 3369 | 14:02:22 INFO - PROCESS | 3369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 14:02:22 INFO - PROCESS | 3369 | Values: 63.0 64.0 66.0 64.0 63.0 63.0 62.0 63.0 62.0 62.0 14:02:22 INFO - PROCESS | 3369 | -------- Summary: end -------- 14:02:22 INFO - PROCESS | 3369 | 14:02:23 INFO - TEST-INFO | 3369: exit 0 14:02:23 INFO - TEST-OK | kraken | took 62580ms 14:02:23 INFO - SUITE-END | took 1175s 14:02:23 INFO - Completed test suite (00:19:36) 14:02:23 INFO - javascript benchmark 14:02:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.554022436859, 3198.9360212795746, 3243.1243564237666, 3250.3661785951736, 3250.902472925813, 5307.628466007372, 5359.651622644526, 5470.7538160782815, 5510.531604813591, 5531.668099914003, 5328.813491527797, 5360.517553420192, 5368.409474957752, 5388.78444862205, 5410.053240682884, 4824.324594556756, 4871.342368780222, 4978.153713868651, 5042.697438153704, 5071.366079240095, 5018.021485810268, 5041.8235361762345, 5064.594832413398, 5068.1890897456415, 5072.898542029157, 4836.202026665614, 4887.047025829965, 4919.827806026772, 4938.012397520511, 4997.175466048097, 4954.182559877616, 4955.975220123876, 4956.578690811285, 4970.801167953277, 4999.775010124553, 4810.639202059824, 4923.138450771101, 4937.481564435754, 4963.106640804654, 4992.850214493571, 5279.70961597112, 5333.0, 5363.115086010804, 5371.409144994048, 5372.54333381663, 5727.541796656257, 5765.1352297155345, 5767.336756272998, 5769.394213607595, 5771.624844385102, 5790.826275211751, 5802.535797136261, 5860.062390017577, 5865.58940874139, 5939.70301484924, 5388.326459192601, 5402.054640437947, 5433.972830135824, 5446.91829622556, 5496.670199787985, 6005.309389420186, 6043.909341359883, 6056.424639659225, 6059.303180134253, 6068.8786224276155, 5532.419095994863, 5707.686077265707, 5757.884842303214, 5781.768729250783, 5804.187413762077, 5886.646801191942, 5890.087036509348, 5901.911471327933, 5914.083317085859, 5964.31410387811, 5865.090910908816, 5872.17789509469, 5873.706314684248, 5874.030784920526, 5877.177195192677, 5645.915311270334, 5709.971450142806, 5734.856628584319, 5735.0250457422335, 5801.8549536261935, 4391.143726973273, 4400.4939431965095, 4404.185225733249, 4409.691321607456, 4434.800433980478, 3843.788591627487, 3923.6861051115843, 3935.4293627423863, 3959.40608908666, 3975.980120099381, 5407.567394608422, 5424.918626220609, 5431.83704488866, 5475.151351540518, 5477.4796394342475, 5812.3025236971835, 5834.795782147605, 5837.591368604157, 5846.327672317738, 5847.122931560215, 5310.548603368757, 5405.810796622178, 5457.99027179965, 5459.181122831527, 5464.644798088191, 4964.106460837084, 5017.949820501822, 5019.7490125494305, 5021.046001259822, 5059.974700126476, 6011.3086994995265, 6024.096385542116, 6032.0, 6038.33578306386, 6044.576879618385, 5660.29246344207, 5778.94221057784, 5809.970950145223, 5841.094630332305, 5850.034744267148, 6073.817785466443, 6091.919257029749, 6091.994469032087, 6123.908141377972, 6144.78493252734, 5740.339860916049, 5750.338711048115, 5786.132080188006, 5794.739236734273, 5796.159556864147, 5665.858353541194, 5715.199872017838, 5760.567957403127, 5865.472107510174, 5886.146508756292, 5649.6327738696855, 5656.123300888369, 5658.886822263614, 5663.377028526941, 5691.914621280767, 5589.245451864109, 5624.943750562442, 5625.943740562542, 5635.323761148688, 5635.520980716685, 5438.646487978269, 5522.972385138049, 5538.418466061005, 5552.750126244248, 5586.357568879631, 5745.6552606843725, 5789.768409263583, 5792.073268277056, 5797.449242321973, 5806.477417032487, 5560.833175004756, 5580.693061881636, 5621.072523033654, 5623.100303951348, 5630.915536267041], "value": 5360.4562596502665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.7913469852899, 625.2309659119284, 643.4273496588035, 656.2059907511909, 659.0476761080238, 34793.826030869845, 37797.62202377975, 37877.62122378779, 37905.241895162115, 44044.55955440445, 47958.52041479584, 48373.0, 48386.0, 48418.75790621051, 48504.02991940168, 8876.68931587393, 8916.465012099296, 9012.68455604054, 9026.187643112118, 9029.142231488031, 8734.781630459225, 8811.295096392305, 8828.558572071372, 8834.911650883505, 8837.29301655866, 8886.688965886195, 8939.55302234889, 8946.64213431462, 8957.731268061969, 8960.865587016167, 8835.95582022089, 8899.555022248926, 8905.599248033854, 8905.732828015138, 8918.241949434307, 8923.598438070303, 8951.507667078307, 8979.506127163004, 8999.325050621164, 9002.234810041155, 43305.0, 43816.123677526586, 43836.0, 43858.780706096266, 43875.341869871976, 3762.4920635714375, 3849.095462566295, 3856.3058649443087, 3916.3929590913453, 4228.830846766125, 33038.6696133038, 33322.3335533288, 33909.6609033909, 33964.32071358559, 33966.1508462288, 3672.889813305605, 3766.472693822867, 3786.9431958520645, 3826.942595861064, 3868.941965870514, 340673.0, 360347.0, 367549.0, 368296.0, 513519.4324028393, 62623.6868815653, 62858.02848729363, 63027.36972630307, 63107.368926311065, 63364.0, 48469.27296090561, 64536.677316614056, 64847.0, 66861.33138668648, 67144.0, 17432.38986635487, 17543.035133067802, 17570.209340579448, 17625.647487050443, 17664.470065898044, 13461.125026873222, 13547.0, 13571.1857288563, 13572.117812342363, 13573.321333933462, 17999.550011249823, 19563.241126462377, 20419.591608167753, 20621.89689051545, 20717.27489537859, 7189.676464559003, 7270.946692049081, 7322.0, 7416.517926334771, 7422.290863834662, 1046.2728403759465, 1095.4139535348709, 1125.4935279124427, 1165.7843298989715, 1220.8767933501201, 32864.0, 34033.0, 34153.0, 34189.82905085458, 34378.82810585931, 1117.3966058328574, 1120.7926533591312, 1152.2049785647876, 1163.7265242667966, 1175.4769127738075, 17262.741058884127, 17906.373276935246, 18206.817931820777, 18216.81783182151, 18248.635027299646, 524914.0, 526048.0, 526343.0, 529363.0, 529939.0, 59817.40182598205, 61152.38847611556, 61429.69285153635, 61437.38562614406, 61458.0, 1380.9792853107213, 1418.8935829812806, 1432.6991331820227, 1434.2613554019688, 1451.5790420778067, 31886.202844928135, 32815.0, 32905.83547082345, 33302.335813135374, 33868.49197262093, 53565.732171338896, 53845.46154538561, 53943.0, 53972.19041714456, 54000.729996349764, 333778.0, 338144.0, 338796.0, 339660.0, 340969.0, 27153.456930861666, 27734.722652773213, 29077.854610727656, 29393.853030735565, 29820.254493637833, 48941.755291223315, 50232.0, 50834.23748643699, 54858.72570637121, 55540.0, 43569.0, 44649.55350446584, 44662.77668611636, 45395.54604454045, 45952.31071533997, 44021.77989110034, 44165.558344416146, 44184.33723494215, 44886.0, 45458.0, 44071.55928440674, 44261.0, 45639.771801140785, 45673.77163114163, 45795.771021146014, 37610.0, 38475.230495389376, 39170.2165956685, 39344.80327598344, 39452.605473944895, 29821.552676709434, 29894.701052989192, 30136.547951780303, 30254.84872575711, 30260.0], "value": 20764.495382459078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.75699174032735, 386.98452061917527, 396.8055652730162, 409.0816117815504, 412.75853625629003, 14549.345279462423, 18256.81743182568, 18416.0, 19962.50093747657, 20048.799512004876, 17824.910875445603, 18141.81858181418, 18633.0, 18922.810771892313, 19066.523336916584, 5606.831795046155, 5784.161296611988, 5807.593468457209, 5815.47660710536, 5841.941580584204, 4126.298529250034, 5709.029464990941, 5727.34135574408, 5814.563907706939, 6071.635701857903, 6080.574359794816, 6099.7865074722395, 6120.602160859552, 6133.969330153343, 6136.140940268344, 6036.305824830135, 6069.817905462844, 6207.162033125538, 6213.0, 6219.222597175353, 5313.548348390392, 5400.945990540084, 5408.107662235727, 5417.404085550586, 5424.728763561806, 23230.30309090713, 23384.18155364571, 23427.88286058559, 23556.7644323558, 23981.88009059961, 2438.878056097188, 2486.552420564298, 2683.892644294226, 2701.972980270192, 2808.003158878589, 13849.792253116211, 14245.934339520814, 14785.852141478555, 15138.80487329342, 15286.159261240628, 1982.5836574319267, 1988.801119888014, 2003.8998050097582, 2038.2152871144567, 2056.938291851247, 63810.68094659497, 70074.64962675155, 71597.64201179013, 77568.0, 78858.0, 10815.40515271652, 10981.945090274497, 11014.614488492864, 11032.669019929415, 11205.607803726993, 15053.473128440672, 15151.545453636409, 15215.0, 15228.46700365482, 15243.466478673416, 8059.234372734698, 8331.750047498585, 8385.874211886827, 8426.620802063799, 8476.194761497647, 7942.285194332538, 8295.62669679866, 8323.95838020806, 8446.155384461628, 8517.06312305646, 6684.131062961881, 6769.120014398097, 6825.453963682893, 6877.1747390313485, 7067.575945443187, 1898.8955607441724, 1957.4421289932302, 2004.2183548416128, 2036.3483685220588, 2041.765197002334, 947.1617618407621, 987.5407935310116, 1014.1734486393566, 1053.204830353094, 1095.27164435651, 18312.542186445444, 18852.905735471235, 19172.90413547923, 19568.90215548913, 20739.688904666444, 1009.7021378693303, 1018.034754630724, 1018.5263852308713, 1021.7343490692474, 1028.6554004408458, 10840.783184336427, 11418.486168122454, 11443.0, 11586.826197607043, 11641.359725215194, 345956.0, 354303.0, 355520.0, 470886.0, 494437.0, 88920.5553972226, 95685.0, 96991.0, 99745.0, 99905.0, 973.1096047116808, 1074.9408782517037, 1085.6960051185522, 1107.0977153619774, 1110.9166812489095, 16253.756193656867, 16859.662806744043, 18014.909925450287, 18032.6557547518, 18211.635767284846, 36285.27429451343, 37583.43624845684, 38922.61077389303, 42392.1521569573, 42992.57007430011, 55939.72030139986, 56303.43696563146, 58298.0, 59062.0, 59321.70339148277, 8572.0, 8687.478751274944, 8771.605277762388, 9027.819443610959, 9129.360944733804, 12457.314847683101, 12523.93738031304, 12656.936715316364, 12864.807027894401, 12868.227906325275, 11520.884791152317, 11581.13141514373, 11681.941590291994, 11773.587924422603, 11832.230904991147, 11086.944565277123, 11096.944515277371, 11305.604303849326, 11320.26418282809, 11462.770744584896, 11854.110941679237, 11908.702282442662, 12129.150959433107, 12198.085143614087, 12649.0, 8768.298536117223, 8812.867806982773, 8844.690435834715, 8933.731988040368, 9025.593848276712, 9133.45199288045, 11706.356150411468, 11849.170558060852, 12131.636050918487, 12492.875071249171], "value": 9437.91151819707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.8300212473441, 1511.501204602481, 1550.426342253366, 1680.6638672265542, 1826.844718198953, 8653.653853845846, 9056.818863622724, 9069.13843184898, 9376.156145946863, 9385.483798391086, 9118.81762364754, 9349.579268932897, 9355.812883742321, 9356.25149988001, 9360.344775865693, 2400.4238982644215, 2426.46617744096, 2430.8176886733477, 2431.1247950737807, 2432.063655492639, 2311.572359113561, 2343.086196383412, 2347.495288512969, 2350.576896158691, 2375.180562705864, 2376.0970831084164, 2389.3309873235435, 2399.5800734871414, 2405.5429468401035, 2422.5760491913934, 2258.864468131901, 2282.429392651837, 2288.39357570244, 2301.436148143707, 2308.503671710582, 2238.0, 2301.7813307735737, 2304.884755762222, 2306.5041016181603, 2308.180595888469, 7752.496087754334, 8771.78070548235, 8940.821183576358, 8984.371094023421, 8985.910140898639, 5268.92096618551, 5341.252224688546, 5357.624966252364, 5361.169018802092, 5366.195070739382, 3405.880794172192, 3503.1417302760733, 3525.8589656413715, 3540.309639620275, 3541.38025845476, 1102.1458369763418, 1112.4382186995597, 1129.7627498225384, 1141.2068612314445, 1156.0462618339902, 12868.356582170854, 12981.610551683465, 13031.674208144777, 13044.28256445895, 13064.477420903153, 4872.098661747588, 4872.3909511311085, 4892.902141957212, 4916.606671466274, 5005.524475174852, 10754.838677419844, 10843.240973131962, 10897.019268265894, 10915.56337746497, 10918.344899306067, 5434.212039254286, 5435.4237271191705, 5438.2386465894015, 5439.646422982493, 5441.428649991773, 4929.926051109236, 4993.201087825931, 5047.848564543069, 5086.364204474441, 5106.617003724736, 3794.430835374716, 3806.1245913440066, 3892.980535097363, 3894.6105389460827, 3909.8045097745, 1250.987490125087, 1258.4777317413354, 1262.6590820478602, 1272.7327261275236, 1288.4459682336685, 883.1874675298741, 984.7488890333062, 998.2812375090069, 1015.9434188444084, 1028.4651980969854, 6170.6914654268, 6245.656488893063, 6253.78111766086, 6303.558750887394, 6398.520110991694, 419.8488544124113, 420.8653230966061, 430.3609140426464, 433.3348310343607, 433.70074648492437, 4328.8268469260875, 4338.783060846945, 4342.261815491374, 4377.802998865059, 4386.8903277417685, 11256.718582035515, 11551.191416600925, 11769.764604708029, 11769.823452648217, 11789.941050294694, 11585.478653460614, 11594.362310073027, 11598.0, 11600.245984011011, 11600.419979001017, 7891.6054197289905, 8175.3459723222, 8180.141085186089, 8371.623276952552, 8375.916240837514, 6211.627302361872, 6498.122753428416, 6512.153420055362, 6575.704093315908, 6623.304553021863, 10679.786404272027, 10799.838002430128, 10826.02565769053, 10895.182861285593, 10903.509342079784, 10869.347839129678, 10933.398663073289, 11009.339439633648, 11071.225014249247, 11169.88830111721, 7767.300942915164, 7805.765827025199, 7857.332126769289, 7889.3294070004695, 7890.644920978455, 8380.163071832158, 8639.092895245909, 8662.090480499457, 8675.82648347017, 8698.956505217686, 7761.185075566984, 7858.528488290721, 7911.683532658629, 7978.960105199437, 8046.396520261121, 7205.279472052753, 7261.273872612696, 7446.441516886363, 7463.626818659154, 7614.505057171487, 6995.510314277952, 7017.508774385744, 7028.929710702828, 7074.540154889915, 7077.363037326665, 5312.654677445954, 5357.1696387060065, 5385.973070134624, 5432.18517222404, 5437.700926449083, 5471.644343117685, 5516.668999860021, 5546.500814926676, 5681.971590142023, 5735.942640573541], "value": 4680.2933701526445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2638299995012, 322.22344150597064, 322.3601151713849, 336.74743942043466, 340.4671688807017, 5330.626856120069, 5351.545118664909, 5392.703401312921, 5395.571992603334, 5400.648957817744, 5301.946980530193, 5333.706646134461, 5352.0, 5356.1697936819855, 5381.973090134544, 3885.1841113366227, 4011.5587285398583, 4143.011354549818, 4151.481064866892, 4168.749375187447, 4198.790060496978, 4206.537280899099, 4213.536510983789, 4227.175700738358, 4229.873103806891, 4123.216588848124, 4182.16356728654, 4183.874483765492, 4188.308929026707, 4189.141226048653, 4016.136530645896, 4043.818028188709, 4119.176164767058, 4185.832566697329, 4201.978990105061, 3658.5426821647293, 3676.2721520885143, 3684.9815750921075, 3689.1883785567134, 3704.573973992998, 5119.462456442057, 5121.513456221653, 5135.255387968724, 5147.845564633029, 5171.198464238049, 4547.749873756942, 4767.213409787381, 4774.474807771142, 4816.373871396696, 4844.0, 5601.29983752031, 5627.831165065055, 5628.859278518029, 5633.633813802131, 5654.0, 4014.4379786829577, 4026.094128821021, 4070.6336429721173, 4096.160287141129, 4110.445089912853, 5698.031334673115, 5775.797847075374, 5801.795317779259, 5832.387599302097, 5868.501177399926, 4107.856225032169, 4111.753294802322, 4114.547399786021, 4132.194222126656, 4137.54487006429, 4199.769012704331, 4231.301835197158, 4236.788160591958, 4239.173361194599, 4263.126059157865, 4684.718916864931, 4795.160846851787, 4875.512448755097, 4890.779914903838, 4901.926471102936, 5602.467765562265, 5639.915401268984, 5648.943510564924, 5661.490465858093, 5666.838298148952, 1426.7574512332928, 1446.24795106544, 1447.4499690117689, 1455.3669153917867, 1462.349254581701, 898.9955050224838, 927.7216834949623, 938.5870217104589, 939.9906000939903, 951.6526467839188, 4725.645576581702, 4737.2183589708, 4747.240441529339, 4756.904861902743, 4758.809647614056, 5085.3134826797905, 5124.487551244845, 5126.385188665633, 5134.766376626105, 5154.742262886915, 4584.014436896084, 4790.760461976957, 4815.22956326986, 4816.349792778, 4834.20235661112, 2723.8832078847577, 2741.917742467729, 2757.786573907474, 2760.7929405294685, 2790.4279622677304, 5100.7959681613065, 5353.250544923714, 5391.51733273353, 5423.7830486780085, 5425.891482170335, 4797.832075877328, 5191.662541934762, 5226.451222621646, 5229.424763276036, 5617.43825617435, 5816.651000939873, 5907.2911250650195, 5939.990201665727, 5950.2264705587995, 5961.4038596140035, 5740.856478588069, 5783.652980821164, 5786.566007549366, 5809.128630705428, 5876.531856620315, 5518.751656175402, 5762.567807414544, 5769.5576105973505, 5774.56690748204, 5774.740136693775, 5978.372270911492, 5984.13230081627, 5993.460588547052, 6003.249593800775, 6005.249343832021, 4145.0, 4149.958500414958, 4157.521884983265, 4186.644135248416, 4187.806475154566, 5561.416051314553, 5821.650700957956, 5827.24245848054, 5830.2129212555765, 5835.620684655484, 5551.19664569406, 5580.35825880029, 5645.858853528694, 5651.0, 5662.980663480613, 5255.973720131375, 5512.747478987417, 5562.582806289625, 5629.521490673339, 5641.605087643826, 5528.364238112668, 5538.584606154635, 5545.916811247916, 5550.861228469321, 5602.4957753802355, 5727.856803579777, 5758.3090029196765, 5765.971170144123, 5817.272840894888, 5821.243238378984, 5466.289382380265, 5568.387477377404, 5584.860378490408, 5586.273784408001, 5616.38219795814], "value": 4209.027063100516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.2030189357799, 808.8907997420347, 815.0708192660364, 858.8711693246013, 888.3293113699157, 15049.62375940602, 15183.39266429343, 15354.923225383858, 15407.38370465183, 15409.152496612696, 14133.081349712262, 14202.644933876632, 14203.502877399293, 14205.218712970782, 14225.359858806352, 697.5152269172927, 809.0049239435498, 810.720301495983, 813.5688085314792, 817.9100298967109, 811.4765975945542, 815.8980127484065, 817.4931542443693, 817.7873752824249, 818.2104269380047, 726.3862036579109, 859.1666083898608, 859.7334826203866, 859.9183077607618, 860.311750599521, 858.8368210040104, 862.1507814802414, 864.3733293362325, 866.7746385939638, 869.7086476030537, 633.8003528888386, 634.1154090044408, 634.5462993959295, 634.7461015593753, 634.9206349206349, 12468.501259949591, 12493.500259989589, 12520.373981300989, 12536.874631253662, 12557.372131393393, 13441.193528388329, 13597.866220802345, 13616.591502254949, 13627.931860340734, 13631.318434078257, 12203.45084471201, 12557.74884502314, 12564.937175314157, 12654.620361389081, 12709.046821488333, 4453.9109217815785, 4454.443194600675, 4482.910341793178, 4524.728516289033, 4557.817687292504, 57316.42683573152, 58389.12416313759, 59106.40893591052, 60068.0, 60317.6984115081, 11023.338599684044, 11078.0, 11098.0, 11186.32882027081, 11215.831762523569, 19800.306989255307, 19834.404967850987, 20156.395308140487, 20255.392338229878, 20277.0, 8244.670213191524, 8270.545120018456, 8274.0, 8287.088420273765, 8611.39720219591, 4927.236278376858, 4949.876253093701, 4961.2558116282125, 5028.622853285945, 5096.108181068373, 3633.291508155937, 3754.1928485375774, 3755.3240416724707, 3762.341590221755, 3768.5666148393284, 603.4960807725511, 694.447913908444, 708.9787306380714, 730.777112980546, 732.7984804178786, 762.4815125714567, 776.9883451748228, 783.2637320918318, 786.4612740272931, 792.5500297206192, 10231.897681023243, 10384.792304153874, 10428.322159059637, 10485.737856553495, 10506.317089389166, 795.3393116338253, 798.5847359373093, 807.2855522862309, 810.6392655268467, 820.3765138494667, 4781.187198176319, 4884.5603895649565, 4920.0, 4922.1140194765285, 4969.378827646544, 60737.0, 62540.0, 62591.6870415645, 73958.63020684863, 74993.62503187449, 61735.0, 62301.68849155725, 63354.0, 63611.36388636147, 64244.357556423834, 57939.8412031757, 57957.420425796045, 58360.41639583635, 58404.0, 59160.0, 9446.149846513847, 9488.715338539854, 9525.476098814632, 9665.081817227352, 9701.417914925127, 37114.0, 38001.42997854979, 38365.61634383732, 38695.419568705925, 39230.0, 47906.76046619745, 50974.23538646849, 51635.48364516307, 51733.7413312931, 52420.0, 12583.559575414816, 12621.87378126207, 12933.159344642945, 13011.609651710463, 13268.93365533166, 13139.60581182566, 14555.636109097357, 15004.924975375054, 15027.173505456867, 15417.69164616679, 14174.291285435893, 14310.785338219726, 14392.136471811726, 14590.85409145895, 14672.926635366755, 13507.459701612219, 14082.436702531784, 14228.928855355656, 14844.851551484779, 14931.178785166485, 13770.0, 13807.516736914562, 13895.791563126764, 14414.279286035866, 14466.493672721404, 9591.664291749756, 9696.75758106053, 9733.513324333613, 9822.165115965223, 10054.296199266273, 10182.33743409488, 10184.898151018395, 10228.289503281785, 10263.640772573222, 10328.328658637165], "value": 7157.14194098169, "unit": "score"}], "name": "dromaeo_css", "value": 7274.000124172983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 112.0, 109.0, 109.0, 110.0, 108.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 150.0, 205.0, 124.0, 149.0, 153.0, 126.0, 177.0, 131.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 160.0, 160.0, 159.0, 161.0, 162.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 153.0, 74.0, 74.0, 76.0, 76.0, 149.0, 75.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 145.0, 91.0, 92.0, 91.0, 118.0, 91.0, 90.0, 123.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 118.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 55.0, 55.0, 56.0, 55.0, 113.0, 53.0, 51.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 78.0, 79.0, 79.0, 84.0, 79.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 118.0, 119.0, 120.0, 118.0, 118.0, 121.0, 197.0, 126.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 164.0, 160.0, 163.0, 161.0, 159.0, 164.0, 159.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1520.5, "alertThreshold": 2.0}]} 14:02:24 INFO - Return code: 0 14:02:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:02:24 ERROR - # TBPL SUCCESS # 14:02:24 INFO - Running post-action listener: _resource_record_post_action 14:02:24 INFO - ##### 14:02:24 INFO - ##### Finished run-tests step (success) 14:02:24 INFO - ##### 14:02:24 INFO - Running post-run listener: _resource_record_post_run 14:02:24 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550658048; Read time: 20; Write time: 436116 14:02:24 INFO - TinderboxPrint: CPU usage
13.1% 14:02:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:02:24 INFO - TinderboxPrint: I/O write bytes / time
550,658,048 / 436,116 14:02:24 INFO - TinderboxPrint: CPU idle
8,277.8 (86.9%) 14:02:24 INFO - TinderboxPrint: CPU user
1,205.0 (12.6%) 14:02:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:02:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261787648; Read time: 0; Write time: 243448 14:02:24 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288686080; Read time: 20; Write time: 192648 14:02:24 INFO - Running post-run listener: _upload_blobber_files 14:02:24 INFO - Blob upload gear active. 14:02:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:02:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:02:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:25 INFO - (blobuploader) - INFO - Done attempting. 14:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:02:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:29 INFO - (blobuploader) - INFO - Done attempting. 14:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:30 INFO - (blobuploader) - INFO - Done attempting. 14:02:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:02:30 INFO - Return code: 0 14:02:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:02:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:02:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df3cf26e7874f688f060dc9fd5a810c164dfad4d9c48e0e1a32d849f11ba7cf34f270dc233bd21a054d105b56caaa31565ef6c7b93ebc327e8ca673ce55d989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be462837cdcce947ed47bbd1b9b19efdd4a3da85e4f85846dd2e328f3aa22e546efce20cb0e8e49962507934131bd1b0a5239830988d0508987af68a9f7a0ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fadf9c33bffbbd3e1e75090df51f6471f789612fa1fa5478675a537919fc9491c96eef221367bb5a98c9ceeef7cc020c8b49fc16eccb789957ae75dfc252614"} 14:02:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:02:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:02:30 INFO - Contents: 14:02:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df3cf26e7874f688f060dc9fd5a810c164dfad4d9c48e0e1a32d849f11ba7cf34f270dc233bd21a054d105b56caaa31565ef6c7b93ebc327e8ca673ce55d989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be462837cdcce947ed47bbd1b9b19efdd4a3da85e4f85846dd2e328f3aa22e546efce20cb0e8e49962507934131bd1b0a5239830988d0508987af68a9f7a0ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fadf9c33bffbbd3e1e75090df51f6471f789612fa1fa5478675a537919fc9491c96eef221367bb5a98c9ceeef7cc020c8b49fc16eccb789957ae75dfc252614"} 14:02:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:02:30 INFO - Copying logs to upload dir... 14:02:30 INFO - mkdir: /builds/slave/test/build/upload/logs 14:02:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.958202 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-13 14:02:30.097312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:02:30.100944) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df3cf26e7874f688f060dc9fd5a810c164dfad4d9c48e0e1a32d849f11ba7cf34f270dc233bd21a054d105b56caaa31565ef6c7b93ebc327e8ca673ce55d989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be462837cdcce947ed47bbd1b9b19efdd4a3da85e4f85846dd2e328f3aa22e546efce20cb0e8e49962507934131bd1b0a5239830988d0508987af68a9f7a0ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fadf9c33bffbbd3e1e75090df51f6471f789612fa1fa5478675a537919fc9491c96eef221367bb5a98c9ceeef7cc020c8b49fc16eccb789957ae75dfc252614"} build_url:https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df3cf26e7874f688f060dc9fd5a810c164dfad4d9c48e0e1a32d849f11ba7cf34f270dc233bd21a054d105b56caaa31565ef6c7b93ebc327e8ca673ce55d989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be462837cdcce947ed47bbd1b9b19efdd4a3da85e4f85846dd2e328f3aa22e546efce20cb0e8e49962507934131bd1b0a5239830988d0508987af68a9f7a0ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fadf9c33bffbbd3e1e75090df51f6471f789612fa1fa5478675a537919fc9491c96eef221367bb5a98c9ceeef7cc020c8b49fc16eccb789957ae75dfc252614"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:02:30.125190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:02:30.125500) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463172106.182962-877557518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:02:30.208294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:02:30.208622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:02:30.208947) ========= ========= Total master_lag: 0.17 =========