builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1464702256.37 results: success (0) buildid: 20160531053439 builduid: f866d3b1a2794dd298a1ae0703747f9c revision: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.371901) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.372276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.372563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.428927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.429202) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 06:44:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-05-31 06:44:16 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.510563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.510868) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016715 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.560389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.560733) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af81ae8922d6a90dc0413bb1c0f8fdf176a628fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af81ae8922d6a90dc0413bb1c0f8fdf176a628fa --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 06:44:16,742 truncating revision to first 12 chars 2016-05-31 06:44:16,743 Setting DEBUG logging. 2016-05-31 06:44:16,743 attempt 1/10 2016-05-31 06:44:16,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af81ae8922d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 06:44:17,060 unpacking tar archive at: fx-team-af81ae8922d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.246787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.247096) ========= script_repo_revision: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.247504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.247776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.255624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-31 06:44:17.255936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:17 INFO - MultiFileLogger online at 20160531 06:44:17 in /builds/slave/test 06:44:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:44:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:17 INFO - {'append_to_log': False, 06:44:17 INFO - 'base_work_dir': '/builds/slave/test', 06:44:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:44:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:17 INFO - 'branch': 'Fx-Team-Non-PGO', 06:44:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:17 INFO - 'config_files': ('talos/linux_config.py',), 06:44:17 INFO - 'default_actions': ('clobber', 06:44:17 INFO - 'read-buildbot-config', 06:44:17 INFO - 'download-and-extract', 06:44:17 INFO - 'populate-webroot', 06:44:17 INFO - 'create-virtualenv', 06:44:17 INFO - 'install', 06:44:17 INFO - 'run-tests'), 06:44:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:17 INFO - 'download_minidump_stackwalk': True, 06:44:17 INFO - 'download_symbols': 'ondemand', 06:44:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:17 INFO - 'installer_path': 'installer.exe', 06:44:17 INFO - 'log_level': 'info', 06:44:17 INFO - 'log_name': 'talos', 06:44:17 INFO - 'log_to_console': True, 06:44:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:17 INFO - 'opt_config_files': (), 06:44:17 INFO - 'pip_index': False, 06:44:17 INFO - 'sps_profile': False, 06:44:17 INFO - 'sps_profile_interval': 0, 06:44:17 INFO - 'suite': 'dromaeojs', 06:44:17 INFO - 'system_bits': '32', 06:44:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:17 INFO - 'title': 'talos-linux64-ix-022', 06:44:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:17 INFO - 'use_talos_json': True, 06:44:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:17 INFO - 'work_dir': 'build'} 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running clobber step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: clobber 06:44:17 INFO - rmtree: /builds/slave/test/build 06:44:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:17 INFO - Running post-action listener: _resource_record_post_action 06:44:17 INFO - ##### 06:44:17 INFO - ##### Finished clobber step (success) 06:44:17 INFO - ##### 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running read-buildbot-config step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: read_buildbot_config 06:44:17 INFO - Using buildbot properties: 06:44:17 INFO - { 06:44:17 INFO - "project": "", 06:44:17 INFO - "product": "firefox", 06:44:17 INFO - "script_repo_revision": "production", 06:44:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:44:17 INFO - "repository": "", 06:44:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:44:17 INFO - "buildid": "20160531053439", 06:44:17 INFO - "pgo_build": "False", 06:44:17 INFO - "basedir": "/builds/slave/test", 06:44:17 INFO - "buildnumber": 1806, 06:44:17 INFO - "slavename": "talos-linux64-ix-022", 06:44:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:44:17 INFO - "platform": "ubuntu64_hw", 06:44:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:44:17 INFO - "branch": "fx-team", 06:44:17 INFO - "repo_path": "integration/fx-team", 06:44:17 INFO - "revision": "af81ae8922d6a90dc0413bb1c0f8fdf176a628fa", 06:44:17 INFO - "stage_platform": "linux64", 06:44:17 INFO - "builduid": "f866d3b1a2794dd298a1ae0703747f9c", 06:44:17 INFO - "slavebuilddir": "test" 06:44:17 INFO - } 06:44:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:44:17 INFO - Running post-action listener: _resource_record_post_action 06:44:17 INFO - ##### 06:44:17 INFO - ##### Finished read-buildbot-config step (success) 06:44:17 INFO - ##### 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running download-and-extract step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: download_and_extract 06:44:17 INFO - mkdir: /builds/slave/test/build/tests 06:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:17 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:20 INFO - Downloaded 1361 bytes. 06:44:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:20 INFO - Using the following test package requirements: 06:44:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:44:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:44:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'jsshell-linux-x86_64.zip'], 06:44:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:44:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:44:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:44:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:44:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:44:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:44: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')]} 06:44:20 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:21 INFO - Downloaded 22840449 bytes. 06:44:21 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'] 06:44:21 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 06:44:22 INFO - Return code: 0 06:44:22 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 06:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:22 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:26 INFO - Downloaded 22840449 bytes. 06:44:26 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'] 06:44:26 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 06:44:28 INFO - Return code: 0 06:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:28 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:29 INFO - Downloaded 10834055 bytes. 06:44:29 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'] 06:44:29 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 06:44:29 INFO - Return code: 0 06:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:29 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:31 INFO - Downloaded 55033677 bytes. 06:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:31 INFO - mkdir: /builds/slave/test/properties 06:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:31 INFO - Contents: 06:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:32 INFO - Running post-action listener: _resource_record_post_action 06:44:32 INFO - Running post-action listener: set_extra_try_arguments 06:44:32 INFO - ##### 06:44:32 INFO - ##### Finished download-and-extract step (success) 06:44:32 INFO - ##### 06:44:32 INFO - ##### 06:44:32 INFO - ##### Running populate-webroot step. 06:44:32 INFO - ##### 06:44:32 INFO - Running pre-action listener: _resource_record_pre_action 06:44:32 INFO - Running main action method: populate_webroot 06:44:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:32 INFO - '--tppagecycles', 06:44:32 INFO - '7'], 06:44:32 INFO - 'tests': ['tsvgm']}}, 06:44:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['damp', 'tps']}, 06:44:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['damp', 'tps']}, 06:44:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['dromaeo_dom']}, 06:44:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tsvgx', 06:44:32 INFO - 'tsvgr_opacity', 06:44:32 INFO - 'tart', 06:44:32 INFO - 'tscrollx', 06:44:32 INFO - 'cart']}, 06:44:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:32 INFO - 'tsvgr_opacity', 06:44:32 INFO - 'tart', 06:44:32 INFO - 'tscrollx', 06:44:32 INFO - 'cart']}, 06:44:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tp5o']}, 06:44:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['tp5o']}, 06:44:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s', 06:44:32 INFO - '--xperf_path', 06:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:32 INFO - 'tests': ['tp5n']}, 06:44:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--xperf_path', 06:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:32 INFO - 'tests': ['tp5n']}}, 06:44:32 INFO - 'talos.zip': {'path': '', 06:44:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:32 INFO - Running post-action listener: _resource_record_post_action 06:44:32 INFO - ##### 06:44:32 INFO - ##### Finished populate-webroot step (success) 06:44:32 INFO - ##### 06:44:32 INFO - ##### 06:44:32 INFO - ##### Running create-virtualenv step. 06:44:32 INFO - ##### 06:44:32 INFO - Running pre-action listener: _resource_record_pre_action 06:44:32 INFO - Running main action method: create_virtualenv 06:44:32 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:32 INFO - Using real prefix '/usr' 06:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:35 INFO - Installing pip.................done. 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:44:35 INFO - Cleaning up... 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Downloading/unpacking psutil>=3.1.1 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:37 INFO - Installing collected packages: psutil 06:44:37 INFO - Running setup.py install for psutil 06:44:37 INFO - building 'psutil._psutil_linux' extension 06:44:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:44:37 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 06:44:37 INFO - building 'psutil._psutil_posix' extension 06:44:37 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 06:44:37 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 06:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:37 INFO - Successfully installed psutil 06:44:37 INFO - Cleaning up... 06:44:37 INFO - Return code: 0 06:44:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:37 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 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:37 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 06:44:37 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 06:44:37 INFO - Using env: {'DISPLAY': ':0', 06:44:37 INFO - 'HOME': '/home/cltbld', 06:44:37 INFO - 'LANG': 'en_US.UTF-8', 06:44:37 INFO - 'LANGUAGE': 'en_US:en', 06:44:37 INFO - 'LOGNAME': 'cltbld', 06:44:37 INFO - 'MAIL': '/var/mail/cltbld', 06:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:37 INFO - 'MOZ_NO_REMOTE': '1', 06:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:37 INFO - 'NO_EM_RESTART': '1', 06:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:37 INFO - 'PWD': '/builds/slave/test', 06:44:37 INFO - 'SHELL': '/bin/bash', 06:44:37 INFO - 'SHLVL': '1', 06:44:37 INFO - 'TERM': 'linux', 06:44:37 INFO - 'TMOUT': '86400', 06:44:37 INFO - 'USER': 'cltbld', 06:44:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:37 INFO - '_': '/tools/buildbot/bin/python'} 06:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:40 INFO - Installing collected packages: mozsystemmonitor 06:44:40 INFO - Running setup.py install for mozsystemmonitor 06:44:40 INFO - Successfully installed mozsystemmonitor 06:44:40 INFO - Cleaning up... 06:44:40 INFO - Return code: 0 06:44:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:44:40 INFO - Using env: {'DISPLAY': ':0', 06:44:40 INFO - 'HOME': '/home/cltbld', 06:44:40 INFO - 'LANG': 'en_US.UTF-8', 06:44:40 INFO - 'LANGUAGE': 'en_US:en', 06:44:40 INFO - 'LOGNAME': 'cltbld', 06:44:40 INFO - 'MAIL': '/var/mail/cltbld', 06:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:40 INFO - 'MOZ_NO_REMOTE': '1', 06:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:40 INFO - 'NO_EM_RESTART': '1', 06:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:40 INFO - 'PWD': '/builds/slave/test', 06:44:40 INFO - 'SHELL': '/bin/bash', 06:44:40 INFO - 'SHLVL': '1', 06:44:40 INFO - 'TERM': 'linux', 06:44:40 INFO - 'TMOUT': '86400', 06:44:40 INFO - 'USER': 'cltbld', 06:44:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:40 INFO - '_': '/tools/buildbot/bin/python'} 06:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:40 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:42 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:43 INFO - Downloading docopt-0.6.1.tar.gz 06:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:43 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:43 INFO - Running setup.py install for blobuploader 06:44:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:43 INFO - Running setup.py install for requests 06:44:43 INFO - Running setup.py install for docopt 06:44:43 INFO - Successfully installed blobuploader requests docopt 06:44:43 INFO - Cleaning up... 06:44:43 INFO - Return code: 0 06:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:43 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')]} 06:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:43 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')]} 06:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:43 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 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:43 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 06:44:43 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 06:44:43 INFO - Using env: {'DISPLAY': ':0', 06:44:43 INFO - 'HOME': '/home/cltbld', 06:44:43 INFO - 'LANG': 'en_US.UTF-8', 06:44:43 INFO - 'LANGUAGE': 'en_US:en', 06:44:43 INFO - 'LOGNAME': 'cltbld', 06:44:43 INFO - 'MAIL': '/var/mail/cltbld', 06:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:43 INFO - 'MOZ_NO_REMOTE': '1', 06:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:43 INFO - 'NO_EM_RESTART': '1', 06:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:43 INFO - 'PWD': '/builds/slave/test', 06:44:43 INFO - 'SHELL': '/bin/bash', 06:44:43 INFO - 'SHLVL': '1', 06:44:43 INFO - 'TERM': 'linux', 06:44:43 INFO - 'TMOUT': '86400', 06:44:43 INFO - 'USER': 'cltbld', 06:44:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:43 INFO - '_': '/tools/buildbot/bin/python'} 06:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:43 INFO - Running setup.py (path:/tmp/pip-pqBqGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:44 INFO - Running setup.py (path:/tmp/pip-chPeb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:44 INFO - Running setup.py (path:/tmp/pip-jILQ9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:44 INFO - Running setup.py (path:/tmp/pip-zMs0gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:44 INFO - Running setup.py (path:/tmp/pip-CfYjch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:44 INFO - Running setup.py (path:/tmp/pip-C9fxZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:44 INFO - Running setup.py (path:/tmp/pip-Q1blKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:44 INFO - Running setup.py (path:/tmp/pip-3xYw9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:44 INFO - Running setup.py (path:/tmp/pip-AiIiQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:44 INFO - Running setup.py (path:/tmp/pip-7D3g5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:44 INFO - Running setup.py (path:/tmp/pip-qbHfC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:44 INFO - Running setup.py (path:/tmp/pip-0qgdCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:44 INFO - Running setup.py (path:/tmp/pip-VmuDZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:44 INFO - Running setup.py (path:/tmp/pip-f5ZtbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:44 INFO - Running setup.py (path:/tmp/pip-Oka8Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:45 INFO - Running setup.py (path:/tmp/pip-T9MkHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:45 INFO - Running setup.py (path:/tmp/pip-7Cahh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:45 INFO - Running setup.py install for manifestparser 06:44:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:45 INFO - Running setup.py install for mozcrash 06:44:45 INFO - Running setup.py install for mozdebug 06:44:45 INFO - Running setup.py install for mozdevice 06:44:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:44:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:45 INFO - Running setup.py install for mozfile 06:44:45 INFO - Running setup.py install for mozhttpd 06:44:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:45 INFO - Running setup.py install for mozinfo 06:44:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:45 INFO - Running setup.py install for mozInstall 06:44:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Running setup.py install for mozleak 06:44:46 INFO - Running setup.py install for mozlog 06:44:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Running setup.py install for moznetwork 06:44:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Running setup.py install for mozprocess 06:44:46 INFO - Running setup.py install for mozprofile 06:44:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Running setup.py install for mozrunner 06:44:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Running setup.py install for mozscreenshot 06:44:46 INFO - Running setup.py install for moztest 06:44:46 INFO - Running setup.py install for mozversion 06:44:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:46 INFO - Cleaning up... 06:44:47 INFO - Return code: 0 06:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:44:47 INFO - Using env: {'DISPLAY': ':0', 06:44:47 INFO - 'HOME': '/home/cltbld', 06:44:47 INFO - 'LANG': 'en_US.UTF-8', 06:44:47 INFO - 'LANGUAGE': 'en_US:en', 06:44:47 INFO - 'LOGNAME': 'cltbld', 06:44:47 INFO - 'MAIL': '/var/mail/cltbld', 06:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:47 INFO - 'MOZ_NO_REMOTE': '1', 06:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:47 INFO - 'NO_EM_RESTART': '1', 06:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:47 INFO - 'PWD': '/builds/slave/test', 06:44:47 INFO - 'SHELL': '/bin/bash', 06:44:47 INFO - 'SHLVL': '1', 06:44:47 INFO - 'TERM': 'linux', 06:44:47 INFO - 'TMOUT': '86400', 06:44:47 INFO - 'USER': 'cltbld', 06:44:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:47 INFO - '_': '/tools/buildbot/bin/python'} 06:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:47 INFO - Running setup.py (path:/tmp/pip-zWyrTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:47 INFO - Running setup.py (path:/tmp/pip-2lk4j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:47 INFO - Running setup.py (path:/tmp/pip-SmG62J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:47 INFO - Running setup.py (path:/tmp/pip-2bkFbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:47 INFO - Running setup.py (path:/tmp/pip-6Ch3hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:47 INFO - Running setup.py (path:/tmp/pip-ULU5MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:47 INFO - Running setup.py (path:/tmp/pip-cXyXok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:47 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)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:47 INFO - Running setup.py (path:/tmp/pip-noZFP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:47 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)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:47 INFO - Running setup.py (path:/tmp/pip-Os95rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:47 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)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:47 INFO - Running setup.py (path:/tmp/pip-RY_9sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:47 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)) 06:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:47 INFO - Running setup.py (path:/tmp/pip-si28R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:48 INFO - Running setup.py (path:/tmp/pip-xHVG_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:48 INFO - Running setup.py (path:/tmp/pip-uGUero-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:48 INFO - Running setup.py (path:/tmp/pip-vU_igr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:48 INFO - Running setup.py (path:/tmp/pip-A5xwao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:48 INFO - Running setup.py (path:/tmp/pip-WtC6gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:48 INFO - Running setup.py (path:/tmp/pip-Pmztzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:44:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:50 INFO - Downloading blessings-1.6.tar.gz 06:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:50 INFO - Installing collected packages: blessings 06:44:50 INFO - Running setup.py install for blessings 06:44:50 INFO - Successfully installed blessings 06:44:50 INFO - Cleaning up... 06:44:50 INFO - Return code: 0 06:44:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:50 INFO - Reading from file tmpfile_stdout 06:44:50 INFO - Current package versions: 06:44:50 INFO - argparse == 1.2.1 06:44:50 INFO - blessings == 1.6 06:44:50 INFO - blobuploader == 1.2.4 06:44:50 INFO - docopt == 0.6.1 06:44:50 INFO - manifestparser == 1.1 06:44:50 INFO - mozInstall == 1.12 06:44:50 INFO - mozcrash == 0.17 06:44:50 INFO - mozdebug == 0.1 06:44:50 INFO - mozdevice == 0.48 06:44:50 INFO - mozfile == 1.2 06:44:50 INFO - mozhttpd == 0.7 06:44:50 INFO - mozinfo == 0.9 06:44:50 INFO - mozleak == 0.1 06:44:50 INFO - mozlog == 3.2 06:44:50 INFO - moznetwork == 0.27 06:44:50 INFO - mozprocess == 0.22 06:44:50 INFO - mozprofile == 0.28 06:44:50 INFO - mozrunner == 6.11 06:44:50 INFO - mozscreenshot == 0.1 06:44:50 INFO - mozsystemmonitor == 0.3 06:44:50 INFO - moztest == 0.7 06:44:50 INFO - mozversion == 1.4 06:44:50 INFO - psutil == 3.1.1 06:44:50 INFO - requests == 1.2.3 06:44:50 INFO - wsgiref == 0.1.2 06:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:50 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 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:50 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 06:44:50 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 06:44:50 INFO - Using env: {'DISPLAY': ':0', 06:44:50 INFO - 'HOME': '/home/cltbld', 06:44:50 INFO - 'LANG': 'en_US.UTF-8', 06:44:50 INFO - 'LANGUAGE': 'en_US:en', 06:44:50 INFO - 'LOGNAME': 'cltbld', 06:44:50 INFO - 'MAIL': '/var/mail/cltbld', 06:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:50 INFO - 'MOZ_NO_REMOTE': '1', 06:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:50 INFO - 'NO_EM_RESTART': '1', 06:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:50 INFO - 'PWD': '/builds/slave/test', 06:44:50 INFO - 'SHELL': '/bin/bash', 06:44:50 INFO - 'SHLVL': '1', 06:44:50 INFO - 'TERM': 'linux', 06:44:50 INFO - 'TMOUT': '86400', 06:44:50 INFO - 'USER': 'cltbld', 06:44:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:50 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:44:51 INFO - Cleaning up... 06:44:51 INFO - Return code: 0 06:44:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:44:51 INFO - Using env: {'DISPLAY': ':0', 06:44:51 INFO - 'HOME': '/home/cltbld', 06:44:51 INFO - 'LANG': 'en_US.UTF-8', 06:44:51 INFO - 'LANGUAGE': 'en_US:en', 06:44:51 INFO - 'LOGNAME': 'cltbld', 06:44:51 INFO - 'MAIL': '/var/mail/cltbld', 06:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:51 INFO - 'MOZ_NO_REMOTE': '1', 06:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:51 INFO - 'NO_EM_RESTART': '1', 06:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:51 INFO - 'PWD': '/builds/slave/test', 06:44:51 INFO - 'SHELL': '/bin/bash', 06:44:51 INFO - 'SHLVL': '1', 06:44:51 INFO - 'TERM': 'linux', 06:44:51 INFO - 'TMOUT': '86400', 06:44:51 INFO - 'USER': 'cltbld', 06:44:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:51 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:51 INFO - Downloading/unpacking jsonschema 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:53 INFO - Downloading/unpacking functools32 (from jsonschema) 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:53 INFO - warning: no files found matching '*.txt' 06:44:53 INFO - no previously-included directories found matching 'build' 06:44:53 INFO - no previously-included directories found matching 'dist' 06:44:53 INFO - no previously-included directories found matching '.git*' 06:44:53 INFO - Installing collected packages: jsonschema, functools32 06:44:53 INFO - Running setup.py install for functools32 06:44:53 INFO - warning: no files found matching '*.txt' 06:44:53 INFO - no previously-included directories found matching 'build' 06:44:53 INFO - no previously-included directories found matching 'dist' 06:44:53 INFO - no previously-included directories found matching '.git*' 06:44:53 INFO - Successfully installed jsonschema functools32 06:44:53 INFO - Cleaning up... 06:44:53 INFO - Return code: 0 06:44:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:53 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 0x7fa1ceac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', '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 06:44:53 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 06:44:53 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 06:44:53 INFO - Using env: {'DISPLAY': ':0', 06:44:53 INFO - 'HOME': '/home/cltbld', 06:44:53 INFO - 'LANG': 'en_US.UTF-8', 06:44:53 INFO - 'LANGUAGE': 'en_US:en', 06:44:53 INFO - 'LOGNAME': 'cltbld', 06:44:53 INFO - 'MAIL': '/var/mail/cltbld', 06:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:53 INFO - 'MOZ_NO_REMOTE': '1', 06:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:53 INFO - 'NO_EM_RESTART': '1', 06:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:53 INFO - 'PWD': '/builds/slave/test', 06:44:53 INFO - 'SHELL': '/bin/bash', 06:44:53 INFO - 'SHLVL': '1', 06:44:53 INFO - 'TERM': 'linux', 06:44:53 INFO - 'TMOUT': '86400', 06:44:53 INFO - 'USER': 'cltbld', 06:44:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:53 INFO - '_': '/tools/buildbot/bin/python'} 06:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:53 INFO - Downloading/unpacking flake8 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:44:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:44:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:44:56 INFO - no previously-included directories found matching 'docs/_build' 06:44:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:44:56 INFO - Running setup.py install for pep8 06:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:44:56 INFO - no previously-included directories found matching 'docs/_build' 06:44:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:44:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:44:56 INFO - Cleaning up... 06:44:56 INFO - Return code: 0 06:44:56 INFO - Running post-action listener: _resource_record_post_action 06:44:56 INFO - Running post-action listener: _start_resource_monitoring 06:44:56 INFO - Starting resource monitoring. 06:44:56 INFO - ##### 06:44:56 INFO - ##### Finished create-virtualenv step (success) 06:44:56 INFO - ##### 06:44:56 INFO - ##### 06:44:56 INFO - ##### Running install step. 06:44:56 INFO - ##### 06:44:56 INFO - Running pre-action listener: _resource_record_pre_action 06:44:56 INFO - Running main action method: install 06:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:57 INFO - Reading from file tmpfile_stdout 06:44:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:44:57 INFO - Reading from file tmpfile_stdout 06:44:57 INFO - Output received: 06:44:57 INFO - Usage: mozinstall [options] installer 06:44:57 INFO - Options: 06:44:57 INFO - -h, --help show this help message and exit 06:44:57 INFO - -d DEST, --destination=DEST 06:44:57 INFO - Directory to install application into. [default: 06:44:57 INFO - "/builds/slave/test"] 06:44:57 INFO - --app=APP Application being installed. [default: firefox] 06:44:57 INFO - mkdir: /builds/slave/test/build/application 06:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:45:13 INFO - Reading from file tmpfile_stdout 06:45:13 INFO - Output received: 06:45:13 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:13 INFO - Running post-action listener: _resource_record_post_action 06:45:13 INFO - ##### 06:45:13 INFO - ##### Finished install step (success) 06:45:13 INFO - ##### 06:45:13 INFO - ##### 06:45:13 INFO - ##### Running run-tests step. 06:45:13 INFO - ##### 06:45:13 INFO - Running pre-action listener: _resource_record_pre_action 06:45:13 INFO - Running main action method: run_tests 06:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:13 INFO - Python 2.7.3 06:45:13 INFO - Return code: 0 06:45:13 INFO - grabbing minidump binary from tooltool 06:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddb9c0>, '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 0xddc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddcd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:45:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:45:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:45:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:13 INFO - Return code: 0 06:45:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:45:14 INFO - Return code: 0 06:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:45:14 INFO - Using env: {'DISPLAY': ':0', 06:45:14 INFO - 'HOME': '/home/cltbld', 06:45:14 INFO - 'LANG': 'en_US.UTF-8', 06:45:14 INFO - 'LANGUAGE': 'en_US:en', 06:45:14 INFO - 'LOGNAME': 'cltbld', 06:45:14 INFO - 'MAIL': '/var/mail/cltbld', 06:45:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:14 INFO - 'MOZ_NO_REMOTE': '1', 06:45:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:14 INFO - 'NO_EM_RESTART': '1', 06:45:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:14 INFO - 'PWD': '/builds/slave/test', 06:45:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:14 INFO - 'SHELL': '/bin/bash', 06:45:14 INFO - 'SHLVL': '1', 06:45:14 INFO - 'TERM': 'linux', 06:45:14 INFO - 'TMOUT': '86400', 06:45:14 INFO - 'USER': 'cltbld', 06:45:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790', 06:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:14 INFO - '_': '/tools/buildbot/bin/python'} 06:45:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:45:14 INFO - mozversion application_buildid: 20160531053439 06:45:14 INFO - mozversion application_changeset: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa 06:45:14 INFO - mozversion application_display_name: Nightly 06:45:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:14 INFO - mozversion application_name: Firefox 06:45:14 INFO - mozversion application_remotingname: firefox 06:45:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:45:14 INFO - mozversion application_vendor: Mozilla 06:45:14 INFO - mozversion application_version: 49.0a1 06:45:14 INFO - mozversion platform_buildid: 20160531053439 06:45:14 INFO - mozversion platform_changeset: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa 06:45:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:45:14 INFO - mozversion platform_version: 49.0a1 06:45:14 INFO - using testdate: 1464702314 06:45:14 INFO - actual date: 1464702314 06:45:14 INFO - starting webserver on 'localhost:44579' 06:45:14 INFO - SUITE-START | Running 2 tests 06:45:14 INFO - TEST-START | dromaeo_css 06:45:14 INFO - operating with platform_type : linux_ 06:45:14 INFO - Initialising browser for dromaeo_css test... 06:45:14 INFO - TEST-INFO | started process 6859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3KVsfO/profile http://localhost:44579/getInfo.html) 06:45:18 INFO - PROCESS | 6859 | __metrics Screen width/height:1600/1200 06:45:18 INFO - PROCESS | 6859 | colorDepth:24 06:45:18 INFO - PROCESS | 6859 | Browser inner width/height: 1024/697 06:45:18 INFO - PROCESS | 6859 | __metrics 06:45:19 ERROR - PROCESS | 6859 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:45:20 INFO - TEST-INFO | 6859: exit 0 06:45:20 INFO - Browser initialized. 06:45:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:20 INFO - TEST-INFO | started process 6942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3KVsfO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:32 INFO - PROCESS | 6942 | RSS: Main: 157282304 06:45:32 INFO - PROCESS | 6942 | 06:46:24 INFO - PROCESS | 6942 | 1464702384057 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] 06:48:35 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44579/tests/dromaeo/cssquery-ext.html) 06:48:36 INFO - PROCESS | 6942 | RSS: Main: 278142976 06:48:36 INFO - PROCESS | 6942 | 06:51:39 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-ext.html (next: http://localhost:44579/tests/dromaeo/cssquery-jquery.html) 06:51:40 INFO - PROCESS | 6942 | RSS: Main: 247754752 06:51:40 INFO - PROCESS | 6942 | 06:54:42 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44579/tests/dromaeo/cssquery-mootools.html) 06:54:43 INFO - PROCESS | 6942 | RSS: Main: 243732480 06:54:43 INFO - PROCESS | 6942 | 06:57:45 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44579/tests/dromaeo/cssquery-prototype.html) 06:57:45 INFO - PROCESS | 6942 | RSS: Main: 236544000 06:57:45 INFO - PROCESS | 6942 | 07:00:48 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44579/tests/dromaeo/cssquery-yui.html) 07:00:49 INFO - PROCESS | 6942 | RSS: Main: 213692416 07:00:49 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | Cycle 1(1): loaded http://localhost:44579/tests/dromaeo/cssquery-yui.html (next: http://localhost:44579/tests/dromaeo/cssquery-dojo.html) 07:03:52 INFO - PROCESS | 6942 | RSS: Main: 277774336 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | __start_tp_report 07:03:52 INFO - PROCESS | 6942 | _x_x_mozilla_page_load 07:03:52 INFO - PROCESS | 6942 | _x_x_mozilla_page_load_details 07:03:52 INFO - PROCESS | 6942 | |i|pagename|runs| 07:03:52 INFO - PROCESS | 6942 | |0;dojo.html;2664.0542607374377;2690.959635605465;2721.6733991920964;2727.7681397081246;2741.931451713707;4606.47025592057;4685.929711054328;4688.882777930549;4760.024195040013;4801.855944321667;4678.461976872661;4705.505921878196;4710.057988402316;4730.314104454852;4740.312654665072;4308.3106702927535;4313.2020576193345;4378.452693413324;4420.491643460995;4528.9094218115615;4452.777361131946;4460.576245256695;4463.352813841991;4512.503624601291;4526.411566496367;4187.51843537994;4215.831366745327;4254.276772948606;4287.356896465524;4348.391225228486;4282.122164956177;4290.849820256307;4292.678049146327;4362.411074504965;4393.319035549495;4312.266914624522;4317.244482215599;4320.762358070305;4340.565943405666;4366.868993930188;4477.955220447787;4572.177008138534;4599.724016559017;4621.884452888671;4684.718916864965;5041.798328066873;5073.365829271341;5086.3133476980875;5088.872778180538;5089.3638295213095;5074.517920797518;5095.312132862054;5128.230765385185;5133.948660513422;5137.17805151174;4599.770011499411;4716.174669432836;4729.834455794065;4792.520747925249;4793.856184314476;5219.660722053054;5227.3465816772905;5235.450277720861;5286.841394758163;5293.285406470077;5045.798168073309;5085.2372144177925;5088.567471764942;5096.184610462383;5102.183650615883;4870.464248932614;4999.200127979506;5036.722980236049;5061.038402703474;5078.238264260317;4985.451600323961;4998.350214472095;4998.725070121178;5019.096562618691;5054.898902021939;4804.111239420648;4977.228529577921;4986.401631804207;4989.875253118628;5041.2438134280155;4110.424540564323;4158.708890377645;4225.176090662353;4230.61924426803;4234.322508398642;3653.6163702811355;3674.228412033503;3676.466912297702;3712.1833196696684;3713.3316003119157;4331.263685173528;4339.218940590724;4342.305231162999;4388;4388.034632380871;4896.1921282987905;4932.457429682732;4968.8757781055765;4989.501049894981;4994.825181118644;4249.320108782642;4258.787060646955;4271.765052922119;4275.422817919603;4308.849190278325;4385.956140438619;4428.22506061438;4430.468343798765;4474.463064432289;4480.126375356775;4810.518948105161;4857.635677324144;4877.975610122068;4882.36529251195;4882.536159064884;5101.311322971352;5111.233315002779;5131.666441681279;5135.460776618401;5192.74036298176;4657.534246575316;4753.287006948985;4859.246816743411;4872.366592342973;4926.4088309403105;4984.800607975641;5023.2214006829;5033.84898453047;5061.215511595708;5093.92359114621;5087.745612719424;5113.207452844815;5129.8974020518635;5134.845954621367;5167.457416971164;4735.195016847076;4848.636352273664;4876.878078048077;4967.081089998362;4989.25161225819;4879.292502587034;4900.198563017739;4904.362432883702;4908.852734417973;4941.061198372441;4855.223164293696;4863.537963893425;4888.291197776373;4898.9020219594695;4908.92636610444;4751.9287210692555;4788.880277993078;4894.853154405374;4906.067847109038;5000.699958002531;4732.313814496947;4826.855194344175;4828.082664293773;4839.588634966068;4864.416270047617 07:03:52 INFO - PROCESS | 6942 | |1;ext.html;522.8911636811898;574.8965186266472;583.6439771739239;586.5893874287999;592.1118322516227;27973.300667483323;28522.57216141757;30546.389072218542;30550.54174187389;30625.234369140784;41513.37729934054;42101.78949105258;42348;42769.35845962305;42872.78563607178;7673.462857599984;7850;7857.960710196441;7861.25318094783;7866;7487.363574096208;7706.807329816771;7843.176466471024;9919.702408927744;10221.89778102217;9821.852672209923;10191.847122293171;10203.387796732182;10204.795904081951;10211.540480678388;10044.849327260097;10148.289619726622;10150.187984961185;10154.238432117547;10156.593736250541;9916.851247231298;10030.548625311878;10083.59665613382;10122.595096196217;10124.190064794873;39439;39534.60465395338;39814.80092599548;39867.60132398668;39918.80040599778;3232.3535292941506;3235.4014507315987;3263.640999490078;3414.9829250853836;3517.208628058692;30759.538606920913;30888.53667194994;31534.36931261362;31536.526952095508;32301.838490807397;3460.1176699941607;3535.169235229719;3578.3916734155255;3600.6039335673054;3676.871309504181;283404;285061;285915.5704221486;286028;288313;59557.404425956054;60168.09747853786;60555.69722151361;60578.39421605728;60598.091028634604;63786.36213637897;63799;64115;64414.677926611;64448.677756610916;14156.64608384778;14652.194129322776;14652.78020829667;14659.633509162357;14666.63333416673;10157.492125393701;11127.554897804159;11261;11266.155038371991;11273.267237629529;18989.240430382906;19531.888594270356;20146.798532014785;20213.696794548094;20312.69530957037;7327.120745510573;7372.741954031583;7395.334419902235;7399.408047356306;7410.407167426593;905.4657751926263;971.8639390485338;993.8310487217191;1003.6136087606324;1024;29044.7095529042;29143.7085629141;29166.937471565605;29389.412211755644;29744.405111897642;982.6757170133839;998.3061772068343;1016;1023.8515415264745;1102.1183053557122;15141.394344226328;15447.845521544641;15533.456329028655;15866.127362994916;15891.125988070768;387012;388154;388258;388802;389614;52840.471595284325;52927.47072529225;53144;53223.46776532185;53301.200481992804;1087.320424734541;1203.1577895473029;1225.3138242584182;1241.2118304876287;1249.2691775311364;28938.565921511614;29959;30295.545566816956;30341;30933.226669333446;44408.11183776371;44475.33287000633;44851.327230092225;45050.99999999869;45069.32396014128;243664;244578;245461;245900;246791;32908.341833162725;34213.486797698555;41546.169076618906;42205;42811;43379.78310108429;44009.55990440054;44128.77935610301;44664;45261.77369113133;36910.26179476449;37891.24217515579;37926.810365948;38449;38565.80717096509;35924.64075359213;37472.81263593664;37676.81161594175;37771.62228377791;37780;36514.26971460503;36568.45147322739;36966.630333697394;37283.81358093192;37460.62539374681;32960.67039329576;33045.504317434774;33755;34076.82961585176;34351.82824085864;25603.23190304294;25622;25632.231033069038;26092.73907260979;26297.737022629528 07:03:52 INFO - PROCESS | 6942 | |2;jquery.html;363.77445983490225;368.43629247251704;373.8112253312077;384.97497662651944;387.02662803050333;15886.76169857453;16533.66932661346;16824.07467589282;16837.41069062583;17190.140492975333;16049.919750401232;16439.58901027475;17164.22760975756;17214.56963575911;17316.480505584823;5061.291419201315;5103.438621751604;5124.4106927703415;5246.50158234969;5248.5276325130735;3690.5571331440265;3872.612738726119;5138.897222055557;5557.666540007593;5874.471297583216;5904.88190236195;5912.142739302799;5919.911201331962;5935.169076329317;5938.88122237555;5849.122631605251;5919.200907877467;5941.316748573904;5946.256717910262;6081.635101893857;3321.485169798685;4879.243717223836;5253;5256.6057545684225;5273.393559740641;17348.826511734973;17361.913190434094;17417.30330786767;20334.186632534827;20452.693209601868;1886.9905650471796;1931.1406424141262;1972.2209727157692;1985.2852972929734;2044.1108117968731;12964.157329773534;12986.22082675033;13110.082294239408;13121.343932803322;13542.661433464144;1721.9754246223476;1759.0940665557248;1776.2806063544285;1790.6687262856412;1836.7244913262984;67380.6630966842;67855.66072169656;68154.97767533541;68160;68648;9465.43207407544;9574.425534467955;9621.27840411958;9630.229581633452;9822.557984890696;13374.06381553282;13468.326583670778;13472.663183420296;13476;13496.190228586316;7430.256974302527;7433.219511951275;7483.6258187090425;7619.809504762315;7665.61671916402;7175.461840361993;7257.237990011078;7270.454715896329;7298.087739032621;7340.743073992385;5992.40075992406;6088.269407671108;6148.600340977911;6226.377362263828;6262.467690246289;1567.6786258816915;1689.0372487682148;1697.2532085882171;1699.9575010624833;1784.6698360803293;747.8354761952362;830.5390508267849;889.3729920406098;938.7090002099371;1027.7790275090892;16497.365690109305;17083.145842707814;17281;17570.824291757173;17654.823451765576;920.7467946314817;928.8142371525722;936.9344145909721;941.2140862379989;972.8783902012249;9878.259130565237;9983.201343892471;10031.498425078717;10135.7466063349;10137.847932281022;366151;366344;373737;377205;378440;65801.67099164473;66806;66827.66586167038;66908;67596.32403676;872.0363997782613;878.6053630707461;879.8812160358269;907.773056735816;912.8904531456268;15350;15357.155356455502;15422.46021389246;15468.226588670746;15840.207989600704;23761.287161385186;30437.391252174388;30482.23794405069;31503.684963150074;32749;42315;42335;42448.1510369797;42453.363199551415;42595;6227.159333489921;6390.7763228286785;6583.80248592543;7027.61348125858;7177.784666460015;9394.577244023898;9905.15806156456;10248.53881575316;10292.176625870063;10636.680899573024;9047.864282035644;9129.908700912905;9388.155066044088;9389.671361502315;9437.57530911097;8916.687915922912;9496.287778416508;9559.426434413957;9584.66453674118;9671.226301895691;8738.519381434082;9012.729618111467;9333.813323733351;9596.808063838544;9887.4067555944;7012.474064445289;7189.2810718927685;7236;7239.239879812544;7351.889721654286;8318.417710760188;9281.814363712552;9378.249740020645;9493.382930109521;9497 07:03:52 INFO - PROCESS | 6942 | |3;mootools.html;1190.5832958464543;1405.1849927042317;1443.747344214762;1574.645704716439;1789.5973405983655;6907.965460172698;7658.310752032316;7879.330256928168;7884.408669349793;7896.684132634688;7885.56629385385;7910.36717062635;7954.045514538249;7956;7997.320227780631;2166.306781829819;2199.516106456577;2200.2299195281685;2202.3392982105383;2202.878841663716;2155.3426205007468;2163.5132095278595;2213.2585583829436;2213.4577028627928;2217.846719705752;2155.0948601587293;2162.891855407231;2172.869627822328;2173.913043478259;2198.109765544949;2150.849440539163;2157.061678170001;2159.0284372032493;2159.600473912323;2159.88120653364;2126.712893759354;2172.902219400131;2176.2056849250066;2176.4667656424117;2178.0525471419983;7770.3006729394065;7778.805529861742;7791.454598178129;7799.7270095546955;7812.72655457062;4486.394336764528;4676.672632915697;4689.601383882374;4692.061587682477;4693.037927224945;2771.6812566554904;2808.775297976157;2861.6136821529035;2863.0551917867056;2869.583910333011;825.2531459029528;843.4854738609444;867.280157469299;1731.9480415587552;1815.210383483189;10577.9471102644;10601.204909631808;10617.203709721725;10629.627963021258;10637.9468102659;4051.2100140472326;4063.89840253996;4155.688323375759;4157.958420415757;4234.513031001413;8452.61963211657;8461.407701460961;8469.703560375357;8477.27943124829;8479.236868681848;4539.523350048264;4586.3579098926175;4592;4597.379353787196;4599.33309670096;3801.6198380161763;4153.127843152912;4176.227397931331;4215.936760948588;4290.89272768177;3430.828458577061;3450.309938012357;3521.8063006534885;3543.6633519815578;3546.556680414948;1013.2957594471771;1026.1277913773233;1035.1615191694752;1037.1858091398367;1038.2991480750463;791.897053383068;792.37798328312;797.5214871077308;803.2931020701745;805.1787177079347;5225.346831646044;5392.56859451243;5415;5475.945240547623;5544.972275138679;395.58858786861344;401.65257052649247;406.3072461453215;408.9775561097257;425.12848660246374;3728.2357116790995;3748.681362084199;3752.4371344298575;3773.396256598931;3788.0908581940134;9663.226941844636;10042.598296068076;10116.645917393003;10117.392956422638;10122.746931326776;9736.853947190797;9992.050755178247;10003.849942250872;10012.199024078202;10106.090451859369;7602.733904313433;7611.124720657084;7664.31021208094;7676.57778822159;7681.846363072819;5342.813001544927;5347.144456887035;5357.464253574612;5360.892782144413;5487.4238204987905;8877.37858349935;9102.180803727697;9196.724098277062;9213.170814626448;9213.677521286723;9481.431114133175;9544.699433983009;9644.614215431584;9665.371750836173;9705.5147242639;6302.905456418249;6602.438792702674;6726.327367263235;6949.131358580177;7084.716611335489;7475.551466912003;7526.5860377679755;7548.1697013329585;7554;7557.05536807899;6423.614583125028;6604.669766511559;6609.933900660932;6691.631960242234;6719.496037797087;6507.251666058464;6532.41208291256;6570.244421891543;6640.136782218281;6720.227173875067;6451.3226111257645;6546.738130474918;6570.737170513126;6575.24384695747;6575.408213260829;4610.308453731833;4840.685355451885;4937.061958228069;5045.11710450677;5082.33929589151;4928.457869634266;4941.481144479778;5003.274525193754;5022.4977502249485;5099.821506247264 07:03:52 INFO - PROCESS | 6942 | |4;prototype.html;301.46489980284997;302.4495418338623;303.7448543223692;306.13364179372377;309.24235622724325;4684.6252299816015;4760.42874855017;4766.642501812365;4783.617310615151;4785.1147537705465;4714.434267887849;4714.669973101884;4723.763811809413;4736.313234580984;4748.976255118729;3576.7675101118407;3669.6330366963357;3678.3746763050344;3765.4351847222997;3803.125281185329;3738.065483629093;3759.567649720276;3763.4919285896326;3765.6046115157924;3788.6969042476535;3567.6432356764376;3734.047817806469;3739.7195210359196;3748.962510374902;3752.7185461090526;3642.981785091071;3743.588205297429;3743.644353786386;3774.9056273593105;3791.563970143414;3327.7670563060597;3334;3334.7498937579535;3350;3356;4542.364069030338;4552.90402526282;4558.2251017327135;4572.51988541205;4578.610818080467;4192.287311157111;4222.200217843345;4295.828166873322;4311.361682560639;4311.8059687313835;4943.456219815817;4958.363739965803;4958.404991401055;4982.402111746614;4990.276409920578;3616.6383361663884;3621.746477746559;3622.094476380905;3631.110377957391;3640.290143422007;4945.431275403339;5175.560077393388;5216.878371150221;5222.92165617516;5237.895242095175;3686.870959516404;3721.2371463849845;3724.77651340915;3736.3087828751222;3743.5320584926885;3751.643593858579;3762.698984081267;3769.849206031783;3788.1855401088897;3797.9620203798163;4257.489101307801;4262.381954616625;4263.232618128704;4266.402703621496;4271.654428854901;4661.277501987197;4880.487049014817;4928.827491037868;4935.395996301217;4973.975130124399;1272.7200015996466;1295.1840340585559;1299.389287035092;1300.9852315194164;1304.0806231606693;839.8068444257855;844.7634662294568;882.4396508217328;908.7728067983004;909.8498747706686;4348.782560871944;4351.73889566627;4358.3244597087505;4368.803403846835;4370.322599997005;5068.721220332917;5076.74616269185;5078.5937125029905;5083.212102124176;5098.745062746922;4167.499900012018;4294.828206871753;4311.741295522279;4323.135372925428;4324.675649326313;2643.70919198888;2652.9388244702272;2655.526182968471;2658.614500897359;2668.1461932181514;4720.740359280204;4728.148933192058;4759.452662943806;4772.475027746945;4773.856784296477;4888.877778055577;5084.796608135707;5116;5123.846284611468;5134.666246693953;4700.764961751967;4744.59670927975;4772.976135119302;4803.063402636452;4804.615630749532;4967.180415231446;4972.552470277692;4978.800847966186;5035.16919708244;5036.294918711456;4719.905601887875;4929.482404347492;4938.209886418156;4938.2839488273285;5039.815643323743;4884.926726099183;4898.24077268024;4917.582005529427;4925.655204135676;4928.67963582366;3604.981975090108;3610.1516143705685;3616.0417489364813;3616.349057169735;3621.9535962181285;5025;5084;5131.25596788471;5172.663776854492;5178.456262092577;4963.900721985612;4971.875703107451;5001.224810154432;5002.274670172732;5009.273655319886;4962.156433406258;4972.552470277692;4986.700797952134;4995.400551933792;5003.4246061701915;4778.371895457554;4848.466668666514;4882.170031094794;4891.33966914462;4915.361003069578;4794.904101918012;4888.437829649636;4977.178765503796;5024.171011783015;5035.244713293036;4915.926261106158;4923.310736496822;4929.507049295042;4931.397295878925;4941.950580494149 07:03:52 INFO - PROCESS | 6942 | |5;yui.html;664.9601023938565;682.1711620381238;692.954957927735;729.5768454296508;783.9764807055786;10787.892121078787;12215.38923053847;12453.501859925615;12455.750884982295;12464.563740269092;12046.939765301162;12142.453589588467;12186.756264874719;12342;12535.874641253584;797.3023604346212;807.6850028488894;813.1786895235796;814.027237451246;814.0516298512226;627.6767464755654;782.9256220659057;808.7533302342813;816.2042009041168;819.4100247821559;857.6998050682274;859.0335872143838;859.2438653984516;859.6131740716703;859.8882145321099;848.5460278750901;853.8206976534935;853.9573021348939;854.150120629971;854.1799872122739;480.0231528838796;486.46731828647575;491.1968930798135;491.7762418099756;591.7839988404245;12673.556425525063;13147.474101035947;13149.342532873414;13199.604011879659;13204.60386188416;12513.43689533964;12729.554465593752;13066.412011459412;13098.148620339647;13109.344532773322;11345.773084538263;11357.886421135765;11410.315381077162;11410.885891141066;11429.028532574657;4097.078157414588;4121.155163191538;4150.211459822654;4179.498460184797;4233.978830105861;49834.75082624564;50227;50401.74799126018;50794.49205507972;50894.23658645123;10327.483625818679;10369.826010963776;10434.14450328223;10472.842907356397;10591.417472039111;18667;18701.06494675261;18722.15750291213;18733.718994215098;18779.34272300463;6838.521303508706;6925.445964322842;6950.409215216662;6969.059177011039;7000.574792381044;3757.680597149218;3786.2048969716116;3832.4826148470156;3836.9424458633143;3884.0484081400236;2908.7091290870744;3000.3099287164073;3003.9399212015637;3012.894548690785;3013.5329024001317;493.06564061104007;505.53490788474693;511.59328333974577;520.6875874475285;527.4040334422078;460.5785706078967;466.77128207178237;507.18849840255297;532.7655831434157;533.7651433369305;7492.40060795146;7501.362384197404;7512.474126811071;7644.464887457824;7670.501417407851;530.2894121876703;533.3146906225481;539.8920215956824;542.7883125581027;544.1511242461693;3485.825708714605;3545.5213546170935;3545.7163426925786;3564.625714300013;3614.512040874501;47519.5248047522;48149.75925120422;48773.512264876896;54404.45595544073;58585.41414585885;49427;49866.25200621921;50810.491895081315;51014;51391.7430412853;46783.53216467792;47642.285365719545;47757;47903.9999999993;48111;8124.796880078045;8153;8347.290480309242;8414.368922330726;8540.487570745776;31059.223519412197;31611.84194079015;32272.934071263193;32612.510812338307;33326;39611.60388396194;40900.59099408968;40958.59041409548;41733.16533669249;41800.79099604482;9998.150157236716;10090.646827361006;10356.171506279328;10390.58437662485;10829.458527073772;10955.56177752881;11042.282251653616;11196.104311655212;11665.941670291595;11789.351585662871;10724.142068634646;11004.504797283982;11079.390633515233;11093.44532773342;11226.4386780659;10368.896311036793;10759.246852720235;11015.339079655247;11048.723781905517;11422.714432139262;10368.896311037095;10785.460726963778;10848.891511085103;10857.294275872044;11465.369404682822;8574.91425085766;8604.65581376763;8844.601992910206;9030.142136497023;9123.817523649357;8838.602262898057;9272.860907086264;9368.906310936803;9543.28425368114;9580.95209523948 07:03:52 INFO - PROCESS | 6942 | __end_tp_report 07:03:52 INFO - PROCESS | 6942 | __start_cc_report 07:03:52 INFO - PROCESS | 6942 | _x_x_mozilla_cycle_collect,1158 07:03:52 INFO - PROCESS | 6942 | __end_cc_report 07:03:52 INFO - PROCESS | 6942 | __startTimestamp1464703432834__endTimestamp 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | ------- Summary: start ------- 07:03:52 INFO - PROCESS | 6942 | Number of tests: 6 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#0] dojo.html Cycles:165 Average:4666.16 Median:4810.52 stddev:495.62 (10.3%) stddev-sans-first:471.59 07:03:52 INFO - PROCESS | 6942 | Values: 2664.1 2691.0 2721.7 2727.8 2741.9 4606.5 4685.9 4688.9 4760.0 4801.9 4678.5 4705.5 4710.1 4730.3 4740.3 4308.3 4313.2 4378.5 4420.5 4528.9 4452.8 4460.6 4463.4 4512.5 4526.4 4187.5 4215.8 4254.3 4287.4 4348.4 4282.1 4290.8 4292.7 4362.4 4393.3 4312.3 4317.2 4320.8 4340.6 4366.9 4478.0 4572.2 4599.7 4621.9 4684.7 5041.8 5073.4 5086.3 5088.9 5089.4 5074.5 5095.3 5128.2 5133.9 5137.2 4599.8 4716.2 4729.8 4792.5 4793.9 5219.7 5227.3 5235.5 5286.8 5293.3 5045.8 5085.2 5088.6 5096.2 5102.2 4870.5 4999.2 5036.7 5061.0 5078.2 4985.5 4998.4 4998.7 5019.1 5054.9 4804.1 4977.2 4986.4 4989.9 5041.2 4110.4 4158.7 4225.2 4230.6 4234.3 3653.6 3674.2 3676.5 3712.2 3713.3 4331.3 4339.2 4342.3 4388.0 4388.0 4896.2 4932.5 4968.9 4989.5 4994.8 4249.3 4258.8 4271.8 4275.4 4308.8 4386.0 4428.2 4430.5 4474.5 4480.1 4810.5 4857.6 4878.0 4882.4 4882.5 5101.3 5111.2 5131.7 5135.5 5192.7 4657.5 4753.3 4859.2 4872.4 4926.4 4984.8 5023.2 5033.8 5061.2 5093.9 5087.7 5113.2 5129.9 5134.8 5167.5 4735.2 4848.6 4876.9 4967.1 4989.3 4879.3 4900.2 4904.4 4908.9 4941.1 4855.2 4863.5 4888.3 4898.9 4908.9 4751.9 4788.9 4894.9 4906.1 5000.7 4732.3 4826.9 4828.1 4839.6 4864.4 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#1] ext.html Cycles:180 Average:47908.23 Median:3488.66 stddev:81973.45 (2349.7%) stddev-sans-first:82126.20 07:03:52 INFO - PROCESS | 6942 | Values: 522.9 574.9 583.6 586.6 592.1 27973.3 28522.6 30546.4 30550.5 30625.2 41513.4 42101.8 42348.0 42769.4 42872.8 7673.5 7850.0 7858.0 7861.3 7866.0 7487.4 7706.8 7843.2 9919.7 10221.9 9821.9 10191.8 10203.4 10204.8 10211.5 10044.8 10148.3 10150.2 10154.2 10156.6 9916.9 10030.5 10083.6 10122.6 10124.2 39439.0 39534.6 39814.8 39867.6 39918.8 3232.4 3235.4 3263.6 3415.0 3517.2 30759.5 30888.5 31534.4 31536.5 32301.8 3460.1 3535.2 3578.4 3600.6 3676.9 283404.0 285061.0 285915.6 286028.0 288313.0 59557.4 60168.1 60555.7 60578.4 60598.1 63786.4 63799.0 64115.0 64414.7 64448.7 14156.6 14652.2 14652.8 14659.6 14666.6 10157.5 11127.6 11261.0 11266.2 11273.3 18989.2 19531.9 20146.8 20213.7 20312.7 7327.1 7372.7 7395.3 7399.4 7410.4 905.5 971.9 993.8 1003.6 1024.0 29044.7 29143.7 29166.9 29389.4 29744.4 982.7 998.3 1016.0 1023.9 1102.1 15141.4 15447.8 15533.5 15866.1 15891.1 387012.0 388154.0 388258.0 388802.0 389614.0 52840.5 52927.5 53144.0 53223.5 53301.2 1087.3 1203.2 1225.3 1241.2 1249.3 28938.6 29959.0 30295.5 30341.0 30933.2 44408.1 44475.3 44851.3 45051.0 45069.3 243664.0 244578.0 245461.0 245900.0 246791.0 32908.3 34213.5 41546.2 42205.0 42811.0 43379.8 44009.6 44128.8 44664.0 45261.8 36910.3 37891.2 37926.8 38449.0 38565.8 35924.6 37472.8 37676.8 37771.6 37780.0 36514.3 36568.5 36966.6 37283.8 37460.6 32960.7 33045.5 33755.0 34076.8 34351.8 25603.2 25622.0 25632.2 26092.7 26297.7 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#2] jquery.html Cycles:180 Average:22993.94 Median:5703.39 stddev:61245.81 (1073.8%) stddev-sans-first:61394.05 07:03:52 INFO - PROCESS | 6942 | Values: 363.8 368.4 373.8 385.0 387.0 15886.8 16533.7 16824.1 16837.4 17190.1 16049.9 16439.6 17164.2 17214.6 17316.5 5061.3 5103.4 5124.4 5246.5 5248.5 3690.6 3872.6 5138.9 5557.7 5874.5 5904.9 5912.1 5919.9 5935.2 5938.9 5849.1 5919.2 5941.3 5946.3 6081.6 3321.5 4879.2 5253.0 5256.6 5273.4 17348.8 17361.9 17417.3 20334.2 20452.7 1887.0 1931.1 1972.2 1985.3 2044.1 12964.2 12986.2 13110.1 13121.3 13542.7 1722.0 1759.1 1776.3 1790.7 1836.7 67380.7 67855.7 68155.0 68160.0 68648.0 9465.4 9574.4 9621.3 9630.2 9822.6 13374.1 13468.3 13472.7 13476.0 13496.2 7430.3 7433.2 7483.6 7619.8 7665.6 7175.5 7257.2 7270.5 7298.1 7340.7 5992.4 6088.3 6148.6 6226.4 6262.5 1567.7 1689.0 1697.3 1700.0 1784.7 747.8 830.5 889.4 938.7 1027.8 16497.4 17083.1 17281.0 17570.8 17654.8 920.7 928.8 936.9 941.2 972.9 9878.3 9983.2 10031.5 10135.7 10137.8 366151.0 366344.0 373737.0 377205.0 378440.0 65801.7 66806.0 66827.7 66908.0 67596.3 872.0 878.6 879.9 907.8 912.9 15350.0 15357.2 15422.5 15468.2 15840.2 23761.3 30437.4 30482.2 31503.7 32749.0 42315.0 42335.0 42448.2 42453.4 42595.0 6227.2 6390.8 6583.8 7027.6 7177.8 9394.6 9905.2 10248.5 10292.2 10636.7 9047.9 9129.9 9388.2 9389.7 9437.6 8916.7 9496.3 9559.4 9584.7 9671.2 8738.5 9012.7 9333.8 9596.8 9887.4 7012.5 7189.3 7236.0 7239.2 7351.9 8318.4 9281.8 9378.2 9493.4 9497.0 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#3] mootools.html Cycles:180 Average:5192.22 Median:4884.57 stddev:2942.44 (60.2%) stddev-sans-first:2935.32 07:03:52 INFO - PROCESS | 6942 | Values: 1190.6 1405.2 1443.7 1574.6 1789.6 6908.0 7658.3 7879.3 7884.4 7896.7 7885.6 7910.4 7954.0 7956.0 7997.3 2166.3 2199.5 2200.2 2202.3 2202.9 2155.3 2163.5 2213.3 2213.5 2217.8 2155.1 2162.9 2172.9 2173.9 2198.1 2150.8 2157.1 2159.0 2159.6 2159.9 2126.7 2172.9 2176.2 2176.5 2178.1 7770.3 7778.8 7791.5 7799.7 7812.7 4486.4 4676.7 4689.6 4692.1 4693.0 2771.7 2808.8 2861.6 2863.1 2869.6 825.3 843.5 867.3 1731.9 1815.2 10577.9 10601.2 10617.2 10629.6 10637.9 4051.2 4063.9 4155.7 4158.0 4234.5 8452.6 8461.4 8469.7 8477.3 8479.2 4539.5 4586.4 4592.0 4597.4 4599.3 3801.6 4153.1 4176.2 4215.9 4290.9 3430.8 3450.3 3521.8 3543.7 3546.6 1013.3 1026.1 1035.2 1037.2 1038.3 791.9 792.4 797.5 803.3 805.2 5225.3 5392.6 5415.0 5475.9 5545.0 395.6 401.7 406.3 409.0 425.1 3728.2 3748.7 3752.4 3773.4 3788.1 9663.2 10042.6 10116.6 10117.4 10122.7 9736.9 9992.1 10003.8 10012.2 10106.1 7602.7 7611.1 7664.3 7676.6 7681.8 5342.8 5347.1 5357.5 5360.9 5487.4 8877.4 9102.2 9196.7 9213.2 9213.7 9481.4 9544.7 9644.6 9665.4 9705.5 6302.9 6602.4 6726.3 6949.1 7084.7 7475.6 7526.6 7548.2 7554.0 7557.1 6423.6 6604.7 6609.9 6691.6 6719.5 6507.3 6532.4 6570.2 6640.1 6720.2 6451.3 6546.7 6570.7 6575.2 6575.4 4610.3 4840.7 4937.1 5045.1 5082.3 4928.5 4941.5 5003.3 5022.5 5099.8 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#4] prototype.html Cycles:180 Average:4129.38 Median:4720.32 stddev:1179.46 (25.0%) stddev-sans-first:1147.24 07:03:52 INFO - PROCESS | 6942 | Values: 301.5 302.4 303.7 306.1 309.2 4684.6 4760.4 4766.6 4783.6 4785.1 4714.4 4714.7 4723.8 4736.3 4749.0 3576.8 3669.6 3678.4 3765.4 3803.1 3738.1 3759.6 3763.5 3765.6 3788.7 3567.6 3734.0 3739.7 3749.0 3752.7 3643.0 3743.6 3743.6 3774.9 3791.6 3327.8 3334.0 3334.7 3350.0 3356.0 4542.4 4552.9 4558.2 4572.5 4578.6 4192.3 4222.2 4295.8 4311.4 4311.8 4943.5 4958.4 4958.4 4982.4 4990.3 3616.6 3621.7 3622.1 3631.1 3640.3 4945.4 5175.6 5216.9 5222.9 5237.9 3686.9 3721.2 3724.8 3736.3 3743.5 3751.6 3762.7 3769.8 3788.2 3798.0 4257.5 4262.4 4263.2 4266.4 4271.7 4661.3 4880.5 4928.8 4935.4 4974.0 1272.7 1295.2 1299.4 1301.0 1304.1 839.8 844.8 882.4 908.8 909.8 4348.8 4351.7 4358.3 4368.8 4370.3 5068.7 5076.7 5078.6 5083.2 5098.7 4167.5 4294.8 4311.7 4323.1 4324.7 2643.7 2652.9 2655.5 2658.6 2668.1 4720.7 4728.1 4759.5 4772.5 4773.9 4888.9 5084.8 5116.0 5123.8 5134.7 4700.8 4744.6 4773.0 4803.1 4804.6 4967.2 4972.6 4978.8 5035.2 5036.3 4719.9 4929.5 4938.2 4938.3 5039.8 4884.9 4898.2 4917.6 4925.7 4928.7 3605.0 3610.2 3616.0 3616.3 3622.0 5025.0 5084.0 5131.3 5172.7 5178.5 4963.9 4971.9 5001.2 5002.3 5009.3 4962.2 4972.6 4986.7 4995.4 5003.4 4778.4 4848.5 4882.2 4891.3 4915.4 4794.9 4888.4 4977.2 5024.2 5035.2 4915.9 4923.3 4929.5 4931.4 4942.0 07:03:52 INFO - PROCESS | 6942 | 07:03:52 INFO - PROCESS | 6942 | [#5] yui.html Cycles:180 Average:13336.59 Median:23625.15 stddev:15465.80 (65.5%) stddev-sans-first:15479.91 07:03:52 INFO - PROCESS | 6942 | Values: 665.0 682.2 693.0 729.6 784.0 10787.9 12215.4 12453.5 12455.8 12464.6 12046.9 12142.5 12186.8 12342.0 12535.9 797.3 807.7 813.2 814.0 814.1 627.7 782.9 808.8 816.2 819.4 857.7 859.0 859.2 859.6 859.9 848.5 853.8 854.0 854.2 854.2 480.0 486.5 491.2 491.8 591.8 12673.6 13147.5 13149.3 13199.6 13204.6 12513.4 12729.6 13066.4 13098.1 13109.3 11345.8 11357.9 11410.3 11410.9 11429.0 4097.1 4121.2 4150.2 4179.5 4234.0 49834.8 50227.0 50401.7 50794.5 50894.2 10327.5 10369.8 10434.1 10472.8 10591.4 18667.0 18701.1 18722.2 18733.7 18779.3 6838.5 6925.4 6950.4 6969.1 7000.6 3757.7 3786.2 3832.5 3836.9 3884.0 2908.7 3000.3 3003.9 3012.9 3013.5 493.1 505.5 511.6 520.7 527.4 460.6 466.8 507.2 532.8 533.8 7492.4 7501.4 7512.5 7644.5 7670.5 530.3 533.3 539.9 542.8 544.2 3485.8 3545.5 3545.7 3564.6 3614.5 47519.5 48149.8 48773.5 54404.5 58585.4 49427.0 49866.3 50810.5 51014.0 51391.7 46783.5 47642.3 47757.0 47904.0 48111.0 8124.8 8153.0 8347.3 8414.4 8540.5 31059.2 31611.8 32272.9 32612.5 33326.0 39611.6 40900.6 40958.6 41733.2 41800.8 9998.2 10090.6 10356.2 10390.6 10829.5 10955.6 11042.3 11196.1 11665.9 11789.4 10724.1 11004.5 11079.4 11093.4 11226.4 10368.9 10759.2 11015.3 11048.7 11422.7 10368.9 10785.5 10848.9 10857.3 11465.4 8574.9 8604.7 8844.6 9030.1 9123.8 8838.6 9272.9 9368.9 9543.3 9581.0 07:03:52 INFO - PROCESS | 6942 | -------- Summary: end -------- 07:03:52 INFO - PROCESS | 6942 | 07:03:53 INFO - TEST-INFO | 6942: exit 0 07:03:53 INFO - TEST-OK | dromaeo_css | took 1119452ms 07:03:53 INFO - TEST-START | kraken 07:03:53 INFO - operating with platform_type : linux_ 07:03:53 INFO - Initialising browser for kraken test... 07:03:53 INFO - TEST-INFO | started process 7120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH7AwRL/profile http://localhost:44579/getInfo.html) 07:03:57 INFO - PROCESS | 7120 | __metrics Screen width/height:1600/1200 07:03:57 INFO - PROCESS | 7120 | colorDepth:24 07:03:57 INFO - PROCESS | 7120 | Browser inner width/height: 1024/697 07:03:57 INFO - PROCESS | 7120 | __metrics 07:03:58 ERROR - PROCESS | 7120 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:03:59 INFO - TEST-INFO | 7120: exit 0 07:03:59 INFO - Browser initialized. 07:03:59 INFO - Running cycle 1/1 for kraken test... 07:03:59 INFO - TEST-INFO | started process 7200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH7AwRL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:11 INFO - PROCESS | 7200 | RSS: Main: 157392896 07:04:11 INFO - PROCESS | 7200 | 07:04:14 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44579/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:15 INFO - PROCESS | 7200 | RSS: Main: 214302720 07:04:15 INFO - PROCESS | 7200 | 07:04:18 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44579/tests/kraken/driver.html?testName=audio-dft) 07:04:18 INFO - PROCESS | 7200 | RSS: Main: 202940416 07:04:18 INFO - PROCESS | 7200 | 07:04:22 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44579/tests/kraken/driver.html?testName=audio-fft) 07:04:22 INFO - PROCESS | 7200 | RSS: Main: 270491648 07:04:22 INFO - PROCESS | 7200 | 07:04:24 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44579/tests/kraken/driver.html?testName=audio-oscillator) 07:04:25 INFO - PROCESS | 7200 | RSS: Main: 180092928 07:04:25 INFO - PROCESS | 7200 | 07:04:27 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:28 INFO - PROCESS | 7200 | RSS: Main: 184356864 07:04:28 INFO - PROCESS | 7200 | 07:04:31 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44579/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:32 INFO - PROCESS | 7200 | RSS: Main: 220045312 07:04:32 INFO - PROCESS | 7200 | 07:04:35 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44579/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:36 INFO - PROCESS | 7200 | RSS: Main: 220790784 07:04:36 INFO - PROCESS | 7200 | 07:04:38 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44579/tests/kraken/driver.html?testName=json-parse-financial) 07:04:39 INFO - PROCESS | 7200 | RSS: Main: 221392896 07:04:39 INFO - PROCESS | 7200 | 07:04:41 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:41 INFO - PROCESS | 7200 | RSS: Main: 205058048 07:04:41 INFO - PROCESS | 7200 | 07:04:43 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:44 INFO - PROCESS | 7200 | RSS: Main: 210210816 07:04:44 INFO - PROCESS | 7200 | 07:04:46 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:47 INFO - PROCESS | 7200 | RSS: Main: 216551424 07:04:47 INFO - PROCESS | 7200 | 07:04:50 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:50 INFO - PROCESS | 7200 | RSS: Main: 223305728 07:04:50 INFO - PROCESS | 7200 | 07:04:53 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:54 INFO - PROCESS | 7200 | RSS: Main: 221196288 07:04:54 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | Cycle 1(1): loaded http://localhost:44579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44579/tests/kraken/driver.html?testName=ai-astar) 07:04:56 INFO - PROCESS | 7200 | RSS: Main: 263069696 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | __start_tp_report 07:04:56 INFO - PROCESS | 7200 | _x_x_mozilla_page_load 07:04:56 INFO - PROCESS | 7200 | _x_x_mozilla_page_load_details 07:04:56 INFO - PROCESS | 7200 | |i|pagename|runs| 07:04:56 INFO - PROCESS | 7200 | |0;ai-astar;113;111;115;115;112;113;114;114;113;115 07:04:56 INFO - PROCESS | 7200 | |1;audio-beat-detection;155;127;132;197;137;138;154;129;182;129 07:04:56 INFO - PROCESS | 7200 | |2;audio-dft;161;162;162;161;161;160;163;162;163;161 07:04:56 INFO - PROCESS | 7200 | |3;audio-fft;76;76;77;105;77;77;75;75;100;75 07:04:56 INFO - PROCESS | 7200 | |4;audio-oscillator;85;85;109;84;85;84;125;85;83;123 07:04:56 INFO - PROCESS | 7200 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 07:04:56 INFO - PROCESS | 7200 | |6;imaging-darkroom;147;145;146;146;147;146;145;146;146;145 07:04:56 INFO - PROCESS | 7200 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;96 07:04:56 INFO - PROCESS | 7200 | |8;json-parse-financial;64;64;65;70;66;68;68;65;64;65 07:04:56 INFO - PROCESS | 7200 | |9;json-stringify-tinderbox;65;66;65;66;67;66;72;65;66;65 07:04:56 INFO - PROCESS | 7200 | |10;stanford-crypto-aes;84;88;85;83;86;90;86;84;116;89 07:04:56 INFO - PROCESS | 7200 | |11;stanford-crypto-ccm;131;131;129;130;133;137;131;133;142;143 07:04:56 INFO - PROCESS | 7200 | |12;stanford-crypto-pbkdf2;171;168;172;168;169;167;166;172;172;165 07:04:56 INFO - PROCESS | 7200 | |13;stanford-crypto-sha256-iterative;67;69;71;67;68;68;66;67;66;68 07:04:56 INFO - PROCESS | 7200 | __end_tp_report 07:04:56 INFO - PROCESS | 7200 | __start_cc_report 07:04:56 INFO - PROCESS | 7200 | _x_x_mozilla_cycle_collect,1911 07:04:56 INFO - PROCESS | 7200 | __end_cc_report 07:04:56 INFO - PROCESS | 7200 | __startTimestamp1464703496260__endTimestamp 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | ------- Summary: start ------- 07:04:56 INFO - PROCESS | 7200 | Number of tests: 14 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 07:04:56 INFO - PROCESS | 7200 | Values: 113.0 111.0 115.0 115.0 112.0 113.0 114.0 114.0 113.0 115.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:146.00 stddev:24.23 (16.6%) stddev-sans-first:25.56 07:04:56 INFO - PROCESS | 7200 | Values: 155.0 127.0 132.0 197.0 137.0 138.0 154.0 129.0 182.0 129.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 07:04:56 INFO - PROCESS | 7200 | Values: 161.0 162.0 162.0 161.0 161.0 160.0 163.0 162.0 163.0 161.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.26 (14.8%) stddev-sans-first:11.78 07:04:56 INFO - PROCESS | 7200 | Values: 76.0 76.0 77.0 105.0 77.0 77.0 75.0 75.0 100.0 75.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.50 stddev:17.21 (20.4%) stddev-sans-first:17.88 07:04:56 INFO - PROCESS | 7200 | Values: 85.0 85.0 109.0 84.0 85.0 84.0 125.0 85.0 83.0 123.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:04:56 INFO - PROCESS | 7200 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 07:04:56 INFO - PROCESS | 7200 | Values: 147.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 145.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:04:56 INFO - PROCESS | 7200 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.50 stddev:2.08 (3.2%) stddev-sans-first:2.09 07:04:56 INFO - PROCESS | 7200 | Values: 64.0 64.0 65.0 70.0 66.0 68.0 68.0 65.0 64.0 65.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:2.11 (3.2%) stddev-sans-first:2.19 07:04:56 INFO - PROCESS | 7200 | Values: 65.0 66.0 65.0 66.0 67.0 66.0 72.0 65.0 66.0 65.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:86.00 stddev:9.72 (11.3%) stddev-sans-first:10.14 07:04:56 INFO - PROCESS | 7200 | Values: 84.0 88.0 85.0 83.0 86.0 90.0 86.0 84.0 116.0 89.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:4.99 (3.8%) stddev-sans-first:5.17 07:04:56 INFO - PROCESS | 7200 | Values: 131.0 131.0 129.0 130.0 133.0 137.0 131.0 133.0 142.0 143.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.62 (1.5%) stddev-sans-first:2.68 07:04:56 INFO - PROCESS | 7200 | Values: 171.0 168.0 172.0 168.0 169.0 167.0 166.0 172.0 172.0 165.0 07:04:56 INFO - PROCESS | 7200 | 07:04:56 INFO - PROCESS | 7200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 07:04:56 INFO - PROCESS | 7200 | Values: 67.0 69.0 71.0 67.0 68.0 68.0 66.0 67.0 66.0 68.0 07:04:56 INFO - PROCESS | 7200 | -------- Summary: end -------- 07:04:56 INFO - PROCESS | 7200 | 07:04:57 INFO - TEST-INFO | 7200: exit 0 07:04:57 INFO - TEST-OK | kraken | took 63631ms 07:04:57 INFO - SUITE-END | took 1183s 07:04:57 INFO - Completed test suite (00:19:43) 07:04:57 INFO - javascript benchmark 07:04:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.0542607374377, 2690.959635605465, 2721.6733991920964, 2727.7681397081246, 2741.931451713707, 4606.47025592057, 4685.929711054328, 4688.882777930549, 4760.024195040013, 4801.855944321667, 4678.461976872661, 4705.505921878196, 4710.057988402316, 4730.314104454852, 4740.312654665072, 4308.3106702927535, 4313.2020576193345, 4378.452693413324, 4420.491643460995, 4528.9094218115615, 4452.777361131946, 4460.576245256695, 4463.352813841991, 4512.503624601291, 4526.411566496367, 4187.51843537994, 4215.831366745327, 4254.276772948606, 4287.356896465524, 4348.391225228486, 4282.122164956177, 4290.849820256307, 4292.678049146327, 4362.411074504965, 4393.319035549495, 4312.266914624522, 4317.244482215599, 4320.762358070305, 4340.565943405666, 4366.868993930188, 4477.955220447787, 4572.177008138534, 4599.724016559017, 4621.884452888671, 4684.718916864965, 5041.798328066873, 5073.365829271341, 5086.3133476980875, 5088.872778180538, 5089.3638295213095, 5074.517920797518, 5095.312132862054, 5128.230765385185, 5133.948660513422, 5137.17805151174, 4599.770011499411, 4716.174669432836, 4729.834455794065, 4792.520747925249, 4793.856184314476, 5219.660722053054, 5227.3465816772905, 5235.450277720861, 5286.841394758163, 5293.285406470077, 5045.798168073309, 5085.2372144177925, 5088.567471764942, 5096.184610462383, 5102.183650615883, 4870.464248932614, 4999.200127979506, 5036.722980236049, 5061.038402703474, 5078.238264260317, 4985.451600323961, 4998.350214472095, 4998.725070121178, 5019.096562618691, 5054.898902021939, 4804.111239420648, 4977.228529577921, 4986.401631804207, 4989.875253118628, 5041.2438134280155, 4110.424540564323, 4158.708890377645, 4225.176090662353, 4230.61924426803, 4234.322508398642, 3653.6163702811355, 3674.228412033503, 3676.466912297702, 3712.1833196696684, 3713.3316003119157, 4331.263685173528, 4339.218940590724, 4342.305231162999, 4388.0, 4388.034632380871, 4896.1921282987905, 4932.457429682732, 4968.8757781055765, 4989.501049894981, 4994.825181118644, 4249.320108782642, 4258.787060646955, 4271.765052922119, 4275.422817919603, 4308.849190278325, 4385.956140438619, 4428.22506061438, 4430.468343798765, 4474.463064432289, 4480.126375356775, 4810.518948105161, 4857.635677324144, 4877.975610122068, 4882.36529251195, 4882.536159064884, 5101.311322971352, 5111.233315002779, 5131.666441681279, 5135.460776618401, 5192.74036298176, 4657.534246575316, 4753.287006948985, 4859.246816743411, 4872.366592342973, 4926.4088309403105, 4984.800607975641, 5023.2214006829, 5033.84898453047, 5061.215511595708, 5093.92359114621, 5087.745612719424, 5113.207452844815, 5129.8974020518635, 5134.845954621367, 5167.457416971164, 4735.195016847076, 4848.636352273664, 4876.878078048077, 4967.081089998362, 4989.25161225819, 4879.292502587034, 4900.198563017739, 4904.362432883702, 4908.852734417973, 4941.061198372441, 4855.223164293696, 4863.537963893425, 4888.291197776373, 4898.9020219594695, 4908.92636610444, 4751.9287210692555, 4788.880277993078, 4894.853154405374, 4906.067847109038, 5000.699958002531, 4732.313814496947, 4826.855194344175, 4828.082664293773, 4839.588634966068, 4864.416270047617], "value": 4634.906861281153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.8911636811898, 574.8965186266472, 583.6439771739239, 586.5893874287999, 592.1118322516227, 27973.300667483323, 28522.57216141757, 30546.389072218542, 30550.54174187389, 30625.234369140784, 41513.37729934054, 42101.78949105258, 42348.0, 42769.35845962305, 42872.78563607178, 7673.462857599984, 7850.0, 7857.960710196441, 7861.25318094783, 7866.0, 7487.363574096208, 7706.807329816771, 7843.176466471024, 9919.702408927744, 10221.89778102217, 9821.852672209923, 10191.847122293171, 10203.387796732182, 10204.795904081951, 10211.540480678388, 10044.849327260097, 10148.289619726622, 10150.187984961185, 10154.238432117547, 10156.593736250541, 9916.851247231298, 10030.548625311878, 10083.59665613382, 10122.595096196217, 10124.190064794873, 39439.0, 39534.60465395338, 39814.80092599548, 39867.60132398668, 39918.80040599778, 3232.3535292941506, 3235.4014507315987, 3263.640999490078, 3414.9829250853836, 3517.208628058692, 30759.538606920913, 30888.53667194994, 31534.36931261362, 31536.526952095508, 32301.838490807397, 3460.1176699941607, 3535.169235229719, 3578.3916734155255, 3600.6039335673054, 3676.871309504181, 283404.0, 285061.0, 285915.5704221486, 286028.0, 288313.0, 59557.404425956054, 60168.09747853786, 60555.69722151361, 60578.39421605728, 60598.091028634604, 63786.36213637897, 63799.0, 64115.0, 64414.677926611, 64448.677756610916, 14156.64608384778, 14652.194129322776, 14652.78020829667, 14659.633509162357, 14666.63333416673, 10157.492125393701, 11127.554897804159, 11261.0, 11266.155038371991, 11273.267237629529, 18989.240430382906, 19531.888594270356, 20146.798532014785, 20213.696794548094, 20312.69530957037, 7327.120745510573, 7372.741954031583, 7395.334419902235, 7399.408047356306, 7410.407167426593, 905.4657751926263, 971.8639390485338, 993.8310487217191, 1003.6136087606324, 1024.0, 29044.7095529042, 29143.7085629141, 29166.937471565605, 29389.412211755644, 29744.405111897642, 982.6757170133839, 998.3061772068343, 1016.0, 1023.8515415264745, 1102.1183053557122, 15141.394344226328, 15447.845521544641, 15533.456329028655, 15866.127362994916, 15891.125988070768, 387012.0, 388154.0, 388258.0, 388802.0, 389614.0, 52840.471595284325, 52927.47072529225, 53144.0, 53223.46776532185, 53301.200481992804, 1087.320424734541, 1203.1577895473029, 1225.3138242584182, 1241.2118304876287, 1249.2691775311364, 28938.565921511614, 29959.0, 30295.545566816956, 30341.0, 30933.226669333446, 44408.11183776371, 44475.33287000633, 44851.327230092225, 45050.99999999869, 45069.32396014128, 243664.0, 244578.0, 245461.0, 245900.0, 246791.0, 32908.341833162725, 34213.486797698555, 41546.169076618906, 42205.0, 42811.0, 43379.78310108429, 44009.55990440054, 44128.77935610301, 44664.0, 45261.77369113133, 36910.26179476449, 37891.24217515579, 37926.810365948, 38449.0, 38565.80717096509, 35924.64075359213, 37472.81263593664, 37676.81161594175, 37771.62228377791, 37780.0, 36514.26971460503, 36568.45147322739, 36966.630333697394, 37283.81358093192, 37460.62539374681, 32960.67039329576, 33045.504317434774, 33755.0, 34076.82961585176, 34351.82824085864, 25603.23190304294, 25622.0, 25632.231033069038, 26092.73907260979, 26297.737022629528], "value": 18660.23732241312, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.77445983490225, 368.43629247251704, 373.8112253312077, 384.97497662651944, 387.02662803050333, 15886.76169857453, 16533.66932661346, 16824.07467589282, 16837.41069062583, 17190.140492975333, 16049.919750401232, 16439.58901027475, 17164.22760975756, 17214.56963575911, 17316.480505584823, 5061.291419201315, 5103.438621751604, 5124.4106927703415, 5246.50158234969, 5248.5276325130735, 3690.5571331440265, 3872.612738726119, 5138.897222055557, 5557.666540007593, 5874.471297583216, 5904.88190236195, 5912.142739302799, 5919.911201331962, 5935.169076329317, 5938.88122237555, 5849.122631605251, 5919.200907877467, 5941.316748573904, 5946.256717910262, 6081.635101893857, 3321.485169798685, 4879.243717223836, 5253.0, 5256.6057545684225, 5273.393559740641, 17348.826511734973, 17361.913190434094, 17417.30330786767, 20334.186632534827, 20452.693209601868, 1886.9905650471796, 1931.1406424141262, 1972.2209727157692, 1985.2852972929734, 2044.1108117968731, 12964.157329773534, 12986.22082675033, 13110.082294239408, 13121.343932803322, 13542.661433464144, 1721.9754246223476, 1759.0940665557248, 1776.2806063544285, 1790.6687262856412, 1836.7244913262984, 67380.6630966842, 67855.66072169656, 68154.97767533541, 68160.0, 68648.0, 9465.43207407544, 9574.425534467955, 9621.27840411958, 9630.229581633452, 9822.557984890696, 13374.06381553282, 13468.326583670778, 13472.663183420296, 13476.0, 13496.190228586316, 7430.256974302527, 7433.219511951275, 7483.6258187090425, 7619.809504762315, 7665.61671916402, 7175.461840361993, 7257.237990011078, 7270.454715896329, 7298.087739032621, 7340.743073992385, 5992.40075992406, 6088.269407671108, 6148.600340977911, 6226.377362263828, 6262.467690246289, 1567.6786258816915, 1689.0372487682148, 1697.2532085882171, 1699.9575010624833, 1784.6698360803293, 747.8354761952362, 830.5390508267849, 889.3729920406098, 938.7090002099371, 1027.7790275090892, 16497.365690109305, 17083.145842707814, 17281.0, 17570.824291757173, 17654.823451765576, 920.7467946314817, 928.8142371525722, 936.9344145909721, 941.2140862379989, 972.8783902012249, 9878.259130565237, 9983.201343892471, 10031.498425078717, 10135.7466063349, 10137.847932281022, 366151.0, 366344.0, 373737.0, 377205.0, 378440.0, 65801.67099164473, 66806.0, 66827.66586167038, 66908.0, 67596.32403676, 872.0363997782613, 878.6053630707461, 879.8812160358269, 907.773056735816, 912.8904531456268, 15350.0, 15357.155356455502, 15422.46021389246, 15468.226588670746, 15840.207989600704, 23761.287161385186, 30437.391252174388, 30482.23794405069, 31503.684963150074, 32749.0, 42315.0, 42335.0, 42448.1510369797, 42453.363199551415, 42595.0, 6227.159333489921, 6390.7763228286785, 6583.80248592543, 7027.61348125858, 7177.784666460015, 9394.577244023898, 9905.15806156456, 10248.53881575316, 10292.176625870063, 10636.680899573024, 9047.864282035644, 9129.908700912905, 9388.155066044088, 9389.671361502315, 9437.57530911097, 8916.687915922912, 9496.287778416508, 9559.426434413957, 9584.66453674118, 9671.226301895691, 8738.519381434082, 9012.729618111467, 9333.813323733351, 9596.808063838544, 9887.4067555944, 7012.474064445289, 7189.2810718927685, 7236.0, 7239.239879812544, 7351.889721654286, 8318.417710760188, 9281.814363712552, 9378.249740020645, 9493.382930109521, 9497.0], "value": 8063.971930121758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.5832958464543, 1405.1849927042317, 1443.747344214762, 1574.645704716439, 1789.5973405983655, 6907.965460172698, 7658.310752032316, 7879.330256928168, 7884.408669349793, 7896.684132634688, 7885.56629385385, 7910.36717062635, 7954.045514538249, 7956.0, 7997.320227780631, 2166.306781829819, 2199.516106456577, 2200.2299195281685, 2202.3392982105383, 2202.878841663716, 2155.3426205007468, 2163.5132095278595, 2213.2585583829436, 2213.4577028627928, 2217.846719705752, 2155.0948601587293, 2162.891855407231, 2172.869627822328, 2173.913043478259, 2198.109765544949, 2150.849440539163, 2157.061678170001, 2159.0284372032493, 2159.600473912323, 2159.88120653364, 2126.712893759354, 2172.902219400131, 2176.2056849250066, 2176.4667656424117, 2178.0525471419983, 7770.3006729394065, 7778.805529861742, 7791.454598178129, 7799.7270095546955, 7812.72655457062, 4486.394336764528, 4676.672632915697, 4689.601383882374, 4692.061587682477, 4693.037927224945, 2771.6812566554904, 2808.775297976157, 2861.6136821529035, 2863.0551917867056, 2869.583910333011, 825.2531459029528, 843.4854738609444, 867.280157469299, 1731.9480415587552, 1815.210383483189, 10577.9471102644, 10601.204909631808, 10617.203709721725, 10629.627963021258, 10637.9468102659, 4051.2100140472326, 4063.89840253996, 4155.688323375759, 4157.958420415757, 4234.513031001413, 8452.61963211657, 8461.407701460961, 8469.703560375357, 8477.27943124829, 8479.236868681848, 4539.523350048264, 4586.3579098926175, 4592.0, 4597.379353787196, 4599.33309670096, 3801.6198380161763, 4153.127843152912, 4176.227397931331, 4215.936760948588, 4290.89272768177, 3430.828458577061, 3450.309938012357, 3521.8063006534885, 3543.6633519815578, 3546.556680414948, 1013.2957594471771, 1026.1277913773233, 1035.1615191694752, 1037.1858091398367, 1038.2991480750463, 791.897053383068, 792.37798328312, 797.5214871077308, 803.2931020701745, 805.1787177079347, 5225.346831646044, 5392.56859451243, 5415.0, 5475.945240547623, 5544.972275138679, 395.58858786861344, 401.65257052649247, 406.3072461453215, 408.9775561097257, 425.12848660246374, 3728.2357116790995, 3748.681362084199, 3752.4371344298575, 3773.396256598931, 3788.0908581940134, 9663.226941844636, 10042.598296068076, 10116.645917393003, 10117.392956422638, 10122.746931326776, 9736.853947190797, 9992.050755178247, 10003.849942250872, 10012.199024078202, 10106.090451859369, 7602.733904313433, 7611.124720657084, 7664.31021208094, 7676.57778822159, 7681.846363072819, 5342.813001544927, 5347.144456887035, 5357.464253574612, 5360.892782144413, 5487.4238204987905, 8877.37858349935, 9102.180803727697, 9196.724098277062, 9213.170814626448, 9213.677521286723, 9481.431114133175, 9544.699433983009, 9644.614215431584, 9665.371750836173, 9705.5147242639, 6302.905456418249, 6602.438792702674, 6726.327367263235, 6949.131358580177, 7084.716611335489, 7475.551466912003, 7526.5860377679755, 7548.1697013329585, 7554.0, 7557.05536807899, 6423.614583125028, 6604.669766511559, 6609.933900660932, 6691.631960242234, 6719.496037797087, 6507.251666058464, 6532.41208291256, 6570.244421891543, 6640.136782218281, 6720.227173875067, 6451.3226111257645, 6546.738130474918, 6570.737170513126, 6575.24384695747, 6575.408213260829, 4610.308453731833, 4840.685355451885, 4937.061958228069, 5045.11710450677, 5082.33929589151, 4928.457869634266, 4941.481144479778, 5003.274525193754, 5022.4977502249485, 5099.821506247264], "value": 4102.707273460951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.46489980284997, 302.4495418338623, 303.7448543223692, 306.13364179372377, 309.24235622724325, 4684.6252299816015, 4760.42874855017, 4766.642501812365, 4783.617310615151, 4785.1147537705465, 4714.434267887849, 4714.669973101884, 4723.763811809413, 4736.313234580984, 4748.976255118729, 3576.7675101118407, 3669.6330366963357, 3678.3746763050344, 3765.4351847222997, 3803.125281185329, 3738.065483629093, 3759.567649720276, 3763.4919285896326, 3765.6046115157924, 3788.6969042476535, 3567.6432356764376, 3734.047817806469, 3739.7195210359196, 3748.962510374902, 3752.7185461090526, 3642.981785091071, 3743.588205297429, 3743.644353786386, 3774.9056273593105, 3791.563970143414, 3327.7670563060597, 3334.0, 3334.7498937579535, 3350.0, 3356.0, 4542.364069030338, 4552.90402526282, 4558.2251017327135, 4572.51988541205, 4578.610818080467, 4192.287311157111, 4222.200217843345, 4295.828166873322, 4311.361682560639, 4311.8059687313835, 4943.456219815817, 4958.363739965803, 4958.404991401055, 4982.402111746614, 4990.276409920578, 3616.6383361663884, 3621.746477746559, 3622.094476380905, 3631.110377957391, 3640.290143422007, 4945.431275403339, 5175.560077393388, 5216.878371150221, 5222.92165617516, 5237.895242095175, 3686.870959516404, 3721.2371463849845, 3724.77651340915, 3736.3087828751222, 3743.5320584926885, 3751.643593858579, 3762.698984081267, 3769.849206031783, 3788.1855401088897, 3797.9620203798163, 4257.489101307801, 4262.381954616625, 4263.232618128704, 4266.402703621496, 4271.654428854901, 4661.277501987197, 4880.487049014817, 4928.827491037868, 4935.395996301217, 4973.975130124399, 1272.7200015996466, 1295.1840340585559, 1299.389287035092, 1300.9852315194164, 1304.0806231606693, 839.8068444257855, 844.7634662294568, 882.4396508217328, 908.7728067983004, 909.8498747706686, 4348.782560871944, 4351.73889566627, 4358.3244597087505, 4368.803403846835, 4370.322599997005, 5068.721220332917, 5076.74616269185, 5078.5937125029905, 5083.212102124176, 5098.745062746922, 4167.499900012018, 4294.828206871753, 4311.741295522279, 4323.135372925428, 4324.675649326313, 2643.70919198888, 2652.9388244702272, 2655.526182968471, 2658.614500897359, 2668.1461932181514, 4720.740359280204, 4728.148933192058, 4759.452662943806, 4772.475027746945, 4773.856784296477, 4888.877778055577, 5084.796608135707, 5116.0, 5123.846284611468, 5134.666246693953, 4700.764961751967, 4744.59670927975, 4772.976135119302, 4803.063402636452, 4804.615630749532, 4967.180415231446, 4972.552470277692, 4978.800847966186, 5035.16919708244, 5036.294918711456, 4719.905601887875, 4929.482404347492, 4938.209886418156, 4938.2839488273285, 5039.815643323743, 4884.926726099183, 4898.24077268024, 4917.582005529427, 4925.655204135676, 4928.67963582366, 3604.981975090108, 3610.1516143705685, 3616.0417489364813, 3616.349057169735, 3621.9535962181285, 5025.0, 5084.0, 5131.25596788471, 5172.663776854492, 5178.456262092577, 4963.900721985612, 4971.875703107451, 5001.224810154432, 5002.274670172732, 5009.273655319886, 4962.156433406258, 4972.552470277692, 4986.700797952134, 4995.400551933792, 5003.4246061701915, 4778.371895457554, 4848.466668666514, 4882.170031094794, 4891.33966914462, 4915.361003069578, 4794.904101918012, 4888.437829649636, 4977.178765503796, 5024.171011783015, 5035.244713293036, 4915.926261106158, 4923.310736496822, 4929.507049295042, 4931.397295878925, 4941.950580494149], "value": 3759.2346980078105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.9601023938565, 682.1711620381238, 692.954957927735, 729.5768454296508, 783.9764807055786, 10787.892121078787, 12215.38923053847, 12453.501859925615, 12455.750884982295, 12464.563740269092, 12046.939765301162, 12142.453589588467, 12186.756264874719, 12342.0, 12535.874641253584, 797.3023604346212, 807.6850028488894, 813.1786895235796, 814.027237451246, 814.0516298512226, 627.6767464755654, 782.9256220659057, 808.7533302342813, 816.2042009041168, 819.4100247821559, 857.6998050682274, 859.0335872143838, 859.2438653984516, 859.6131740716703, 859.8882145321099, 848.5460278750901, 853.8206976534935, 853.9573021348939, 854.150120629971, 854.1799872122739, 480.0231528838796, 486.46731828647575, 491.1968930798135, 491.7762418099756, 591.7839988404245, 12673.556425525063, 13147.474101035947, 13149.342532873414, 13199.604011879659, 13204.60386188416, 12513.43689533964, 12729.554465593752, 13066.412011459412, 13098.148620339647, 13109.344532773322, 11345.773084538263, 11357.886421135765, 11410.315381077162, 11410.885891141066, 11429.028532574657, 4097.078157414588, 4121.155163191538, 4150.211459822654, 4179.498460184797, 4233.978830105861, 49834.75082624564, 50227.0, 50401.74799126018, 50794.49205507972, 50894.23658645123, 10327.483625818679, 10369.826010963776, 10434.14450328223, 10472.842907356397, 10591.417472039111, 18667.0, 18701.06494675261, 18722.15750291213, 18733.718994215098, 18779.34272300463, 6838.521303508706, 6925.445964322842, 6950.409215216662, 6969.059177011039, 7000.574792381044, 3757.680597149218, 3786.2048969716116, 3832.4826148470156, 3836.9424458633143, 3884.0484081400236, 2908.7091290870744, 3000.3099287164073, 3003.9399212015637, 3012.894548690785, 3013.5329024001317, 493.06564061104007, 505.53490788474693, 511.59328333974577, 520.6875874475285, 527.4040334422078, 460.5785706078967, 466.77128207178237, 507.18849840255297, 532.7655831434157, 533.7651433369305, 7492.40060795146, 7501.362384197404, 7512.474126811071, 7644.464887457824, 7670.501417407851, 530.2894121876703, 533.3146906225481, 539.8920215956824, 542.7883125581027, 544.1511242461693, 3485.825708714605, 3545.5213546170935, 3545.7163426925786, 3564.625714300013, 3614.512040874501, 47519.5248047522, 48149.75925120422, 48773.512264876896, 54404.45595544073, 58585.41414585885, 49427.0, 49866.25200621921, 50810.491895081315, 51014.0, 51391.7430412853, 46783.53216467792, 47642.285365719545, 47757.0, 47903.9999999993, 48111.0, 8124.796880078045, 8153.0, 8347.290480309242, 8414.368922330726, 8540.487570745776, 31059.223519412197, 31611.84194079015, 32272.934071263193, 32612.510812338307, 33326.0, 39611.60388396194, 40900.59099408968, 40958.59041409548, 41733.16533669249, 41800.79099604482, 9998.150157236716, 10090.646827361006, 10356.171506279328, 10390.58437662485, 10829.458527073772, 10955.56177752881, 11042.282251653616, 11196.104311655212, 11665.941670291595, 11789.351585662871, 10724.142068634646, 11004.504797283982, 11079.390633515233, 11093.44532773342, 11226.4386780659, 10368.896311036793, 10759.246852720235, 11015.339079655247, 11048.723781905517, 11422.714432139262, 10368.896311037095, 10785.460726963778, 10848.891511085103, 10857.294275872044, 11465.369404682822, 8574.91425085766, 8604.65581376763, 8844.601992910206, 9030.142136497023, 9123.817523649357, 8838.602262898057, 9272.860907086264, 9368.906310936803, 9543.28425368114, 9580.95209523948], "value": 5990.844428133724, "unit": "score"}], "name": "dromaeo_css", "value": 6331.934199253283, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 115.0, 115.0, 112.0, 113.0, 114.0, 114.0, 113.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 132.0, 197.0, 137.0, 138.0, 154.0, 129.0, 182.0, 129.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 160.0, 163.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 105.0, 77.0, 77.0, 75.0, 75.0, 100.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 84.0, 85.0, 84.0, 125.0, 85.0, 83.0, 123.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 70.0, 66.0, 68.0, 68.0, 65.0, 64.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 72.0, 65.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 85.0, 83.0, 86.0, 90.0, 86.0, 84.0, 116.0, 89.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 129.0, 130.0, 133.0, 137.0, 131.0, 133.0, 142.0, 143.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 172.0, 168.0, 169.0, 167.0, 166.0, 172.0, 172.0, 165.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 67.0, 68.0, 68.0, 66.0, 67.0, 66.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1548.8999999999999, "alertThreshold": 2.0}]} 07:04:57 INFO - Return code: 0 07:04:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:04:57 ERROR - # TBPL SUCCESS # 07:04:57 INFO - Running post-action listener: _resource_record_post_action 07:04:57 INFO - ##### 07:04:57 INFO - ##### Finished run-tests step (success) 07:04:57 INFO - ##### 07:04:57 INFO - Running post-run listener: _resource_record_post_run 07:04:57 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 503808; Write bytes: 522747904; Read time: 100; Write time: 426140 07:04:57 INFO - TinderboxPrint: CPU usage
13.1% 07:04:57 INFO - TinderboxPrint: I/O read bytes / time
503,808 / 100 07:04:57 INFO - TinderboxPrint: I/O write bytes / time
522,747,904 / 426,140 07:04:57 INFO - TinderboxPrint: CPU idle
8,324.4 (86.9%) 07:04:57 INFO - TinderboxPrint: CPU user
1,210.9 (12.6%) 07:04:57 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237076480; Read time: 0; Write time: 250200 07:04:57 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 503808; Write bytes: 285593600; Read time: 100; Write time: 175940 07:04:58 INFO - Running post-run listener: _upload_blobber_files 07:04:58 INFO - Blob upload gear active. 07:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04:58 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 07:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:04:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:59 INFO - (blobuploader) - INFO - Done attempting. 07:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:04 INFO - (blobuploader) - INFO - Done attempting. 07:05:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:05:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:05 INFO - (blobuploader) - INFO - Done attempting. 07:05:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:05 INFO - Return code: 0 07:05:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a75b19ec3a2f9596e0ae7c2cbd37b43e393c3eb67a13ad15c04fbd043bca6419e9f0929a906516d44ae49378604483847fbb6e48a5d4af353fc7dbf12b302acf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95a07e9f4cf6ac3af34f8fb7c2102cde7a76f07876f3c6b0915fa925d05d66d100b469210c916d39ec29a4680ca365aec015f77117f0ee0a7a7435ffcf581ed2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1234eb288ed1b8fe22accdde0e13950bab10751d4390b4d707eaae2ac818d397546ed5d0146ddb44183634c0a2edcde066264f84819289c06117dca72d3faf10"} 07:05:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:05 INFO - Contents: 07:05:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a75b19ec3a2f9596e0ae7c2cbd37b43e393c3eb67a13ad15c04fbd043bca6419e9f0929a906516d44ae49378604483847fbb6e48a5d4af353fc7dbf12b302acf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95a07e9f4cf6ac3af34f8fb7c2102cde7a76f07876f3c6b0915fa925d05d66d100b469210c916d39ec29a4680ca365aec015f77117f0ee0a7a7435ffcf581ed2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1234eb288ed1b8fe22accdde0e13950bab10751d4390b4d707eaae2ac818d397546ed5d0146ddb44183634c0a2edcde066264f84819289c06117dca72d3faf10"} 07:05:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:05 INFO - Copying logs to upload dir... 07:05:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.930643 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-31 07:05:05.203435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:05.207097) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a75b19ec3a2f9596e0ae7c2cbd37b43e393c3eb67a13ad15c04fbd043bca6419e9f0929a906516d44ae49378604483847fbb6e48a5d4af353fc7dbf12b302acf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95a07e9f4cf6ac3af34f8fb7c2102cde7a76f07876f3c6b0915fa925d05d66d100b469210c916d39ec29a4680ca365aec015f77117f0ee0a7a7435ffcf581ed2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1234eb288ed1b8fe22accdde0e13950bab10751d4390b4d707eaae2ac818d397546ed5d0146ddb44183634c0a2edcde066264f84819289c06117dca72d3faf10"} build_url:https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a75b19ec3a2f9596e0ae7c2cbd37b43e393c3eb67a13ad15c04fbd043bca6419e9f0929a906516d44ae49378604483847fbb6e48a5d4af353fc7dbf12b302acf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95a07e9f4cf6ac3af34f8fb7c2102cde7a76f07876f3c6b0915fa925d05d66d100b469210c916d39ec29a4680ca365aec015f77117f0ee0a7a7435ffcf581ed2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1234eb288ed1b8fe22accdde0e13950bab10751d4390b4d707eaae2ac818d397546ed5d0146ddb44183634c0a2edcde066264f84819289c06117dca72d3faf10"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:05.233238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:05.233717) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464701344.908955-1188917790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:05.319535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 07:05:05.319873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 07:05:05.320184) ========= ========= Total master_lag: 0.17 =========