builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1463171482.97 results: success (0) buildid: 20160513073004 builduid: 4fce73e9c9604b1881795a9e1b7c6863 revision: 6a50a177ebef2b99751b519df44de186e0c41833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:22.970213) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:22.970689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:22.970994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:23.047328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:23.047653) ========= 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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 13:31:23-- 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% 12.2M=0.001s 2016-05-13 13:31:23 (12.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197729 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:23.276645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:23.276958) ========= 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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073798 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:23.359703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 13:31:23.360063) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6a50a177ebef2b99751b519df44de186e0c41833 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6a50a177ebef2b99751b519df44de186e0c41833 --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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 13:31:23,409 truncating revision to first 12 chars 2016-05-13 13:31:23,409 Setting DEBUG logging. 2016-05-13 13:31:23,409 attempt 1/10 2016-05-13 13:31:23,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6a50a177ebef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 13:31:24,448 unpacking tar archive at: mozilla-inbound-6a50a177ebef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 13:31:24.682449) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:24.682797) ========= script_repo_revision: 6a50a177ebef2b99751b519df44de186e0c41833 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:24.683189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:24.683461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:31:24.692710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-13 13:31:24.693031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:24 INFO - MultiFileLogger online at 20160513 13:31:24 in /builds/slave/test 13:31:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:31:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:24 INFO - {'append_to_log': False, 13:31:24 INFO - 'base_work_dir': '/builds/slave/test', 13:31:24 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:31:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:24 INFO - 'branch': 'Mozilla-Inbound', 13:31:24 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:24 INFO - 'config_files': ('talos/linux_config.py',), 13:31:24 INFO - 'default_actions': ('clobber', 13:31:24 INFO - 'read-buildbot-config', 13:31:24 INFO - 'download-and-extract', 13:31:24 INFO - 'populate-webroot', 13:31:24 INFO - 'create-virtualenv', 13:31:24 INFO - 'install', 13:31:24 INFO - 'run-tests'), 13:31:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:24 INFO - 'download_minidump_stackwalk': True, 13:31:24 INFO - 'download_symbols': 'ondemand', 13:31:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:24 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:24 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:24 INFO - 'installer_path': 'installer.exe', 13:31:24 INFO - 'log_level': 'info', 13:31:24 INFO - 'log_name': 'talos', 13:31:24 INFO - 'log_to_console': True, 13:31:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:24 INFO - 'opt_config_files': (), 13:31:24 INFO - 'pip_index': False, 13:31:24 INFO - 'sps_profile': False, 13:31:24 INFO - 'sps_profile_interval': 0, 13:31:24 INFO - 'suite': 'dromaeojs', 13:31:24 INFO - 'system_bits': '32', 13:31:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:24 INFO - 'title': 'talos-linux64-ix-063', 13:31:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:24 INFO - 'use_talos_json': True, 13:31:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:24 INFO - 'work_dir': 'build'} 13:31:24 INFO - ##### 13:31:24 INFO - ##### Running clobber step. 13:31:24 INFO - ##### 13:31:24 INFO - Running pre-action listener: _resource_record_pre_action 13:31:24 INFO - Running main action method: clobber 13:31:24 INFO - rmtree: /builds/slave/test/build 13:31:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:26 INFO - Running post-action listener: _resource_record_post_action 13:31:26 INFO - ##### 13:31:26 INFO - ##### Finished clobber step (success) 13:31:26 INFO - ##### 13:31:26 INFO - ##### 13:31:26 INFO - ##### Running read-buildbot-config step. 13:31:26 INFO - ##### 13:31:26 INFO - Running pre-action listener: _resource_record_pre_action 13:31:26 INFO - Running main action method: read_buildbot_config 13:31:26 INFO - Using buildbot properties: 13:31:26 INFO - { 13:31:26 INFO - "project": "", 13:31:26 INFO - "product": "firefox", 13:31:26 INFO - "script_repo_revision": "production", 13:31:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:31:26 INFO - "repository": "", 13:31:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:31:26 INFO - "buildid": "20160513073004", 13:31:26 INFO - "pgo_build": "True", 13:31:26 INFO - "basedir": "/builds/slave/test", 13:31:26 INFO - "buildnumber": 907, 13:31:26 INFO - "slavename": "talos-linux64-ix-063", 13:31:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:31:26 INFO - "platform": "ubuntu64_hw", 13:31:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:31:26 INFO - "branch": "mozilla-inbound", 13:31:26 INFO - "repo_path": "integration/mozilla-inbound", 13:31:26 INFO - "revision": "6a50a177ebef2b99751b519df44de186e0c41833", 13:31:26 INFO - "stage_platform": "linux64-pgo", 13:31:26 INFO - "builduid": "4fce73e9c9604b1881795a9e1b7c6863", 13:31:26 INFO - "slavebuilddir": "test" 13:31:26 INFO - } 13:31:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:31:26 INFO - Running post-action listener: _resource_record_post_action 13:31:26 INFO - ##### 13:31:26 INFO - ##### Finished read-buildbot-config step (success) 13:31:26 INFO - ##### 13:31:26 INFO - ##### 13:31:26 INFO - ##### Running download-and-extract step. 13:31:26 INFO - ##### 13:31:26 INFO - Running pre-action listener: _resource_record_pre_action 13:31:26 INFO - Running main action method: download_and_extract 13:31:26 INFO - mkdir: /builds/slave/test/build/tests 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:26 INFO - https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:31:26 INFO - Downloaded 1361 bytes. 13:31:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:26 INFO - Using the following test package requirements: 13:31:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:31:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:31:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'jsshell-linux-x86_64.zip'], 13:31:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:31:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:31:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:31:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:31:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:31:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:26 INFO - https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:31:28 INFO - Downloaded 24023303 bytes. 13:31:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:31:29 INFO - Return code: 0 13:31:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:31: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')]} 13:31:29 INFO - https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:31:30 INFO - Downloaded 24023303 bytes. 13:31:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:31:32 INFO - Return code: 0 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:32 INFO - https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:31:33 INFO - Downloaded 10840239 bytes. 13:31:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:31:33 INFO - Return code: 0 13:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:33 INFO - https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:31:34 INFO - Downloaded 58391884 bytes. 13:31:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:34 INFO - mkdir: /builds/slave/test/properties 13:31:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:31:34 INFO - Writing to file /builds/slave/test/properties/build_url 13:31:34 INFO - Contents: 13:31:34 INFO - build_url:https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:35 INFO - Running post-action listener: _resource_record_post_action 13:31:35 INFO - Running post-action listener: set_extra_try_arguments 13:31:35 INFO - ##### 13:31:35 INFO - ##### Finished download-and-extract step (success) 13:31:35 INFO - ##### 13:31:35 INFO - ##### 13:31:35 INFO - ##### Running populate-webroot step. 13:31:35 INFO - ##### 13:31:35 INFO - Running pre-action listener: _resource_record_pre_action 13:31:35 INFO - Running main action method: populate_webroot 13:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:35 INFO - '--tppagecycles', 13:31:35 INFO - '7'], 13:31:35 INFO - 'tests': ['tsvgm']}}, 13:31:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:31:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:31:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['damp', 'tps']}, 13:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'tests': ['damp', 'tps']}, 13:31:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['dromaeo_dom']}, 13:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['a11yr', 13:31:35 INFO - 'ts_paint', 13:31:35 INFO - 'tpaint', 13:31:35 INFO - 'sessionrestore', 13:31:35 INFO - 'sessionrestore_no_auto_restore', 13:31:35 INFO - 'tabpaint']}, 13:31:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['tsvgx', 13:31:35 INFO - 'tsvgr_opacity', 13:31:35 INFO - 'tart', 13:31:35 INFO - 'tscrollx', 13:31:35 INFO - 'cart']}, 13:31:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:31:35 INFO - 'tsvgr_opacity', 13:31:35 INFO - 'tart', 13:31:35 INFO - 'tscrollx', 13:31:35 INFO - 'cart']}, 13:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'talos_options': ['--disable-e10s'], 13:31:35 INFO - 'tests': ['tp5o']}, 13:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'tests': ['tp5o']}, 13:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'talos_options': ['--disable-e10s', 13:31:35 INFO - '--xperf_path', 13:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:35 INFO - 'tests': ['tp5n']}, 13:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:35 INFO - 'talos_options': ['--xperf_path', 13:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:35 INFO - 'tests': ['tp5n']}}, 13:31:35 INFO - 'talos.zip': {'path': '', 13:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:35 INFO - Running post-action listener: _resource_record_post_action 13:31:35 INFO - ##### 13:31:35 INFO - ##### Finished populate-webroot step (success) 13:31:35 INFO - ##### 13:31:35 INFO - ##### 13:31:35 INFO - ##### Running create-virtualenv step. 13:31:35 INFO - ##### 13:31:35 INFO - Running pre-action listener: _resource_record_pre_action 13:31:35 INFO - Running main action method: create_virtualenv 13:31:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:31:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:31:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:36 INFO - Using real prefix '/usr' 13:31:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:31:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:43 INFO - Installing pip.................done. 13:31:43 INFO - Return code: 0 13:31:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:43 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:31:43 INFO - Using env: {'DISPLAY': ':0', 13:31:43 INFO - 'HOME': '/home/cltbld', 13:31:43 INFO - 'LANG': 'en_US.UTF-8', 13:31:43 INFO - 'LANGUAGE': 'en_US:en', 13:31:43 INFO - 'LOGNAME': 'cltbld', 13:31:43 INFO - 'MAIL': '/var/mail/cltbld', 13:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:43 INFO - 'MOZ_NO_REMOTE': '1', 13:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:43 INFO - 'NO_EM_RESTART': '1', 13:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:43 INFO - 'PWD': '/builds/slave/test', 13:31:43 INFO - 'SHELL': '/bin/bash', 13:31:43 INFO - 'SHLVL': '1', 13:31:43 INFO - 'TERM': 'linux', 13:31:43 INFO - 'TMOUT': '86400', 13:31:43 INFO - 'USER': 'cltbld', 13:31:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:43 INFO - '_': '/tools/buildbot/bin/python'} 13:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:31:43 INFO - Cleaning up... 13:31:43 INFO - Return code: 0 13:31:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:43 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:31:43 INFO - Using env: {'DISPLAY': ':0', 13:31:43 INFO - 'HOME': '/home/cltbld', 13:31:43 INFO - 'LANG': 'en_US.UTF-8', 13:31:43 INFO - 'LANGUAGE': 'en_US:en', 13:31:43 INFO - 'LOGNAME': 'cltbld', 13:31:43 INFO - 'MAIL': '/var/mail/cltbld', 13:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:43 INFO - 'MOZ_NO_REMOTE': '1', 13:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:43 INFO - 'NO_EM_RESTART': '1', 13:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:43 INFO - 'PWD': '/builds/slave/test', 13:31:43 INFO - 'SHELL': '/bin/bash', 13:31:43 INFO - 'SHLVL': '1', 13:31:43 INFO - 'TERM': 'linux', 13:31:43 INFO - 'TMOUT': '86400', 13:31:43 INFO - 'USER': 'cltbld', 13:31:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:43 INFO - '_': '/tools/buildbot/bin/python'} 13:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:43 INFO - Downloading/unpacking psutil>=3.1.1 13:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:46 INFO - Installing collected packages: psutil 13:31:46 INFO - Running setup.py install for psutil 13:31:46 INFO - building 'psutil._psutil_linux' extension 13:31:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:31:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:31:47 INFO - building 'psutil._psutil_posix' extension 13:31:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:31:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:47 INFO - Successfully installed psutil 13:31:47 INFO - Cleaning up... 13:31:47 INFO - Return code: 0 13:31:47 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 13:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 13:31:47 INFO - Using env: {'DISPLAY': ':0', 13:31:47 INFO - 'HOME': '/home/cltbld', 13:31:47 INFO - 'LANG': 'en_US.UTF-8', 13:31:47 INFO - 'LANGUAGE': 'en_US:en', 13:31:47 INFO - 'LOGNAME': 'cltbld', 13:31:47 INFO - 'MAIL': '/var/mail/cltbld', 13:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:47 INFO - 'MOZ_NO_REMOTE': '1', 13:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:47 INFO - 'NO_EM_RESTART': '1', 13:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:47 INFO - 'PWD': '/builds/slave/test', 13:31:47 INFO - 'SHELL': '/bin/bash', 13:31:47 INFO - 'SHLVL': '1', 13:31:47 INFO - 'TERM': 'linux', 13:31:47 INFO - 'TMOUT': '86400', 13:31:47 INFO - 'USER': 'cltbld', 13:31:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:47 INFO - '_': '/tools/buildbot/bin/python'} 13:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:47 INFO - Downloading/unpacking mozsystemmonitor==0.1 13:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:49 INFO - Downloading mozsystemmonitor-0.1.tar.gz 13:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 13:31:50 INFO - Installing collected packages: mozsystemmonitor 13:31:50 INFO - Running setup.py install for mozsystemmonitor 13:31:50 INFO - Successfully installed mozsystemmonitor 13:31:50 INFO - Cleaning up... 13:31:50 INFO - Return code: 0 13:31:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:50 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:31:50 INFO - Using env: {'DISPLAY': ':0', 13:31:50 INFO - 'HOME': '/home/cltbld', 13:31:50 INFO - 'LANG': 'en_US.UTF-8', 13:31:50 INFO - 'LANGUAGE': 'en_US:en', 13:31:50 INFO - 'LOGNAME': 'cltbld', 13:31:50 INFO - 'MAIL': '/var/mail/cltbld', 13:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:50 INFO - 'MOZ_NO_REMOTE': '1', 13:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:50 INFO - 'NO_EM_RESTART': '1', 13:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:50 INFO - 'PWD': '/builds/slave/test', 13:31:50 INFO - 'SHELL': '/bin/bash', 13:31:50 INFO - 'SHLVL': '1', 13:31:50 INFO - 'TERM': 'linux', 13:31:50 INFO - 'TMOUT': '86400', 13:31:50 INFO - 'USER': 'cltbld', 13:31:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:50 INFO - '_': '/tools/buildbot/bin/python'} 13:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:31:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:31:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - Downloading docopt-0.6.1.tar.gz 13:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:31:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:31:53 INFO - Running setup.py install for blobuploader 13:31:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:31:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:31:53 INFO - Running setup.py install for requests 13:31:53 INFO - Running setup.py install for docopt 13:31:53 INFO - Successfully installed blobuploader requests docopt 13:31:53 INFO - Cleaning up... 13:31:53 INFO - Return code: 0 13:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:53 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:31:53 INFO - Using env: {'DISPLAY': ':0', 13:31:53 INFO - 'HOME': '/home/cltbld', 13:31:53 INFO - 'LANG': 'en_US.UTF-8', 13:31:53 INFO - 'LANGUAGE': 'en_US:en', 13:31:53 INFO - 'LOGNAME': 'cltbld', 13:31:53 INFO - 'MAIL': '/var/mail/cltbld', 13:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:53 INFO - 'MOZ_NO_REMOTE': '1', 13:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:53 INFO - 'NO_EM_RESTART': '1', 13:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:53 INFO - 'PWD': '/builds/slave/test', 13:31:53 INFO - 'SHELL': '/bin/bash', 13:31:53 INFO - 'SHLVL': '1', 13:31:53 INFO - 'TERM': 'linux', 13:31:53 INFO - 'TMOUT': '86400', 13:31:53 INFO - 'USER': 'cltbld', 13:31:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:53 INFO - '_': '/tools/buildbot/bin/python'} 13:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:31:53 INFO - Running setup.py (path:/tmp/pip-zoaPO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:31:53 INFO - Running setup.py (path:/tmp/pip-Koypep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:31:53 INFO - Running setup.py (path:/tmp/pip-bcTTzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:31:54 INFO - Running setup.py (path:/tmp/pip-yHgBsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:31:54 INFO - Running setup.py (path:/tmp/pip-WRinif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:31:54 INFO - Running setup.py (path:/tmp/pip-2WYgrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:31:54 INFO - Running setup.py (path:/tmp/pip-GHfr9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:31:54 INFO - Running setup.py (path:/tmp/pip-n6W6Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:31:54 INFO - Running setup.py (path:/tmp/pip-4Tswqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:31:54 INFO - Running setup.py (path:/tmp/pip-ECSNjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:31:54 INFO - Running setup.py (path:/tmp/pip-D8CUBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:31:54 INFO - Running setup.py (path:/tmp/pip-4AR7g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:31:54 INFO - Running setup.py (path:/tmp/pip-xIqsu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:31:54 INFO - Running setup.py (path:/tmp/pip-SWsADh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:54 INFO - Running setup.py (path:/tmp/pip-ZHTjrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:31:54 INFO - Running setup.py (path:/tmp/pip-fL6699-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:31:54 INFO - Running setup.py (path:/tmp/pip-A_E_Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:31:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:31:55 INFO - Running setup.py install for manifestparser 13:31:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Running setup.py install for mozcrash 13:31:55 INFO - Running setup.py install for mozdebug 13:31:55 INFO - Running setup.py install for mozdevice 13:31:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Running setup.py install for mozfile 13:31:55 INFO - Running setup.py install for mozhttpd 13:31:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Running setup.py install for mozinfo 13:31:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Running setup.py install for mozInstall 13:31:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:31:55 INFO - Running setup.py install for mozleak 13:31:55 INFO - Running setup.py install for mozlog 13:31:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Running setup.py install for moznetwork 13:31:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Running setup.py install for mozprocess 13:31:56 INFO - Running setup.py install for mozprofile 13:31:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Running setup.py install for mozrunner 13:31:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Running setup.py install for mozscreenshot 13:31:56 INFO - Running setup.py install for moztest 13:31:56 INFO - Running setup.py install for mozversion 13:31:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:31:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:31:56 INFO - Cleaning up... 13:31:56 INFO - Return code: 0 13:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:31:56 INFO - Using env: {'DISPLAY': ':0', 13:31:56 INFO - 'HOME': '/home/cltbld', 13:31:56 INFO - 'LANG': 'en_US.UTF-8', 13:31:56 INFO - 'LANGUAGE': 'en_US:en', 13:31:56 INFO - 'LOGNAME': 'cltbld', 13:31:56 INFO - 'MAIL': '/var/mail/cltbld', 13:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:56 INFO - 'MOZ_NO_REMOTE': '1', 13:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:56 INFO - 'NO_EM_RESTART': '1', 13:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:56 INFO - 'PWD': '/builds/slave/test', 13:31:56 INFO - 'SHELL': '/bin/bash', 13:31:56 INFO - 'SHLVL': '1', 13:31:56 INFO - 'TERM': 'linux', 13:31:56 INFO - 'TMOUT': '86400', 13:31:56 INFO - 'USER': 'cltbld', 13:31:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:56 INFO - '_': '/tools/buildbot/bin/python'} 13:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:31:57 INFO - Running setup.py (path:/tmp/pip-njB_4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:31:57 INFO - Running setup.py (path:/tmp/pip-ulImC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:31:57 INFO - Running setup.py (path:/tmp/pip-Kb4bzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:31:57 INFO - Running setup.py (path:/tmp/pip-0kVcIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:31:57 INFO - Running setup.py (path:/tmp/pip-YvjYKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:31:57 INFO - Running setup.py (path:/tmp/pip-KvgTPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:31:57 INFO - Running setup.py (path:/tmp/pip-C7WoKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:31:57 INFO - Running setup.py (path:/tmp/pip-XrH0yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:31:57 INFO - Running setup.py (path:/tmp/pip-xWV2BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:31:57 INFO - Running setup.py (path:/tmp/pip-Sc65FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:31:57 INFO - Running setup.py (path:/tmp/pip-igFEtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:31:57 INFO - Running setup.py (path:/tmp/pip-HlPpwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:31:57 INFO - Running setup.py (path:/tmp/pip-gEAiUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:31:58 INFO - Running setup.py (path:/tmp/pip-ap8g3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:58 INFO - Running setup.py (path:/tmp/pip-X9Su3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:31:58 INFO - Running setup.py (path:/tmp/pip-tnX2au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:31:58 INFO - Running setup.py (path:/tmp/pip-O16DC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:00 INFO - Downloading blessings-1.6.tar.gz 13:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:00 INFO - Installing collected packages: blessings 13:32:00 INFO - Running setup.py install for blessings 13:32:00 INFO - Successfully installed blessings 13:32:00 INFO - Cleaning up... 13:32:00 INFO - Return code: 0 13:32:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:00 INFO - Reading from file tmpfile_stdout 13:32:00 INFO - Current package versions: 13:32:00 INFO - argparse == 1.2.1 13:32:00 INFO - blessings == 1.6 13:32:00 INFO - blobuploader == 1.2.4 13:32:00 INFO - docopt == 0.6.1 13:32:00 INFO - manifestparser == 1.1 13:32:00 INFO - mozInstall == 1.12 13:32:00 INFO - mozcrash == 0.17 13:32:00 INFO - mozdebug == 0.1 13:32:00 INFO - mozdevice == 0.48 13:32:00 INFO - mozfile == 1.2 13:32:00 INFO - mozhttpd == 0.7 13:32:00 INFO - mozinfo == 0.9 13:32:00 INFO - mozleak == 0.1 13:32:00 INFO - mozlog == 3.2 13:32:00 INFO - moznetwork == 0.27 13:32:00 INFO - mozprocess == 0.22 13:32:00 INFO - mozprofile == 0.28 13:32:00 INFO - mozrunner == 6.11 13:32:00 INFO - mozscreenshot == 0.1 13:32:00 INFO - mozsystemmonitor == 0.1 13:32:00 INFO - moztest == 0.7 13:32:00 INFO - mozversion == 1.4 13:32:00 INFO - psutil == 3.1.1 13:32:00 INFO - requests == 1.2.3 13:32:00 INFO - wsgiref == 0.1.2 13:32:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:00 INFO - Using env: {'DISPLAY': ':0', 13:32:00 INFO - 'HOME': '/home/cltbld', 13:32:00 INFO - 'LANG': 'en_US.UTF-8', 13:32:00 INFO - 'LANGUAGE': 'en_US:en', 13:32:00 INFO - 'LOGNAME': 'cltbld', 13:32:00 INFO - 'MAIL': '/var/mail/cltbld', 13:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:00 INFO - 'MOZ_NO_REMOTE': '1', 13:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:00 INFO - 'NO_EM_RESTART': '1', 13:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:00 INFO - 'PWD': '/builds/slave/test', 13:32:00 INFO - 'SHELL': '/bin/bash', 13:32:00 INFO - 'SHLVL': '1', 13:32:00 INFO - 'TERM': 'linux', 13:32:00 INFO - 'TMOUT': '86400', 13:32:00 INFO - 'USER': 'cltbld', 13:32:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:00 INFO - '_': '/tools/buildbot/bin/python'} 13:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:00 INFO - Cleaning up... 13:32:00 INFO - Return code: 0 13:32:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:00 INFO - Using env: {'DISPLAY': ':0', 13:32:00 INFO - 'HOME': '/home/cltbld', 13:32:00 INFO - 'LANG': 'en_US.UTF-8', 13:32:00 INFO - 'LANGUAGE': 'en_US:en', 13:32:00 INFO - 'LOGNAME': 'cltbld', 13:32:00 INFO - 'MAIL': '/var/mail/cltbld', 13:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:00 INFO - 'MOZ_NO_REMOTE': '1', 13:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:00 INFO - 'NO_EM_RESTART': '1', 13:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:00 INFO - 'PWD': '/builds/slave/test', 13:32:00 INFO - 'SHELL': '/bin/bash', 13:32:00 INFO - 'SHLVL': '1', 13:32:00 INFO - 'TERM': 'linux', 13:32:00 INFO - 'TMOUT': '86400', 13:32:00 INFO - 'USER': 'cltbld', 13:32:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:00 INFO - '_': '/tools/buildbot/bin/python'} 13:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:01 INFO - Downloading/unpacking jsonschema 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:02 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:03 INFO - warning: no files found matching '*.txt' 13:32:03 INFO - no previously-included directories found matching 'build' 13:32:03 INFO - no previously-included directories found matching 'dist' 13:32:03 INFO - no previously-included directories found matching '.git*' 13:32:03 INFO - Installing collected packages: jsonschema, functools32 13:32:03 INFO - Running setup.py install for functools32 13:32:03 INFO - warning: no files found matching '*.txt' 13:32:03 INFO - no previously-included directories found matching 'build' 13:32:03 INFO - no previously-included directories found matching 'dist' 13:32:03 INFO - no previously-included directories found matching '.git*' 13:32:03 INFO - Successfully installed jsonschema functools32 13:32:03 INFO - Cleaning up... 13:32:03 INFO - Return code: 0 13:32:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:03 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 0x7f13966d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:32:03 INFO - Using env: {'DISPLAY': ':0', 13:32:03 INFO - 'HOME': '/home/cltbld', 13:32:03 INFO - 'LANG': 'en_US.UTF-8', 13:32:03 INFO - 'LANGUAGE': 'en_US:en', 13:32:03 INFO - 'LOGNAME': 'cltbld', 13:32:03 INFO - 'MAIL': '/var/mail/cltbld', 13:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:03 INFO - 'MOZ_NO_REMOTE': '1', 13:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:03 INFO - 'NO_EM_RESTART': '1', 13:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:03 INFO - 'PWD': '/builds/slave/test', 13:32:03 INFO - 'SHELL': '/bin/bash', 13:32:03 INFO - 'SHLVL': '1', 13:32:03 INFO - 'TERM': 'linux', 13:32:03 INFO - 'TMOUT': '86400', 13:32:03 INFO - 'USER': 'cltbld', 13:32:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:03 INFO - '_': '/tools/buildbot/bin/python'} 13:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:03 INFO - Downloading/unpacking flake8 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:06 INFO - no previously-included directories found matching 'docs/_build' 13:32:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:06 INFO - Running setup.py install for pep8 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:06 INFO - no previously-included directories found matching 'docs/_build' 13:32:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:06 INFO - Cleaning up... 13:32:06 INFO - Return code: 0 13:32:06 INFO - Running post-action listener: _resource_record_post_action 13:32:06 INFO - Running post-action listener: _start_resource_monitoring 13:32:06 INFO - Starting resource monitoring. 13:32:06 INFO - ##### 13:32:06 INFO - ##### Finished create-virtualenv step (success) 13:32:06 INFO - ##### 13:32:06 INFO - ##### 13:32:06 INFO - ##### Running install step. 13:32:06 INFO - ##### 13:32:06 INFO - Running pre-action listener: _resource_record_pre_action 13:32:06 INFO - Running main action method: install 13:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:06 INFO - Reading from file tmpfile_stdout 13:32:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:06 INFO - Reading from file tmpfile_stdout 13:32:06 INFO - Output received: 13:32:06 INFO - Usage: mozinstall [options] installer 13:32:06 INFO - Options: 13:32:06 INFO - -h, --help show this help message and exit 13:32:06 INFO - -d DEST, --destination=DEST 13:32:06 INFO - Directory to install application into. [default: 13:32:06 INFO - "/builds/slave/test"] 13:32:06 INFO - --app=APP Application being installed. [default: firefox] 13:32:06 INFO - mkdir: /builds/slave/test/build/application 13:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:32:23 INFO - Reading from file tmpfile_stdout 13:32:23 INFO - Output received: 13:32:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:23 INFO - Running post-action listener: _resource_record_post_action 13:32:23 INFO - ##### 13:32:23 INFO - ##### Finished install step (success) 13:32:23 INFO - ##### 13:32:23 INFO - ##### 13:32:23 INFO - ##### Running run-tests step. 13:32:23 INFO - ##### 13:32:23 INFO - Running pre-action listener: _resource_record_pre_action 13:32:23 INFO - Running main action method: run_tests 13:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:23 INFO - Python 2.7.3 13:32:23 INFO - Return code: 0 13:32:23 INFO - grabbing minidump binary from tooltool 13:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:23 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 0xf749c0>, '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 0xf758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf75d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:32:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:32:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:32:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:23 INFO - Return code: 0 13:32:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:32:24 INFO - Return code: 0 13:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:32:24 INFO - Using env: {'DISPLAY': ':0', 13:32:24 INFO - 'HOME': '/home/cltbld', 13:32:24 INFO - 'LANG': 'en_US.UTF-8', 13:32:24 INFO - 'LANGUAGE': 'en_US:en', 13:32:24 INFO - 'LOGNAME': 'cltbld', 13:32:24 INFO - 'MAIL': '/var/mail/cltbld', 13:32:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:24 INFO - 'MOZ_NO_REMOTE': '1', 13:32:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:24 INFO - 'NO_EM_RESTART': '1', 13:32:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:24 INFO - 'PWD': '/builds/slave/test', 13:32:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:24 INFO - 'SHELL': '/bin/bash', 13:32:24 INFO - 'SHLVL': '1', 13:32:24 INFO - 'TERM': 'linux', 13:32:24 INFO - 'TMOUT': '86400', 13:32:24 INFO - 'USER': 'cltbld', 13:32:24 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345', 13:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:24 INFO - '_': '/tools/buildbot/bin/python'} 13:32:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:32:25 INFO - mozversion application_buildid: 20160513073004 13:32:25 INFO - mozversion application_changeset: 6a50a177ebef2b99751b519df44de186e0c41833 13:32:25 INFO - mozversion application_display_name: Nightly 13:32:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:25 INFO - mozversion application_name: Firefox 13:32:25 INFO - mozversion application_remotingname: firefox 13:32:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:32:25 INFO - mozversion application_vendor: Mozilla 13:32:25 INFO - mozversion application_version: 49.0a1 13:32:25 INFO - mozversion platform_buildid: 20160513073004 13:32:25 INFO - mozversion platform_changeset: 6a50a177ebef2b99751b519df44de186e0c41833 13:32:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:32:25 INFO - mozversion platform_version: 49.0a1 13:32:25 INFO - using testdate: 1463171545 13:32:25 INFO - actual date: 1463171545 13:32:25 INFO - starting webserver on 'localhost:56024' 13:32:25 INFO - SUITE-START | Running 2 tests 13:32:25 INFO - TEST-START | dromaeo_css 13:32:25 INFO - operating with platform_type : linux_ 13:32:25 INFO - Initialising browser for dromaeo_css test... 13:32:25 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUudhM/profile http://localhost:56024/getInfo.html) 13:32:32 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 13:32:32 INFO - PROCESS | 3316 | colorDepth:24 13:32:32 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 13:32:32 INFO - PROCESS | 3316 | __metrics 13:32:34 ERROR - PROCESS | 3316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:32:34 INFO - PROCESS | 3316 | console.error: PushService: 13:32:34 INFO - PROCESS | 3316 | stateChangeProcessEnqueue: Error transitioning state 13:32:34 INFO - PROCESS | 3316 | UnknownError 13:32:35 INFO - TEST-INFO | 3316: exit 0 13:32:35 INFO - Browser initialized. 13:32:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:32:35 INFO - TEST-INFO | started process 3400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUudhM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:46 INFO - PROCESS | 3400 | RSS: Main: 152305664 13:32:46 INFO - PROCESS | 3400 | 13:33:38 INFO - PROCESS | 3400 | 1463171618441 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:35:46 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56024/tests/dromaeo/cssquery-ext.html) 13:35:47 INFO - PROCESS | 3400 | RSS: Main: 249606144 13:35:47 INFO - PROCESS | 3400 | 13:38:50 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-ext.html (next: http://localhost:56024/tests/dromaeo/cssquery-jquery.html) 13:38:50 INFO - PROCESS | 3400 | RSS: Main: 245747712 13:38:50 INFO - PROCESS | 3400 | 13:41:52 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56024/tests/dromaeo/cssquery-mootools.html) 13:41:53 INFO - PROCESS | 3400 | RSS: Main: 253980672 13:41:53 INFO - PROCESS | 3400 | 13:44:55 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56024/tests/dromaeo/cssquery-prototype.html) 13:44:55 INFO - PROCESS | 3400 | RSS: Main: 240541696 13:44:55 INFO - PROCESS | 3400 | 13:47:58 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56024/tests/dromaeo/cssquery-yui.html) 13:47:59 INFO - PROCESS | 3400 | RSS: Main: 206114816 13:47:59 INFO - PROCESS | 3400 | 13:51:01 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:56024/tests/dromaeo/cssquery-yui.html (next: http://localhost:56024/tests/dromaeo/cssquery-dojo.html) 13:51:02 INFO - PROCESS | 3400 | RSS: Main: 295010304 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | __start_tp_report 13:51:02 INFO - PROCESS | 3400 | _x_x_mozilla_page_load 13:51:02 INFO - PROCESS | 3400 | _x_x_mozilla_page_load_details 13:51:02 INFO - PROCESS | 3400 | |i|pagename|runs| 13:51:02 INFO - PROCESS | 3400 | |0;dojo.html;3176.7776255662097;3200.055983484872;3222.854971526281;3232.2404235004783;3259.445894197986;5274.709890955995;5352.759125839337;5386.165144402619;5488.259085023521;5499;5316.627836051478;5319.20211968205;5362.490563396481;5376.032314183445;5400.756965936533;4808.182608956477;4899.093667671475;4904.632152588552;4914.901701965959;5059.089363914494;4959.603231741452;5023.773930173133;5026.798928042892;5038.899222015558;5084.0594490019275;4809.975950120244;4819.2530157825595;4849.951500485021;4859.028194361142;4957.925631115536;4856.975715121402;4860;4866.926996095026;4920.950790492121;4968.776405061781;4915.16442204826;4916.139675556763;4917.77055736066;4921.040397122562;4928.654994150411;5095.847124586268;5216.165413533854;5293;5300.575953923677;5369.9463005369835;5720.256366672347;5772.682502462363;5809.331926828427;5813.79651712188;5820.650760954356;5727.541796656299;5819.039858423355;5830.30036395631;5876.265466816648;5881.411858814127;5451.700156491392;5487.314085739283;5567.638103523299;5580.497755202051;5585.078462053756;6037.376597232153;6040.128187264793;6071.726772295257;6084.269887613515;6090.147379366804;5552.666839989613;5553.1670249462095;5861.70691465425;5869.765209391577;5871.2073870027;5740.913886291709;5792.131180322901;5802.6808525531505;5804.303483581997;5857.70711464425;5718.714064296769;5754.108113242454;5755.482006619424;5762.394948530427;5779.075347944308;5566.997940370691;5651.773929042793;5673.716314184357;5773.24947756789;5785.392533783892;4326.264535029052;4341.9131617367475;4355.499117601516;4372.300431930876;4382.496012958551;3873.573906870242;3902.2195560887935;3912.726109172331;3938.6849052075763;3944.980275098606;5185.922211166836;5358.732063396815;5389.865253368697;5428.484293992144;5430.5927055471;5752.395998420189;5775.94224057754;5776.566757493205;5797.884042319214;5836.299644042742;5420.430854760272;5431.4840090191365;5435.374931882805;5446.91829622556;5457.699826509501;4791.448983366888;4873.634477414137;4888.95111048885;4905.2151655734915;4963.379577552806;5893.5579831512805;5895.233619629506;5899.351071382144;5904.586678932434;5905.498032667186;5732.627379220504;5740.827775166752;5748.741306641127;5750.0512415450985;5764.423557644202;5815.185873977562;5869.207656966426;5878.794242201502;5879.353271140257;5906.822795316148;5555.527780138572;5610.971945140248;5613.045782217115;5626.803061892814;5634.126710359901;5662.518685911744;5720.056190728483;5726.141078838041;5731.541476681939;5738.885222295614;5629.802956896489;5678.3186017678145;5693.4021927696995;5715.657060576379;5720.971395142998;5697.800576979786;5702.486776190163;5703.144528320785;5705.343885453226;5719.5710321726865;5428.022955867824;5436.891262174813;5567.972160139336;5613.326400831927;5628.774849005994;5592.496675299242;5690.3456102548735;5704.286964129484;5708.058170401837;5709.8287051388525;5490.423505531861;5528.032594296063;5530.944690553204;5539.861503462445;5583.441655834384 13:51:02 INFO - PROCESS | 3400 | |1;ext.html;633.9651319177444;638.875419293238;644.9387308205721;647.4076220258462;660.455124522269;42033.579664203346;44098.118037639266;44172.77913610431;48038.75980620101;48144.277835832494;46369.536304636946;46648.53351466484;46715.299270510885;46770.53229467713;46896.531034689644;9011.369204155711;9126.771830704252;9129;9142.040085790963;9151.816963660724;8933.062028487013;9011.684591039315;9013.053629368887;9014.954925225366;9016.729498115066;9066.637334506644;9093.363464557484;9099.363044586882;9106.63573457061;9108.908910910872;9002.32482563807;9035.774105647346;9039.728808135766;9040.68357607487;9044.638214471413;8694.130586941319;8771.342149338761;8775.341849361259;8776.868346974801;8777;41212.1757564847;41435.58564414347;41445.37831932493;41562.79218603918;41585.1682966342;3518.542589463379;3521.559805024372;3591.7665351752053;3632.219072899313;3633.7819730816236;31521;31966.680333196837;32499.577152294933;32723.50914736257;33067.3386532268;4420.40324556184;4436.489803672586;4467.441569803775;4475.731456112644;4490.326451032339;371723;371997;372423.99999999726;373824;374775;53780.46219537833;62161.68919155466;62537;62567;62575.6871215641;69238;70692;70975;71009;71011.2898871015;14845.777313340308;14971.251437428085;14971.475998340005;14998.325075371635;15036.473723419627;10351.63769268072;10989.890101099047;11022.393768342657;11073.390963496924;11148.331100134017;18989.525261868563;19567.706484402745;19636.509087272934;19648.312309069115;19710.40868773939;7091.219965803757;7130.572165670076;7189.856202875913;7267.63661816907;7451.950713553708;1028.1774580335702;1104.861892263467;1134.2570616246371;1237.0783766094137;1240.9689757755948;32513.34973300521;32607.836960815042;32801.50797738036;33063;33099.338013240085;1121.0919155484085;1142.4002398740727;1165.7260543772206;1219.1831472912993;1226.7485165541043;17217.96692198472;17390.391336303168;17720.822791771916;17966.19152138157;18008.459746207634;513674;514322;516918;518002;520204;59459.810803784545;59834.401655983755;59951.70024149851;59982.100268496004;60010;1297.3642914971786;1369.3084992078936;1421.0336970859707;1430.7210094031773;1469.1625773309324;32306.676933230367;32770;33511.32977340488;33627.83186084054;33718;49691.50308496869;50239.24641130313;50395.74802125966;50396.244056339914;50455.495445046545;424038;428285;428353;428403;428943;24623.876880615484;26764.59853102244;27610.72389276162;27630.723692762815;29006.51921769401;45803.31295030644;47258;47266;48423.51576484331;48595.75702121467;39141.03618828672;40178.39732404075;40698.186036278516;40732.59267407288;41146;39209.803950980066;40077.39883901685;40395.99010024773;40739.592604074765;41395.793021034704;39451.60548394479;40619;40807.795961020005;40842;40971.38542921799;34255.82872085724;35494.29011419706;35913.281734364646;36108.27783444369;36118.09704757297;27375.315617109733;27549.17352479429;27675.44649107047;27811.860940695165;27959.580606290514 13:51:02 INFO - PROCESS | 3400 | |2;jquery.html;401.08952677422235;402.24779662032006;404.141199950106;409.696824349981;413.78483188741853;18537.07314634268;18802.34191803287;19899.204031838708;19972.900135499338;20136.194552217912;18438.72341914869;18536.073196340196;18904.243830246807;19004.714929276073;19018.14418351174;5643.153526970967;5666.54667626591;5751.741171647286;5841.970790146043;5857.414258574151;5672.716364181795;5752.5110365618975;5776.220210271623;5777.42225777421;5785.16115163301;5542.528885044776;5667.433256674321;5700.971495142539;5742.081266997281;5742.827715168552;5610.046292130327;5632.887342253132;5687.118496633028;5694.5159661428825;5703.344115426717;5010.073136469765;5127;5147.073526765181;5156;5160.690358578459;21978.120875164976;22001;22299;22349.217777377875;22515.662265066036;2171.7393912730417;2446.5718499262734;2452.730199678034;2497.5629264878753;2795.5387361085395;9797.951010244975;10039.648612298608;10125.949370253174;10395.584176632925;10859.294145880493;1922.826945574905;1995.3714579907282;2004.4287378097317;2039.4901274681329;2066.1941842681217;62032;82261;83249.58375208145;84054.57972710159;88429;11034.668959931216;11103.278286911325;11242.718932026764;11528.884711152949;11926.284422934477;15756.133412662413;15808.130552819704;15846.524604261891;15864.92067539655;15915;7177.389921856597;7337.41300695943;7344.96327518359;7480.625968701652;7494.325510703954;6783.491238157158;6796.25241223465;6868.278830722802;6903.930960690429;6907.378335949788;4825.565699087099;4838.927416088762;4844.975775121102;4888.364512613338;4938.950610493849;1982.5638359560874;2036.551958569142;2040.5816807554415;2049.467138543989;2058.5265388960624;976.2141476111656;1009.4145395670494;1026.8089016740546;1075.510642657589;1114.3870871020906;17395.47813565595;19098.52253693669;19265.422037338903;20129.194832206842;20319.796802032088;986.837171866634;1000.494750151169;1055.145332280855;1062.4900047977014;1099.7470581766238;10429.009244121797;10671.19966002553;10835.783284334428;10871.130309575374;10895.182861285435;464205;469108;478044;482079;484827;95337;98588;98974;99001.50499247458;99949;1061.2093989977516;1067.5036108209565;1078.487718333785;1083.5286650307141;1091.4215465803138;16797.580060498585;16949.406770762966;17088.487345379657;17163.656726865644;17297.91351043287;34151;37030.44454333241;42083.789581053126;42460.36309455299;42690.35964460474;56935;58820.705896470245;59767;59890.70054649699;60449.69775151096;7466.701331946661;7761.883571746315;7764.84470310602;8830.867536986822;9176.082391761038;9532.809343812945;9642.758931026781;10948;13969.860301396857;14227.430902764188;9689.12797848197;11227.607033753779;12094.092943029133;12210;12304;9602.423854568748;11898.583549575724;12080;12101.273923564615;12152.75694486123;11743.647690569296;12180.512779488721;12343.814842777187;12490.937545312216;12590.685232869251;7784.143744188248;7975.641096150571;8100.270975612223;8167.754967350989;8187.672493100447;10895.891041089804;12182.878171218174;12337.383130843242;12384.56654017105;12427.378631068592 13:51:02 INFO - PROCESS | 3400 | |3;mootools.html;1340.4772138865837;1496.7455532559463;1543.155928665245;1663.9251233694483;1886.5000774794682;8673.436226645264;9080.091990800925;9111.908880911189;9396.24830013599;9400.059994000596;9107.954460227706;9306.627734890613;9320.067993200677;9321.906780932188;9324.300677449184;1978.5943881504256;2279.5213005268915;2324.081987614891;2353.8116950643907;2361.551305252005;2214.579229946305;2219.655953327229;2222.944426389345;2223;2223.4107961390246;2340.9882950585225;2391.0435825669697;2393.090625562284;2395.101836811196;2395.3053614451787;2045.4477291131386;2260.819134469247;2328.406256404623;2332.393577669818;2353.0470159585393;2207.9779202207933;2230.230570453191;2231.230225572175;2241.529278851443;2242.8093612042994;9292.210162136227;9346.766330841716;9347.392419492711;9354.438733676001;9360.297977651704;5224.973875130638;5366.731663416853;5369.62412631116;5371.194320851864;5375.381831089436;3525.2068284636007;3624.474451204587;3636.9818150909077;3641.599424063351;3643.6902863256655;1184.466989854569;1208.2810727617054;1235.876412358766;1239.0768877186463;1247.4324182497032;12813.487460501568;12850.228986260854;12851.16467429614;12862.871371286261;12884.935575322157;4605.447346318396;4754.904901901942;4799.544043315879;4816.4220293564995;4823.03539292143;10810;10854.62008829703;10862.293950893167;10876.728081798019;10890.23768336209;4787.305840653085;5380.973095134577;5392.838214853561;5400.189971504227;5402.648827826258;4441.955580444154;4745.905081898342;4896.5837903777865;4907.018596280758;4941;3966.643002129822;4005.639492445694;4097.651699605507;4101.85643502476;4105.117399759066;1196.8982636475823;1198.316959333189;1207.1127721124967;1209.9334536600395;1213.9150259481928;994.0208894239169;1010.1514727628827;1034.5809946971488;1036.7770929250248;1037.2531777120462;5795;5943.465088142088;5999.520038396918;6020.698965051817;6088.786892458743;458.6674660870842;476.1833455623622;484.38483126429236;485.73527427551363;492.04788733799495;4375.912481750347;4410.955890441054;4434.3348497724955;4436.0462500562535;4450.065486247924;11136.61021864247;11223.775524489627;11242.775144497064;11419;11450.94274528622;10807.243492955418;11085.778284434266;11160.497777600027;11169;11289.49197286124;8626.180512851395;8627.78430539229;8643.78390540229;8697.21725044749;8777.078406767198;6154.538409619386;6354.872902541831;6386.265579458236;6407.8718425630295;6420.935790642221;10415.843762343722;10733;10753.032227099598;10766;10880.727981800519;10883.346999180074;10979.890201098206;11008.339499630049;11011.174161937726;11016.724581885517;7287.27127287267;7768.844623107393;8038.316743076904;8186.75439736785;8334.79163020905;8909.198172164537;8959.1936725695;9008.954955225445;9017.458952462874;9041.457512549268;7979.5611241382285;8210.507369557845;8264.545450000067;8302.792430189053;8342.29090527312;7969.561674107979;8073.111957684532;8088.312493438124;8096.149904259968;8247.835043298981;6855.588664679935;7112.893306600302;7126.964365178141;7434.182239953492;7472.551646901204;5057.241413787961;5113.437521872516;5184.170532714747;5196.298499702491;5255.710935898409;4953.851384458472;4999.350084488993;5005.249212618136;5059.974700126623;5143.4085080216255 13:51:02 INFO - PROCESS | 3400 | |4;prototype.html;335.832083958021;342.5615212527964;351.2395663388763;354.1942081763985;354.90240183949425;5260.132078207096;5275.947240527603;5301.973490132554;5323.334583177103;5379.354477462705;5250.606204534656;5269.367675878891;5278.261043453919;5285.942811437718;5315.707636080014;3987.7607343559334;4182;4206.516250631186;4208.642265407437;4223.324268117102;3719.3863012602887;4013.598640135978;4119.732217405859;4211.136716973013;4237.279662457374;4121.361189015707;4140.441040459545;4156;4176.310908700076;4208.558101399355;4005.4792876925812;4143.363371468268;4164.667306461934;4180.519240287345;4191.8532851350055;3634.963650363489;3699.9445008324897;3726.8695595654294;3736.6823819975334;3745.1011757178353;5122.487751224885;5131.845334799677;5152.562032227265;5153.9742301288625;5175.7670904809;4772.6897751646375;4773.474917759044;4786.114568804747;4791.760411979387;4807.879803004917;5544.253560128546;5579.2746942897165;5585.636933599344;5604.3835178130375;5609.35492418373;3928.7839168845703;4036.7779772112817;4037.5356833963883;4097.385392191165;4132.504099508078;5543.805966791143;5664.150377443375;5696.772129114872;5710.628809127394;5730.398308177623;3990.481237439172;4075.5109386873764;4099.528554216244;4104.363823607346;4121.26906699187;4088.4684990950987;4164.8542301019315;4190.350495673176;4209.684273679486;4211.599898009684;4691.601213896789;4732.479427262998;4743.786529606176;4744.7627618618935;4756.239001759702;5464.672119672832;5484.2596249506605;5505.476979686923;5532.723363831792;5554.250176226238;1421.651695334629;1430.3348942741468;1453.0046917861298;1459.8904832327296;1469.1038466535406;958.2717134977328;959.2949182351106;969.1519920069939;972.7227740094039;981.5828272983953;4848.466668666444;4867.933202082665;4895.461499235082;4897.975510122426;4955.306257124005;5119.029173768052;5122.206058060932;5126.0521002018995;5126.846194614168;5132.8460146195675;4870.707757534559;4881.804727810848;4884.998575292057;4906.582940450102;5020.623453241022;3059.571659967606;3061.5151651449028;3073.7387322077425;3084.922876928095;3088.7992280501694;5856.3690511882905;5884.205632239678;5930.110483427434;5932.822015339547;5937.168796368512;5644.6613203207935;5780.971095144498;5781.566382521328;5801.3038435388025;5826.737796799154;5837.6497410155525;5840.29916410025;5850.59585699429;5852.268466441695;5871.882562348729;5523.337199536081;5725.34158571753;5730.770769169187;5733.541316694738;5754;5690.317161940594;5690.402507736793;5693.060644993529;5706.80026199081;5707.372189059283;5901.527877769854;5914.408559144051;5930.762769489172;5934.851628709317;5946.197263369563;4046.473958385391;4188;4204.705670603028;4261.573842615714;4279.443672322578;5608.355039170548;5649.85875353103;5660.811229641821;5691.26013618227;5705.743241554057;5521.309836270466;5541.3904470507405;5548.807006493624;5570.61005729595;5585.301837270341;5456.699881506396;5558.499735023867;5563.7774489019985;5567.8608034797835;5570.108782594765;5420.4850539198715;5424.864378390572;5433.320834895638;5463.180522921593;5480.917786233289;5274.314339135888;5524.309461317335;5560.804427048204;5566.805161819317;5585.664860108406;5414.106672399168;5445.482679145475;5448.700321482356;5502.972485137549;5531.585131115102 13:51:02 INFO - PROCESS | 3400 | |5;yui.html;814.9307308878745;862.6247582301697;863.6027427383403;871.5206636350006;873.2184694698245;14905.776413353808;15066.171360575165;15201.163935983517;15221.543353699379;15243.92378038111;14126.081804682688;14242.501512447066;14267.71464570708;14295.285235738223;14332.785008224884;695.7217113154753;809.8218391953761;811.8416908702806;838.3419016072385;841.0496139362511;832.8167803083312;837.8952630921135;839.8698201778703;841.0706169682474;841.2260720137458;890.3811850763722;892.085612247445;892.2460520859895;892.5849479991803;892.9241014513774;716.4197000429668;860.918212769789;885.8405487012335;887.5784002598779;888.6578667213105;644.3170239546049;645.2611759535353;645.3481983196958;645.7320212111968;645.7836624730721;14530.273486325641;14553.854461455356;14572.927135364362;14583.489577864724;14604.415823367053;13954.372053257628;14113.153210807384;14250.14499130045;14251.358688859027;14272.714545709028;12152.939235303767;12245.877541224563;12311.630651080482;12334.75330493394;12570.497180112785;4300.978495107535;4323.805428755713;4341.587549182823;4408.911821763547;4415.359772832953;56368;56520.717396413165;56673.71663141658;56825.71587142079;56970.860582788526;11065.889341106647;11153.553857845758;11170.664880053611;11391;11767.823482647767;20472.488187795425;20904.895475522524;20945.057472413777;21001;21001.89499052495;8222.506649601042;8247.95876020628;8333.749987500385;8413.411061225777;8424.241818236389;4715.088681006593;4862.756862156878;4930.605551555867;5011.498850114959;5014.247862820534;3359.3953088443827;3451.7928924264124;3454.740894432877;3460.186856088817;3461.0655123116617;615.5321955313993;654.0908137688616;680.9114815074008;685.5235611250233;691.3086913086913;776.5612428977722;796.0924546017544;802.4823988527368;803.1165717710588;826.4751882554501;9369.344145909858;9555.761105972406;9719.56261968213;9777.951110244545;9813.067758562926;726.894600282956;740.1303468424687;788.7228565311142;791.4081383469185;821.37575442664;4512.842050528281;4555.498895121534;4581.79381927814;4582.450105987303;4603.58567728906;64749.352506475276;65037.67481162564;66886.33113668801;67413;67592;50578;51770;60665.696671517246;60902.39097609056;61700.38299617036;48631;50991.745041275295;54889;55575;58557;9534.95232523833;9545.665901693408;9710.75723106928;9751.463669498246;9800.607975681178;34997.65002349944;36918.96945668014;37307.44038839474;37680.623193768806;38285.4257186148;48743.75628121837;49074.50925490842;49490;49552.256716150005;50409.74795126001;12277.508899643914;12683.365831708563;12715.491380344683;12828.10203285761;13070.934645326712;14116.223607701675;14200.147991120566;14241.430342786172;14394.064385814889;15225.695486090437;13233.933830330787;13315;13811.240381778696;13923.512677056255;13943.790843137564;12910.419031143434;13416.530421435593;13557.457701691821;14287.857121428653;14296;12878.549250776177;13336.666583335495;13378;13900.652483687583;13907;11198.16013798952;11256.662300131009;11296.6046188383;11298.265612735146;11934.28394296345;10977;11281.830772538255;11318.886811132114;11349.092072634334;11425.657230283105 13:51:02 INFO - PROCESS | 3400 | __end_tp_report 13:51:02 INFO - PROCESS | 3400 | __start_cc_report 13:51:02 INFO - PROCESS | 3400 | _x_x_mozilla_cycle_collect,929 13:51:02 INFO - PROCESS | 3400 | __end_cc_report 13:51:02 INFO - PROCESS | 3400 | __startTimestamp1463172662120__endTimestamp 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | ------- Summary: start ------- 13:51:02 INFO - PROCESS | 3400 | Number of tests: 6 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#0] dojo.html Cycles:165 Average:5356.64 Median:5567.64 stddev:604.61 (10.9%) stddev-sans-first:581.78 13:51:02 INFO - PROCESS | 3400 | Values: 3176.8 3200.1 3222.9 3232.2 3259.4 5274.7 5352.8 5386.2 5488.3 5499.0 5316.6 5319.2 5362.5 5376.0 5400.8 4808.2 4899.1 4904.6 4914.9 5059.1 4959.6 5023.8 5026.8 5038.9 5084.1 4810.0 4819.3 4850.0 4859.0 4957.9 4857.0 4860.0 4866.9 4921.0 4968.8 4915.2 4916.1 4917.8 4921.0 4928.7 5095.8 5216.2 5293.0 5300.6 5369.9 5720.3 5772.7 5809.3 5813.8 5820.7 5727.5 5819.0 5830.3 5876.3 5881.4 5451.7 5487.3 5567.6 5580.5 5585.1 6037.4 6040.1 6071.7 6084.3 6090.1 5552.7 5553.2 5861.7 5869.8 5871.2 5740.9 5792.1 5802.7 5804.3 5857.7 5718.7 5754.1 5755.5 5762.4 5779.1 5567.0 5651.8 5673.7 5773.2 5785.4 4326.3 4341.9 4355.5 4372.3 4382.5 3873.6 3902.2 3912.7 3938.7 3945.0 5185.9 5358.7 5389.9 5428.5 5430.6 5752.4 5775.9 5776.6 5797.9 5836.3 5420.4 5431.5 5435.4 5446.9 5457.7 4791.4 4873.6 4889.0 4905.2 4963.4 5893.6 5895.2 5899.4 5904.6 5905.5 5732.6 5740.8 5748.7 5750.1 5764.4 5815.2 5869.2 5878.8 5879.4 5906.8 5555.5 5611.0 5613.0 5626.8 5634.1 5662.5 5720.1 5726.1 5731.5 5738.9 5629.8 5678.3 5693.4 5715.7 5721.0 5697.8 5702.5 5703.1 5705.3 5719.6 5428.0 5436.9 5568.0 5613.3 5628.8 5592.5 5690.3 5704.3 5708.1 5709.8 5490.4 5528.0 5530.9 5539.9 5583.4 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#1] ext.html Cycles:180 Average:60476.82 Median:41415.69 stddev:117302.91 (283.2%) stddev-sans-first:117545.92 13:51:02 INFO - PROCESS | 3400 | Values: 634.0 638.9 644.9 647.4 660.5 42033.6 44098.1 44172.8 48038.8 48144.3 46369.5 46648.5 46715.3 46770.5 46896.5 9011.4 9126.8 9129.0 9142.0 9151.8 8933.1 9011.7 9013.1 9015.0 9016.7 9066.6 9093.4 9099.4 9106.6 9108.9 9002.3 9035.8 9039.7 9040.7 9044.6 8694.1 8771.3 8775.3 8776.9 8777.0 41212.2 41435.6 41445.4 41562.8 41585.2 3518.5 3521.6 3591.8 3632.2 3633.8 31521.0 31966.7 32499.6 32723.5 33067.3 4420.4 4436.5 4467.4 4475.7 4490.3 371723.0 371997.0 372424.0 373824.0 374775.0 53780.5 62161.7 62537.0 62567.0 62575.7 69238.0 70692.0 70975.0 71009.0 71011.3 14845.8 14971.3 14971.5 14998.3 15036.5 10351.6 10989.9 11022.4 11073.4 11148.3 18989.5 19567.7 19636.5 19648.3 19710.4 7091.2 7130.6 7189.9 7267.6 7452.0 1028.2 1104.9 1134.3 1237.1 1241.0 32513.3 32607.8 32801.5 33063.0 33099.3 1121.1 1142.4 1165.7 1219.2 1226.7 17218.0 17390.4 17720.8 17966.2 18008.5 513674.0 514322.0 516918.0 518002.0 520204.0 59459.8 59834.4 59951.7 59982.1 60010.0 1297.4 1369.3 1421.0 1430.7 1469.2 32306.7 32770.0 33511.3 33627.8 33718.0 49691.5 50239.2 50395.7 50396.2 50455.5 424038.0 428285.0 428353.0 428403.0 428943.0 24623.9 26764.6 27610.7 27630.7 29006.5 45803.3 47258.0 47266.0 48423.5 48595.8 39141.0 40178.4 40698.2 40732.6 41146.0 39209.8 40077.4 40396.0 40739.6 41395.8 39451.6 40619.0 40807.8 40842.0 40971.4 34255.8 35494.3 35913.3 36108.3 36118.1 27375.3 27549.2 27675.4 27811.9 27959.6 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#2] jquery.html Cycles:180 Average:28618.88 Median:2475.15 stddev:78694.23 (3179.4%) stddev-sans-first:78886.47 13:51:02 INFO - PROCESS | 3400 | Values: 401.1 402.2 404.1 409.7 413.8 18537.1 18802.3 19899.2 19972.9 20136.2 18438.7 18536.1 18904.2 19004.7 19018.1 5643.2 5666.5 5751.7 5842.0 5857.4 5672.7 5752.5 5776.2 5777.4 5785.2 5542.5 5667.4 5701.0 5742.1 5742.8 5610.0 5632.9 5687.1 5694.5 5703.3 5010.1 5127.0 5147.1 5156.0 5160.7 21978.1 22001.0 22299.0 22349.2 22515.7 2171.7 2446.6 2452.7 2497.6 2795.5 9798.0 10039.6 10125.9 10395.6 10859.3 1922.8 1995.4 2004.4 2039.5 2066.2 62032.0 82261.0 83249.6 84054.6 88429.0 11034.7 11103.3 11242.7 11528.9 11926.3 15756.1 15808.1 15846.5 15864.9 15915.0 7177.4 7337.4 7345.0 7480.6 7494.3 6783.5 6796.3 6868.3 6903.9 6907.4 4825.6 4838.9 4845.0 4888.4 4939.0 1982.6 2036.6 2040.6 2049.5 2058.5 976.2 1009.4 1026.8 1075.5 1114.4 17395.5 19098.5 19265.4 20129.2 20319.8 986.8 1000.5 1055.1 1062.5 1099.7 10429.0 10671.2 10835.8 10871.1 10895.2 464205.0 469108.0 478044.0 482079.0 484827.0 95337.0 98588.0 98974.0 99001.5 99949.0 1061.2 1067.5 1078.5 1083.5 1091.4 16797.6 16949.4 17088.5 17163.7 17297.9 34151.0 37030.4 42083.8 42460.4 42690.4 56935.0 58820.7 59767.0 59890.7 60449.7 7466.7 7761.9 7764.8 8830.9 9176.1 9532.8 9642.8 10948.0 13969.9 14227.4 9689.1 11227.6 12094.1 12210.0 12304.0 9602.4 11898.6 12080.0 12101.3 12152.8 11743.6 12180.5 12343.8 12490.9 12590.7 7784.1 7975.6 8100.3 8167.8 8187.7 10895.9 12182.9 12337.4 12384.6 12427.4 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#3] mootools.html Cycles:180 Average:6007.82 Median:2532.06 stddev:3514.45 (138.8%) stddev-sans-first:3506.80 13:51:02 INFO - PROCESS | 3400 | Values: 1340.5 1496.7 1543.2 1663.9 1886.5 8673.4 9080.1 9111.9 9396.2 9400.1 9108.0 9306.6 9320.1 9321.9 9324.3 1978.6 2279.5 2324.1 2353.8 2361.6 2214.6 2219.7 2222.9 2223.0 2223.4 2341.0 2391.0 2393.1 2395.1 2395.3 2045.4 2260.8 2328.4 2332.4 2353.0 2208.0 2230.2 2231.2 2241.5 2242.8 9292.2 9346.8 9347.4 9354.4 9360.3 5225.0 5366.7 5369.6 5371.2 5375.4 3525.2 3624.5 3637.0 3641.6 3643.7 1184.5 1208.3 1235.9 1239.1 1247.4 12813.5 12850.2 12851.2 12862.9 12884.9 4605.4 4754.9 4799.5 4816.4 4823.0 10810.0 10854.6 10862.3 10876.7 10890.2 4787.3 5381.0 5392.8 5400.2 5402.6 4442.0 4745.9 4896.6 4907.0 4941.0 3966.6 4005.6 4097.7 4101.9 4105.1 1196.9 1198.3 1207.1 1209.9 1213.9 994.0 1010.2 1034.6 1036.8 1037.3 5795.0 5943.5 5999.5 6020.7 6088.8 458.7 476.2 484.4 485.7 492.0 4375.9 4411.0 4434.3 4436.0 4450.1 11136.6 11223.8 11242.8 11419.0 11450.9 10807.2 11085.8 11160.5 11169.0 11289.5 8626.2 8627.8 8643.8 8697.2 8777.1 6154.5 6354.9 6386.3 6407.9 6420.9 10415.8 10733.0 10753.0 10766.0 10880.7 10883.3 10979.9 11008.3 11011.2 11016.7 7287.3 7768.8 8038.3 8186.8 8334.8 8909.2 8959.2 9009.0 9017.5 9041.5 7979.6 8210.5 8264.5 8302.8 8342.3 7969.6 8073.1 8088.3 8096.1 8247.8 6855.6 7112.9 7127.0 7434.2 7472.6 5057.2 5113.4 5184.2 5196.3 5255.7 4953.9 4999.4 5005.2 5060.0 5143.4 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#4] prototype.html Cycles:180 Average:4653.48 Median:5255.37 stddev:1346.23 (25.6%) stddev-sans-first:1310.42 13:51:02 INFO - PROCESS | 3400 | Values: 335.8 342.6 351.2 354.2 354.9 5260.1 5275.9 5302.0 5323.3 5379.4 5250.6 5269.4 5278.3 5285.9 5315.7 3987.8 4182.0 4206.5 4208.6 4223.3 3719.4 4013.6 4119.7 4211.1 4237.3 4121.4 4140.4 4156.0 4176.3 4208.6 4005.5 4143.4 4164.7 4180.5 4191.9 3635.0 3699.9 3726.9 3736.7 3745.1 5122.5 5131.8 5152.6 5154.0 5175.8 4772.7 4773.5 4786.1 4791.8 4807.9 5544.3 5579.3 5585.6 5604.4 5609.4 3928.8 4036.8 4037.5 4097.4 4132.5 5543.8 5664.2 5696.8 5710.6 5730.4 3990.5 4075.5 4099.5 4104.4 4121.3 4088.5 4164.9 4190.4 4209.7 4211.6 4691.6 4732.5 4743.8 4744.8 4756.2 5464.7 5484.3 5505.5 5532.7 5554.3 1421.7 1430.3 1453.0 1459.9 1469.1 958.3 959.3 969.2 972.7 981.6 4848.5 4867.9 4895.5 4898.0 4955.3 5119.0 5122.2 5126.1 5126.8 5132.8 4870.7 4881.8 4885.0 4906.6 5020.6 3059.6 3061.5 3073.7 3084.9 3088.8 5856.4 5884.2 5930.1 5932.8 5937.2 5644.7 5781.0 5781.6 5801.3 5826.7 5837.6 5840.3 5850.6 5852.3 5871.9 5523.3 5725.3 5730.8 5733.5 5754.0 5690.3 5690.4 5693.1 5706.8 5707.4 5901.5 5914.4 5930.8 5934.9 5946.2 4046.5 4188.0 4204.7 4261.6 4279.4 5608.4 5649.9 5660.8 5691.3 5705.7 5521.3 5541.4 5548.8 5570.6 5585.3 5456.7 5558.5 5563.8 5567.9 5570.1 5420.5 5424.9 5433.3 5463.2 5480.9 5274.3 5524.3 5560.8 5566.8 5585.7 5414.1 5445.5 5448.7 5503.0 5531.6 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - PROCESS | 3400 | [#5] yui.html Cycles:180 Average:15712.19 Median:4788.92 stddev:18164.53 (379.3%) stddev-sans-first:18181.04 13:51:02 INFO - PROCESS | 3400 | Values: 814.9 862.6 863.6 871.5 873.2 14905.8 15066.2 15201.2 15221.5 15243.9 14126.1 14242.5 14267.7 14295.3 14332.8 695.7 809.8 811.8 838.3 841.0 832.8 837.9 839.9 841.1 841.2 890.4 892.1 892.2 892.6 892.9 716.4 860.9 885.8 887.6 888.7 644.3 645.3 645.3 645.7 645.8 14530.3 14553.9 14572.9 14583.5 14604.4 13954.4 14113.2 14250.1 14251.4 14272.7 12152.9 12245.9 12311.6 12334.8 12570.5 4301.0 4323.8 4341.6 4408.9 4415.4 56368.0 56520.7 56673.7 56825.7 56970.9 11065.9 11153.6 11170.7 11391.0 11767.8 20472.5 20904.9 20945.1 21001.0 21001.9 8222.5 8248.0 8333.7 8413.4 8424.2 4715.1 4862.8 4930.6 5011.5 5014.2 3359.4 3451.8 3454.7 3460.2 3461.1 615.5 654.1 680.9 685.5 691.3 776.6 796.1 802.5 803.1 826.5 9369.3 9555.8 9719.6 9778.0 9813.1 726.9 740.1 788.7 791.4 821.4 4512.8 4555.5 4581.8 4582.5 4603.6 64749.4 65037.7 66886.3 67413.0 67592.0 50578.0 51770.0 60665.7 60902.4 61700.4 48631.0 50991.7 54889.0 55575.0 58557.0 9535.0 9545.7 9710.8 9751.5 9800.6 34997.7 36919.0 37307.4 37680.6 38285.4 48743.8 49074.5 49490.0 49552.3 50409.7 12277.5 12683.4 12715.5 12828.1 13070.9 14116.2 14200.1 14241.4 14394.1 15225.7 13233.9 13315.0 13811.2 13923.5 13943.8 12910.4 13416.5 13557.5 14287.9 14296.0 12878.5 13336.7 13378.0 13900.7 13907.0 11198.2 11256.7 11296.6 11298.3 11934.3 10977.0 11281.8 11318.9 11349.1 11425.7 13:51:02 INFO - PROCESS | 3400 | -------- Summary: end -------- 13:51:02 INFO - PROCESS | 3400 | 13:51:02 INFO - TEST-INFO | 3400: exit 0 13:51:02 INFO - TEST-OK | dromaeo_css | took 1117603ms 13:51:02 INFO - TEST-START | kraken 13:51:02 INFO - operating with platform_type : linux_ 13:51:02 INFO - Initialising browser for kraken test... 13:51:02 INFO - TEST-INFO | started process 3579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4zpJj/profile http://localhost:56024/getInfo.html) 13:51:07 INFO - PROCESS | 3579 | __metrics Screen width/height:1600/1200 13:51:07 INFO - PROCESS | 3579 | colorDepth:24 13:51:07 INFO - PROCESS | 3579 | Browser inner width/height: 1024/697 13:51:07 INFO - PROCESS | 3579 | __metrics 13:51:08 ERROR - PROCESS | 3579 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:51:09 INFO - TEST-INFO | 3579: exit 0 13:51:09 INFO - Browser initialized. 13:51:09 INFO - Running cycle 1/1 for kraken test... 13:51:09 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4zpJj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:21 INFO - PROCESS | 3664 | RSS: Main: 152834048 13:51:21 INFO - PROCESS | 3664 | 13:51:23 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56024/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:24 INFO - PROCESS | 3664 | RSS: Main: 208343040 13:51:24 INFO - PROCESS | 3664 | 13:51:27 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56024/tests/kraken/driver.html?testName=audio-dft) 13:51:27 INFO - PROCESS | 3664 | RSS: Main: 197554176 13:51:27 INFO - PROCESS | 3664 | 13:51:31 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56024/tests/kraken/driver.html?testName=audio-fft) 13:51:31 INFO - PROCESS | 3664 | RSS: Main: 265015296 13:51:31 INFO - PROCESS | 3664 | 13:51:33 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56024/tests/kraken/driver.html?testName=audio-oscillator) 13:51:34 INFO - PROCESS | 3664 | RSS: Main: 174764032 13:51:34 INFO - PROCESS | 3664 | 13:51:36 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:51:37 INFO - PROCESS | 3664 | RSS: Main: 179040256 13:51:37 INFO - PROCESS | 3664 | 13:51:40 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56024/tests/kraken/driver.html?testName=imaging-darkroom) 13:51:41 INFO - PROCESS | 3664 | RSS: Main: 214110208 13:51:41 INFO - PROCESS | 3664 | 13:51:44 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56024/tests/kraken/driver.html?testName=imaging-desaturate) 13:51:45 INFO - PROCESS | 3664 | RSS: Main: 212402176 13:51:45 INFO - PROCESS | 3664 | 13:51:48 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56024/tests/kraken/driver.html?testName=json-parse-financial) 13:51:48 INFO - PROCESS | 3664 | RSS: Main: 213528576 13:51:48 INFO - PROCESS | 3664 | 13:51:50 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:51:50 INFO - PROCESS | 3664 | RSS: Main: 203550720 13:51:50 INFO - PROCESS | 3664 | 13:51:52 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:51:53 INFO - PROCESS | 3664 | RSS: Main: 208031744 13:51:53 INFO - PROCESS | 3664 | 13:51:55 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:51:56 INFO - PROCESS | 3664 | RSS: Main: 217829376 13:51:56 INFO - PROCESS | 3664 | 13:51:58 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:51:59 INFO - PROCESS | 3664 | RSS: Main: 222814208 13:51:59 INFO - PROCESS | 3664 | 13:52:02 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:02 INFO - PROCESS | 3664 | RSS: Main: 218943488 13:52:02 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:56024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56024/tests/kraken/driver.html?testName=ai-astar) 13:52:04 INFO - PROCESS | 3664 | RSS: Main: 265646080 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | __start_tp_report 13:52:04 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 13:52:04 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 13:52:04 INFO - PROCESS | 3664 | |i|pagename|runs| 13:52:04 INFO - PROCESS | 3664 | |0;ai-astar;109;105;110;108;110;109;109;110;109;109 13:52:04 INFO - PROCESS | 3664 | |1;audio-beat-detection;155;123;149;214;123;147;160;125;181;130 13:52:04 INFO - PROCESS | 3664 | |2;audio-dft;161;161;161;161;160;160;162;163;162;162 13:52:04 INFO - PROCESS | 3664 | |3;audio-fft;75;74;74;156;74;76;75;73;134;74 13:52:04 INFO - PROCESS | 3664 | |4;audio-oscillator;91;91;157;93;92;91;123;92;91;115 13:52:04 INFO - PROCESS | 3664 | |5;imaging-gaussian-blur;116;116;117;117;116;117;116;116;117;116 13:52:04 INFO - PROCESS | 3664 | |6;imaging-darkroom;146;146;144;146;145;147;145;146;145;146 13:52:04 INFO - PROCESS | 3664 | |7;imaging-desaturate;94;95;95;95;95;94;95;94;95;95 13:52:04 INFO - PROCESS | 3664 | |8;json-parse-financial;56;53;56;55;55;55;55;107;54;55 13:52:04 INFO - PROCESS | 3664 | |9;json-stringify-tinderbox;60;60;60;60;61;60;64;60;60;60 13:52:04 INFO - PROCESS | 3664 | |10;stanford-crypto-aes;77;78;84;77;79;79;76;78;78;84 13:52:04 INFO - PROCESS | 3664 | |11;stanford-crypto-ccm;125;119;119;121;120;125;120;129;190;127 13:52:04 INFO - PROCESS | 3664 | |12;stanford-crypto-pbkdf2;160;158;159;158;159;164;163;165;158;157 13:52:04 INFO - PROCESS | 3664 | |13;stanford-crypto-sha256-iterative;63;71;62;62;62;61;62;64;61;63 13:52:04 INFO - PROCESS | 3664 | __end_tp_report 13:52:04 INFO - PROCESS | 3664 | __start_cc_report 13:52:04 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,1838 13:52:04 INFO - PROCESS | 3664 | __end_cc_report 13:52:04 INFO - PROCESS | 3664 | __startTimestamp1463172724712__endTimestamp 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | ------- Summary: start ------- 13:52:04 INFO - PROCESS | 3664 | Number of tests: 14 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.48 (1.4%) stddev-sans-first:1.56 13:52:04 INFO - PROCESS | 3664 | Values: 109.0 105.0 110.0 108.0 110.0 109.0 109.0 110.0 109.0 109.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:152.00 stddev:29.19 (19.2%) stddev-sans-first:30.92 13:52:04 INFO - PROCESS | 3664 | Values: 155.0 123.0 149.0 214.0 123.0 147.0 160.0 125.0 181.0 130.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:52:04 INFO - PROCESS | 3664 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 162.0 163.0 162.0 162.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.00 stddev:30.24 (40.9%) stddev-sans-first:31.67 13:52:04 INFO - PROCESS | 3664 | Values: 75.0 74.0 74.0 156.0 74.0 76.0 75.0 73.0 134.0 74.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:91.00 stddev:22.05 (24.2%) stddev-sans-first:22.91 13:52:04 INFO - PROCESS | 3664 | Values: 91.0 91.0 157.0 93.0 92.0 91.0 123.0 92.0 91.0 115.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:52:04 INFO - PROCESS | 3664 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 13:52:04 INFO - PROCESS | 3664 | Values: 146.0 146.0 144.0 146.0 145.0 147.0 145.0 146.0 145.0 146.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:52:04 INFO - PROCESS | 3664 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:55.00 stddev:16.50 (30.0%) stddev-sans-first:17.44 13:52:04 INFO - PROCESS | 3664 | Values: 56.0 53.0 56.0 55.0 55.0 55.0 55.0 107.0 54.0 55.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.27 (2.1%) stddev-sans-first:1.33 13:52:04 INFO - PROCESS | 3664 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 64.0 60.0 60.0 60.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.50 stddev:2.79 (3.6%) stddev-sans-first:2.86 13:52:04 INFO - PROCESS | 3664 | Values: 77.0 78.0 84.0 77.0 79.0 79.0 76.0 78.0 78.0 84.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:125.00 stddev:21.55 (17.2%) stddev-sans-first:22.80 13:52:04 INFO - PROCESS | 3664 | Values: 125.0 119.0 119.0 121.0 120.0 125.0 120.0 129.0 190.0 127.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:159.50 stddev:2.85 (1.8%) stddev-sans-first:3.02 13:52:04 INFO - PROCESS | 3664 | Values: 160.0 158.0 159.0 158.0 159.0 164.0 163.0 165.0 158.0 157.0 13:52:04 INFO - PROCESS | 3664 | 13:52:04 INFO - PROCESS | 3664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.50 stddev:2.92 (4.7%) stddev-sans-first:3.10 13:52:04 INFO - PROCESS | 3664 | Values: 63.0 71.0 62.0 62.0 62.0 61.0 62.0 64.0 61.0 63.0 13:52:04 INFO - PROCESS | 3664 | -------- Summary: end -------- 13:52:04 INFO - PROCESS | 3664 | 13:52:05 INFO - TEST-INFO | 3664: exit 0 13:52:05 INFO - TEST-OK | kraken | took 62741ms 13:52:05 INFO - SUITE-END | took 1180s 13:52:05 INFO - Completed test suite (00:19:40) 13:52:05 INFO - javascript benchmark 13:52:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.7776255662097, 3200.055983484872, 3222.854971526281, 3232.2404235004783, 3259.445894197986, 5274.709890955995, 5352.759125839337, 5386.165144402619, 5488.259085023521, 5499.0, 5316.627836051478, 5319.20211968205, 5362.490563396481, 5376.032314183445, 5400.756965936533, 4808.182608956477, 4899.093667671475, 4904.632152588552, 4914.901701965959, 5059.089363914494, 4959.603231741452, 5023.773930173133, 5026.798928042892, 5038.899222015558, 5084.0594490019275, 4809.975950120244, 4819.2530157825595, 4849.951500485021, 4859.028194361142, 4957.925631115536, 4856.975715121402, 4860.0, 4866.926996095026, 4920.950790492121, 4968.776405061781, 4915.16442204826, 4916.139675556763, 4917.77055736066, 4921.040397122562, 4928.654994150411, 5095.847124586268, 5216.165413533854, 5293.0, 5300.575953923677, 5369.9463005369835, 5720.256366672347, 5772.682502462363, 5809.331926828427, 5813.79651712188, 5820.650760954356, 5727.541796656299, 5819.039858423355, 5830.30036395631, 5876.265466816648, 5881.411858814127, 5451.700156491392, 5487.314085739283, 5567.638103523299, 5580.497755202051, 5585.078462053756, 6037.376597232153, 6040.128187264793, 6071.726772295257, 6084.269887613515, 6090.147379366804, 5552.666839989613, 5553.1670249462095, 5861.70691465425, 5869.765209391577, 5871.2073870027, 5740.913886291709, 5792.131180322901, 5802.6808525531505, 5804.303483581997, 5857.70711464425, 5718.714064296769, 5754.108113242454, 5755.482006619424, 5762.394948530427, 5779.075347944308, 5566.997940370691, 5651.773929042793, 5673.716314184357, 5773.24947756789, 5785.392533783892, 4326.264535029052, 4341.9131617367475, 4355.499117601516, 4372.300431930876, 4382.496012958551, 3873.573906870242, 3902.2195560887935, 3912.726109172331, 3938.6849052075763, 3944.980275098606, 5185.922211166836, 5358.732063396815, 5389.865253368697, 5428.484293992144, 5430.5927055471, 5752.395998420189, 5775.94224057754, 5776.566757493205, 5797.884042319214, 5836.299644042742, 5420.430854760272, 5431.4840090191365, 5435.374931882805, 5446.91829622556, 5457.699826509501, 4791.448983366888, 4873.634477414137, 4888.95111048885, 4905.2151655734915, 4963.379577552806, 5893.5579831512805, 5895.233619629506, 5899.351071382144, 5904.586678932434, 5905.498032667186, 5732.627379220504, 5740.827775166752, 5748.741306641127, 5750.0512415450985, 5764.423557644202, 5815.185873977562, 5869.207656966426, 5878.794242201502, 5879.353271140257, 5906.822795316148, 5555.527780138572, 5610.971945140248, 5613.045782217115, 5626.803061892814, 5634.126710359901, 5662.518685911744, 5720.056190728483, 5726.141078838041, 5731.541476681939, 5738.885222295614, 5629.802956896489, 5678.3186017678145, 5693.4021927696995, 5715.657060576379, 5720.971395142998, 5697.800576979786, 5702.486776190163, 5703.144528320785, 5705.343885453226, 5719.5710321726865, 5428.022955867824, 5436.891262174813, 5567.972160139336, 5613.326400831927, 5628.774849005994, 5592.496675299242, 5690.3456102548735, 5704.286964129484, 5708.058170401837, 5709.8287051388525, 5490.423505531861, 5528.032594296063, 5530.944690553204, 5539.861503462445, 5583.441655834384], "value": 5316.716909125662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9651319177444, 638.875419293238, 644.9387308205721, 647.4076220258462, 660.455124522269, 42033.579664203346, 44098.118037639266, 44172.77913610431, 48038.75980620101, 48144.277835832494, 46369.536304636946, 46648.53351466484, 46715.299270510885, 46770.53229467713, 46896.531034689644, 9011.369204155711, 9126.771830704252, 9129.0, 9142.040085790963, 9151.816963660724, 8933.062028487013, 9011.684591039315, 9013.053629368887, 9014.954925225366, 9016.729498115066, 9066.637334506644, 9093.363464557484, 9099.363044586882, 9106.63573457061, 9108.908910910872, 9002.32482563807, 9035.774105647346, 9039.728808135766, 9040.68357607487, 9044.638214471413, 8694.130586941319, 8771.342149338761, 8775.341849361259, 8776.868346974801, 8777.0, 41212.1757564847, 41435.58564414347, 41445.37831932493, 41562.79218603918, 41585.1682966342, 3518.542589463379, 3521.559805024372, 3591.7665351752053, 3632.219072899313, 3633.7819730816236, 31521.0, 31966.680333196837, 32499.577152294933, 32723.50914736257, 33067.3386532268, 4420.40324556184, 4436.489803672586, 4467.441569803775, 4475.731456112644, 4490.326451032339, 371723.0, 371997.0, 372423.99999999726, 373824.0, 374775.0, 53780.46219537833, 62161.68919155466, 62537.0, 62567.0, 62575.6871215641, 69238.0, 70692.0, 70975.0, 71009.0, 71011.2898871015, 14845.777313340308, 14971.251437428085, 14971.475998340005, 14998.325075371635, 15036.473723419627, 10351.63769268072, 10989.890101099047, 11022.393768342657, 11073.390963496924, 11148.331100134017, 18989.525261868563, 19567.706484402745, 19636.509087272934, 19648.312309069115, 19710.40868773939, 7091.219965803757, 7130.572165670076, 7189.856202875913, 7267.63661816907, 7451.950713553708, 1028.1774580335702, 1104.861892263467, 1134.2570616246371, 1237.0783766094137, 1240.9689757755948, 32513.34973300521, 32607.836960815042, 32801.50797738036, 33063.0, 33099.338013240085, 1121.0919155484085, 1142.4002398740727, 1165.7260543772206, 1219.1831472912993, 1226.7485165541043, 17217.96692198472, 17390.391336303168, 17720.822791771916, 17966.19152138157, 18008.459746207634, 513674.0, 514322.0, 516918.0, 518002.0, 520204.0, 59459.810803784545, 59834.401655983755, 59951.70024149851, 59982.100268496004, 60010.0, 1297.3642914971786, 1369.3084992078936, 1421.0336970859707, 1430.7210094031773, 1469.1625773309324, 32306.676933230367, 32770.0, 33511.32977340488, 33627.83186084054, 33718.0, 49691.50308496869, 50239.24641130313, 50395.74802125966, 50396.244056339914, 50455.495445046545, 424038.0, 428285.0, 428353.0, 428403.0, 428943.0, 24623.876880615484, 26764.59853102244, 27610.72389276162, 27630.723692762815, 29006.51921769401, 45803.31295030644, 47258.0, 47266.0, 48423.51576484331, 48595.75702121467, 39141.03618828672, 40178.39732404075, 40698.186036278516, 40732.59267407288, 41146.0, 39209.803950980066, 40077.39883901685, 40395.99010024773, 40739.592604074765, 41395.793021034704, 39451.60548394479, 40619.0, 40807.795961020005, 40842.0, 40971.38542921799, 34255.82872085724, 35494.29011419706, 35913.281734364646, 36108.27783444369, 36118.09704757297, 27375.315617109733, 27549.17352479429, 27675.44649107047, 27811.860940695165, 27959.580606290514], "value": 20351.11783726567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.08952677422235, 402.24779662032006, 404.141199950106, 409.696824349981, 413.78483188741853, 18537.07314634268, 18802.34191803287, 19899.204031838708, 19972.900135499338, 20136.194552217912, 18438.72341914869, 18536.073196340196, 18904.243830246807, 19004.714929276073, 19018.14418351174, 5643.153526970967, 5666.54667626591, 5751.741171647286, 5841.970790146043, 5857.414258574151, 5672.716364181795, 5752.5110365618975, 5776.220210271623, 5777.42225777421, 5785.16115163301, 5542.528885044776, 5667.433256674321, 5700.971495142539, 5742.081266997281, 5742.827715168552, 5610.046292130327, 5632.887342253132, 5687.118496633028, 5694.5159661428825, 5703.344115426717, 5010.073136469765, 5127.0, 5147.073526765181, 5156.0, 5160.690358578459, 21978.120875164976, 22001.0, 22299.0, 22349.217777377875, 22515.662265066036, 2171.7393912730417, 2446.5718499262734, 2452.730199678034, 2497.5629264878753, 2795.5387361085395, 9797.951010244975, 10039.648612298608, 10125.949370253174, 10395.584176632925, 10859.294145880493, 1922.826945574905, 1995.3714579907282, 2004.4287378097317, 2039.4901274681329, 2066.1941842681217, 62032.0, 82261.0, 83249.58375208145, 84054.57972710159, 88429.0, 11034.668959931216, 11103.278286911325, 11242.718932026764, 11528.884711152949, 11926.284422934477, 15756.133412662413, 15808.130552819704, 15846.524604261891, 15864.92067539655, 15915.0, 7177.389921856597, 7337.41300695943, 7344.96327518359, 7480.625968701652, 7494.325510703954, 6783.491238157158, 6796.25241223465, 6868.278830722802, 6903.930960690429, 6907.378335949788, 4825.565699087099, 4838.927416088762, 4844.975775121102, 4888.364512613338, 4938.950610493849, 1982.5638359560874, 2036.551958569142, 2040.5816807554415, 2049.467138543989, 2058.5265388960624, 976.2141476111656, 1009.4145395670494, 1026.8089016740546, 1075.510642657589, 1114.3870871020906, 17395.47813565595, 19098.52253693669, 19265.422037338903, 20129.194832206842, 20319.796802032088, 986.837171866634, 1000.494750151169, 1055.145332280855, 1062.4900047977014, 1099.7470581766238, 10429.009244121797, 10671.19966002553, 10835.783284334428, 10871.130309575374, 10895.182861285435, 464205.0, 469108.0, 478044.0, 482079.0, 484827.0, 95337.0, 98588.0, 98974.0, 99001.50499247458, 99949.0, 1061.2093989977516, 1067.5036108209565, 1078.487718333785, 1083.5286650307141, 1091.4215465803138, 16797.580060498585, 16949.406770762966, 17088.487345379657, 17163.656726865644, 17297.91351043287, 34151.0, 37030.44454333241, 42083.789581053126, 42460.36309455299, 42690.35964460474, 56935.0, 58820.705896470245, 59767.0, 59890.70054649699, 60449.69775151096, 7466.701331946661, 7761.883571746315, 7764.84470310602, 8830.867536986822, 9176.082391761038, 9532.809343812945, 9642.758931026781, 10948.0, 13969.860301396857, 14227.430902764188, 9689.12797848197, 11227.607033753779, 12094.092943029133, 12210.0, 12304.0, 9602.423854568748, 11898.583549575724, 12080.0, 12101.273923564615, 12152.75694486123, 11743.647690569296, 12180.512779488721, 12343.814842777187, 12490.937545312216, 12590.685232869251, 7784.143744188248, 7975.641096150571, 8100.270975612223, 8167.754967350989, 8187.672493100447, 10895.891041089804, 12182.878171218174, 12337.383130843242, 12384.56654017105, 12427.378631068592], "value": 9175.84867789603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4772138865837, 1496.7455532559463, 1543.155928665245, 1663.9251233694483, 1886.5000774794682, 8673.436226645264, 9080.091990800925, 9111.908880911189, 9396.24830013599, 9400.059994000596, 9107.954460227706, 9306.627734890613, 9320.067993200677, 9321.906780932188, 9324.300677449184, 1978.5943881504256, 2279.5213005268915, 2324.081987614891, 2353.8116950643907, 2361.551305252005, 2214.579229946305, 2219.655953327229, 2222.944426389345, 2223.0, 2223.4107961390246, 2340.9882950585225, 2391.0435825669697, 2393.090625562284, 2395.101836811196, 2395.3053614451787, 2045.4477291131386, 2260.819134469247, 2328.406256404623, 2332.393577669818, 2353.0470159585393, 2207.9779202207933, 2230.230570453191, 2231.230225572175, 2241.529278851443, 2242.8093612042994, 9292.210162136227, 9346.766330841716, 9347.392419492711, 9354.438733676001, 9360.297977651704, 5224.973875130638, 5366.731663416853, 5369.62412631116, 5371.194320851864, 5375.381831089436, 3525.2068284636007, 3624.474451204587, 3636.9818150909077, 3641.599424063351, 3643.6902863256655, 1184.466989854569, 1208.2810727617054, 1235.876412358766, 1239.0768877186463, 1247.4324182497032, 12813.487460501568, 12850.228986260854, 12851.16467429614, 12862.871371286261, 12884.935575322157, 4605.447346318396, 4754.904901901942, 4799.544043315879, 4816.4220293564995, 4823.03539292143, 10810.0, 10854.62008829703, 10862.293950893167, 10876.728081798019, 10890.23768336209, 4787.305840653085, 5380.973095134577, 5392.838214853561, 5400.189971504227, 5402.648827826258, 4441.955580444154, 4745.905081898342, 4896.5837903777865, 4907.018596280758, 4941.0, 3966.643002129822, 4005.639492445694, 4097.651699605507, 4101.85643502476, 4105.117399759066, 1196.8982636475823, 1198.316959333189, 1207.1127721124967, 1209.9334536600395, 1213.9150259481928, 994.0208894239169, 1010.1514727628827, 1034.5809946971488, 1036.7770929250248, 1037.2531777120462, 5795.0, 5943.465088142088, 5999.520038396918, 6020.698965051817, 6088.786892458743, 458.6674660870842, 476.1833455623622, 484.38483126429236, 485.73527427551363, 492.04788733799495, 4375.912481750347, 4410.955890441054, 4434.3348497724955, 4436.0462500562535, 4450.065486247924, 11136.61021864247, 11223.775524489627, 11242.775144497064, 11419.0, 11450.94274528622, 10807.243492955418, 11085.778284434266, 11160.497777600027, 11169.0, 11289.49197286124, 8626.180512851395, 8627.78430539229, 8643.78390540229, 8697.21725044749, 8777.078406767198, 6154.538409619386, 6354.872902541831, 6386.265579458236, 6407.8718425630295, 6420.935790642221, 10415.843762343722, 10733.0, 10753.032227099598, 10766.0, 10880.727981800519, 10883.346999180074, 10979.890201098206, 11008.339499630049, 11011.174161937726, 11016.724581885517, 7287.27127287267, 7768.844623107393, 8038.316743076904, 8186.75439736785, 8334.79163020905, 8909.198172164537, 8959.1936725695, 9008.954955225445, 9017.458952462874, 9041.457512549268, 7979.5611241382285, 8210.507369557845, 8264.545450000067, 8302.792430189053, 8342.29090527312, 7969.561674107979, 8073.111957684532, 8088.312493438124, 8096.149904259968, 8247.835043298981, 6855.588664679935, 7112.893306600302, 7126.964365178141, 7434.182239953492, 7472.551646901204, 5057.241413787961, 5113.437521872516, 5184.170532714747, 5196.298499702491, 5255.710935898409, 4953.851384458472, 4999.350084488993, 5005.249212618136, 5059.974700126623, 5143.4085080216255], "value": 4682.3347595111145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.832083958021, 342.5615212527964, 351.2395663388763, 354.1942081763985, 354.90240183949425, 5260.132078207096, 5275.947240527603, 5301.973490132554, 5323.334583177103, 5379.354477462705, 5250.606204534656, 5269.367675878891, 5278.261043453919, 5285.942811437718, 5315.707636080014, 3987.7607343559334, 4182.0, 4206.516250631186, 4208.642265407437, 4223.324268117102, 3719.3863012602887, 4013.598640135978, 4119.732217405859, 4211.136716973013, 4237.279662457374, 4121.361189015707, 4140.441040459545, 4156.0, 4176.310908700076, 4208.558101399355, 4005.4792876925812, 4143.363371468268, 4164.667306461934, 4180.519240287345, 4191.8532851350055, 3634.963650363489, 3699.9445008324897, 3726.8695595654294, 3736.6823819975334, 3745.1011757178353, 5122.487751224885, 5131.845334799677, 5152.562032227265, 5153.9742301288625, 5175.7670904809, 4772.6897751646375, 4773.474917759044, 4786.114568804747, 4791.760411979387, 4807.879803004917, 5544.253560128546, 5579.2746942897165, 5585.636933599344, 5604.3835178130375, 5609.35492418373, 3928.7839168845703, 4036.7779772112817, 4037.5356833963883, 4097.385392191165, 4132.504099508078, 5543.805966791143, 5664.150377443375, 5696.772129114872, 5710.628809127394, 5730.398308177623, 3990.481237439172, 4075.5109386873764, 4099.528554216244, 4104.363823607346, 4121.26906699187, 4088.4684990950987, 4164.8542301019315, 4190.350495673176, 4209.684273679486, 4211.599898009684, 4691.601213896789, 4732.479427262998, 4743.786529606176, 4744.7627618618935, 4756.239001759702, 5464.672119672832, 5484.2596249506605, 5505.476979686923, 5532.723363831792, 5554.250176226238, 1421.651695334629, 1430.3348942741468, 1453.0046917861298, 1459.8904832327296, 1469.1038466535406, 958.2717134977328, 959.2949182351106, 969.1519920069939, 972.7227740094039, 981.5828272983953, 4848.466668666444, 4867.933202082665, 4895.461499235082, 4897.975510122426, 4955.306257124005, 5119.029173768052, 5122.206058060932, 5126.0521002018995, 5126.846194614168, 5132.8460146195675, 4870.707757534559, 4881.804727810848, 4884.998575292057, 4906.582940450102, 5020.623453241022, 3059.571659967606, 3061.5151651449028, 3073.7387322077425, 3084.922876928095, 3088.7992280501694, 5856.3690511882905, 5884.205632239678, 5930.110483427434, 5932.822015339547, 5937.168796368512, 5644.6613203207935, 5780.971095144498, 5781.566382521328, 5801.3038435388025, 5826.737796799154, 5837.6497410155525, 5840.29916410025, 5850.59585699429, 5852.268466441695, 5871.882562348729, 5523.337199536081, 5725.34158571753, 5730.770769169187, 5733.541316694738, 5754.0, 5690.317161940594, 5690.402507736793, 5693.060644993529, 5706.80026199081, 5707.372189059283, 5901.527877769854, 5914.408559144051, 5930.762769489172, 5934.851628709317, 5946.197263369563, 4046.473958385391, 4188.0, 4204.705670603028, 4261.573842615714, 4279.443672322578, 5608.355039170548, 5649.85875353103, 5660.811229641821, 5691.26013618227, 5705.743241554057, 5521.309836270466, 5541.3904470507405, 5548.807006493624, 5570.61005729595, 5585.301837270341, 5456.699881506396, 5558.499735023867, 5563.7774489019985, 5567.8608034797835, 5570.108782594765, 5420.4850539198715, 5424.864378390572, 5433.320834895638, 5463.180522921593, 5480.917786233289, 5274.314339135888, 5524.309461317335, 5560.804427048204, 5566.805161819317, 5585.664860108406, 5414.106672399168, 5445.482679145475, 5448.700321482356, 5502.972485137549, 5531.585131115102], "value": 4232.099942429119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9307308878745, 862.6247582301697, 863.6027427383403, 871.5206636350006, 873.2184694698245, 14905.776413353808, 15066.171360575165, 15201.163935983517, 15221.543353699379, 15243.92378038111, 14126.081804682688, 14242.501512447066, 14267.71464570708, 14295.285235738223, 14332.785008224884, 695.7217113154753, 809.8218391953761, 811.8416908702806, 838.3419016072385, 841.0496139362511, 832.8167803083312, 837.8952630921135, 839.8698201778703, 841.0706169682474, 841.2260720137458, 890.3811850763722, 892.085612247445, 892.2460520859895, 892.5849479991803, 892.9241014513774, 716.4197000429668, 860.918212769789, 885.8405487012335, 887.5784002598779, 888.6578667213105, 644.3170239546049, 645.2611759535353, 645.3481983196958, 645.7320212111968, 645.7836624730721, 14530.273486325641, 14553.854461455356, 14572.927135364362, 14583.489577864724, 14604.415823367053, 13954.372053257628, 14113.153210807384, 14250.14499130045, 14251.358688859027, 14272.714545709028, 12152.939235303767, 12245.877541224563, 12311.630651080482, 12334.75330493394, 12570.497180112785, 4300.978495107535, 4323.805428755713, 4341.587549182823, 4408.911821763547, 4415.359772832953, 56368.0, 56520.717396413165, 56673.71663141658, 56825.71587142079, 56970.860582788526, 11065.889341106647, 11153.553857845758, 11170.664880053611, 11391.0, 11767.823482647767, 20472.488187795425, 20904.895475522524, 20945.057472413777, 21001.0, 21001.89499052495, 8222.506649601042, 8247.95876020628, 8333.749987500385, 8413.411061225777, 8424.241818236389, 4715.088681006593, 4862.756862156878, 4930.605551555867, 5011.498850114959, 5014.247862820534, 3359.3953088443827, 3451.7928924264124, 3454.740894432877, 3460.186856088817, 3461.0655123116617, 615.5321955313993, 654.0908137688616, 680.9114815074008, 685.5235611250233, 691.3086913086913, 776.5612428977722, 796.0924546017544, 802.4823988527368, 803.1165717710588, 826.4751882554501, 9369.344145909858, 9555.761105972406, 9719.56261968213, 9777.951110244545, 9813.067758562926, 726.894600282956, 740.1303468424687, 788.7228565311142, 791.4081383469185, 821.37575442664, 4512.842050528281, 4555.498895121534, 4581.79381927814, 4582.450105987303, 4603.58567728906, 64749.352506475276, 65037.67481162564, 66886.33113668801, 67413.0, 67592.0, 50578.0, 51770.0, 60665.696671517246, 60902.39097609056, 61700.38299617036, 48631.0, 50991.745041275295, 54889.0, 55575.0, 58557.0, 9534.95232523833, 9545.665901693408, 9710.75723106928, 9751.463669498246, 9800.607975681178, 34997.65002349944, 36918.96945668014, 37307.44038839474, 37680.623193768806, 38285.4257186148, 48743.75628121837, 49074.50925490842, 49490.0, 49552.256716150005, 50409.74795126001, 12277.508899643914, 12683.365831708563, 12715.491380344683, 12828.10203285761, 13070.934645326712, 14116.223607701675, 14200.147991120566, 14241.430342786172, 14394.064385814889, 15225.695486090437, 13233.933830330787, 13315.0, 13811.240381778696, 13923.512677056255, 13943.790843137564, 12910.419031143434, 13416.530421435593, 13557.457701691821, 14287.857121428653, 14296.0, 12878.549250776177, 13336.666583335495, 13378.0, 13900.652483687583, 13907.0, 11198.16013798952, 11256.662300131009, 11296.6046188383, 11298.265612735146, 11934.28394296345, 10977.0, 11281.830772538255, 11318.886811132114, 11349.092072634334, 11425.657230283105], "value": 7122.146115180646, "unit": "score"}], "name": "dromaeo_css", "value": 7207.069989595938, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 110.0, 108.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 149.0, 214.0, 123.0, 147.0, 160.0, 125.0, 181.0, 130.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 163.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 156.0, 74.0, 76.0, 75.0, 73.0, 134.0, 74.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 157.0, 93.0, 92.0, 91.0, 123.0, 92.0, 91.0, 115.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 144.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 56.0, 55.0, 55.0, 55.0, 55.0, 107.0, 54.0, 55.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 64.0, 60.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 84.0, 77.0, 79.0, 79.0, 76.0, 78.0, 78.0, 84.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 119.0, 121.0, 120.0, 125.0, 120.0, 129.0, 190.0, 127.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 158.0, 159.0, 164.0, 163.0, 165.0, 158.0, 157.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 62.0, 62.0, 62.0, 61.0, 62.0, 64.0, 61.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1521.8999999999999, "alertThreshold": 2.0}]} 13:52:05 INFO - Return code: 0 13:52:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:52:06 ERROR - # TBPL SUCCESS # 13:52:06 INFO - Running post-action listener: _resource_record_post_action 13:52:06 INFO - ##### 13:52:06 INFO - ##### Finished run-tests step (success) 13:52:06 INFO - ##### 13:52:06 INFO - Running post-run listener: _resource_record_post_run 13:52:06 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 432795648; Read time: 2332; Write time: 763412 13:52:06 INFO - TinderboxPrint: CPU usage
13.1% 13:52:06 INFO - TinderboxPrint: I/O read bytes / time
7,806,976 / 2,332 13:52:06 INFO - TinderboxPrint: I/O write bytes / time
432,795,648 / 763,412 13:52:06 INFO - TinderboxPrint: CPU idle
8,314.2 (86.9%) 13:52:06 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 13:52:06 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15015936; Read time: 0; Write time: 10492 13:52:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 6070272; Write bytes: 417779712; Read time: 2196; Write time: 752920 13:52:06 INFO - Running post-run listener: _upload_blobber_files 13:52:06 INFO - Blob upload gear active. 13:52:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:06 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 13:52:06 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:52:06 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:52:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:07 INFO - (blobuploader) - INFO - Done attempting. 13:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:12 INFO - (blobuploader) - INFO - Done attempting. 13:52:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:52:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:52:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:12 INFO - (blobuploader) - INFO - Done attempting. 13:52:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:12 INFO - Return code: 0 13:52:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f5cfa425c5ea304bc50c6165d59fe6831462d19b9ff426a990b3ca3d9d3e96c350e5aef28ced9f1533d68a3107b753d42b2fe430de079967ef719c93b75e027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67e197de93ce4212275563281bd2944af4e5212a20f0454cc709cdf701434a7896942ab95f71bdad9a47a1f012ce87ef4ff7f8aaa013bb8fc90d7306967800be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea14345e64580ee4af4f9bb7a027da4575c8e7a1fd5f15b663880acac72d4b5ad2c9df519ac8d10c3772f1167f55e6a4f24d65886558e5ee81386b2f1d37e228"} 13:52:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:12 INFO - Contents: 13:52:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f5cfa425c5ea304bc50c6165d59fe6831462d19b9ff426a990b3ca3d9d3e96c350e5aef28ced9f1533d68a3107b753d42b2fe430de079967ef719c93b75e027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67e197de93ce4212275563281bd2944af4e5212a20f0454cc709cdf701434a7896942ab95f71bdad9a47a1f012ce87ef4ff7f8aaa013bb8fc90d7306967800be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea14345e64580ee4af4f9bb7a027da4575c8e7a1fd5f15b663880acac72d4b5ad2c9df519ac8d10c3772f1167f55e6a4f24d65886558e5ee81386b2f1d37e228"} 13:52:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:12 INFO - Copying logs to upload dir... 13:52:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.288579 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-13 13:52:12.983181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 13:52:12.986974) ========= 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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f5cfa425c5ea304bc50c6165d59fe6831462d19b9ff426a990b3ca3d9d3e96c350e5aef28ced9f1533d68a3107b753d42b2fe430de079967ef719c93b75e027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67e197de93ce4212275563281bd2944af4e5212a20f0454cc709cdf701434a7896942ab95f71bdad9a47a1f012ce87ef4ff7f8aaa013bb8fc90d7306967800be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea14345e64580ee4af4f9bb7a027da4575c8e7a1fd5f15b663880acac72d4b5ad2c9df519ac8d10c3772f1167f55e6a4f24d65886558e5ee81386b2f1d37e228"} build_url:https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/OYa-qw2CSwaFvWUIfy4MyQ/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/Mozilla-Inbound/sha512/9f5cfa425c5ea304bc50c6165d59fe6831462d19b9ff426a990b3ca3d9d3e96c350e5aef28ced9f1533d68a3107b753d42b2fe430de079967ef719c93b75e027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67e197de93ce4212275563281bd2944af4e5212a20f0454cc709cdf701434a7896942ab95f71bdad9a47a1f012ce87ef4ff7f8aaa013bb8fc90d7306967800be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea14345e64580ee4af4f9bb7a027da4575c8e7a1fd5f15b663880acac72d4b5ad2c9df519ac8d10c3772f1167f55e6a4f24d65886558e5ee81386b2f1d37e228"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 13:52:13.011330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:52:13.011677) ========= 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=33d5923976266a1c518c4bf7000001ab-1463171451.643593-1327626345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:52:13.096364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 13:52:13.096701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 13:52:13.096994) ========= ========= Total master_lag: 0.15 =========