builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1463451257.84 results: success (0) buildid: 20160516163016 builduid: 643fa4e81f97488584908b7cf1ecf951 revision: a884b96685aa13b65601feddb24e5f85ba861561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:17.842020) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:17.842475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:17.842810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:17.878285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:17.878611) ========= 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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 19:14:19-- 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% 224M=0s 2016-05-16 19:14:19 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.173400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.174203) ========= 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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021737 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.229304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.230129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a884b96685aa13b65601feddb24e5f85ba861561 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a884b96685aa13b65601feddb24e5f85ba861561 --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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 19:14:19,489 truncating revision to first 12 chars 2016-05-16 19:14:19,489 Setting DEBUG logging. 2016-05-16 19:14:19,489 attempt 1/10 2016-05-16 19:14:19,489 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a884b96685aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 19:14:19,748 unpacking tar archive at: mozilla-central-a884b96685aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.775083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.775896) ========= script_repo_revision: a884b96685aa13b65601feddb24e5f85ba861561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.776953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.777704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 19:14:18.792127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 19:14:18.792443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:14:20 INFO - MultiFileLogger online at 20160516 19:14:20 in /builds/slave/test 19:14:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:14:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:14:20 INFO - {'append_to_log': False, 19:14:20 INFO - 'base_work_dir': '/builds/slave/test', 19:14:20 INFO - 'blob_upload_branch': 'Firefox', 19:14:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:14:20 INFO - 'branch': 'Firefox', 19:14:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:14:20 INFO - 'config_files': ('talos/linux_config.py',), 19:14:20 INFO - 'default_actions': ('clobber', 19:14:20 INFO - 'read-buildbot-config', 19:14:20 INFO - 'download-and-extract', 19:14:20 INFO - 'populate-webroot', 19:14:20 INFO - 'create-virtualenv', 19:14:20 INFO - 'install', 19:14:20 INFO - 'run-tests'), 19:14:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:14:20 INFO - 'download_minidump_stackwalk': True, 19:14:20 INFO - 'download_symbols': 'ondemand', 19:14:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:14:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:14:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:14:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:14:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:14:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:14:20 INFO - 'installer_path': 'installer.exe', 19:14:20 INFO - 'log_level': 'info', 19:14:20 INFO - 'log_name': 'talos', 19:14:20 INFO - 'log_to_console': True, 19:14:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:14:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:14:20 INFO - 'opt_config_files': (), 19:14:20 INFO - 'pip_index': False, 19:14:20 INFO - 'sps_profile': False, 19:14:20 INFO - 'sps_profile_interval': 0, 19:14:20 INFO - 'suite': 'dromaeojs', 19:14:20 INFO - 'system_bits': '32', 19:14:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:14:20 INFO - 'title': 'talos-linux64-ix-044', 19:14:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:14:20 INFO - 'use_talos_json': True, 19:14:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:14:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:14:20 INFO - 'work_dir': 'build'} 19:14:20 INFO - ##### 19:14:20 INFO - ##### Running clobber step. 19:14:20 INFO - ##### 19:14:20 INFO - Running pre-action listener: _resource_record_pre_action 19:14:20 INFO - Running main action method: clobber 19:14:20 INFO - rmtree: /builds/slave/test/build 19:14:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:14:20 INFO - Running post-action listener: _resource_record_post_action 19:14:20 INFO - ##### 19:14:20 INFO - ##### Finished clobber step (success) 19:14:20 INFO - ##### 19:14:20 INFO - ##### 19:14:20 INFO - ##### Running read-buildbot-config step. 19:14:20 INFO - ##### 19:14:20 INFO - Running pre-action listener: _resource_record_pre_action 19:14:20 INFO - Running main action method: read_buildbot_config 19:14:20 INFO - Using buildbot properties: 19:14:20 INFO - { 19:14:20 INFO - "project": "", 19:14:20 INFO - "product": "firefox", 19:14:20 INFO - "script_repo_revision": "production", 19:14:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:14:20 INFO - "repository": "", 19:14:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:14:20 INFO - "buildid": "20160516163016", 19:14:20 INFO - "pgo_build": "True", 19:14:20 INFO - "basedir": "/builds/slave/test", 19:14:20 INFO - "buildnumber": 288, 19:14:20 INFO - "slavename": "talos-linux64-ix-044", 19:14:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:14:20 INFO - "platform": "ubuntu64_hw", 19:14:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:14:20 INFO - "branch": "mozilla-central", 19:14:20 INFO - "repo_path": "mozilla-central", 19:14:20 INFO - "revision": "a884b96685aa13b65601feddb24e5f85ba861561", 19:14:20 INFO - "stage_platform": "linux64-pgo", 19:14:20 INFO - "builduid": "643fa4e81f97488584908b7cf1ecf951", 19:14:20 INFO - "slavebuilddir": "test" 19:14:20 INFO - } 19:14:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:14:20 INFO - Running post-action listener: _resource_record_post_action 19:14:20 INFO - ##### 19:14:20 INFO - ##### Finished read-buildbot-config step (success) 19:14:20 INFO - ##### 19:14:20 INFO - ##### 19:14:20 INFO - ##### Running download-and-extract step. 19:14:20 INFO - ##### 19:14:20 INFO - Running pre-action listener: _resource_record_pre_action 19:14:20 INFO - Running main action method: download_and_extract 19:14:20 INFO - mkdir: /builds/slave/test/build/tests 19:14: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')]} 19:14:20 INFO - https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:23 INFO - Downloaded 1361 bytes. 19:14:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:14:23 INFO - Using the following test package requirements: 19:14:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:14:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:14:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:14:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'jsshell-linux-x86_64.zip'], 19:14:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:14:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:14:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:14:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:14:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:14:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:14:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:14:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:14: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')]} 19:14:23 INFO - https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:31 INFO - Downloaded 24023644 bytes. 19:14:31 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'] 19:14:31 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 19:14:32 INFO - Return code: 0 19:14:32 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 19:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:32 INFO - https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:34 INFO - Downloaded 24023644 bytes. 19:14:34 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'] 19:14:34 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 19:14:36 INFO - Return code: 0 19:14:36 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')]} 19:14:36 INFO - https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:37 INFO - Downloaded 10840194 bytes. 19:14:37 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'] 19:14:37 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 19:14:37 INFO - Return code: 0 19:14:37 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')]} 19:14:37 INFO - https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/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 19:14:38 INFO - Downloaded 58430661 bytes. 19:14:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:14:38 INFO - mkdir: /builds/slave/test/properties 19:14:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:14:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:14:38 INFO - Contents: 19:14:38 INFO - build_url:https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:14:39 INFO - Running post-action listener: _resource_record_post_action 19:14:39 INFO - Running post-action listener: set_extra_try_arguments 19:14:39 INFO - ##### 19:14:39 INFO - ##### Finished download-and-extract step (success) 19:14:39 INFO - ##### 19:14:39 INFO - ##### 19:14:39 INFO - ##### Running populate-webroot step. 19:14:39 INFO - ##### 19:14:39 INFO - Running pre-action listener: _resource_record_pre_action 19:14:39 INFO - Running main action method: populate_webroot 19:14:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:14:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:14:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:14:39 INFO - '--tppagecycles', 19:14:39 INFO - '7'], 19:14:39 INFO - 'tests': ['tsvgm']}}, 19:14:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:14:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:14:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:14:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:14:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['damp', 'tps']}, 19:14:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'tests': ['damp', 'tps']}, 19:14:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['dromaeo_dom']}, 19:14:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:14:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'other-e10s': {'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['a11yr', 19:14:39 INFO - 'ts_paint', 19:14:39 INFO - 'tpaint', 19:14:39 INFO - 'sessionrestore', 19:14:39 INFO - 'sessionrestore_no_auto_restore', 19:14:39 INFO - 'tabpaint']}, 19:14:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['tsvgx', 19:14:39 INFO - 'tsvgr_opacity', 19:14:39 INFO - 'tart', 19:14:39 INFO - 'tscrollx', 19:14:39 INFO - 'cart']}, 19:14:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:14:39 INFO - 'tsvgr_opacity', 19:14:39 INFO - 'tart', 19:14:39 INFO - 'tscrollx', 19:14:39 INFO - 'cart']}, 19:14:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'talos_options': ['--disable-e10s'], 19:14:39 INFO - 'tests': ['tp5o']}, 19:14:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'tests': ['tp5o']}, 19:14:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'talos_options': ['--disable-e10s', 19:14:39 INFO - '--xperf_path', 19:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:39 INFO - 'tests': ['tp5n']}, 19:14:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:39 INFO - 'talos_options': ['--xperf_path', 19:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:39 INFO - 'tests': ['tp5n']}}, 19:14:39 INFO - 'talos.zip': {'path': '', 19:14:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:14:39 INFO - Running post-action listener: _resource_record_post_action 19:14:39 INFO - ##### 19:14:39 INFO - ##### Finished populate-webroot step (success) 19:14:39 INFO - ##### 19:14:39 INFO - ##### 19:14:39 INFO - ##### Running create-virtualenv step. 19:14:39 INFO - ##### 19:14:39 INFO - Running pre-action listener: _resource_record_pre_action 19:14:39 INFO - Running main action method: create_virtualenv 19:14:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:14:39 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 19:14:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:14:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:14:39 INFO - Using real prefix '/usr' 19:14:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:14:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:14:41 INFO - Installing pip.................done. 19:14:41 INFO - Return code: 0 19:14:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:14:41 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')]} 19:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:41 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')]} 19:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:41 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:41 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 19:14:41 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 19:14:41 INFO - Using env: {'DISPLAY': ':0', 19:14:41 INFO - 'HOME': '/home/cltbld', 19:14:41 INFO - 'LANG': 'en_US.UTF-8', 19:14:41 INFO - 'LANGUAGE': 'en_US:en', 19:14:41 INFO - 'LOGNAME': 'cltbld', 19:14:41 INFO - 'MAIL': '/var/mail/cltbld', 19:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:41 INFO - 'MOZ_NO_REMOTE': '1', 19:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:41 INFO - 'NO_EM_RESTART': '1', 19:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:41 INFO - 'PWD': '/builds/slave/test', 19:14:41 INFO - 'SHELL': '/bin/bash', 19:14:41 INFO - 'SHLVL': '1', 19:14:41 INFO - 'TERM': 'linux', 19:14:41 INFO - 'TMOUT': '86400', 19:14:41 INFO - 'USER': 'cltbld', 19:14:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:41 INFO - '_': '/tools/buildbot/bin/python'} 19:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:42 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 19:14:42 INFO - Cleaning up... 19:14:42 INFO - Return code: 0 19:14:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:14:42 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')]} 19:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:42 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')]} 19:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:42 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:42 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 19:14:42 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 19:14:42 INFO - Using env: {'DISPLAY': ':0', 19:14:42 INFO - 'HOME': '/home/cltbld', 19:14:42 INFO - 'LANG': 'en_US.UTF-8', 19:14:42 INFO - 'LANGUAGE': 'en_US:en', 19:14:42 INFO - 'LOGNAME': 'cltbld', 19:14:42 INFO - 'MAIL': '/var/mail/cltbld', 19:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:42 INFO - 'MOZ_NO_REMOTE': '1', 19:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:42 INFO - 'NO_EM_RESTART': '1', 19:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:42 INFO - 'PWD': '/builds/slave/test', 19:14:42 INFO - 'SHELL': '/bin/bash', 19:14:42 INFO - 'SHLVL': '1', 19:14:42 INFO - 'TERM': 'linux', 19:14:42 INFO - 'TMOUT': '86400', 19:14:42 INFO - 'USER': 'cltbld', 19:14:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:42 INFO - '_': '/tools/buildbot/bin/python'} 19:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:42 INFO - Downloading/unpacking psutil>=3.1.1 19:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:44 INFO - Installing collected packages: psutil 19:14:44 INFO - Running setup.py install for psutil 19:14:44 INFO - building 'psutil._psutil_linux' extension 19:14:44 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 19:14:44 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 19:14:44 INFO - building 'psutil._psutil_posix' extension 19:14:44 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 19:14:44 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 19:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:44 INFO - Successfully installed psutil 19:14:44 INFO - Cleaning up... 19:14:44 INFO - Return code: 0 19:14:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:14:44 INFO - Using env: {'DISPLAY': ':0', 19:14:44 INFO - 'HOME': '/home/cltbld', 19:14:44 INFO - 'LANG': 'en_US.UTF-8', 19:14:44 INFO - 'LANGUAGE': 'en_US:en', 19:14:44 INFO - 'LOGNAME': 'cltbld', 19:14:44 INFO - 'MAIL': '/var/mail/cltbld', 19:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:44 INFO - 'MOZ_NO_REMOTE': '1', 19:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:44 INFO - 'NO_EM_RESTART': '1', 19:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:44 INFO - 'PWD': '/builds/slave/test', 19:14:44 INFO - 'SHELL': '/bin/bash', 19:14:44 INFO - 'SHLVL': '1', 19:14:44 INFO - 'TERM': 'linux', 19:14:44 INFO - 'TMOUT': '86400', 19:14:44 INFO - 'USER': 'cltbld', 19:14:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:44 INFO - '_': '/tools/buildbot/bin/python'} 19:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:14:45 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 19:14:45 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 19:14:45 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 19:14:45 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 19:14:45 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 19:14:45 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 19:14:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:14:47 INFO - Installing collected packages: mozsystemmonitor 19:14:47 INFO - Running setup.py install for mozsystemmonitor 19:14:47 INFO - Successfully installed mozsystemmonitor 19:14:47 INFO - Cleaning up... 19:14:47 INFO - Return code: 0 19:14:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:47 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:47 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 19:14:47 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 19:14:47 INFO - Using env: {'DISPLAY': ':0', 19:14:47 INFO - 'HOME': '/home/cltbld', 19:14:47 INFO - 'LANG': 'en_US.UTF-8', 19:14:47 INFO - 'LANGUAGE': 'en_US:en', 19:14:47 INFO - 'LOGNAME': 'cltbld', 19:14:47 INFO - 'MAIL': '/var/mail/cltbld', 19:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:47 INFO - 'MOZ_NO_REMOTE': '1', 19:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:47 INFO - 'NO_EM_RESTART': '1', 19:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:47 INFO - 'PWD': '/builds/slave/test', 19:14:47 INFO - 'SHELL': '/bin/bash', 19:14:47 INFO - 'SHLVL': '1', 19:14:47 INFO - 'TERM': 'linux', 19:14:47 INFO - 'TMOUT': '86400', 19:14:47 INFO - 'USER': 'cltbld', 19:14:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:47 INFO - '_': '/tools/buildbot/bin/python'} 19:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:14:47 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 19:14:47 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 19:14:47 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 19:14:47 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 19:14:47 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 19:14:47 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 19:14:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:50 INFO - Downloading docopt-0.6.1.tar.gz 19:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:14:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:14:50 INFO - Running setup.py install for blobuploader 19:14:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:14:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:14:50 INFO - Running setup.py install for requests 19:14:50 INFO - Running setup.py install for docopt 19:14:50 INFO - Successfully installed blobuploader requests docopt 19:14:50 INFO - Cleaning up... 19:14:50 INFO - Return code: 0 19:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:50 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')]} 19:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:50 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')]} 19:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:50 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:50 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 19:14:50 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 19:14:50 INFO - Using env: {'DISPLAY': ':0', 19:14:50 INFO - 'HOME': '/home/cltbld', 19:14:50 INFO - 'LANG': 'en_US.UTF-8', 19:14:50 INFO - 'LANGUAGE': 'en_US:en', 19:14:50 INFO - 'LOGNAME': 'cltbld', 19:14:50 INFO - 'MAIL': '/var/mail/cltbld', 19:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:50 INFO - 'MOZ_NO_REMOTE': '1', 19:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:50 INFO - 'NO_EM_RESTART': '1', 19:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:50 INFO - 'PWD': '/builds/slave/test', 19:14:50 INFO - 'SHELL': '/bin/bash', 19:14:50 INFO - 'SHLVL': '1', 19:14:50 INFO - 'TERM': 'linux', 19:14:50 INFO - 'TMOUT': '86400', 19:14:50 INFO - 'USER': 'cltbld', 19:14:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:50 INFO - '_': '/tools/buildbot/bin/python'} 19:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:50 INFO - Running setup.py (path:/tmp/pip-VPpq89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:51 INFO - Running setup.py (path:/tmp/pip-BO33JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:51 INFO - Running setup.py (path:/tmp/pip-8exC1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:51 INFO - Running setup.py (path:/tmp/pip-cdrFPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:51 INFO - Running setup.py (path:/tmp/pip-n9QeN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:51 INFO - Running setup.py (path:/tmp/pip-xfbNRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:51 INFO - Running setup.py (path:/tmp/pip-52dYKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:51 INFO - Running setup.py (path:/tmp/pip-TZ0V0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:51 INFO - Running setup.py (path:/tmp/pip-tr1drE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:51 INFO - Running setup.py (path:/tmp/pip-MoBAjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:51 INFO - Running setup.py (path:/tmp/pip-OyTW9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:51 INFO - Running setup.py (path:/tmp/pip-J58JMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:51 INFO - Running setup.py (path:/tmp/pip-KMCTmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:51 INFO - Running setup.py (path:/tmp/pip-HA0cdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:51 INFO - Running setup.py (path:/tmp/pip-BxYLFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:52 INFO - Running setup.py (path:/tmp/pip-_XIRR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:52 INFO - Running setup.py (path:/tmp/pip-CmjFjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:14:52 INFO - Running setup.py install for manifestparser 19:14:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Running setup.py install for mozcrash 19:14:52 INFO - Running setup.py install for mozdebug 19:14:52 INFO - Running setup.py install for mozdevice 19:14:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Running setup.py install for mozfile 19:14:52 INFO - Running setup.py install for mozhttpd 19:14:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Running setup.py install for mozinfo 19:14:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Running setup.py install for mozInstall 19:14:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:14:52 INFO - Running setup.py install for mozleak 19:14:53 INFO - Running setup.py install for mozlog 19:14:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Running setup.py install for moznetwork 19:14:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Running setup.py install for mozprocess 19:14:53 INFO - Running setup.py install for mozprofile 19:14:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Running setup.py install for mozrunner 19:14:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Running setup.py install for mozscreenshot 19:14:53 INFO - Running setup.py install for moztest 19:14:53 INFO - Running setup.py install for mozversion 19:14:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:14:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:14:53 INFO - Cleaning up... 19:14:53 INFO - Return code: 0 19:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:53 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')]} 19:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:53 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')]} 19:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:53 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:53 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 19:14:53 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 19:14:53 INFO - Using env: {'DISPLAY': ':0', 19:14:53 INFO - 'HOME': '/home/cltbld', 19:14:53 INFO - 'LANG': 'en_US.UTF-8', 19:14:53 INFO - 'LANGUAGE': 'en_US:en', 19:14:53 INFO - 'LOGNAME': 'cltbld', 19:14:53 INFO - 'MAIL': '/var/mail/cltbld', 19:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:53 INFO - 'MOZ_NO_REMOTE': '1', 19:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:53 INFO - 'NO_EM_RESTART': '1', 19:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:53 INFO - 'PWD': '/builds/slave/test', 19:14:53 INFO - 'SHELL': '/bin/bash', 19:14:53 INFO - 'SHLVL': '1', 19:14:53 INFO - 'TERM': 'linux', 19:14:53 INFO - 'TMOUT': '86400', 19:14:53 INFO - 'USER': 'cltbld', 19:14:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:53 INFO - '_': '/tools/buildbot/bin/python'} 19:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:54 INFO - Running setup.py (path:/tmp/pip-hWo12F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:54 INFO - Running setup.py (path:/tmp/pip-aSbbk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:54 INFO - Running setup.py (path:/tmp/pip-WUgqEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:54 INFO - Running setup.py (path:/tmp/pip-TZ46az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:54 INFO - Running setup.py (path:/tmp/pip-GUvnJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:54 INFO - Running setup.py (path:/tmp/pip-rL6vea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:54 INFO - Running setup.py (path:/tmp/pip-XF5mnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:54 INFO - Running setup.py (path:/tmp/pip-ocbpqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:54 INFO - Running setup.py (path:/tmp/pip-2KC0QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:54 INFO - Running setup.py (path:/tmp/pip-Mgqi2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:54 INFO - Running setup.py (path:/tmp/pip-mJicTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:54 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)) 19:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:54 INFO - Running setup.py (path:/tmp/pip-PDCVeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:55 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)) 19:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:55 INFO - Running setup.py (path:/tmp/pip-lvatJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:55 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)) 19:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:55 INFO - Running setup.py (path:/tmp/pip-ogo90s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:55 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)) 19:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:55 INFO - Running setup.py (path:/tmp/pip-wzHkb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:55 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)) 19:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:55 INFO - Running setup.py (path:/tmp/pip-fxY07f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:55 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)) 19:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:55 INFO - Running setup.py (path:/tmp/pip-S6ILfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:55 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)) 19:14:55 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)) 19:14:55 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)) 19:14:55 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)) 19:14:55 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)) 19:14:55 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)) 19:14:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14:55 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 19:14:55 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 19:14:55 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 19:14:55 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 19:14:55 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 19:14:55 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 19:14:57 INFO - Downloading blessings-1.6.tar.gz 19:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:14:57 INFO - Installing collected packages: blessings 19:14:57 INFO - Running setup.py install for blessings 19:14:57 INFO - Successfully installed blessings 19:14:57 INFO - Cleaning up... 19:14:57 INFO - Return code: 0 19:14:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:57 INFO - Reading from file tmpfile_stdout 19:14:57 INFO - Current package versions: 19:14:57 INFO - argparse == 1.2.1 19:14:57 INFO - blessings == 1.6 19:14:57 INFO - blobuploader == 1.2.4 19:14:57 INFO - docopt == 0.6.1 19:14:57 INFO - manifestparser == 1.1 19:14:57 INFO - mozInstall == 1.12 19:14:57 INFO - mozcrash == 0.17 19:14:57 INFO - mozdebug == 0.1 19:14:57 INFO - mozdevice == 0.48 19:14:57 INFO - mozfile == 1.2 19:14:57 INFO - mozhttpd == 0.7 19:14:57 INFO - mozinfo == 0.9 19:14:57 INFO - mozleak == 0.1 19:14:57 INFO - mozlog == 3.2 19:14:57 INFO - moznetwork == 0.27 19:14:57 INFO - mozprocess == 0.22 19:14:57 INFO - mozprofile == 0.28 19:14:57 INFO - mozrunner == 6.11 19:14:57 INFO - mozscreenshot == 0.1 19:14:57 INFO - mozsystemmonitor == 0.3 19:14:57 INFO - moztest == 0.7 19:14:57 INFO - mozversion == 1.4 19:14:57 INFO - psutil == 3.1.1 19:14:57 INFO - requests == 1.2.3 19:14:57 INFO - wsgiref == 0.1.2 19:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:57 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:57 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 19:14:57 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 19:14:57 INFO - Using env: {'DISPLAY': ':0', 19:14:57 INFO - 'HOME': '/home/cltbld', 19:14:57 INFO - 'LANG': 'en_US.UTF-8', 19:14:57 INFO - 'LANGUAGE': 'en_US:en', 19:14:57 INFO - 'LOGNAME': 'cltbld', 19:14:57 INFO - 'MAIL': '/var/mail/cltbld', 19:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:57 INFO - 'MOZ_NO_REMOTE': '1', 19:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:57 INFO - 'NO_EM_RESTART': '1', 19:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:57 INFO - 'PWD': '/builds/slave/test', 19:14:57 INFO - 'SHELL': '/bin/bash', 19:14:57 INFO - 'SHLVL': '1', 19:14:57 INFO - 'TERM': 'linux', 19:14:57 INFO - 'TMOUT': '86400', 19:14:57 INFO - 'USER': 'cltbld', 19:14:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:57 INFO - '_': '/tools/buildbot/bin/python'} 19:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 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)) 19:14:58 INFO - Cleaning up... 19:14:58 INFO - Return code: 0 19:14:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:14:58 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')]} 19:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:58 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')]} 19:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:58 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:14:58 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 19:14:58 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 19:14:58 INFO - Using env: {'DISPLAY': ':0', 19:14:58 INFO - 'HOME': '/home/cltbld', 19:14:58 INFO - 'LANG': 'en_US.UTF-8', 19:14:58 INFO - 'LANGUAGE': 'en_US:en', 19:14:58 INFO - 'LOGNAME': 'cltbld', 19:14:58 INFO - 'MAIL': '/var/mail/cltbld', 19:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:58 INFO - 'MOZ_NO_REMOTE': '1', 19:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:58 INFO - 'NO_EM_RESTART': '1', 19:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:58 INFO - 'PWD': '/builds/slave/test', 19:14:58 INFO - 'SHELL': '/bin/bash', 19:14:58 INFO - 'SHLVL': '1', 19:14:58 INFO - 'TERM': 'linux', 19:14:58 INFO - 'TMOUT': '86400', 19:14:58 INFO - 'USER': 'cltbld', 19:14:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:58 INFO - '_': '/tools/buildbot/bin/python'} 19:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:58 INFO - Downloading/unpacking jsonschema 19:14:58 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 19:14:58 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 19:14:58 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 19:14:58 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 19:14:58 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 19:14:58 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 19:15:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:15:00 INFO - Downloading/unpacking functools32 (from jsonschema) 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:15:00 INFO - warning: no files found matching '*.txt' 19:15:00 INFO - no previously-included directories found matching 'build' 19:15:00 INFO - no previously-included directories found matching 'dist' 19:15:00 INFO - no previously-included directories found matching '.git*' 19:15:00 INFO - Installing collected packages: jsonschema, functools32 19:15:00 INFO - Running setup.py install for functools32 19:15:00 INFO - warning: no files found matching '*.txt' 19:15:00 INFO - no previously-included directories found matching 'build' 19:15:00 INFO - no previously-included directories found matching 'dist' 19:15:00 INFO - no previously-included directories found matching '.git*' 19:15:00 INFO - Successfully installed jsonschema functools32 19:15:00 INFO - Cleaning up... 19:15:00 INFO - Return code: 0 19:15:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:00 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 0x7f3a6cc76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, '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': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', '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 19:15:00 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 19:15:00 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 19:15:00 INFO - Using env: {'DISPLAY': ':0', 19:15:00 INFO - 'HOME': '/home/cltbld', 19:15:00 INFO - 'LANG': 'en_US.UTF-8', 19:15:00 INFO - 'LANGUAGE': 'en_US:en', 19:15:00 INFO - 'LOGNAME': 'cltbld', 19:15:00 INFO - 'MAIL': '/var/mail/cltbld', 19:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:00 INFO - 'MOZ_NO_REMOTE': '1', 19:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:00 INFO - 'NO_EM_RESTART': '1', 19:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:00 INFO - 'PWD': '/builds/slave/test', 19:15:00 INFO - 'SHELL': '/bin/bash', 19:15:00 INFO - 'SHLVL': '1', 19:15:00 INFO - 'TERM': 'linux', 19:15:00 INFO - 'TMOUT': '86400', 19:15:00 INFO - 'USER': 'cltbld', 19:15:00 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:00 INFO - '_': '/tools/buildbot/bin/python'} 19:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:00 INFO - Downloading/unpacking flake8 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:00 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 19:15:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:15:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:15:02 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 19:15:02 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 19:15:02 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 19:15:02 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 19:15:02 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 19:15:02 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 19:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 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 19:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:15:03 INFO - no previously-included directories found matching 'docs/_build' 19:15:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:15:03 INFO - Running setup.py install for pep8 19:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:15:03 INFO - no previously-included directories found matching 'docs/_build' 19:15:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:15:03 INFO - Cleaning up... 19:15:03 INFO - Return code: 0 19:15:03 INFO - Running post-action listener: _resource_record_post_action 19:15:03 INFO - Running post-action listener: _start_resource_monitoring 19:15:03 INFO - Starting resource monitoring. 19:15:03 INFO - ##### 19:15:03 INFO - ##### Finished create-virtualenv step (success) 19:15:03 INFO - ##### 19:15:03 INFO - ##### 19:15:03 INFO - ##### Running install step. 19:15:03 INFO - ##### 19:15:03 INFO - Running pre-action listener: _resource_record_pre_action 19:15:03 INFO - Running main action method: install 19:15:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:04 INFO - Reading from file tmpfile_stdout 19:15:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:15:04 INFO - Reading from file tmpfile_stdout 19:15:04 INFO - Output received: 19:15:04 INFO - Usage: mozinstall [options] installer 19:15:04 INFO - Options: 19:15:04 INFO - -h, --help show this help message and exit 19:15:04 INFO - -d DEST, --destination=DEST 19:15:04 INFO - Directory to install application into. [default: 19:15:04 INFO - "/builds/slave/test"] 19:15:04 INFO - --app=APP Application being installed. [default: firefox] 19:15:04 INFO - mkdir: /builds/slave/test/build/application 19:15:04 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'] 19:15:04 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 19:15:20 INFO - Reading from file tmpfile_stdout 19:15:20 INFO - Output received: 19:15:20 INFO - /builds/slave/test/build/application/firefox/firefox 19:15:20 INFO - Running post-action listener: _resource_record_post_action 19:15:20 INFO - ##### 19:15:20 INFO - ##### Finished install step (success) 19:15:20 INFO - ##### 19:15:20 INFO - ##### 19:15:20 INFO - ##### Running run-tests step. 19:15:20 INFO - ##### 19:15:20 INFO - Running pre-action listener: _resource_record_pre_action 19:15:20 INFO - Running main action method: run_tests 19:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:15:20 INFO - Python 2.7.3 19:15:20 INFO - Return code: 0 19:15:20 INFO - grabbing minidump binary from tooltool 19:15: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')]} 19:15:20 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 0x1f8e9c0>, '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 0x1f8f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:15:20 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 19:15:20 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 19:15:20 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 19:15:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:15:20 INFO - Return code: 0 19:15:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:15:21 INFO - Return code: 0 19:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 19:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 19:15:21 INFO - Using env: {'DISPLAY': ':0', 19:15:21 INFO - 'HOME': '/home/cltbld', 19:15:21 INFO - 'LANG': 'en_US.UTF-8', 19:15:21 INFO - 'LANGUAGE': 'en_US:en', 19:15:21 INFO - 'LOGNAME': 'cltbld', 19:15:21 INFO - 'MAIL': '/var/mail/cltbld', 19:15:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:21 INFO - 'MOZ_NO_REMOTE': '1', 19:15:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:21 INFO - 'NO_EM_RESTART': '1', 19:15:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:21 INFO - 'PWD': '/builds/slave/test', 19:15:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:21 INFO - 'SHELL': '/bin/bash', 19:15:21 INFO - 'SHLVL': '1', 19:15:21 INFO - 'TERM': 'linux', 19:15:21 INFO - 'TMOUT': '86400', 19:15:21 INFO - 'USER': 'cltbld', 19:15:21 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955', 19:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:21 INFO - '_': '/tools/buildbot/bin/python'} 19:15:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 19:15:21 INFO - mozversion application_buildid: 20160516163016 19:15:21 INFO - mozversion application_changeset: a884b96685aa13b65601feddb24e5f85ba861561 19:15:21 INFO - mozversion application_display_name: Nightly 19:15:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:15:21 INFO - mozversion application_name: Firefox 19:15:21 INFO - mozversion application_remotingname: firefox 19:15:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:15:21 INFO - mozversion application_vendor: Mozilla 19:15:21 INFO - mozversion application_version: 49.0a1 19:15:21 INFO - mozversion platform_buildid: 20160516163016 19:15:21 INFO - mozversion platform_changeset: a884b96685aa13b65601feddb24e5f85ba861561 19:15:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:15:21 INFO - mozversion platform_version: 49.0a1 19:15:21 INFO - using testdate: 1463451321 19:15:21 INFO - actual date: 1463451321 19:15:21 INFO - starting webserver on 'localhost:58677' 19:15:21 INFO - SUITE-START | Running 2 tests 19:15:21 INFO - TEST-START | dromaeo_css 19:15:21 INFO - operating with platform_type : linux_ 19:15:21 INFO - Initialising browser for dromaeo_css test... 19:15:21 INFO - TEST-INFO | started process 21513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI1sksX/profile http://localhost:58677/getInfo.html) 19:15:26 INFO - PROCESS | 21513 | __metrics Screen width/height:1600/1200 19:15:26 INFO - PROCESS | 21513 | colorDepth:24 19:15:26 INFO - PROCESS | 21513 | Browser inner width/height: 1024/697 19:15:26 INFO - PROCESS | 21513 | __metrics 19:15:27 ERROR - PROCESS | 21513 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:15:27 INFO - TEST-INFO | 21513: exit 0 19:15:27 INFO - Browser initialized. 19:15:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:15:27 INFO - TEST-INFO | started process 21597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI1sksX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:39 INFO - PROCESS | 21597 | RSS: Main: 152014848 19:15:39 INFO - PROCESS | 21597 | 19:16:30 INFO - PROCESS | 21597 | 1463451390680 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] 19:18:38 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58677/tests/dromaeo/cssquery-ext.html) 19:18:39 INFO - PROCESS | 21597 | RSS: Main: 264589312 19:18:39 INFO - PROCESS | 21597 | 19:21:41 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-ext.html (next: http://localhost:58677/tests/dromaeo/cssquery-jquery.html) 19:21:42 INFO - PROCESS | 21597 | RSS: Main: 236793856 19:21:42 INFO - PROCESS | 21597 | 19:24:44 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58677/tests/dromaeo/cssquery-mootools.html) 19:24:44 INFO - PROCESS | 21597 | RSS: Main: 237510656 19:24:44 INFO - PROCESS | 21597 | 19:27:46 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58677/tests/dromaeo/cssquery-prototype.html) 19:27:47 INFO - PROCESS | 21597 | RSS: Main: 233816064 19:27:47 INFO - PROCESS | 21597 | 19:30:50 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58677/tests/dromaeo/cssquery-yui.html) 19:30:50 INFO - PROCESS | 21597 | RSS: Main: 225124352 19:30:50 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | Cycle 1(1): loaded http://localhost:58677/tests/dromaeo/cssquery-yui.html (next: http://localhost:58677/tests/dromaeo/cssquery-dojo.html) 19:33:53 INFO - PROCESS | 21597 | RSS: Main: 271015936 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | __start_tp_report 19:33:53 INFO - PROCESS | 21597 | _x_x_mozilla_page_load 19:33:53 INFO - PROCESS | 21597 | _x_x_mozilla_page_load_details 19:33:53 INFO - PROCESS | 21597 | |i|pagename|runs| 19:33:53 INFO - PROCESS | 21597 | |0;dojo.html;3111.751059915207;3120.563121163036;3146.0719087869074;3160.2573395252098;3181.5704879841214;5150.768215430306;5190.1176799944005;5252.6848389096685;5265.210218467232;5312.601554883385;5169.663971841827;5200.349956255468;5262.184361423976;5343.786248550063;5364.597655175858;4662.417197850277;4675.181843177447;4797.424309082915;4824.17988941879;4836.806527738886;4797.2324428091515;4798.7600619969035;4829.4446138693975;4851.563359297663;4903.289023091649;4624.09830083134;4727.598154156901;4741.95258047422;4798.736069516175;4811.711297322172;4811.591014763714;4817.0365926814775;4820.060088282787;4828.96177321874;4851.296561998526;4629.86110416688;4643.6517261205545;4763.54746299101;4788.497207793202;4834.057358815033;5114.488551144893;5192.740362981874;5206.869828254286;5208.947910520884;5219.243209734605;5508.256385387961;5557.6109672322955;5558.86102847428;5564.081926482126;5579.414161513064;5328.573714102862;5577.247071645316;5616.410276920906;5672.801451949162;5725.255716756837;5399.838004859821;5400.78396864125;5426.023315803193;5426.75579598919;5434.483724046209;5912.17229587858;5950.85122871923;5951.404859514014;5955.106733989849;5961.105834124829;5221.190715439113;5520.66875987442;5569.136783798437;5580.609357345028;5682.829515114553;5658.858528536737;5679.659220446786;5683.403242659544;5731.168980497804;5731.885362292731;5658.094704847204;5675.971620141873;5677.403872593318;5680.261565996394;5681.545476361881;5374.6506477078865;5441.673499590037;5465.07093794048;5497.038018346773;5525.143602741581;4233.576642335804;4243.405923170759;4243.851465198703;4248.532661407243;4284.228838809045;3756.38019726742;3776.055986003499;3800.5059342285326;3821.464994900716;3839.5584507781964;5349.1976203569775;5354.170103633865;5404.702741349263;5438.3473983121485;5440.455954404528;5741.1388291756575;5773.971130144322;5785.595008349375;5788;5796.304443466811;5222.869428264248;5299.708516031656;5328.200769884548;5440.863978400572;5459.781608735686;4870.318155458239;4893.779779909842;4908.680935739166;4945.159322915113;4946.975265123651;5807.535397168301;5809.244798176294;5818;5818.418158184232;5819.127130930395;5494.917576236279;5679.119736440858;5686.061799802987;5734.913976290276;5748.137779333133;5882.441168089024;5915.940840591539;5916.881662366814;5919.993601087912;5934.525237981037;5670.092785154356;5680;5682.77268909239;5685.0903855384595;5686.687232202103;5475.151351540518;5618.185363122406;5632.802851900327;5656.688882111359;5704.11586204139;5544.528715059265;5548.0845660465575;5548.583856210719;5551.750171242385;5554;5318.441563635763;5527.364353099284;5539.7784088636;5556.749946252347;5593.0771422716425;5406.756695948613;5445.83662490126;5488.643238189505;5516.696581688046;5524.613277070727;5627.52166065889;5633.352164501135;5650.717464126859;5672.659640421588;5698.601097923106;5322.254884316276;5389.865253368697;5511.338639363302;5519.917201241904;5550.306211723535 19:33:53 INFO - PROCESS | 21597 | |1;ext.html;607.9088136779483;648.9286178520364;652.7617419641832;662.0830150241917;664.8038828545579;31864.20339491511;32457.51313730293;34853.302933941304;34910.47634285485;44351.55648443515;42427.57572424275;46873;46920.296195557006;46924.765376173156;46973;8989.190972812445;9135.862962055542;9144.131307525808;9147.496887671176;9148.908510914905;8922.197002269795;9003.459792412443;9028.68399606014;9029.593668284942;9031.458112513237;9062.410943288665;9083.046280140588;9096.727098187064;9104.271658267357;9109.180173784358;9044.186023257906;9083.318751093695;9099.272058235325;9101.499417532033;9104.817903641957;8899.688510902088;8984.191422771983;8985.23625491834;8988.146126118008;8992.77518062047;42845.57154428478;43094.784526077485;43322.56677433217;43328.70013899556;43378.783106084265;3475.548178736748;3547.166415892263;3645.6901163400876;3670.4127339625798;3950.2297052074855;30952.535711964338;32692;33171.33657326864;33362.833185834155;34448.82775586131;4186.727862688946;4260.360945858115;4268.9573104268875;4286.0999190170105;4419.977900110511;371928;371978;372145;372386;372764;58527;58603.41396585979;58721.77030263376;59010.40989590049;59016.1147582778;54651.453485465434;59595;60951.69524152351;60954;65400.34599653943;16966.830331696772;17202.225899834288;17212.483625491255;17282.65434691299;17317;13405.597832065054;13599.59201223965;13700.520481783089;13703.040787144804;13704.944258361325;14778.33497492594;15975.920120399323;16403.58991025234;16555.420560280334;17008.404705835237;6523.780975219805;6779.288174741581;6824.761133360308;6844.8973265401055;6880.415164711056;996.7757254617653;1085.5494969587533;1097.358045543366;1099.8460215569826;1105.0330960409642;32625.673743262265;32732.345353092805;32899.67100328966;33040.21968653011;33248;1117.5529788084832;1129.8983091521802;1152.991132758836;1153.9423028848523;1233.0628722171214;16983.49049528516;16987.575310617085;17151.828481715274;17295.913520432317;17413.129343533026;503230;504738;505838;507060;507921;56874;57005;57006;57152.71423642938;57240.427595724344;1304.5694920676153;1398.909070910408;1413.9080959737585;1416.4688241909284;1445.4724025730532;32241.35517289688;32784.50823237701;33929.83035084809;34030.8298458516;34740;50463.49536504588;50969;51025;51029.489705102475;51062;410117;412099;413461;413553;414058;31446.528302075945;37721.62278377181;38025;39750.60249397469;40313.59686403216;45498;46120.53879461296;46235;46563;46856.53143468658;39214.80392598019;39396.21207575775;39671.60328396679;39938.201235974535;40026.79986600048;38275;39563.80218098891;39876;39958.400623990085;40098.198036038535;39092.41361379639;39911;40477.39283910685;40555.79722101371;40653;34237;34785.8260708705;35485.290294194485;35616.10959726028;35649;27461.86269068642;27685;27744.861275693493;27780.16659500218;27873.860630696716 19:33:53 INFO - PROCESS | 21597 | |2;jquery.html;377.89796754876176;385.5450568329372;392.40550565892676;396.39549686727753;410.81718635207307;17129.657406851857;19105.42683719487;19652.410427687155;19687.21251149952;19737.21051157954;17968.37110701126;17984.820151798478;18202.271909123618;18593.628127437478;18917.62164756704;5541.949478692889;5562.443755624436;5639.915401268984;5711.257536520267;5749.8275051748515;5693.3452652945025;5706.429357064281;5731.14032895067;5746.856328591777;5749.281339832521;5125.38495380553;5412.56699464042;5732.025555655528;5757.625754325976;5757.884842303151;5273.1299335609965;5330.760115794798;5350.3312085989055;5425.538829199503;5432.483914028181;5446.7276636168035;5476.561875049986;5477.123660214346;5490.972545137289;5492.725363731797;11732.824007639892;12068.879311206863;12206.816897746541;12283.877161228364;12303.261804291771;2157.91368345266;2191.5069109450405;2267.4104732769433;2398.2205783120557;2462.9507409851703;9086.182243598108;9206.309526785519;9284.350095493319;9431.528423578862;9534.237261019101;1888.6694828404975;1900.9619807603908;1942.0678074524167;1947.581270026951;1979.6337677529702;53004.46995530072;73378;75354.24645753582;77325.998564937;80363.19636803615;9457.43255404678;9762.463064531377;9762.609495620096;10734.73163170927;10874.347539147677;28928.276793080342;30017.24956876052;30445;30525.847370763004;33203.50194747081;9920;10008.39949603026;10298.845517317246;10303.845442318372;10552.261341706007;8021.558814265155;8027.518348899085;8030.759077227693;8479.448835825651;8822.823543529094;8615.396922215385;8754.380439618692;8845.646174152962;8887.40026795183;8998.370114091951;3270.9018729438153;3354.98051753419;3486.4770284457027;3513.4202856528896;3599.820008999592;915.2860768600502;978.256525040974;997.5610731278215;1056.0231785598444;1080.2168427889717;18368.908155459136;18570;18590.349337773383;19164.233430662895;19361.031948402524;1002.4837208837455;1005.4118340770585;1017.2421545948316;1044.4777611194402;1069.198101423932;8265.669373225124;10790.946045269724;10821.783564328669;10982.560697572168;11026.393548354918;481732;488686;494119;494638;494928;64613;90849;91990.54004729934;92014.53992730127;95572.52213739026;1021.8927012663712;1027.198784947742;1040.0327695243495;1041.8645576075062;1047.800917825626;16197.919010404872;16743.91628041852;16866.241019153924;16911;16923.323067077672;41014;41215.7939210314;41418.792906035276;42591.3611295837;42855.57144428516;56348;58217;58722.70638646779;59083.70458147682;59190.40809592021;7546.471746977879;7677.654505547152;8109.1485394035135;8170.632321545426;8278.544680042656;13022.674433139247;13200.33998300062;13258.20450772918;13832.446702131801;13869.791953120914;11496.137789665641;11740.295582265091;11759.76480470403;11844.585439509921;12292;11362.204645674723;11584.94207528957;11671.649850504498;11811.881881181078;11894.464749086485;11651.941740291244;11943.283402995849;12033;12058.336791476553;12119.272843629411;7465.552066876005;7620.199879012624;7677.270659287359;7919.762407127795;8178.591070446573;11450.885491144982;11796.115291353355;12060.939695301468;12070.45682944252;12319.815202772144 19:33:53 INFO - PROCESS | 21597 | |3;mootools.html;1337.2912356451084;1531.686004369104;1545.945891893784;1728.153204929585;1842.649896519661;8305.169483051699;8675.522846243453;8690.130986901308;8835.602397892095;8932.196102350803;8626.094260102678;8800.691975780848;8810.251128654056;8820.514871682055;8828.823423531525;1954.140178321534;2007.7590689117326;2010.4270282969358;2302.2172461363134;2328.464453175762;2375.9881200593973;2463.174836429789;2463.8521688698734;2474.826762126652;2485.0805202075258;2282.589133955887;2287.7712228777154;2304.389336825734;2309.2379514760087;2318.4551630366936;1988.5823976964855;2297.356740112771;2309.307207837659;2327.0924339507606;2331.1258278145697;2381.8094552435764;2429.392651837041;2429.6598476213344;2431.817613678981;2432.9026838926598;8878.911210887873;8938.865917011184;8941.374103812735;8942.552872356422;8944.64221431142;5222.216667499867;5344.198370244456;5360.785568577252;5367.141257398797;5369.570434365241;3247.8213698246586;3332.6334103248623;3460.3425349183826;3465.42820434628;3480.0255928340107;1125.6004118537965;1136.891995260449;1156.2368836567825;1157.7279339355246;1159.1596092832713;12890.677733056655;12896.935515322364;12905.225686458842;12914.160579562298;12941.094123411365;4910.975445122752;4913.1893237615395;4927.926081108786;4930.6795058321095;5000.924801167694;10802.027817496462;10882.836757448644;10903.890961090447;10921.781564368668;10922.508487118099;5531.695756733418;5564.443555644484;5586;5588.357338905997;5591.580631452576;4139.4204811326435;4560.293154561048;5049.772760225798;5091.796328146833;5114.028334616411;4110.383442483591;4140.730852494578;4176.686748493875;4249.87250382489;4297.462817147856;1278.571678487717;1318.156379916854;1328.448693792085;1341.121565374681;1342.724741428005;1014.4015031131668;1021.0861279155263;1027.9794404111876;1047.4553232319151;1049.228816819637;6239.376062393815;6242.375762423812;6289.182406287245;6309.747610095545;6391.07329437229;462.1404188209927;464.7443905851768;465.36942442989937;467.2873867352247;481.7904211667936;4313.827446902152;4458.9331160032625;4474.865754027384;4508.391367165456;4558.840440584564;11019;11137.443127843575;11485.0811935045;11523.423828808525;11527.423628818693;11319.094472442184;11492.885071149349;11497.655070347902;11520.308781473139;11532.827007594893;8519.275861551714;8524.27543658796;8641.179087986631;8672.696455624024;8715.477071375737;6196.287426945959;6223.471004964447;6243.37566243372;6261.530385221217;6349.587276826992;10464.267501274837;10498.947505262426;10631.149508039493;10663.46682665879;10684.626038088629;10029.799404012025;10457.738556536147;10462.424566648908;10661.786764264827;10668.146548276274;8184.7953801155445;8263.256306932404;8319.958400207961;8341.666333346599;8344.37417193725;8791.340649451444;8851.291896648125;8851.822963540564;8864.379493435656;8946.597403116744;8003.679852806055;8101.9594902027475;8148.307393871587;8214.958925205574;8374.497530147966;7428.442866784904;7437.442191835526;7529.096508419025;7623.16145224036;7686.57723825195;6979.4765392594745;6999.8950015750825;7076.681549330396;7087.787366379017;7128.536645118051;5099.056674515226;5125.92311115341;5143.974280128725;5179.274901513866;5283.682979021271;5190.8260701430345;5286.920696189483;5301.284326616012;5389.9759045781175;5463.945360546344 19:33:53 INFO - PROCESS | 21597 | |4;prototype.html;318.59856580708316;323.98218098004605;326.1454987931619;329.17213208779924;331.75284413112234;5133.845984620458;5272.969906585963;5292.814751483699;5298.4436634153435;5340.866478338044;5230.149568485175;5269.473052694738;5283.498067683564;5293.417724050351;5309.469053094688;4156.792160391976;4163.897231897888;4165.500139983191;4165.541790403053;4209.6000879916355;3885.8834234972996;3910.921781564367;4132.772697501636;4163.375493675958;4166.708330416872;4052.898677533056;4083.3466645336753;4095.5290141633795;4108.85619003335;4112.157007813406;4069.776162311072;4072.8778136655947;4081.632653061209;4082.6121518455698;4092.3043082675717;3584.444411116255;3603.4594810778594;3608.693261072786;3619.3304238715923;3626.582942961567;5021.748912554394;5055.292259083732;5109.233614957749;5122.129238029544;5127.97445009223;4609.792559334838;4639.420072490939;4643.907121857577;4648.3957085578995;4676.228422310314;5201.739913004335;5438.646487978269;5472.890542189174;5478.260434841325;5480.342358916955;3932.8791294480934;3957.28768821612;3963.9405408918888;3977.5425826030087;3977.880663580097;5629.802956896489;5654.604177707603;5681.744321505542;5713.885722285572;5718.884012915248;4057.411675307123;4077.8164982575854;4088.3867419887256;4091.1204091119957;4112.074783173822;3910.569837317893;4036.737612055207;4041.5958404159937;4072.9817545613596;4083.224187404384;4623.589805109474;4659.510751371057;4660.297027723912;4665.790039448233;4702.988857395676;5538.529225015838;5544.750486228129;5548.833534993957;5554.861128471821;5575.581831362664;1308.3719814489098;1345.0248569786827;1392.554382597559;1393.7212557488542;1399.7130588229388;879.4942907828024;886.4061079077034;887.5562218890555;889.9377043606885;891.1801142948503;4714.575688188011;4758.262469317261;4762.4285085789925;4781.163296423112;4800.855974320776;5017.8243761468175;5040.49595040493;5040.689420750631;5070.873228169326;5083.398729400227;4560.908781824412;4739.980904105565;4773;4785.952140478551;4789.95210047895;2672.398710290169;2680.8659567021573;2683.6913754918432;2685.4827022732093;2691.9730802692116;5011.373578302712;5047.4447810740785;5134.871628209325;5137.229415587692;5139.9720055988955;4923.990581930696;5070.9604531071045;5082.872928176826;5083.923741143886;5087.211482220262;5096.388433388017;5105.183170692671;5125.15434953236;5134.743262836843;5137.460566640524;4926.4088309403105;4936.383716630192;4937.580585513145;4942.382202224722;5001.924586213836;4907.276461563723;4969.403671559436;4985.45450910219;5268;5682;5832.9708351457975;5854.590178687451;5855.648661080349;5859.5019423349495;5866.2373891393845;3874.3994680824517;4069.67442604585;4085.71400001997;4110.77390743512;4120.21715873983;5577;5657.943420565742;5661.264035675335;5682.090865461506;5684.63049901755;5530.474604912527;5536.086545719912;5541.251930989265;5569.19246709233;5592.049351610155;5275.868103297448;5544.916826247691;5546.528545073714;5553.250311207935;5576.832695019156;5429.67421954684;5441.918371224356;5444.945550544444;5449.746558291695;5478.082671065095;5526.585506086979;5526.91709624364;5574.9721251393485;5579.4978451937895;5640.717964101696;5305.336832895888;5429.429909859408;5455.236266922555;5477.260569823182;5482.91775623358 19:33:53 INFO - PROCESS | 21597 | |5;yui.html;799.7520768561745;814.1803070138236;818.4311903227258;822.9218224268697;830.1611929575988;13853.238071906053;14690.926545367272;14811.851881481181;14833.110013399204;14854.628634284134;14304.35630396632;14357.78463323051;14371.640708982255;14388.856111438909;14402.927985360086;680.3638597910945;801.591188493868;808.4946908182386;816.1919699497485;836.5984327522792;821.6631181215703;830.7175560309494;830.8047608811925;833.2042899031441;835.381817455085;874.4796845876725;876.1807709791334;876.8640860666607;878.1920633017608;878.5431575580694;721.1058287723238;734.9816254593625;855.5080828523562;874.8381549413378;877.9912200878038;646.4698946863574;646.7800947677812;646.7930262316061;646.9029645553157;647.0520687193284;14614.561563153122;14714.264286785618;14726.926365368105;14739.55781326562;14748.188849613267;14072.648183795385;14216.573502794932;14217.85782142186;14269.928650356786;14298.396991491216;12369.567065152676;12453.1905426147;12535.31055791931;12593.811092833523;12703.428345724464;4533.727976321431;4553.385292985437;4588.839390621346;4601.493835678073;4652.534451647754;52300.47699522994;53715.462845371825;53884.191737123976;57975.71012144954;59461.7026914867;11012;11253.493592788343;11336.29478953226;11346.716332091599;11511.539538418538;21280.36158915235;21359.89320053421;21421.78578214198;21441.78558214429;21473.248436304653;8651.567421628893;8817.823643527094;8853.335999799912;8876.245519130816;9017.323700722472;4655.231886738718;4664.930026049612;4713.81144754206;4724.314974328772;4725.976370118127;3463.5843698755807;3567.4827150063616;3572.1783989682;3579;3598.4962105305276;639.6897504710212;667.2626747444004;667.4760313154247;671.8790617688863;672.1765836849918;660.365595151995;706.1949377709312;775.441681988967;794.1819925476768;803.4978138663336;10184.083432491112;10551.630692925712;10599.07834101372;10610.029191826146;10677;627.9277883043509;692.1452006771633;723.989140162898;780.55898417394;805.2712295372697;5046.772895219724;5079.5428411443145;5083.110455670243;5121.489160697603;5137.6660517066275;56465.7176714122;73681.63159184277;76425.6178719114;76820;76957.230427695;66799.66600166968;66866.66566667135;67250.32749672538;67370;68616.31383686198;58796.41203587995;59044.40955590475;59196.70401647964;59393.40606593965;60244.49388765228;9570.808583828424;9591.376560523544;9607.567659455202;9626;9781.315307928377;38935;39183;39189.608103918596;39442.802785985885;40571;52270.215946760065;54174;54321;54391;54407.18389224086;11979.520819167135;12082.335471548797;12097.879021209676;12281.201721888048;12578;13680.179189248676;13914.791278130633;14069.226192559097;14213.50252741149;14406.639834004234;13023.153495022792;13035.15271507349;13207.537736179187;13477.730445391233;13739.656508587364;12932.15940963872;12934.288614125937;13494.595162145151;13533.390997404944;13543;12553.184043037174;12597.685057873627;12733;12822.422990965242;13457.259850707913;10596.205284603531;10829.404382759023;10855.077318427706;11148.498317575892;11238.7752244953;10514.474276286308;10983.61557345489;11108.833367499332;11154.49804758804;11209.55161793519 19:33:53 INFO - PROCESS | 21597 | __end_tp_report 19:33:53 INFO - PROCESS | 21597 | __start_cc_report 19:33:53 INFO - PROCESS | 21597 | _x_x_mozilla_cycle_collect,836 19:33:53 INFO - PROCESS | 21597 | __end_cc_report 19:33:53 INFO - PROCESS | 21597 | __startTimestamp1463452433612__endTimestamp 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | ------- Summary: start ------- 19:33:53 INFO - PROCESS | 21597 | Number of tests: 6 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#0] dojo.html Cycles:165 Average:5254.79 Median:5445.84 stddev:607.18 (11.1%) stddev-sans-first:585.30 19:33:53 INFO - PROCESS | 21597 | Values: 3111.8 3120.6 3146.1 3160.3 3181.6 5150.8 5190.1 5252.7 5265.2 5312.6 5169.7 5200.3 5262.2 5343.8 5364.6 4662.4 4675.2 4797.4 4824.2 4836.8 4797.2 4798.8 4829.4 4851.6 4903.3 4624.1 4727.6 4742.0 4798.7 4811.7 4811.6 4817.0 4820.1 4829.0 4851.3 4629.9 4643.7 4763.5 4788.5 4834.1 5114.5 5192.7 5206.9 5208.9 5219.2 5508.3 5557.6 5558.9 5564.1 5579.4 5328.6 5577.2 5616.4 5672.8 5725.3 5399.8 5400.8 5426.0 5426.8 5434.5 5912.2 5950.9 5951.4 5955.1 5961.1 5221.2 5520.7 5569.1 5580.6 5682.8 5658.9 5679.7 5683.4 5731.2 5731.9 5658.1 5676.0 5677.4 5680.3 5681.5 5374.7 5441.7 5465.1 5497.0 5525.1 4233.6 4243.4 4243.9 4248.5 4284.2 3756.4 3776.1 3800.5 3821.5 3839.6 5349.2 5354.2 5404.7 5438.3 5440.5 5741.1 5774.0 5785.6 5788.0 5796.3 5222.9 5299.7 5328.2 5440.9 5459.8 4870.3 4893.8 4908.7 4945.2 4947.0 5807.5 5809.2 5818.0 5818.4 5819.1 5494.9 5679.1 5686.1 5734.9 5748.1 5882.4 5915.9 5916.9 5920.0 5934.5 5670.1 5680.0 5682.8 5685.1 5686.7 5475.2 5618.2 5632.8 5656.7 5704.1 5544.5 5548.1 5548.6 5551.8 5554.0 5318.4 5527.4 5539.8 5556.7 5593.1 5406.8 5445.8 5488.6 5516.7 5524.6 5627.5 5633.4 5650.7 5672.7 5698.6 5322.3 5389.9 5511.3 5519.9 5550.3 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#1] ext.html Cycles:180 Average:59341.33 Median:40516.60 stddev:114730.12 (283.2%) stddev-sans-first:114967.22 19:33:53 INFO - PROCESS | 21597 | Values: 607.9 648.9 652.8 662.1 664.8 31864.2 32457.5 34853.3 34910.5 44351.6 42427.6 46873.0 46920.3 46924.8 46973.0 8989.2 9135.9 9144.1 9147.5 9148.9 8922.2 9003.5 9028.7 9029.6 9031.5 9062.4 9083.0 9096.7 9104.3 9109.2 9044.2 9083.3 9099.3 9101.5 9104.8 8899.7 8984.2 8985.2 8988.1 8992.8 42845.6 43094.8 43322.6 43328.7 43378.8 3475.5 3547.2 3645.7 3670.4 3950.2 30952.5 32692.0 33171.3 33362.8 34448.8 4186.7 4260.4 4269.0 4286.1 4420.0 371928.0 371978.0 372145.0 372386.0 372764.0 58527.0 58603.4 58721.8 59010.4 59016.1 54651.5 59595.0 60951.7 60954.0 65400.3 16966.8 17202.2 17212.5 17282.7 17317.0 13405.6 13599.6 13700.5 13703.0 13704.9 14778.3 15975.9 16403.6 16555.4 17008.4 6523.8 6779.3 6824.8 6844.9 6880.4 996.8 1085.5 1097.4 1099.8 1105.0 32625.7 32732.3 32899.7 33040.2 33248.0 1117.6 1129.9 1153.0 1153.9 1233.1 16983.5 16987.6 17151.8 17295.9 17413.1 503230.0 504738.0 505838.0 507060.0 507921.0 56874.0 57005.0 57006.0 57152.7 57240.4 1304.6 1398.9 1413.9 1416.5 1445.5 32241.4 32784.5 33929.8 34030.8 34740.0 50463.5 50969.0 51025.0 51029.5 51062.0 410117.0 412099.0 413461.0 413553.0 414058.0 31446.5 37721.6 38025.0 39750.6 40313.6 45498.0 46120.5 46235.0 46563.0 46856.5 39214.8 39396.2 39671.6 39938.2 40026.8 38275.0 39563.8 39876.0 39958.4 40098.2 39092.4 39911.0 40477.4 40555.8 40653.0 34237.0 34785.8 35485.3 35616.1 35649.0 27461.9 27685.0 27744.9 27780.2 27873.9 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#2] jquery.html Cycles:180 Average:28836.00 Median:3556.62 stddev:80695.71 (2268.9%) stddev-sans-first:80893.79 19:33:53 INFO - PROCESS | 21597 | Values: 377.9 385.5 392.4 396.4 410.8 17129.7 19105.4 19652.4 19687.2 19737.2 17968.4 17984.8 18202.3 18593.6 18917.6 5541.9 5562.4 5639.9 5711.3 5749.8 5693.3 5706.4 5731.1 5746.9 5749.3 5125.4 5412.6 5732.0 5757.6 5757.9 5273.1 5330.8 5350.3 5425.5 5432.5 5446.7 5476.6 5477.1 5491.0 5492.7 11732.8 12068.9 12206.8 12283.9 12303.3 2157.9 2191.5 2267.4 2398.2 2463.0 9086.2 9206.3 9284.4 9431.5 9534.2 1888.7 1901.0 1942.1 1947.6 1979.6 53004.5 73378.0 75354.2 77326.0 80363.2 9457.4 9762.5 9762.6 10734.7 10874.3 28928.3 30017.2 30445.0 30525.8 33203.5 9920.0 10008.4 10298.8 10303.8 10552.3 8021.6 8027.5 8030.8 8479.4 8822.8 8615.4 8754.4 8845.6 8887.4 8998.4 3270.9 3355.0 3486.5 3513.4 3599.8 915.3 978.3 997.6 1056.0 1080.2 18368.9 18570.0 18590.3 19164.2 19361.0 1002.5 1005.4 1017.2 1044.5 1069.2 8265.7 10790.9 10821.8 10982.6 11026.4 481732.0 488686.0 494119.0 494638.0 494928.0 64613.0 90849.0 91990.5 92014.5 95572.5 1021.9 1027.2 1040.0 1041.9 1047.8 16197.9 16743.9 16866.2 16911.0 16923.3 41014.0 41215.8 41418.8 42591.4 42855.6 56348.0 58217.0 58722.7 59083.7 59190.4 7546.5 7677.7 8109.1 8170.6 8278.5 13022.7 13200.3 13258.2 13832.4 13869.8 11496.1 11740.3 11759.8 11844.6 12292.0 11362.2 11584.9 11671.6 11811.9 11894.5 11651.9 11943.3 12033.0 12058.3 12119.3 7465.6 7620.2 7677.3 7919.8 8178.6 11450.9 11796.1 12060.9 12070.5 12319.8 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#3] mootools.html Cycles:180 Average:5983.86 Median:4559.57 stddev:3460.18 (75.9%) stddev-sans-first:3452.27 19:33:53 INFO - PROCESS | 21597 | Values: 1337.3 1531.7 1545.9 1728.2 1842.6 8305.2 8675.5 8690.1 8835.6 8932.2 8626.1 8800.7 8810.3 8820.5 8828.8 1954.1 2007.8 2010.4 2302.2 2328.5 2376.0 2463.2 2463.9 2474.8 2485.1 2282.6 2287.8 2304.4 2309.2 2318.5 1988.6 2297.4 2309.3 2327.1 2331.1 2381.8 2429.4 2429.7 2431.8 2432.9 8878.9 8938.9 8941.4 8942.6 8944.6 5222.2 5344.2 5360.8 5367.1 5369.6 3247.8 3332.6 3460.3 3465.4 3480.0 1125.6 1136.9 1156.2 1157.7 1159.2 12890.7 12896.9 12905.2 12914.2 12941.1 4911.0 4913.2 4927.9 4930.7 5000.9 10802.0 10882.8 10903.9 10921.8 10922.5 5531.7 5564.4 5586.0 5588.4 5591.6 4139.4 4560.3 5049.8 5091.8 5114.0 4110.4 4140.7 4176.7 4249.9 4297.5 1278.6 1318.2 1328.4 1341.1 1342.7 1014.4 1021.1 1028.0 1047.5 1049.2 6239.4 6242.4 6289.2 6309.7 6391.1 462.1 464.7 465.4 467.3 481.8 4313.8 4458.9 4474.9 4508.4 4558.8 11019.0 11137.4 11485.1 11523.4 11527.4 11319.1 11492.9 11497.7 11520.3 11532.8 8519.3 8524.3 8641.2 8672.7 8715.5 6196.3 6223.5 6243.4 6261.5 6349.6 10464.3 10498.9 10631.1 10663.5 10684.6 10029.8 10457.7 10462.4 10661.8 10668.1 8184.8 8263.3 8320.0 8341.7 8344.4 8791.3 8851.3 8851.8 8864.4 8946.6 8003.7 8102.0 8148.3 8215.0 8374.5 7428.4 7437.4 7529.1 7623.2 7686.6 6979.5 6999.9 7076.7 7087.8 7128.5 5099.1 5125.9 5144.0 5179.3 5283.7 5190.8 5286.9 5301.3 5390.0 5463.9 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#4] prototype.html Cycles:180 Average:4497.43 Median:5019.79 stddev:1308.55 (26.1%) stddev-sans-first:1274.07 19:33:53 INFO - PROCESS | 21597 | Values: 318.6 324.0 326.1 329.2 331.8 5133.8 5273.0 5292.8 5298.4 5340.9 5230.1 5269.5 5283.5 5293.4 5309.5 4156.8 4163.9 4165.5 4165.5 4209.6 3885.9 3910.9 4132.8 4163.4 4166.7 4052.9 4083.3 4095.5 4108.9 4112.2 4069.8 4072.9 4081.6 4082.6 4092.3 3584.4 3603.5 3608.7 3619.3 3626.6 5021.7 5055.3 5109.2 5122.1 5128.0 4609.8 4639.4 4643.9 4648.4 4676.2 5201.7 5438.6 5472.9 5478.3 5480.3 3932.9 3957.3 3963.9 3977.5 3977.9 5629.8 5654.6 5681.7 5713.9 5718.9 4057.4 4077.8 4088.4 4091.1 4112.1 3910.6 4036.7 4041.6 4073.0 4083.2 4623.6 4659.5 4660.3 4665.8 4703.0 5538.5 5544.8 5548.8 5554.9 5575.6 1308.4 1345.0 1392.6 1393.7 1399.7 879.5 886.4 887.6 889.9 891.2 4714.6 4758.3 4762.4 4781.2 4800.9 5017.8 5040.5 5040.7 5070.9 5083.4 4560.9 4740.0 4773.0 4786.0 4790.0 2672.4 2680.9 2683.7 2685.5 2692.0 5011.4 5047.4 5134.9 5137.2 5140.0 4924.0 5071.0 5082.9 5083.9 5087.2 5096.4 5105.2 5125.2 5134.7 5137.5 4926.4 4936.4 4937.6 4942.4 5001.9 4907.3 4969.4 4985.5 5268.0 5682.0 5833.0 5854.6 5855.6 5859.5 5866.2 3874.4 4069.7 4085.7 4110.8 4120.2 5577.0 5657.9 5661.3 5682.1 5684.6 5530.5 5536.1 5541.3 5569.2 5592.0 5275.9 5544.9 5546.5 5553.3 5576.8 5429.7 5441.9 5444.9 5449.7 5478.1 5526.6 5526.9 5575.0 5579.5 5640.7 5305.3 5429.4 5455.2 5477.3 5482.9 19:33:53 INFO - PROCESS | 21597 | 19:33:53 INFO - PROCESS | 21597 | [#5] yui.html Cycles:180 Average:16449.93 Median:4660.08 stddev:19902.39 (427.1%) stddev-sans-first:19923.52 19:33:53 INFO - PROCESS | 21597 | Values: 799.8 814.2 818.4 822.9 830.2 13853.2 14690.9 14811.9 14833.1 14854.6 14304.4 14357.8 14371.6 14388.9 14402.9 680.4 801.6 808.5 816.2 836.6 821.7 830.7 830.8 833.2 835.4 874.5 876.2 876.9 878.2 878.5 721.1 735.0 855.5 874.8 878.0 646.5 646.8 646.8 646.9 647.1 14614.6 14714.3 14726.9 14739.6 14748.2 14072.6 14216.6 14217.9 14269.9 14298.4 12369.6 12453.2 12535.3 12593.8 12703.4 4533.7 4553.4 4588.8 4601.5 4652.5 52300.5 53715.5 53884.2 57975.7 59461.7 11012.0 11253.5 11336.3 11346.7 11511.5 21280.4 21359.9 21421.8 21441.8 21473.2 8651.6 8817.8 8853.3 8876.2 9017.3 4655.2 4664.9 4713.8 4724.3 4726.0 3463.6 3567.5 3572.2 3579.0 3598.5 639.7 667.3 667.5 671.9 672.2 660.4 706.2 775.4 794.2 803.5 10184.1 10551.6 10599.1 10610.0 10677.0 627.9 692.1 724.0 780.6 805.3 5046.8 5079.5 5083.1 5121.5 5137.7 56465.7 73681.6 76425.6 76820.0 76957.2 66799.7 66866.7 67250.3 67370.0 68616.3 58796.4 59044.4 59196.7 59393.4 60244.5 9570.8 9591.4 9607.6 9626.0 9781.3 38935.0 39183.0 39189.6 39442.8 40571.0 52270.2 54174.0 54321.0 54391.0 54407.2 11979.5 12082.3 12097.9 12281.2 12578.0 13680.2 13914.8 14069.2 14213.5 14406.6 13023.2 13035.2 13207.5 13477.7 13739.7 12932.2 12934.3 13494.6 13533.4 13543.0 12553.2 12597.7 12733.0 12822.4 13457.3 10596.2 10829.4 10855.1 11148.5 11238.8 10514.5 10983.6 11108.8 11154.5 11209.6 19:33:53 INFO - PROCESS | 21597 | -------- Summary: end -------- 19:33:53 INFO - PROCESS | 21597 | 19:33:54 INFO - TEST-INFO | 21597: exit 0 19:33:54 INFO - TEST-OK | dromaeo_css | took 1112454ms 19:33:54 INFO - TEST-START | kraken 19:33:54 INFO - operating with platform_type : linux_ 19:33:54 INFO - Initialising browser for kraken test... 19:33:54 INFO - TEST-INFO | started process 21780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwb8qdn/profile http://localhost:58677/getInfo.html) 19:33:58 INFO - PROCESS | 21780 | __metrics Screen width/height:1600/1200 19:33:58 INFO - PROCESS | 21780 | colorDepth:24 19:33:58 INFO - PROCESS | 21780 | Browser inner width/height: 1024/697 19:33:58 INFO - PROCESS | 21780 | __metrics 19:33:59 ERROR - PROCESS | 21780 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:34:00 INFO - TEST-INFO | 21780: exit 0 19:34:00 INFO - Browser initialized. 19:34:00 INFO - Running cycle 1/1 for kraken test... 19:34:00 INFO - TEST-INFO | started process 21860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwb8qdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:12 INFO - PROCESS | 21860 | RSS: Main: 152743936 19:34:12 INFO - PROCESS | 21860 | 19:34:14 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58677/tests/kraken/driver.html?testName=audio-beat-detection) 19:34:15 INFO - PROCESS | 21860 | RSS: Main: 208617472 19:34:15 INFO - PROCESS | 21860 | 19:34:18 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58677/tests/kraken/driver.html?testName=audio-dft) 19:34:18 INFO - PROCESS | 21860 | RSS: Main: 197758976 19:34:18 INFO - PROCESS | 21860 | 19:34:22 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58677/tests/kraken/driver.html?testName=audio-fft) 19:34:22 INFO - PROCESS | 21860 | RSS: Main: 265052160 19:34:22 INFO - PROCESS | 21860 | 19:34:24 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58677/tests/kraken/driver.html?testName=audio-oscillator) 19:34:25 INFO - PROCESS | 21860 | RSS: Main: 174710784 19:34:25 INFO - PROCESS | 21860 | 19:34:27 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58677/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:34:28 INFO - PROCESS | 21860 | RSS: Main: 179077120 19:34:28 INFO - PROCESS | 21860 | 19:34:31 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58677/tests/kraken/driver.html?testName=imaging-darkroom) 19:34:32 INFO - PROCESS | 21860 | RSS: Main: 214421504 19:34:32 INFO - PROCESS | 21860 | 19:34:35 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58677/tests/kraken/driver.html?testName=imaging-desaturate) 19:34:36 INFO - PROCESS | 21860 | RSS: Main: 212762624 19:34:36 INFO - PROCESS | 21860 | 19:34:39 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58677/tests/kraken/driver.html?testName=json-parse-financial) 19:34:39 INFO - PROCESS | 21860 | RSS: Main: 214052864 19:34:39 INFO - PROCESS | 21860 | 19:34:41 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58677/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:34:42 INFO - PROCESS | 21860 | RSS: Main: 202784768 19:34:42 INFO - PROCESS | 21860 | 19:34:43 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:34:44 INFO - PROCESS | 21860 | RSS: Main: 206790656 19:34:44 INFO - PROCESS | 21860 | 19:34:46 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:34:47 INFO - PROCESS | 21860 | RSS: Main: 218009600 19:34:47 INFO - PROCESS | 21860 | 19:34:49 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:34:50 INFO - PROCESS | 21860 | RSS: Main: 222928896 19:34:50 INFO - PROCESS | 21860 | 19:34:53 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:34:53 INFO - PROCESS | 21860 | RSS: Main: 218910720 19:34:53 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | Cycle 1(1): loaded http://localhost:58677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58677/tests/kraken/driver.html?testName=ai-astar) 19:34:55 INFO - PROCESS | 21860 | RSS: Main: 265023488 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | __start_tp_report 19:34:55 INFO - PROCESS | 21860 | _x_x_mozilla_page_load 19:34:55 INFO - PROCESS | 21860 | _x_x_mozilla_page_load_details 19:34:55 INFO - PROCESS | 21860 | |i|pagename|runs| 19:34:55 INFO - PROCESS | 21860 | |0;ai-astar;111;108;113;114;110;110;110;109;109;109 19:34:55 INFO - PROCESS | 21860 | |1;audio-beat-detection;154;126;153;203;126;152;150;124;194;123 19:34:55 INFO - PROCESS | 21860 | |2;audio-dft;161;159;160;161;161;160;160;161;160;160 19:34:55 INFO - PROCESS | 21860 | |3;audio-fft;74;75;74;161;75;74;75;75;129;74 19:34:55 INFO - PROCESS | 21860 | |4;audio-oscillator;90;91;145;91;90;90;124;91;102;124 19:34:55 INFO - PROCESS | 21860 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;117;117;116 19:34:55 INFO - PROCESS | 21860 | |6;imaging-darkroom;145;145;147;146;144;145;146;145;145;146 19:34:55 INFO - PROCESS | 21860 | |7;imaging-desaturate;95;95;94;96;96;96;95;94;94;94 19:34:55 INFO - PROCESS | 21860 | |8;json-parse-financial;56;58;57;55;56;56;56;119;53;53 19:34:55 INFO - PROCESS | 21860 | |9;json-stringify-tinderbox;59;60;59;59;60;59;60;58;59;59 19:34:55 INFO - PROCESS | 21860 | |10;stanford-crypto-aes;80;81;79;78;77;78;83;78;84;85 19:34:55 INFO - PROCESS | 21860 | |11;stanford-crypto-ccm;121;123;128;120;125;120;130;134;190;129 19:34:55 INFO - PROCESS | 21860 | |12;stanford-crypto-pbkdf2;160;168;156;157;160;159;158;159;157;157 19:34:55 INFO - PROCESS | 21860 | |13;stanford-crypto-sha256-iterative;62;64;66;61;63;62;63;62;62;60 19:34:55 INFO - PROCESS | 21860 | __end_tp_report 19:34:55 INFO - PROCESS | 21860 | __start_cc_report 19:34:55 INFO - PROCESS | 21860 | _x_x_mozilla_cycle_collect,1886 19:34:55 INFO - PROCESS | 21860 | __end_cc_report 19:34:55 INFO - PROCESS | 21860 | __startTimestamp1463452495830__endTimestamp 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | ------- Summary: start ------- 19:34:55 INFO - PROCESS | 21860 | Number of tests: 14 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 19:34:55 INFO - PROCESS | 21860 | Values: 111.0 108.0 113.0 114.0 110.0 110.0 110.0 109.0 109.0 109.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:152.50 stddev:28.54 (18.7%) stddev-sans-first:30.24 19:34:55 INFO - PROCESS | 21860 | Values: 154.0 126.0 153.0 203.0 126.0 152.0 150.0 124.0 194.0 123.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:34:55 INFO - PROCESS | 21860 | Values: 161.0 159.0 160.0 161.0 161.0 160.0 160.0 161.0 160.0 160.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#3] audio-fft Cycles:10 Average:88.60 Median:74.50 stddev:30.67 (41.2%) stddev-sans-first:32.07 19:34:55 INFO - PROCESS | 21860 | Values: 74.0 75.0 74.0 161.0 75.0 74.0 75.0 75.0 129.0 74.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:90.00 stddev:19.94 (22.2%) stddev-sans-first:20.52 19:34:55 INFO - PROCESS | 21860 | Values: 90.0 91.0 145.0 91.0 90.0 90.0 124.0 91.0 102.0 124.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:34:55 INFO - PROCESS | 21860 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 19:34:55 INFO - PROCESS | 21860 | Values: 145.0 145.0 147.0 146.0 144.0 145.0 146.0 145.0 145.0 146.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 19:34:55 INFO - PROCESS | 21860 | Values: 95.0 95.0 94.0 96.0 96.0 96.0 95.0 94.0 94.0 94.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:56.00 stddev:20.12 (35.9%) stddev-sans-first:21.23 19:34:55 INFO - PROCESS | 21860 | Values: 56.0 58.0 57.0 55.0 56.0 56.0 56.0 119.0 53.0 53.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 19:34:55 INFO - PROCESS | 21860 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 60.0 58.0 59.0 59.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:2.83 (3.5%) stddev-sans-first:3.00 19:34:55 INFO - PROCESS | 21860 | Values: 80.0 81.0 79.0 78.0 77.0 78.0 83.0 78.0 84.0 85.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:128.50 stddev:20.91 (16.3%) stddev-sans-first:21.80 19:34:55 INFO - PROCESS | 21860 | Values: 121.0 123.0 128.0 120.0 125.0 120.0 130.0 134.0 190.0 129.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:3.41 (2.1%) stddev-sans-first:3.61 19:34:55 INFO - PROCESS | 21860 | Values: 160.0 168.0 156.0 157.0 160.0 159.0 158.0 159.0 157.0 157.0 19:34:55 INFO - PROCESS | 21860 | 19:34:55 INFO - PROCESS | 21860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.65 (2.6%) stddev-sans-first:1.74 19:34:55 INFO - PROCESS | 21860 | Values: 62.0 64.0 66.0 61.0 63.0 62.0 63.0 62.0 62.0 60.0 19:34:55 INFO - PROCESS | 21860 | -------- Summary: end -------- 19:34:55 INFO - PROCESS | 21860 | 19:34:56 INFO - TEST-INFO | 21860: exit 0 19:34:56 INFO - TEST-OK | kraken | took 62495ms 19:34:56 INFO - SUITE-END | took 1174s 19:34:56 INFO - Completed test suite (00:19:35) 19:34:56 INFO - javascript benchmark 19:34:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.751059915207, 3120.563121163036, 3146.0719087869074, 3160.2573395252098, 3181.5704879841214, 5150.768215430306, 5190.1176799944005, 5252.6848389096685, 5265.210218467232, 5312.601554883385, 5169.663971841827, 5200.349956255468, 5262.184361423976, 5343.786248550063, 5364.597655175858, 4662.417197850277, 4675.181843177447, 4797.424309082915, 4824.17988941879, 4836.806527738886, 4797.2324428091515, 4798.7600619969035, 4829.4446138693975, 4851.563359297663, 4903.289023091649, 4624.09830083134, 4727.598154156901, 4741.95258047422, 4798.736069516175, 4811.711297322172, 4811.591014763714, 4817.0365926814775, 4820.060088282787, 4828.96177321874, 4851.296561998526, 4629.86110416688, 4643.6517261205545, 4763.54746299101, 4788.497207793202, 4834.057358815033, 5114.488551144893, 5192.740362981874, 5206.869828254286, 5208.947910520884, 5219.243209734605, 5508.256385387961, 5557.6109672322955, 5558.86102847428, 5564.081926482126, 5579.414161513064, 5328.573714102862, 5577.247071645316, 5616.410276920906, 5672.801451949162, 5725.255716756837, 5399.838004859821, 5400.78396864125, 5426.023315803193, 5426.75579598919, 5434.483724046209, 5912.17229587858, 5950.85122871923, 5951.404859514014, 5955.106733989849, 5961.105834124829, 5221.190715439113, 5520.66875987442, 5569.136783798437, 5580.609357345028, 5682.829515114553, 5658.858528536737, 5679.659220446786, 5683.403242659544, 5731.168980497804, 5731.885362292731, 5658.094704847204, 5675.971620141873, 5677.403872593318, 5680.261565996394, 5681.545476361881, 5374.6506477078865, 5441.673499590037, 5465.07093794048, 5497.038018346773, 5525.143602741581, 4233.576642335804, 4243.405923170759, 4243.851465198703, 4248.532661407243, 4284.228838809045, 3756.38019726742, 3776.055986003499, 3800.5059342285326, 3821.464994900716, 3839.5584507781964, 5349.1976203569775, 5354.170103633865, 5404.702741349263, 5438.3473983121485, 5440.455954404528, 5741.1388291756575, 5773.971130144322, 5785.595008349375, 5788.0, 5796.304443466811, 5222.869428264248, 5299.708516031656, 5328.200769884548, 5440.863978400572, 5459.781608735686, 4870.318155458239, 4893.779779909842, 4908.680935739166, 4945.159322915113, 4946.975265123651, 5807.535397168301, 5809.244798176294, 5818.0, 5818.418158184232, 5819.127130930395, 5494.917576236279, 5679.119736440858, 5686.061799802987, 5734.913976290276, 5748.137779333133, 5882.441168089024, 5915.940840591539, 5916.881662366814, 5919.993601087912, 5934.525237981037, 5670.092785154356, 5680.0, 5682.77268909239, 5685.0903855384595, 5686.687232202103, 5475.151351540518, 5618.185363122406, 5632.802851900327, 5656.688882111359, 5704.11586204139, 5544.528715059265, 5548.0845660465575, 5548.583856210719, 5551.750171242385, 5554.0, 5318.441563635763, 5527.364353099284, 5539.7784088636, 5556.749946252347, 5593.0771422716425, 5406.756695948613, 5445.83662490126, 5488.643238189505, 5516.696581688046, 5524.613277070727, 5627.52166065889, 5633.352164501135, 5650.717464126859, 5672.659640421588, 5698.601097923106, 5322.254884316276, 5389.865253368697, 5511.338639363302, 5519.917201241904, 5550.306211723535], "value": 5213.889374795346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9088136779483, 648.9286178520364, 652.7617419641832, 662.0830150241917, 664.8038828545579, 31864.20339491511, 32457.51313730293, 34853.302933941304, 34910.47634285485, 44351.55648443515, 42427.57572424275, 46873.0, 46920.296195557006, 46924.765376173156, 46973.0, 8989.190972812445, 9135.862962055542, 9144.131307525808, 9147.496887671176, 9148.908510914905, 8922.197002269795, 9003.459792412443, 9028.68399606014, 9029.593668284942, 9031.458112513237, 9062.410943288665, 9083.046280140588, 9096.727098187064, 9104.271658267357, 9109.180173784358, 9044.186023257906, 9083.318751093695, 9099.272058235325, 9101.499417532033, 9104.817903641957, 8899.688510902088, 8984.191422771983, 8985.23625491834, 8988.146126118008, 8992.77518062047, 42845.57154428478, 43094.784526077485, 43322.56677433217, 43328.70013899556, 43378.783106084265, 3475.548178736748, 3547.166415892263, 3645.6901163400876, 3670.4127339625798, 3950.2297052074855, 30952.535711964338, 32692.0, 33171.33657326864, 33362.833185834155, 34448.82775586131, 4186.727862688946, 4260.360945858115, 4268.9573104268875, 4286.0999190170105, 4419.977900110511, 371928.0, 371978.0, 372145.0, 372386.0, 372764.0, 58527.0, 58603.41396585979, 58721.77030263376, 59010.40989590049, 59016.1147582778, 54651.453485465434, 59595.0, 60951.69524152351, 60954.0, 65400.34599653943, 16966.830331696772, 17202.225899834288, 17212.483625491255, 17282.65434691299, 17317.0, 13405.597832065054, 13599.59201223965, 13700.520481783089, 13703.040787144804, 13704.944258361325, 14778.33497492594, 15975.920120399323, 16403.58991025234, 16555.420560280334, 17008.404705835237, 6523.780975219805, 6779.288174741581, 6824.761133360308, 6844.8973265401055, 6880.415164711056, 996.7757254617653, 1085.5494969587533, 1097.358045543366, 1099.8460215569826, 1105.0330960409642, 32625.673743262265, 32732.345353092805, 32899.67100328966, 33040.21968653011, 33248.0, 1117.5529788084832, 1129.8983091521802, 1152.991132758836, 1153.9423028848523, 1233.0628722171214, 16983.49049528516, 16987.575310617085, 17151.828481715274, 17295.913520432317, 17413.129343533026, 503230.0, 504738.0, 505838.0, 507060.0, 507921.0, 56874.0, 57005.0, 57006.0, 57152.71423642938, 57240.427595724344, 1304.5694920676153, 1398.909070910408, 1413.9080959737585, 1416.4688241909284, 1445.4724025730532, 32241.35517289688, 32784.50823237701, 33929.83035084809, 34030.8298458516, 34740.0, 50463.49536504588, 50969.0, 51025.0, 51029.489705102475, 51062.0, 410117.0, 412099.0, 413461.0, 413553.0, 414058.0, 31446.528302075945, 37721.62278377181, 38025.0, 39750.60249397469, 40313.59686403216, 45498.0, 46120.53879461296, 46235.0, 46563.0, 46856.53143468658, 39214.80392598019, 39396.21207575775, 39671.60328396679, 39938.201235974535, 40026.79986600048, 38275.0, 39563.80218098891, 39876.0, 39958.400623990085, 40098.198036038535, 39092.41361379639, 39911.0, 40477.39283910685, 40555.79722101371, 40653.0, 34237.0, 34785.8260708705, 35485.290294194485, 35616.10959726028, 35649.0, 27461.86269068642, 27685.0, 27744.861275693493, 27780.16659500218, 27873.860630696716], "value": 20230.355841336466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.89796754876176, 385.5450568329372, 392.40550565892676, 396.39549686727753, 410.81718635207307, 17129.657406851857, 19105.42683719487, 19652.410427687155, 19687.21251149952, 19737.21051157954, 17968.37110701126, 17984.820151798478, 18202.271909123618, 18593.628127437478, 18917.62164756704, 5541.949478692889, 5562.443755624436, 5639.915401268984, 5711.257536520267, 5749.8275051748515, 5693.3452652945025, 5706.429357064281, 5731.14032895067, 5746.856328591777, 5749.281339832521, 5125.38495380553, 5412.56699464042, 5732.025555655528, 5757.625754325976, 5757.884842303151, 5273.1299335609965, 5330.760115794798, 5350.3312085989055, 5425.538829199503, 5432.483914028181, 5446.7276636168035, 5476.561875049986, 5477.123660214346, 5490.972545137289, 5492.725363731797, 11732.824007639892, 12068.879311206863, 12206.816897746541, 12283.877161228364, 12303.261804291771, 2157.91368345266, 2191.5069109450405, 2267.4104732769433, 2398.2205783120557, 2462.9507409851703, 9086.182243598108, 9206.309526785519, 9284.350095493319, 9431.528423578862, 9534.237261019101, 1888.6694828404975, 1900.9619807603908, 1942.0678074524167, 1947.581270026951, 1979.6337677529702, 53004.46995530072, 73378.0, 75354.24645753582, 77325.998564937, 80363.19636803615, 9457.43255404678, 9762.463064531377, 9762.609495620096, 10734.73163170927, 10874.347539147677, 28928.276793080342, 30017.24956876052, 30445.0, 30525.847370763004, 33203.50194747081, 9920.0, 10008.39949603026, 10298.845517317246, 10303.845442318372, 10552.261341706007, 8021.558814265155, 8027.518348899085, 8030.759077227693, 8479.448835825651, 8822.823543529094, 8615.396922215385, 8754.380439618692, 8845.646174152962, 8887.40026795183, 8998.370114091951, 3270.9018729438153, 3354.98051753419, 3486.4770284457027, 3513.4202856528896, 3599.820008999592, 915.2860768600502, 978.256525040974, 997.5610731278215, 1056.0231785598444, 1080.2168427889717, 18368.908155459136, 18570.0, 18590.349337773383, 19164.233430662895, 19361.031948402524, 1002.4837208837455, 1005.4118340770585, 1017.2421545948316, 1044.4777611194402, 1069.198101423932, 8265.669373225124, 10790.946045269724, 10821.783564328669, 10982.560697572168, 11026.393548354918, 481732.0, 488686.0, 494119.0, 494638.0, 494928.0, 64613.0, 90849.0, 91990.54004729934, 92014.53992730127, 95572.52213739026, 1021.8927012663712, 1027.198784947742, 1040.0327695243495, 1041.8645576075062, 1047.800917825626, 16197.919010404872, 16743.91628041852, 16866.241019153924, 16911.0, 16923.323067077672, 41014.0, 41215.7939210314, 41418.792906035276, 42591.3611295837, 42855.57144428516, 56348.0, 58217.0, 58722.70638646779, 59083.70458147682, 59190.40809592021, 7546.471746977879, 7677.654505547152, 8109.1485394035135, 8170.632321545426, 8278.544680042656, 13022.674433139247, 13200.33998300062, 13258.20450772918, 13832.446702131801, 13869.791953120914, 11496.137789665641, 11740.295582265091, 11759.76480470403, 11844.585439509921, 12292.0, 11362.204645674723, 11584.94207528957, 11671.649850504498, 11811.881881181078, 11894.464749086485, 11651.941740291244, 11943.283402995849, 12033.0, 12058.336791476553, 12119.272843629411, 7465.552066876005, 7620.199879012624, 7677.270659287359, 7919.762407127795, 8178.591070446573, 11450.885491144982, 11796.115291353355, 12060.939695301468, 12070.45682944252, 12319.815202772144], "value": 9436.80673342016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.2912356451084, 1531.686004369104, 1545.945891893784, 1728.153204929585, 1842.649896519661, 8305.169483051699, 8675.522846243453, 8690.130986901308, 8835.602397892095, 8932.196102350803, 8626.094260102678, 8800.691975780848, 8810.251128654056, 8820.514871682055, 8828.823423531525, 1954.140178321534, 2007.7590689117326, 2010.4270282969358, 2302.2172461363134, 2328.464453175762, 2375.9881200593973, 2463.174836429789, 2463.8521688698734, 2474.826762126652, 2485.0805202075258, 2282.589133955887, 2287.7712228777154, 2304.389336825734, 2309.2379514760087, 2318.4551630366936, 1988.5823976964855, 2297.356740112771, 2309.307207837659, 2327.0924339507606, 2331.1258278145697, 2381.8094552435764, 2429.392651837041, 2429.6598476213344, 2431.817613678981, 2432.9026838926598, 8878.911210887873, 8938.865917011184, 8941.374103812735, 8942.552872356422, 8944.64221431142, 5222.216667499867, 5344.198370244456, 5360.785568577252, 5367.141257398797, 5369.570434365241, 3247.8213698246586, 3332.6334103248623, 3460.3425349183826, 3465.42820434628, 3480.0255928340107, 1125.6004118537965, 1136.891995260449, 1156.2368836567825, 1157.7279339355246, 1159.1596092832713, 12890.677733056655, 12896.935515322364, 12905.225686458842, 12914.160579562298, 12941.094123411365, 4910.975445122752, 4913.1893237615395, 4927.926081108786, 4930.6795058321095, 5000.924801167694, 10802.027817496462, 10882.836757448644, 10903.890961090447, 10921.781564368668, 10922.508487118099, 5531.695756733418, 5564.443555644484, 5586.0, 5588.357338905997, 5591.580631452576, 4139.4204811326435, 4560.293154561048, 5049.772760225798, 5091.796328146833, 5114.028334616411, 4110.383442483591, 4140.730852494578, 4176.686748493875, 4249.87250382489, 4297.462817147856, 1278.571678487717, 1318.156379916854, 1328.448693792085, 1341.121565374681, 1342.724741428005, 1014.4015031131668, 1021.0861279155263, 1027.9794404111876, 1047.4553232319151, 1049.228816819637, 6239.376062393815, 6242.375762423812, 6289.182406287245, 6309.747610095545, 6391.07329437229, 462.1404188209927, 464.7443905851768, 465.36942442989937, 467.2873867352247, 481.7904211667936, 4313.827446902152, 4458.9331160032625, 4474.865754027384, 4508.391367165456, 4558.840440584564, 11019.0, 11137.443127843575, 11485.0811935045, 11523.423828808525, 11527.423628818693, 11319.094472442184, 11492.885071149349, 11497.655070347902, 11520.308781473139, 11532.827007594893, 8519.275861551714, 8524.27543658796, 8641.179087986631, 8672.696455624024, 8715.477071375737, 6196.287426945959, 6223.471004964447, 6243.37566243372, 6261.530385221217, 6349.587276826992, 10464.267501274837, 10498.947505262426, 10631.149508039493, 10663.46682665879, 10684.626038088629, 10029.799404012025, 10457.738556536147, 10462.424566648908, 10661.786764264827, 10668.146548276274, 8184.7953801155445, 8263.256306932404, 8319.958400207961, 8341.666333346599, 8344.37417193725, 8791.340649451444, 8851.291896648125, 8851.822963540564, 8864.379493435656, 8946.597403116744, 8003.679852806055, 8101.9594902027475, 8148.307393871587, 8214.958925205574, 8374.497530147966, 7428.442866784904, 7437.442191835526, 7529.096508419025, 7623.16145224036, 7686.57723825195, 6979.4765392594745, 6999.8950015750825, 7076.681549330396, 7087.787366379017, 7128.536645118051, 5099.056674515226, 5125.92311115341, 5143.974280128725, 5179.274901513866, 5283.682979021271, 5190.8260701430345, 5286.920696189483, 5301.284326616012, 5389.9759045781175, 5463.945360546344], "value": 4685.726840405452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.59856580708316, 323.98218098004605, 326.1454987931619, 329.17213208779924, 331.75284413112234, 5133.845984620458, 5272.969906585963, 5292.814751483699, 5298.4436634153435, 5340.866478338044, 5230.149568485175, 5269.473052694738, 5283.498067683564, 5293.417724050351, 5309.469053094688, 4156.792160391976, 4163.897231897888, 4165.500139983191, 4165.541790403053, 4209.6000879916355, 3885.8834234972996, 3910.921781564367, 4132.772697501636, 4163.375493675958, 4166.708330416872, 4052.898677533056, 4083.3466645336753, 4095.5290141633795, 4108.85619003335, 4112.157007813406, 4069.776162311072, 4072.8778136655947, 4081.632653061209, 4082.6121518455698, 4092.3043082675717, 3584.444411116255, 3603.4594810778594, 3608.693261072786, 3619.3304238715923, 3626.582942961567, 5021.748912554394, 5055.292259083732, 5109.233614957749, 5122.129238029544, 5127.97445009223, 4609.792559334838, 4639.420072490939, 4643.907121857577, 4648.3957085578995, 4676.228422310314, 5201.739913004335, 5438.646487978269, 5472.890542189174, 5478.260434841325, 5480.342358916955, 3932.8791294480934, 3957.28768821612, 3963.9405408918888, 3977.5425826030087, 3977.880663580097, 5629.802956896489, 5654.604177707603, 5681.744321505542, 5713.885722285572, 5718.884012915248, 4057.411675307123, 4077.8164982575854, 4088.3867419887256, 4091.1204091119957, 4112.074783173822, 3910.569837317893, 4036.737612055207, 4041.5958404159937, 4072.9817545613596, 4083.224187404384, 4623.589805109474, 4659.510751371057, 4660.297027723912, 4665.790039448233, 4702.988857395676, 5538.529225015838, 5544.750486228129, 5548.833534993957, 5554.861128471821, 5575.581831362664, 1308.3719814489098, 1345.0248569786827, 1392.554382597559, 1393.7212557488542, 1399.7130588229388, 879.4942907828024, 886.4061079077034, 887.5562218890555, 889.9377043606885, 891.1801142948503, 4714.575688188011, 4758.262469317261, 4762.4285085789925, 4781.163296423112, 4800.855974320776, 5017.8243761468175, 5040.49595040493, 5040.689420750631, 5070.873228169326, 5083.398729400227, 4560.908781824412, 4739.980904105565, 4773.0, 4785.952140478551, 4789.95210047895, 2672.398710290169, 2680.8659567021573, 2683.6913754918432, 2685.4827022732093, 2691.9730802692116, 5011.373578302712, 5047.4447810740785, 5134.871628209325, 5137.229415587692, 5139.9720055988955, 4923.990581930696, 5070.9604531071045, 5082.872928176826, 5083.923741143886, 5087.211482220262, 5096.388433388017, 5105.183170692671, 5125.15434953236, 5134.743262836843, 5137.460566640524, 4926.4088309403105, 4936.383716630192, 4937.580585513145, 4942.382202224722, 5001.924586213836, 4907.276461563723, 4969.403671559436, 4985.45450910219, 5268.0, 5682.0, 5832.9708351457975, 5854.590178687451, 5855.648661080349, 5859.5019423349495, 5866.2373891393845, 3874.3994680824517, 4069.67442604585, 4085.71400001997, 4110.77390743512, 4120.21715873983, 5577.0, 5657.943420565742, 5661.264035675335, 5682.090865461506, 5684.63049901755, 5530.474604912527, 5536.086545719912, 5541.251930989265, 5569.19246709233, 5592.049351610155, 5275.868103297448, 5544.916826247691, 5546.528545073714, 5553.250311207935, 5576.832695019156, 5429.67421954684, 5441.918371224356, 5444.945550544444, 5449.746558291695, 5478.082671065095, 5526.585506086979, 5526.91709624364, 5574.9721251393485, 5579.4978451937895, 5640.717964101696, 5305.336832895888, 5429.429909859408, 5455.236266922555, 5477.260569823182, 5482.91775623358], "value": 4078.965739537978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.7520768561745, 814.1803070138236, 818.4311903227258, 822.9218224268697, 830.1611929575988, 13853.238071906053, 14690.926545367272, 14811.851881481181, 14833.110013399204, 14854.628634284134, 14304.35630396632, 14357.78463323051, 14371.640708982255, 14388.856111438909, 14402.927985360086, 680.3638597910945, 801.591188493868, 808.4946908182386, 816.1919699497485, 836.5984327522792, 821.6631181215703, 830.7175560309494, 830.8047608811925, 833.2042899031441, 835.381817455085, 874.4796845876725, 876.1807709791334, 876.8640860666607, 878.1920633017608, 878.5431575580694, 721.1058287723238, 734.9816254593625, 855.5080828523562, 874.8381549413378, 877.9912200878038, 646.4698946863574, 646.7800947677812, 646.7930262316061, 646.9029645553157, 647.0520687193284, 14614.561563153122, 14714.264286785618, 14726.926365368105, 14739.55781326562, 14748.188849613267, 14072.648183795385, 14216.573502794932, 14217.85782142186, 14269.928650356786, 14298.396991491216, 12369.567065152676, 12453.1905426147, 12535.31055791931, 12593.811092833523, 12703.428345724464, 4533.727976321431, 4553.385292985437, 4588.839390621346, 4601.493835678073, 4652.534451647754, 52300.47699522994, 53715.462845371825, 53884.191737123976, 57975.71012144954, 59461.7026914867, 11012.0, 11253.493592788343, 11336.29478953226, 11346.716332091599, 11511.539538418538, 21280.36158915235, 21359.89320053421, 21421.78578214198, 21441.78558214429, 21473.248436304653, 8651.567421628893, 8817.823643527094, 8853.335999799912, 8876.245519130816, 9017.323700722472, 4655.231886738718, 4664.930026049612, 4713.81144754206, 4724.314974328772, 4725.976370118127, 3463.5843698755807, 3567.4827150063616, 3572.1783989682, 3579.0, 3598.4962105305276, 639.6897504710212, 667.2626747444004, 667.4760313154247, 671.8790617688863, 672.1765836849918, 660.365595151995, 706.1949377709312, 775.441681988967, 794.1819925476768, 803.4978138663336, 10184.083432491112, 10551.630692925712, 10599.07834101372, 10610.029191826146, 10677.0, 627.9277883043509, 692.1452006771633, 723.989140162898, 780.55898417394, 805.2712295372697, 5046.772895219724, 5079.5428411443145, 5083.110455670243, 5121.489160697603, 5137.6660517066275, 56465.7176714122, 73681.63159184277, 76425.6178719114, 76820.0, 76957.230427695, 66799.66600166968, 66866.66566667135, 67250.32749672538, 67370.0, 68616.31383686198, 58796.41203587995, 59044.40955590475, 59196.70401647964, 59393.40606593965, 60244.49388765228, 9570.808583828424, 9591.376560523544, 9607.567659455202, 9626.0, 9781.315307928377, 38935.0, 39183.0, 39189.608103918596, 39442.802785985885, 40571.0, 52270.215946760065, 54174.0, 54321.0, 54391.0, 54407.18389224086, 11979.520819167135, 12082.335471548797, 12097.879021209676, 12281.201721888048, 12578.0, 13680.179189248676, 13914.791278130633, 14069.226192559097, 14213.50252741149, 14406.639834004234, 13023.153495022792, 13035.15271507349, 13207.537736179187, 13477.730445391233, 13739.656508587364, 12932.15940963872, 12934.288614125937, 13494.595162145151, 13533.390997404944, 13543.0, 12553.184043037174, 12597.685057873627, 12733.0, 12822.422990965242, 13457.259850707913, 10596.205284603531, 10829.404382759023, 10855.077318427706, 11148.498317575892, 11238.7752244953, 10514.474276286308, 10983.61557345489, 11108.833367499332, 11154.49804758804, 11209.55161793519], "value": 7180.4686498492965, "unit": "score"}], "name": "dromaeo_css", "value": 7176.614004466865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 113.0, 114.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 153.0, 203.0, 126.0, 152.0, 150.0, 124.0, 194.0, 123.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 161.0, 75.0, 74.0, 75.0, 75.0, 129.0, 74.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 145.0, 91.0, 90.0, 90.0, 124.0, 91.0, 102.0, 124.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 144.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 96.0, 96.0, 95.0, 94.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 55.0, 56.0, 56.0, 56.0, 119.0, 53.0, 53.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 58.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 78.0, 77.0, 78.0, 83.0, 78.0, 84.0, 85.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 128.0, 120.0, 125.0, 120.0, 130.0, 134.0, 190.0, 129.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 168.0, 156.0, 157.0, 160.0, 159.0, 158.0, 159.0, 157.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 19:34:57 INFO - Return code: 0 19:34:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:34:57 ERROR - # TBPL SUCCESS # 19:34:57 INFO - Running post-action listener: _resource_record_post_action 19:34:57 INFO - ##### 19:34:57 INFO - ##### Finished run-tests step (success) 19:34:57 INFO - ##### 19:34:57 INFO - Running post-run listener: _resource_record_post_run 19:34:57 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 535572480; Read time: 0; Write time: 444552 19:34:57 INFO - TinderboxPrint: CPU usage
13.1% 19:34:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:34:57 INFO - TinderboxPrint: I/O write bytes / time
535,572,480 / 444,552 19:34:57 INFO - TinderboxPrint: CPU idle
8,269.7 (86.9%) 19:34:57 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 19:34:57 INFO - TinderboxPrint: Swap in / out
0 / 0 19:34:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246267904; Read time: 0; Write time: 278700 19:34:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 286969856; Read time: 0; Write time: 165644 19:34:57 INFO - Running post-run listener: _upload_blobber_files 19:34:57 INFO - Blob upload gear active. 19:34:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:34:57 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 19:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 19:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:59 INFO - (blobuploader) - INFO - Done attempting. 19:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:10 INFO - (blobuploader) - INFO - Done attempting. 19:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:10 INFO - (blobuploader) - INFO - Done attempting. 19:35:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:35:10 INFO - Return code: 0 19:35:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:35:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:35:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba97d98e5ccd97a6c585e0e2bf66d0b27a7405fe825abe8488b12a8d6b942256e4d7552088bc80f41e7730a702104abad8d1a06959cb907a1ff69c0bde43b61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721679eededb423cc8c45c0081ad9dccb9496d1f4fbd1a306a2b14deae4dbd429ef19934a5cca1abcb69ef6689f2a5c19c9ec78347cbd56f9b934905b19a05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f95e4a65b4c4e3d571171d381958105827ae36cd3990fba6fd1c4fb63cdc12c1cf1145291fa7cae3eff904f1ac6648ad1fef29f69914b62c53ec35f7920939e"} 19:35:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:35:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:35:10 INFO - Contents: 19:35:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba97d98e5ccd97a6c585e0e2bf66d0b27a7405fe825abe8488b12a8d6b942256e4d7552088bc80f41e7730a702104abad8d1a06959cb907a1ff69c0bde43b61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721679eededb423cc8c45c0081ad9dccb9496d1f4fbd1a306a2b14deae4dbd429ef19934a5cca1abcb69ef6689f2a5c19c9ec78347cbd56f9b934905b19a05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f95e4a65b4c4e3d571171d381958105827ae36cd3990fba6fd1c4fb63cdc12c1cf1145291fa7cae3eff904f1ac6648ad1fef29f69914b62c53ec35f7920939e"} 19:35:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:35:10 INFO - Copying logs to upload dir... 19:35:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:35:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.934166 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 19:35:09.733089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 19:35:09.737103) ========= 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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba97d98e5ccd97a6c585e0e2bf66d0b27a7405fe825abe8488b12a8d6b942256e4d7552088bc80f41e7730a702104abad8d1a06959cb907a1ff69c0bde43b61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721679eededb423cc8c45c0081ad9dccb9496d1f4fbd1a306a2b14deae4dbd429ef19934a5cca1abcb69ef6689f2a5c19c9ec78347cbd56f9b934905b19a05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f95e4a65b4c4e3d571171d381958105827ae36cd3990fba6fd1c4fb63cdc12c1cf1145291fa7cae3eff904f1ac6648ad1fef29f69914b62c53ec35f7920939e"} build_url:https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/YN2Kfg1DQ52wTKjMdpqzdw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba97d98e5ccd97a6c585e0e2bf66d0b27a7405fe825abe8488b12a8d6b942256e4d7552088bc80f41e7730a702104abad8d1a06959cb907a1ff69c0bde43b61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4721679eededb423cc8c45c0081ad9dccb9496d1f4fbd1a306a2b14deae4dbd429ef19934a5cca1abcb69ef6689f2a5c19c9ec78347cbd56f9b934905b19a05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f95e4a65b4c4e3d571171d381958105827ae36cd3990fba6fd1c4fb63cdc12c1cf1145291fa7cae3eff904f1ac6648ad1fef29f69914b62c53ec35f7920939e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 19:35:09.762509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:35:09.762896) ========= 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=574dc5aafe09851ec43d388c000001b6-1463448699.733904-678081955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 19:35:09.845668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 19:35:09.846045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 19:35:09.846383) ========= ========= Total master_lag: 0.17 =========