builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1464800966.0 results: success (0) buildid: 20160601073100 builduid: d9dba89c02594f91a2b9fdf7993e6911 revision: 30e0d233fb29b0ff0d56d9d1704b5b136f16941e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:25.996943) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:25.997797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:25.998471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:26.016783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:26.017421) ========= 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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 10:09:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2016-06-01 10:09:26 (41.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:26.167070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:26.167809) ========= 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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:26.219052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 10:09:26.219464) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 30e0d233fb29b0ff0d56d9d1704b5b136f16941e --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 30e0d233fb29b0ff0d56d9d1704b5b136f16941e --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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 10:09:26,830 truncating revision to first 12 chars 2016-06-01 10:09:26,830 Setting DEBUG logging. 2016-06-01 10:09:26,830 attempt 1/10 2016-06-01 10:09:26,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/30e0d233fb29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 10:09:28,356 unpacking tar archive at: mozilla-inbound-30e0d233fb29/testing/mozharness/ program finished with exit code 0 elapsedTime=1.860837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 10:09:28.097180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:28.097626) ========= script_repo_revision: 30e0d233fb29b0ff0d56d9d1704b5b136f16941e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:28.098736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:28.099444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:09:28.112214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 10:09:28.112808) ========= /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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:28 INFO - MultiFileLogger online at 20160601 10:09:28 in /builds/slave/test 10:09:28 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 10:09:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:28 INFO - {'append_to_log': False, 10:09:28 INFO - 'base_work_dir': '/builds/slave/test', 10:09:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:09:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:28 INFO - 'branch': 'Mozilla-Inbound', 10:09:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:28 INFO - 'config_files': ('talos/linux_config.py',), 10:09:28 INFO - 'default_actions': ('clobber', 10:09:28 INFO - 'read-buildbot-config', 10:09:28 INFO - 'download-and-extract', 10:09:28 INFO - 'populate-webroot', 10:09:28 INFO - 'create-virtualenv', 10:09:28 INFO - 'install', 10:09:28 INFO - 'run-tests'), 10:09:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:28 INFO - 'download_minidump_stackwalk': True, 10:09:28 INFO - 'download_symbols': 'ondemand', 10:09:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:28 INFO - 'installer_path': 'installer.exe', 10:09:28 INFO - 'log_level': 'info', 10:09:28 INFO - 'log_name': 'talos', 10:09:28 INFO - 'log_to_console': True, 10:09:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:28 INFO - 'opt_config_files': (), 10:09:28 INFO - 'pip_index': False, 10:09:28 INFO - 'sps_profile': False, 10:09:28 INFO - 'sps_profile_interval': 0, 10:09:28 INFO - 'suite': 'dromaeojs', 10:09:28 INFO - 'system_bits': '32', 10:09:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:28 INFO - 'title': 'talos-linux64-ix-052', 10:09:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:28 INFO - 'use_talos_json': True, 10:09:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:28 INFO - 'work_dir': 'build'} 10:09:28 INFO - ##### 10:09:28 INFO - ##### Running clobber step. 10:09:28 INFO - ##### 10:09:28 INFO - Running pre-action listener: _resource_record_pre_action 10:09:28 INFO - Running main action method: clobber 10:09:28 INFO - rmtree: /builds/slave/test/build 10:09:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:29 INFO - Running post-action listener: _resource_record_post_action 10:09:29 INFO - ##### 10:09:29 INFO - ##### Finished clobber step (success) 10:09:29 INFO - ##### 10:09:29 INFO - ##### 10:09:29 INFO - ##### Running read-buildbot-config step. 10:09:29 INFO - ##### 10:09:29 INFO - Running pre-action listener: _resource_record_pre_action 10:09:29 INFO - Running main action method: read_buildbot_config 10:09:29 INFO - Using buildbot properties: 10:09:29 INFO - { 10:09:29 INFO - "project": "", 10:09:29 INFO - "product": "firefox", 10:09:29 INFO - "script_repo_revision": "production", 10:09:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:09:29 INFO - "repository": "", 10:09:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:09:29 INFO - "buildid": "20160601073100", 10:09:29 INFO - "pgo_build": "True", 10:09:29 INFO - "basedir": "/builds/slave/test", 10:09:29 INFO - "buildnumber": 1882, 10:09:29 INFO - "slavename": "talos-linux64-ix-052", 10:09:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:09:29 INFO - "platform": "ubuntu64_hw", 10:09:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:09:29 INFO - "branch": "mozilla-inbound", 10:09:29 INFO - "repo_path": "integration/mozilla-inbound", 10:09:29 INFO - "revision": "30e0d233fb29b0ff0d56d9d1704b5b136f16941e", 10:09:29 INFO - "stage_platform": "linux64-pgo", 10:09:29 INFO - "builduid": "d9dba89c02594f91a2b9fdf7993e6911", 10:09:29 INFO - "slavebuilddir": "test" 10:09:29 INFO - } 10:09:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:09:29 INFO - Running post-action listener: _resource_record_post_action 10:09:29 INFO - ##### 10:09:29 INFO - ##### Finished read-buildbot-config step (success) 10:09:29 INFO - ##### 10:09:29 INFO - ##### 10:09:29 INFO - ##### Running download-and-extract step. 10:09:29 INFO - ##### 10:09:29 INFO - Running pre-action listener: _resource_record_pre_action 10:09:29 INFO - Running main action method: download_and_extract 10:09:29 INFO - mkdir: /builds/slave/test/build/tests 10:09: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')]} 10:09:29 INFO - https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:29 INFO - Downloaded 1361 bytes. 10:09:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:09:29 INFO - Using the following test package requirements: 10:09:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:09:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:09:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'jsshell-linux-x86_64.zip'], 10:09:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:09:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:09:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:09:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:09:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:09:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:09: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')]} 10:09:29 INFO - https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:31 INFO - Downloaded 24422680 bytes. 10:09:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:32 INFO - Return code: 0 10:09:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:09: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')]} 10:09:32 INFO - https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:33 INFO - Downloaded 24422680 bytes. 10:09:33 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'] 10:09:33 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 10:09:34 INFO - Return code: 0 10:09:34 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')]} 10:09:34 INFO - https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:35 INFO - Downloaded 10834055 bytes. 10:09:35 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'] 10:09:35 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 10:09:36 INFO - Return code: 0 10:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:36 INFO - https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs-46L-sTwyYTm4cmweuhA/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 10:09:37 INFO - Downloaded 59025059 bytes. 10:09:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:09:37 INFO - mkdir: /builds/slave/test/properties 10:09:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:37 INFO - Contents: 10:09:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:09:38 INFO - Running post-action listener: _resource_record_post_action 10:09:38 INFO - Running post-action listener: set_extra_try_arguments 10:09:38 INFO - ##### 10:09:38 INFO - ##### Finished download-and-extract step (success) 10:09:38 INFO - ##### 10:09:38 INFO - ##### 10:09:38 INFO - ##### Running populate-webroot step. 10:09:38 INFO - ##### 10:09:38 INFO - Running pre-action listener: _resource_record_pre_action 10:09:38 INFO - Running main action method: populate_webroot 10:09:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:38 INFO - '--tppagecycles', 10:09:38 INFO - '7'], 10:09:38 INFO - 'tests': ['tsvgm']}}, 10:09:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['damp', 'tps']}, 10:09:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'tests': ['damp', 'tps']}, 10:09:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['dromaeo_dom']}, 10:09:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['a11yr', 10:09:38 INFO - 'ts_paint', 10:09:38 INFO - 'tpaint', 10:09:38 INFO - 'sessionrestore', 10:09:38 INFO - 'sessionrestore_no_auto_restore', 10:09:38 INFO - 'tabpaint']}, 10:09:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['tsvgx', 10:09:38 INFO - 'tsvgr_opacity', 10:09:38 INFO - 'tart', 10:09:38 INFO - 'tscrollx', 10:09:38 INFO - 'cart']}, 10:09:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:38 INFO - 'tsvgr_opacity', 10:09:38 INFO - 'tart', 10:09:38 INFO - 'tscrollx', 10:09:38 INFO - 'cart']}, 10:09:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'talos_options': ['--disable-e10s'], 10:09:38 INFO - 'tests': ['tp5o']}, 10:09:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'tests': ['tp5o']}, 10:09:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'talos_options': ['--disable-e10s', 10:09:38 INFO - '--xperf_path', 10:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:38 INFO - 'tests': ['tp5n']}, 10:09:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:38 INFO - 'talos_options': ['--xperf_path', 10:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:38 INFO - 'tests': ['tp5n']}}, 10:09:38 INFO - 'talos.zip': {'path': '', 10:09:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:38 INFO - Running post-action listener: _resource_record_post_action 10:09:38 INFO - ##### 10:09:38 INFO - ##### Finished populate-webroot step (success) 10:09:38 INFO - ##### 10:09:38 INFO - ##### 10:09:38 INFO - ##### Running create-virtualenv step. 10:09:38 INFO - ##### 10:09:38 INFO - Running pre-action listener: _resource_record_pre_action 10:09:38 INFO - Running main action method: create_virtualenv 10:09:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:38 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 10:09:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:38 INFO - Using real prefix '/usr' 10:09:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:40 INFO - Installing pip.................done. 10:09:40 INFO - Return code: 0 10:09:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:09:40 INFO - Using env: {'DISPLAY': ':0', 10:09:40 INFO - 'HOME': '/home/cltbld', 10:09:40 INFO - 'LANG': 'en_US.UTF-8', 10:09:40 INFO - 'LANGUAGE': 'en_US:en', 10:09:40 INFO - 'LOGNAME': 'cltbld', 10:09:40 INFO - 'MAIL': '/var/mail/cltbld', 10:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:40 INFO - 'MOZ_NO_REMOTE': '1', 10:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:40 INFO - 'NO_EM_RESTART': '1', 10:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:40 INFO - 'PWD': '/builds/slave/test', 10:09:40 INFO - 'SHELL': '/bin/bash', 10:09:40 INFO - 'SHLVL': '1', 10:09:40 INFO - 'TERM': 'linux', 10:09:40 INFO - 'TMOUT': '86400', 10:09:40 INFO - 'USER': 'cltbld', 10:09:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:40 INFO - '_': '/tools/buildbot/bin/python'} 10:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:41 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 10:09:41 INFO - Cleaning up... 10:09:41 INFO - Return code: 0 10:09:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:09:41 INFO - Using env: {'DISPLAY': ':0', 10:09:41 INFO - 'HOME': '/home/cltbld', 10:09:41 INFO - 'LANG': 'en_US.UTF-8', 10:09:41 INFO - 'LANGUAGE': 'en_US:en', 10:09:41 INFO - 'LOGNAME': 'cltbld', 10:09:41 INFO - 'MAIL': '/var/mail/cltbld', 10:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:41 INFO - 'MOZ_NO_REMOTE': '1', 10:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:41 INFO - 'NO_EM_RESTART': '1', 10:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:41 INFO - 'PWD': '/builds/slave/test', 10:09:41 INFO - 'SHELL': '/bin/bash', 10:09:41 INFO - 'SHLVL': '1', 10:09:41 INFO - 'TERM': 'linux', 10:09:41 INFO - 'TMOUT': '86400', 10:09:41 INFO - 'USER': 'cltbld', 10:09:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:41 INFO - '_': '/tools/buildbot/bin/python'} 10:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:41 INFO - Downloading/unpacking psutil>=3.1.1 10:09:41 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 10:09:41 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 10:09:41 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 10:09:41 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 10:09:41 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 10:09:41 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 10:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:43 INFO - Installing collected packages: psutil 10:09:43 INFO - Running setup.py install for psutil 10:09:43 INFO - building 'psutil._psutil_linux' extension 10:09:43 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 10:09:43 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 10:09:43 INFO - building 'psutil._psutil_posix' extension 10:09:43 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 10:09:43 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 10:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:43 INFO - Successfully installed psutil 10:09:43 INFO - Cleaning up... 10:09:43 INFO - Return code: 0 10:09:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:09: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 mozsystemmonitor==0.3 10:09:43 INFO - Using env: {'DISPLAY': ':0', 10:09:43 INFO - 'HOME': '/home/cltbld', 10:09:43 INFO - 'LANG': 'en_US.UTF-8', 10:09:43 INFO - 'LANGUAGE': 'en_US:en', 10:09:43 INFO - 'LOGNAME': 'cltbld', 10:09:43 INFO - 'MAIL': '/var/mail/cltbld', 10:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:43 INFO - 'MOZ_NO_REMOTE': '1', 10:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:43 INFO - 'NO_EM_RESTART': '1', 10:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:43 INFO - 'PWD': '/builds/slave/test', 10:09:43 INFO - 'SHELL': '/bin/bash', 10:09:43 INFO - 'SHLVL': '1', 10:09:43 INFO - 'TERM': 'linux', 10:09:43 INFO - 'TMOUT': '86400', 10:09:43 INFO - 'USER': 'cltbld', 10:09:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:43 INFO - '_': '/tools/buildbot/bin/python'} 10:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:46 INFO - Installing collected packages: mozsystemmonitor 10:09:46 INFO - Running setup.py install for mozsystemmonitor 10:09:46 INFO - Successfully installed mozsystemmonitor 10:09:46 INFO - Cleaning up... 10:09:46 INFO - Return code: 0 10:09:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:46 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:46 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 10:09:46 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 10:09:46 INFO - Using env: {'DISPLAY': ':0', 10:09:46 INFO - 'HOME': '/home/cltbld', 10:09:46 INFO - 'LANG': 'en_US.UTF-8', 10:09:46 INFO - 'LANGUAGE': 'en_US:en', 10:09:46 INFO - 'LOGNAME': 'cltbld', 10:09:46 INFO - 'MAIL': '/var/mail/cltbld', 10:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:46 INFO - 'MOZ_NO_REMOTE': '1', 10:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:46 INFO - 'NO_EM_RESTART': '1', 10:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:46 INFO - 'PWD': '/builds/slave/test', 10:09:46 INFO - 'SHELL': '/bin/bash', 10:09:46 INFO - 'SHLVL': '1', 10:09:46 INFO - 'TERM': 'linux', 10:09:46 INFO - 'TMOUT': '86400', 10:09:46 INFO - 'USER': 'cltbld', 10:09:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:46 INFO - '_': '/tools/buildbot/bin/python'} 10:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:48 INFO - Downloading docopt-0.6.1.tar.gz 10:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:49 INFO - Running setup.py install for blobuploader 10:09:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:49 INFO - Running setup.py install for requests 10:09:49 INFO - Running setup.py install for docopt 10:09:49 INFO - Successfully installed blobuploader requests docopt 10:09:49 INFO - Cleaning up... 10:09:49 INFO - Return code: 0 10:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:49 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')]} 10:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:49 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')]} 10:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:49 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:49 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 10:09:49 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 10:09:49 INFO - Using env: {'DISPLAY': ':0', 10:09:49 INFO - 'HOME': '/home/cltbld', 10:09:49 INFO - 'LANG': 'en_US.UTF-8', 10:09:49 INFO - 'LANGUAGE': 'en_US:en', 10:09:49 INFO - 'LOGNAME': 'cltbld', 10:09:49 INFO - 'MAIL': '/var/mail/cltbld', 10:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:49 INFO - 'MOZ_NO_REMOTE': '1', 10:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:49 INFO - 'NO_EM_RESTART': '1', 10:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:49 INFO - 'PWD': '/builds/slave/test', 10:09:49 INFO - 'SHELL': '/bin/bash', 10:09:49 INFO - 'SHLVL': '1', 10:09:49 INFO - 'TERM': 'linux', 10:09:49 INFO - 'TMOUT': '86400', 10:09:49 INFO - 'USER': 'cltbld', 10:09:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:49 INFO - '_': '/tools/buildbot/bin/python'} 10:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:49 INFO - Running setup.py (path:/tmp/pip-49SRix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:49 INFO - Running setup.py (path:/tmp/pip-Xooy1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:49 INFO - Running setup.py (path:/tmp/pip-T6uORN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:50 INFO - Running setup.py (path:/tmp/pip-3S0dRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:50 INFO - Running setup.py (path:/tmp/pip-dELdK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:50 INFO - Running setup.py (path:/tmp/pip-r4lBQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:50 INFO - Running setup.py (path:/tmp/pip-m1XJKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:50 INFO - Running setup.py (path:/tmp/pip-g_MqdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:50 INFO - Running setup.py (path:/tmp/pip-ECFpDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:50 INFO - Running setup.py (path:/tmp/pip-6OQBlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:50 INFO - Running setup.py (path:/tmp/pip-kGdZb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:50 INFO - Running setup.py (path:/tmp/pip-YMz3Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:50 INFO - Running setup.py (path:/tmp/pip-owSMh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:50 INFO - Running setup.py (path:/tmp/pip-n9z6CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:50 INFO - Running setup.py (path:/tmp/pip-7ZoUR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:50 INFO - Running setup.py (path:/tmp/pip-zW7e5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:51 INFO - Running setup.py (path:/tmp/pip-etsV8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:51 INFO - Running setup.py install for manifestparser 10:09:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Running setup.py install for mozcrash 10:09:51 INFO - Running setup.py install for mozdebug 10:09:51 INFO - Running setup.py install for mozdevice 10:09:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Running setup.py install for mozfile 10:09:51 INFO - Running setup.py install for mozhttpd 10:09:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Running setup.py install for mozinfo 10:09:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Running setup.py install for mozInstall 10:09:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:51 INFO - Running setup.py install for mozleak 10:09:51 INFO - Running setup.py install for mozlog 10:09:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Running setup.py install for moznetwork 10:09:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Running setup.py install for mozprocess 10:09:52 INFO - Running setup.py install for mozprofile 10:09:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Running setup.py install for mozrunner 10:09:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Running setup.py install for mozscreenshot 10:09:52 INFO - Running setup.py install for moztest 10:09:52 INFO - Running setup.py install for mozversion 10:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:52 INFO - Cleaning up... 10:09:52 INFO - Return code: 0 10:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:52 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')]} 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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')]} 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:52 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 10:09:52 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 10:09:52 INFO - Using env: {'DISPLAY': ':0', 10:09:52 INFO - 'HOME': '/home/cltbld', 10:09:52 INFO - 'LANG': 'en_US.UTF-8', 10:09:52 INFO - 'LANGUAGE': 'en_US:en', 10:09:52 INFO - 'LOGNAME': 'cltbld', 10:09:52 INFO - 'MAIL': '/var/mail/cltbld', 10:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:52 INFO - 'MOZ_NO_REMOTE': '1', 10:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:52 INFO - 'NO_EM_RESTART': '1', 10:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:52 INFO - 'PWD': '/builds/slave/test', 10:09:52 INFO - 'SHELL': '/bin/bash', 10:09:52 INFO - 'SHLVL': '1', 10:09:52 INFO - 'TERM': 'linux', 10:09:52 INFO - 'TMOUT': '86400', 10:09:52 INFO - 'USER': 'cltbld', 10:09:52 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:52 INFO - '_': '/tools/buildbot/bin/python'} 10:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:53 INFO - Running setup.py (path:/tmp/pip-EDB4vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:53 INFO - Running setup.py (path:/tmp/pip-e83M3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:53 INFO - Running setup.py (path:/tmp/pip-yG7GDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:53 INFO - Running setup.py (path:/tmp/pip-g3z6Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:53 INFO - Running setup.py (path:/tmp/pip-xaDgTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:53 INFO - Running setup.py (path:/tmp/pip-OXenWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:53 INFO - Running setup.py (path:/tmp/pip-VBE7Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:53 INFO - Running setup.py (path:/tmp/pip-YG2w1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:53 INFO - Running setup.py (path:/tmp/pip-1pwC5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:53 INFO - Running setup.py (path:/tmp/pip-DwC7Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:53 INFO - Running setup.py (path:/tmp/pip-m0khbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:53 INFO - Running setup.py (path:/tmp/pip-MlHY0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:53 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)) 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:53 INFO - Running setup.py (path:/tmp/pip-yohZlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:54 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)) 10:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:54 INFO - Running setup.py (path:/tmp/pip-ND3BZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:54 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)) 10:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:54 INFO - Running setup.py (path:/tmp/pip-EY5iSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:54 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)) 10:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:54 INFO - Running setup.py (path:/tmp/pip-aSDVT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:54 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)) 10:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:54 INFO - Running setup.py (path:/tmp/pip-PnTJq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:54 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)) 10:09:54 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)) 10:09:54 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)) 10:09:54 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)) 10:09:54 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)) 10:09:54 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)) 10:09:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:56 INFO - Downloading blessings-1.6.tar.gz 10:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:56 INFO - Installing collected packages: blessings 10:09:56 INFO - Running setup.py install for blessings 10:09:56 INFO - Successfully installed blessings 10:09:56 INFO - Cleaning up... 10:09:56 INFO - Return code: 0 10:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:56 INFO - Reading from file tmpfile_stdout 10:09:56 INFO - Current package versions: 10:09:56 INFO - argparse == 1.2.1 10:09:56 INFO - blessings == 1.6 10:09:56 INFO - blobuploader == 1.2.4 10:09:56 INFO - docopt == 0.6.1 10:09:56 INFO - manifestparser == 1.1 10:09:56 INFO - mozInstall == 1.12 10:09:56 INFO - mozcrash == 0.17 10:09:56 INFO - mozdebug == 0.1 10:09:56 INFO - mozdevice == 0.48 10:09:56 INFO - mozfile == 1.2 10:09:56 INFO - mozhttpd == 0.7 10:09:56 INFO - mozinfo == 0.9 10:09:56 INFO - mozleak == 0.1 10:09:56 INFO - mozlog == 3.2 10:09:56 INFO - moznetwork == 0.27 10:09:56 INFO - mozprocess == 0.22 10:09:56 INFO - mozprofile == 0.28 10:09:56 INFO - mozrunner == 6.11 10:09:56 INFO - mozscreenshot == 0.1 10:09:56 INFO - mozsystemmonitor == 0.3 10:09:56 INFO - moztest == 0.7 10:09:56 INFO - mozversion == 1.4 10:09:56 INFO - psutil == 3.1.1 10:09:56 INFO - requests == 1.2.3 10:09:56 INFO - wsgiref == 0.1.2 10:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:56 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:56 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 10:09:56 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 10:09:56 INFO - Using env: {'DISPLAY': ':0', 10:09:56 INFO - 'HOME': '/home/cltbld', 10:09:56 INFO - 'LANG': 'en_US.UTF-8', 10:09:56 INFO - 'LANGUAGE': 'en_US:en', 10:09:56 INFO - 'LOGNAME': 'cltbld', 10:09:56 INFO - 'MAIL': '/var/mail/cltbld', 10:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:56 INFO - 'MOZ_NO_REMOTE': '1', 10:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:56 INFO - 'NO_EM_RESTART': '1', 10:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:56 INFO - 'PWD': '/builds/slave/test', 10:09:56 INFO - 'SHELL': '/bin/bash', 10:09:56 INFO - 'SHLVL': '1', 10:09:56 INFO - 'TERM': 'linux', 10:09:56 INFO - 'TMOUT': '86400', 10:09:56 INFO - 'USER': 'cltbld', 10:09:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:56 INFO - '_': '/tools/buildbot/bin/python'} 10:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 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)) 10:09:56 INFO - Cleaning up... 10:09:56 INFO - Return code: 0 10:09:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:56 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:56 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 10:09:56 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 10:09:56 INFO - Using env: {'DISPLAY': ':0', 10:09:56 INFO - 'HOME': '/home/cltbld', 10:09:56 INFO - 'LANG': 'en_US.UTF-8', 10:09:56 INFO - 'LANGUAGE': 'en_US:en', 10:09:56 INFO - 'LOGNAME': 'cltbld', 10:09:56 INFO - 'MAIL': '/var/mail/cltbld', 10:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:56 INFO - 'MOZ_NO_REMOTE': '1', 10:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:56 INFO - 'NO_EM_RESTART': '1', 10:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:56 INFO - 'PWD': '/builds/slave/test', 10:09:56 INFO - 'SHELL': '/bin/bash', 10:09:56 INFO - 'SHLVL': '1', 10:09:56 INFO - 'TERM': 'linux', 10:09:56 INFO - 'TMOUT': '86400', 10:09:56 INFO - 'USER': 'cltbld', 10:09:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:56 INFO - '_': '/tools/buildbot/bin/python'} 10:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:57 INFO - Downloading/unpacking jsonschema 10:09:57 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 10:09:57 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 10:09:57 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 10:09:57 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 10:09:57 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 10:09:57 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 10:09:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:59 INFO - warning: no files found matching '*.txt' 10:09:59 INFO - no previously-included directories found matching 'build' 10:09:59 INFO - no previously-included directories found matching 'dist' 10:09:59 INFO - no previously-included directories found matching '.git*' 10:09:59 INFO - Installing collected packages: jsonschema, functools32 10:09:59 INFO - Running setup.py install for functools32 10:09:59 INFO - warning: no files found matching '*.txt' 10:09:59 INFO - no previously-included directories found matching 'build' 10:09:59 INFO - no previously-included directories found matching 'dist' 10:09:59 INFO - no previously-included directories found matching '.git*' 10:09:59 INFO - Successfully installed jsonschema functools32 10:09:59 INFO - Cleaning up... 10:09:59 INFO - Return code: 0 10:09:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:59 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 0x7f2f8d31af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2541770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, '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': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', '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 10:09:59 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 10:09:59 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 10:09:59 INFO - Using env: {'DISPLAY': ':0', 10:09:59 INFO - 'HOME': '/home/cltbld', 10:09:59 INFO - 'LANG': 'en_US.UTF-8', 10:09:59 INFO - 'LANGUAGE': 'en_US:en', 10:09:59 INFO - 'LOGNAME': 'cltbld', 10:09:59 INFO - 'MAIL': '/var/mail/cltbld', 10:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:59 INFO - 'MOZ_NO_REMOTE': '1', 10:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:59 INFO - 'NO_EM_RESTART': '1', 10:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:59 INFO - 'PWD': '/builds/slave/test', 10:09:59 INFO - 'SHELL': '/bin/bash', 10:09:59 INFO - 'SHLVL': '1', 10:09:59 INFO - 'TERM': 'linux', 10:09:59 INFO - 'TMOUT': '86400', 10:09:59 INFO - 'USER': 'cltbld', 10:09:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:59 INFO - '_': '/tools/buildbot/bin/python'} 10:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:59 INFO - Downloading/unpacking flake8 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:10:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:10:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:10:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:10:02 INFO - no previously-included directories found matching 'docs/_build' 10:10:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:10:02 INFO - Running setup.py install for pep8 10:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:10:02 INFO - no previously-included directories found matching 'docs/_build' 10:10:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:10:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:10:02 INFO - Cleaning up... 10:10:02 INFO - Return code: 0 10:10:02 INFO - Running post-action listener: _resource_record_post_action 10:10:02 INFO - Running post-action listener: _start_resource_monitoring 10:10:02 INFO - Starting resource monitoring. 10:10:02 INFO - ##### 10:10:02 INFO - ##### Finished create-virtualenv step (success) 10:10:02 INFO - ##### 10:10:02 INFO - ##### 10:10:02 INFO - ##### Running install step. 10:10:02 INFO - ##### 10:10:02 INFO - Running pre-action listener: _resource_record_pre_action 10:10:02 INFO - Running main action method: install 10:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:02 INFO - Reading from file tmpfile_stdout 10:10:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:02 INFO - Reading from file tmpfile_stdout 10:10:02 INFO - Output received: 10:10:02 INFO - Usage: mozinstall [options] installer 10:10:02 INFO - Options: 10:10:02 INFO - -h, --help show this help message and exit 10:10:02 INFO - -d DEST, --destination=DEST 10:10:02 INFO - Directory to install application into. [default: 10:10:02 INFO - "/builds/slave/test"] 10:10:02 INFO - --app=APP Application being installed. [default: firefox] 10:10:02 INFO - mkdir: /builds/slave/test/build/application 10:10:02 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'] 10:10:02 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 10:10:19 INFO - Reading from file tmpfile_stdout 10:10:19 INFO - Output received: 10:10:19 INFO - /builds/slave/test/build/application/firefox/firefox 10:10:19 INFO - Running post-action listener: _resource_record_post_action 10:10:19 INFO - ##### 10:10:19 INFO - ##### Finished install step (success) 10:10:19 INFO - ##### 10:10:19 INFO - ##### 10:10:19 INFO - ##### Running run-tests step. 10:10:19 INFO - ##### 10:10:19 INFO - Running pre-action listener: _resource_record_pre_action 10:10:19 INFO - Running main action method: run_tests 10:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:19 INFO - Python 2.7.3 10:10:19 INFO - Return code: 0 10:10:19 INFO - grabbing minidump binary from tooltool 10:10:19 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')]} 10:10:19 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 0x25d09c0>, '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 0x25d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:19 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 10:10:19 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 10:10:19 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 10:10:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:19 INFO - Return code: 0 10:10:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:10:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:10:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:10:20 INFO - Return code: 0 10:10:20 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/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 10:10:20 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/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 10:10:20 INFO - Using env: {'DISPLAY': ':0', 10:10:20 INFO - 'HOME': '/home/cltbld', 10:10:20 INFO - 'LANG': 'en_US.UTF-8', 10:10:20 INFO - 'LANGUAGE': 'en_US:en', 10:10:20 INFO - 'LOGNAME': 'cltbld', 10:10:20 INFO - 'MAIL': '/var/mail/cltbld', 10:10:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:20 INFO - 'MOZ_NO_REMOTE': '1', 10:10:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:20 INFO - 'NO_EM_RESTART': '1', 10:10:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:20 INFO - 'PWD': '/builds/slave/test', 10:10:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:20 INFO - 'SHELL': '/bin/bash', 10:10:20 INFO - 'SHLVL': '1', 10:10:20 INFO - 'TERM': 'linux', 10:10:20 INFO - 'TMOUT': '86400', 10:10:20 INFO - 'USER': 'cltbld', 10:10:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900', 10:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:20 INFO - '_': '/tools/buildbot/bin/python'} 10:10:20 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/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 10:10:20 INFO - mozversion application_buildid: 20160601073100 10:10:20 INFO - mozversion application_changeset: 30e0d233fb29b0ff0d56d9d1704b5b136f16941e 10:10:20 INFO - mozversion application_display_name: Nightly 10:10:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:20 INFO - mozversion application_name: Firefox 10:10:20 INFO - mozversion application_remotingname: firefox 10:10:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:10:20 INFO - mozversion application_vendor: Mozilla 10:10:20 INFO - mozversion application_version: 49.0a1 10:10:20 INFO - mozversion platform_buildid: 20160601073100 10:10:20 INFO - mozversion platform_changeset: 30e0d233fb29b0ff0d56d9d1704b5b136f16941e 10:10:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:10:20 INFO - mozversion platform_version: 49.0a1 10:10:20 INFO - using testdate: 1464801020 10:10:20 INFO - actual date: 1464801020 10:10:20 INFO - starting webserver on 'localhost:42850' 10:10:20 INFO - SUITE-START | Running 2 tests 10:10:20 INFO - TEST-START | dromaeo_css 10:10:20 INFO - operating with platform_type : linux_ 10:10:20 INFO - Initialising browser for dromaeo_css test... 10:10:20 INFO - TEST-INFO | started process 20394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5y2wTy/profile http://localhost:42850/getInfo.html) 10:10:24 INFO - PROCESS | 20394 | __metrics Screen width/height:1600/1200 10:10:24 INFO - PROCESS | 20394 | colorDepth:24 10:10:24 INFO - PROCESS | 20394 | Browser inner width/height: 1024/697 10:10:24 INFO - PROCESS | 20394 | __metrics 10:10:25 ERROR - PROCESS | 20394 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:10:25 INFO - TEST-INFO | 20394: exit 0 10:10:25 INFO - Browser initialized. 10:10:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:25 INFO - TEST-INFO | started process 20479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5y2wTy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:37 INFO - PROCESS | 20479 | RSS: Main: 156528640 10:10:37 INFO - PROCESS | 20479 | 10:11:28 INFO - PROCESS | 20479 | 1464801088925 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] 10:13:36 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42850/tests/dromaeo/cssquery-ext.html) 10:13:37 INFO - PROCESS | 20479 | RSS: Main: 245669888 10:13:37 INFO - PROCESS | 20479 | 10:16:39 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-ext.html (next: http://localhost:42850/tests/dromaeo/cssquery-jquery.html) 10:16:40 INFO - PROCESS | 20479 | RSS: Main: 249794560 10:16:40 INFO - PROCESS | 20479 | 10:19:42 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42850/tests/dromaeo/cssquery-mootools.html) 10:19:43 INFO - PROCESS | 20479 | RSS: Main: 247054336 10:19:43 INFO - PROCESS | 20479 | 10:22:45 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42850/tests/dromaeo/cssquery-prototype.html) 10:22:45 INFO - PROCESS | 20479 | RSS: Main: 241446912 10:22:45 INFO - PROCESS | 20479 | 10:25:48 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42850/tests/dromaeo/cssquery-yui.html) 10:25:48 INFO - PROCESS | 20479 | RSS: Main: 224141312 10:25:48 INFO - PROCESS | 20479 | 10:28:51 INFO - PROCESS | 20479 | Cycle 1(1): loaded http://localhost:42850/tests/dromaeo/cssquery-yui.html (next: http://localhost:42850/tests/dromaeo/cssquery-dojo.html) 10:28:52 INFO - PROCESS | 20479 | RSS: Main: 277544960 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | __start_tp_report 10:28:52 INFO - PROCESS | 20479 | _x_x_mozilla_page_load 10:28:52 INFO - PROCESS | 20479 | _x_x_mozilla_page_load_details 10:28:52 INFO - PROCESS | 20479 | |i|pagename|runs| 10:28:52 INFO - PROCESS | 20479 | |0;dojo.html;3037.331787006859;3069.7237248647625;3085.6142982127235;3096.4735994880866;3128.6558478567354;5162.303089082972;5198.40218374887;5259.421463639002;5263.0263401270795;5288.6562373445695;5234.267202591631;5236.005159019784;5284.682919024852;5290.576753859692;5335.759890804913;4813.518648135176;4833;4882.97558512207;4887.511248875102;5063.265826455162;4929.063477939198;4949.950500494985;4950.529699678543;4998.650094493387;5027.622928280393;4728.810847566093;4756.904861902777;4781.713097214179;4814.614830813526;4842.588379987706;4800.879978000578;4802;4802.495737947535;4803.063402636487;4903.558679718807;4808.783604737795;4821;4828.782704778293;4830.3720516333005;4891.290762839369;5091.032703786269;5215.765290561933;5277.551408130314;5280.1815718563685;5293.4971177738435;5755.827325180251;5756.136579513065;5764.625299355528;5778.566607504454;5780.653160810322;5791.21818554494;5805.216295800097;5809;5813.79651712188;5813.854653633651;5199;5284.524392804666;5326.680399176062;5331.920021199724;5397.0285348636835;5867.911981320283;5877.089051197071;5879.735411906475;5880.500157486576;5882.264716910387;5360.383555891044;5660.2075709400715;5669.886602267931;5671.461211184931;5674.744636491368;5647.350554686263;5697.088465845445;5698.7435565399655;5752.971235143881;5753.252077229933;5708.971455142698;5714.114312281603;5721.113227449669;5731.971340143273;5734.885302293931;5489.286392768914;5661.66030038199;5701.942980570141;5713.514351280104;5714.3999880012;4325.632321252729;4354.085642015212;4381.759003254851;4420.336949457607;4423.336499525032;3877.747946383476;3895.337792575269;3910.550286717064;3912.197999410114;3936.527616685959;5128.9230661540105;5145.4597267287145;5368.812091576776;5455.09990851513;5488.286522752017;5715.828525144252;5738.655680659173;5774.480296773227;5775.94224057754;5827.446392592697;5427.1316589345515;5438.021156191923;5444.346678398539;5445.047116754552;5448.182772584065;4672.275797251432;4854.053459575349;4901.460839307673;4956.179814379372;5012.122878496249;5875.500582450454;5887.293524777054;5889.970550147222;5892.852678682982;5934.525237980951;5710.2862142232225;5712.514436272963;5717.22817419643;5719.3136823581435;5724.227229323988;5643.35101463337;5847.561432892635;5866.765329386777;5902.793402230901;5935.525157987437;5696.344920334214;5709;5710.685912274865;5712.314522257356;5717.599768016199;5763.452472015152;5786.045302525036;5789.1895134680335;5801.738921748616;5808;5417.187421886749;5548.639338443149;5577.721113944368;5596.356419011703;5634.915476267777;5570.19232211319;5571.470710282517;5572.247746554163;5576.191452239484;5581.888362232651;5312.043832110257;5460.508554229979;5509.531689806411;5515.393306736336;5559.610827242054;5580.525655319181;5584.46947539983;5637.295338082739;5731.254936858182;5744.310682718101;5555.2500412445415;5555.8888822222525;5559.972200138974;5561.833145005657;5594.832155035356 10:28:52 INFO - PROCESS | 20479 | |1;ext.html;610.8686632374039;624.2197253433209;627.2535682537782;640.0015975078877;645.7255666341804;42860.142797144035;44460.77769611155;44464;48223.51776482234;48341.274880876816;44361;45037.77481112598;45052.54947450524;45065.549344506544;45161.77419112908;8722.781930451758;8889.866652000224;8915.063918288584;8916.15296546827;8920.28637708985;8772.429792063496;8857.247133993586;8867.024627290994;8872.822543549157;8884.289256859436;8901.243394311492;8921.776955576097;8947.105289471034;8964;8974.59614317354;8802.16379443955;8834.646614135427;8866.955665221698;8879.95560022199;8890.555472226428;8702.042775294713;8792.296616270683;8799.912000880036;8802;8803.911960880438;41955;42291.57708422907;42297.36553951693;42368;42440.57559424397;3350.5811773528308;3391.270876761508;3396.218869659992;3582.301451217014;3597.460380942853;32543.349133017444;33178.170545736306;33386.66613333884;33432.33135337304;33461.665383346095;4367.628751556122;4374.103308821684;4409.845655402046;4446.155230506226;4543.5910768031035;359168;363545;363658.9999999974;363786;365093;62385;62568.37431625716;62770.68614656897;62898;63017.58876878575;65477;66003.33996659971;66029.33970660232;66084;66144.66927665331;17124.229409676595;17460.30158793634;17461.38885139014;17472.30110795554;17474.912625437046;13128.34358282082;13195.142315749446;13283.203007819562;13284.933575332061;13292.534761283501;18487.135112489774;19665.410037698894;19836.801631983497;19986.300479483147;19991.800081998994;7039.683214255371;7153.92846071543;7203.279672032755;7220.761563915203;7514.511556748794;805.899262592176;884.7655371326604;1007.2345017786535;1120.4005856866538;1162.4594563528;31275.400042884397;32583.83708081492;32670.509942350884;32912.3417531648;33052.83473582617;1146.9139814513944;1182.2315494928366;1203.0375699440413;1206.1255589697575;1217.4582310871576;16902.74645880288;17100.315987360616;17119.22963466647;17245.396411125552;17250.223739931484;163563;164837;165219;166243.1687841553;167428;57665.423345766845;59074.40925590775;59158.40841591615;59214.70392648009;59218;1270.8729127087217;1288.0532808385829;1304.6673098359859;1365.7473367427058;1376.4769387632837;25660.61509077328;32353;33355;33499.66500335063;33973.49039764356;51508.484915151865;51979.2203116946;52179.47820521746;52207.73896130495;52230.21654675259;316998;317270;317278;317778;317826;23909.52180956406;28110;28220;28372.290692732848;29774.404511909208;46714.29928551142;46773.29840052334;47139.528604713516;47701.522984769705;47724.522754772006;38114.61885381111;39455.2108957825;39548.209035819695;39830;39871.40192897051;37840.62159378481;38195.809020954715;38352.80823595864;38746.6125338743;39323.606763931995;36339.818300909385;38354.80822595981;40901;40984.385234220914;41872.79063604662;35119.64880351266;36807.26385472329;37357.62642373541;37366.813165934;37609.81195094007;27589;27712.722872771013;28136.71863281341;28169.295767605974;28407.715922840507 10:28:52 INFO - PROCESS | 20479 | |2;jquery.html;382.9889092795021;384.73261083546936;389.1749491078911;398.09036351935833;414.9917001659967;18549.35077272296;18824.529386765338;20103.195872165114;20227.089780959854;20234.29179978701;11871.287722736643;12513.749725005495;12518.12373133881;12543.55749088855;18042.18810153543;5069.214271787879;5279.524842764151;5309.787608495675;5320.122179840322;5327.121025030885;3818.9045273868096;4123.257813593552;5165.940982098679;6444.581102228363;6560.803175904731;6310.716017779211;6454.709538070774;6469.74121035158;6504.512161587876;6518.608883466984;6269.153664255313;6388.329225431333;6426.518011149135;6466.805995820109;6473.158489396372;3731.9626803731885;5179.870503237412;5421.376541697677;5436.483534064258;5715.057015592422;13523.59429217125;13791.586252412444;13876.58370248884;13945.930270348685;14144.151350918875;2077.8129968302924;2244.259394399844;2285.0973865323103;2302.6315789473606;2428.307932239303;9678.806423871483;9797.265205109574;10334;10584.894151058468;14131.717365652732;1886.820752028555;1897.7438045863908;1904.2954106980367;1927.152053096633;2010.7486564179478;78303.60848195723;83758;83841;84010.57994709988;85134.57432712796;11195;11218.66344009681;11325.603603873826;11681.299122052704;11811.586594469152;15626.062436253862;15654;15698.529044128694;15717.135557544445;15728.528144155694;8055.959720201478;8295.58522073906;8377.036640786266;8478.5336806475;8513.148685131437;8059.234372734581;8107.4324797263625;8253.95873020631;8367.205115514016;8393.202645748644;4702.177119004161;4715.528447155257;4788.449328327218;4866.7079975201605;4928.310036594879;1871.401151631492;1936.1219616971516;1936.5061909213061;1947.9026048697508;1956.434852118328;897.5871099294267;956.1872408452759;977.4428575711776;985.3939827006483;1023.6775415744016;17667.11664416774;19128;19289.131989060246;19388.03059847002;19549.51126221856;1011.6560369474414;1038.1850247555633;1042.9843552346722;1045.3884477580548;1051.2431049644244;10447.529861156267;10907.727306817393;10969;11019.283746556448;11021.889781102247;477818;484834;490649;503311;504811;93342.53328733314;96810;97048;97478;97541.51229243808;1010.4089107871977;1019.2661283875598;1036.9014943580348;1039.1115596165473;1041.193075366597;17096.914515427343;17148.874792252023;17262.309507619553;17320.566985825455;17480.12599370001;29504;37898.810505947295;40086.599134009455;40302.1939561213;40447.79776101101;55904;58229;58547;59762.10356844564;60196;8521.233089022018;8624.09447008055;8691;8782.780430489289;8918.063603321558;9604;12343;13255.867441325849;13284.202947823162;13473.32633368308;12018.278903265833;12116.818247726114;12175;12202.81695774582;12333.50665973351;11589.82615260755;11899.702507437383;11959.521619135137;12160.148789584644;12271.141020128505;12020;12057.397130143283;12191.878081219074;12343.321117338633;12478.25130492137;8771.429857059271;8778.56107194625;8803.339749518684;8829.426087304304;8983.46099234048;8984.910150898408;11210.327380356879;11820.23168494045;12097.395130243276;12118.454669540068 10:28:52 INFO - PROCESS | 20479 | |3;mootools.html;1318.650557602235;1507.7587585986244;1548.1872017190974;1638.2709694186092;1777.9911100444497;8351.123132071129;8717.651293948235;8719.520426376546;8725.38922275441;8731.738047858567;8328;8509.574521273928;8515.574221288942;8519.701810436636;8528.232459078681;2020.171729590868;2270.9886450567724;2293.9541209175804;2320.2227253869974;2362.586547354215;2378.298401971414;2388.725296590897;2389.0682633772844;2390.1634427950166;2398.9880050599722;2317.2700599311247;2325.2791634593245;2341.7424083350816;2345.3901985483812;2346.2843832631042;1958.3831093205595;2209.4365936686204;2290.393045842853;2295.254042436215;2308.803751681109;2268.875211863347;2280.703508543879;2295.3802473332107;2296.0356650206954;2298.092253559851;8485;8556.5293908835;8556.871646925301;8570.228679418882;8572.314214862796;5099.08216521026;5239;5242.895142097175;5246.580273578143;5251.054810134175;3136.466800643896;3290.1116698491514;3363.394588973984;3368.59576850777;3389.3729660012978;1120.490176969477;1132.631894634239;1135.8977692007759;1149.1668540308294;1180.0441642269789;11729.64811055661;11955.701107472383;11969.760604787856;12001.399930003465;12007.159498834997;4459.910801783946;4579.771261260803;4656.185167595657;4695.436547614308;4699.295105734167;10031.147352474976;10040.79918401628;10051.447170405698;10052;10055.547500362354;5174.404943431554;5187.273781670569;5187.974060129675;5188.273641690166;5189.662671926313;4070.7354021988476;4505.279155335131;4604.148232576984;4613.677042606985;4639.9536004640195;3852.3643598805884;3863.594322596087;3918.0792513759243;3919.804009799556;4045.231406032903;1174.2074099982478;1175.7178277213407;1186.2348785033778;1201.2732296960387;1225.993870030662;1010.7523656704154;1014.3457469932;1015.9085682288629;1023.8003589300164;1029.089256008423;5700.40145784695;5937.139114828326;5954.10688396744;6006.519478441714;6073;1008.8839783424853;1022.4632068164274;1025.2105878473683;1063.9627613033506;1145.851039364894;4017.9397309040387;4089.5092588889524;4146.1914926589025;4203.873883783492;4233.724807887539;10406.791864162675;10653.094486968694;10701.946490267499;10733.946330268298;10734.624288149877;10331.12185464229;10612.469376531142;10615.628453004108;10632.362058276529;10659.093977011886;7751.728689495841;7862.567558784322;7880.881786773203;7935.880961785578;7996.320312773363;5804.622699524517;5885.646861188171;5970.984932561388;5974.61165024272;6011.579189456696;9400.435973841591;9727.027297270217;9727.902720972983;9744.707658770249;9785.315027947976;9598.088181622734;9847.753806154904;9867.950660246654;9936.20510359184;9962.402255864672;6845.4865885057825;7005.54463959841;7326.3040011198855;7342.816429589303;7364.263573642593;7919.208079192034;7963.721269755531;7992.480488768211;8010.198980101944;8046.155153708776;7086.362227399559;7226.4218862491925;7314.597697126496;7512.511686740344;7624.504407213513;7128.643567821485;7285.307895749896;7324.633768311456;7331.8533629328185;7581.166071732216;6959.164900212007;6977.476689248225;7014.649267536704;7028.332308430691;7032.718691252498;4920.36035315421;5015.154596728953;5071.39143302806;5244;5246.239295302236;5179.48205179479;5253.185756207794;5282.603804714585;5316;5481.314835645544 10:28:52 INFO - PROCESS | 20479 | |4;prototype.html;319.7106618510249;327.36327842346634;330.7701147702347;331.0531878826557;336.2535171918342;5244.423113457521;5314.495122963317;5317.388500322464;5320.324097909156;5334.786608535659;5229.163333866582;5252.925094587636;5275.577953763699;5305.310309659739;5316.627836051478;3912.902177445558;3965.0682089708966;4050.4126901599398;4051.554329023805;4075.551689314188;4049.5140583130064;4068.9389659155136;4070.2470043041985;4073.2260870434525;4083.9591604084026;3909.7263191576603;4019.859304924328;4024.5249171759306;4034.878953631381;4053.3919912013284;3804.258169656918;3996.9200615987515;4046.7571945683208;4073.775942323171;4117.464729585135;3632.5640923089136;3639.4358874374248;3646.3409148837213;3646.507721457596;3660.2679464107287;5023.899522009576;5028.647994640377;5030.8239211627415;5032.823851165192;5036.143855544529;4522.638188944877;4650.232711602582;4651.62786977041;4682.531746825291;4696.412948381452;5276.7889284428575;5295.947040529584;5296.179092240709;5349.839504814823;5401.810936617199;3741.8877433677035;3845.3462911305146;3957.248122856648;3984.940225896614;4022.859199928018;5604.131359639263;5619.831405057855;5622.156676498517;5627.746751396197;5629.3526244482;3981.1639555693628;3991.3613821788376;3999.9400008999305;4002.939955900664;4006.599340066028;3920.196359746245;4036.6972477064337;4051.7974101294817;4054.493188351456;4100.671946244293;4551.134035045616;4613.700109492872;4639.234526303122;4639.396878405853;4642.489326174118;5376.086065368897;5401.1358182691365;5422.719254850837;5431.755570999236;5432.320959880015;1362.9318534073257;1389.3192335755407;1390.3951780975308;1402.95089671861;1404.7752359622411;880.9119088091139;889.4840992224495;925.2043242811177;926.323783637948;940.6331530703031;5199.922001169985;5322.28149199853;5327.680339179662;5328.4671532846405;5329.733513324319;5539.723013849291;5573.526250268773;5590.86022849432;5619.7471113799975;5634;5015.749212539358;5255.316808814906;5304.655197412156;5308.840734777963;5335.626506144533;2900.825165807809;2959.792814502964;2962.9111126666235;2963.9259018524276;2979.2254013956526;5704.971475142681;5721.313442386857;5721.628094173865;5761.423857614205;5776.797812076557;5535.1180598596675;5559.527440167551;5605.523530499871;5659.830205093854;5660.943390566124;5728.713564321851;5740.512056475163;5747.700919632181;5749.453801888814;5764.798232061858;5366.812161574326;5578.135389014709;5583.776648933997;5588.30146231721;5598.244237027949;5529.944700552943;5534.4742249486235;5539.8892022160135;5540.944590554042;5543.972280138735;5710.714464276853;5794.507466865363;5803.216565763568;5817.185594016925;5824.475797178275;3700.5744339401313;3734.383826668678;3822.311983842824;4052.149048699806;4064.1058967027207;5615;5648.802291919763;5653.293338332708;5658.915116273177;5664.49019588239;5521.254630624975;5521.751521181637;5531.391546929754;5539.169124631177;5546.500814926676;5368.32895888014;5377;5417.377001644862;5422.105352616932;5426.348838139448;5134.640575159852;5271.499207575274;5322.387925388475;5323.467653234646;5343.3587969443915;5396.757145928521;5492.505674489155;5506.944930550643;5516.979358818631;5532.28080349552;5305.408377486816;5334.75993580282;5335.493128152819;5348.1442969124755;5381.75782089799 10:28:52 INFO - PROCESS | 20479 | |5;yui.html;687.8177283020001;712.6127472965569;764.762923493717;801.194799226777;824.6124321568865;15296.923515382421;15483.225838708076;16264.43074492393;16291.674166516663;16301.83698163018;14394;14791.112533248013;15270.694586108299;15282.770758438632;15308.923455382708;807.9798005049892;808.4906508899385;818.9918100818975;819.1971867569786;820.2699597358355;679.1001922452746;801.3348920396087;816.6855760532178;820.7086484298078;826.8511667899776;844.0968164064453;846.1369403208723;846.1622993236682;846.7713717296326;848.0755975986174;712.3517598984898;840.3613253926999;841.2176675691604;841.2933136165589;842.3008902610849;608.7139044649008;612.5252928980032;612.770211170811;619.0961196652892;624.7875722254455;14791.038582492103;14941.925290373478;14946.252687365697;14967;14975.700485990328;13311.40098695561;14132.505362312373;14223.28883555818;14314.92842535791;14546.709065818624;12362.320072396014;12587.74824503514;12596.748065038648;12611.873881261161;12712.618621441372;4456.086502267028;4499.52754960731;4518.186726389248;4578.10726908253;4585.58729714324;77860.61069694672;77874;77961.99999999943;78257.21742782614;78329.60835195845;11219.551217951353;11317.568406570117;11625.18623696333;11734.88265117355;12094.213876098025;21018.684719729215;21019.264325748525;21046.2633807816;21102.2614208502;21239.68140477894;8522.446041007315;8621.161939387877;8903.955480222687;8913.866292005625;9071.909280907106;4707.411573553306;4875.609951203895;4912.926306105412;4932.482089380635;5098.592112631055;3459.930801383958;3577.3203091412547;3579.302036102935;3580.2481478889204;3580.820958952042;576.8413686236235;580.3731969472959;587.3157771196594;587.3509771702293;599.5892813422819;643.6138317009757;657.2605818454239;672.3612568060362;688.2051230828401;696.4463251714899;9699.17557007648;9764;9767.658131965347;9798.804023919623;9816.312858099864;543.4972650298458;605.2779841351436;627.1877918096077;638.1544453599;667.4491704134057;4782.617390608743;4968.975155124202;4995.275685025724;4998.136507068835;5002.949970500321;71861;73680.26319736842;74611.62694186495;75076.62461687656;117233.4138329303;74237;75199.62400187964;101879;105195;110652.4467377658;88758;89363;89392.10607893967;90543.54728226448;91596;9165.77085572866;9241.353105282566;9312.767180820534;9333.533323333942;9586.856197156909;51123.233151503504;52821.471785281654;53091.734541327045;53721.73139134436;54407.45592544024;54944.72527637336;74472.62763686146;76383.61808190924;76442.6177869107;77368.61315693386;11217.831732523855;11643.359615221245;11908.285502869856;12252.203606765532;13555.59333220005;14169.929150354183;14367.928160359132;15065.47270845559;15119.092854428769;15162.3176957035;13893.374798134311;14256.287185640469;14294.642633934234;14494.927525362305;14556.41774329015;13796.793048104488;14424.206668633326;14482.782758258845;14788.778168327268;14857.257137143315;13783.655408614864;14100.36548355306;14135.363908623931;14213.857861421668;14601.780973285622;10094;10200.183985281308;10308.24001037098;10313;10780.245382823126;11585.304881707125;11747.588834390755;11903.642890713292;11978.92189702931;12131 10:28:52 INFO - PROCESS | 20479 | __end_tp_report 10:28:52 INFO - PROCESS | 20479 | __start_cc_report 10:28:52 INFO - PROCESS | 20479 | _x_x_mozilla_cycle_collect,921 10:28:52 INFO - PROCESS | 20479 | __end_cc_report 10:28:52 INFO - PROCESS | 20479 | __startTimestamp1464802132115__endTimestamp 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | ------- Summary: start ------- 10:28:52 INFO - PROCESS | 20479 | Number of tests: 6 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#0] dojo.html Cycles:165 Average:5304.69 Median:5548.64 stddev:609.71 (11.0%) stddev-sans-first:585.06 10:28:52 INFO - PROCESS | 20479 | Values: 3037.3 3069.7 3085.6 3096.5 3128.7 5162.3 5198.4 5259.4 5263.0 5288.7 5234.3 5236.0 5284.7 5290.6 5335.8 4813.5 4833.0 4883.0 4887.5 5063.3 4929.1 4950.0 4950.5 4998.7 5027.6 4728.8 4756.9 4781.7 4814.6 4842.6 4800.9 4802.0 4802.5 4803.1 4903.6 4808.8 4821.0 4828.8 4830.4 4891.3 5091.0 5215.8 5277.6 5280.2 5293.5 5755.8 5756.1 5764.6 5778.6 5780.7 5791.2 5805.2 5809.0 5813.8 5813.9 5199.0 5284.5 5326.7 5331.9 5397.0 5867.9 5877.1 5879.7 5880.5 5882.3 5360.4 5660.2 5669.9 5671.5 5674.7 5647.4 5697.1 5698.7 5753.0 5753.3 5709.0 5714.1 5721.1 5732.0 5734.9 5489.3 5661.7 5701.9 5713.5 5714.4 4325.6 4354.1 4381.8 4420.3 4423.3 3877.7 3895.3 3910.6 3912.2 3936.5 5128.9 5145.5 5368.8 5455.1 5488.3 5715.8 5738.7 5774.5 5775.9 5827.4 5427.1 5438.0 5444.3 5445.0 5448.2 4672.3 4854.1 4901.5 4956.2 5012.1 5875.5 5887.3 5890.0 5892.9 5934.5 5710.3 5712.5 5717.2 5719.3 5724.2 5643.4 5847.6 5866.8 5902.8 5935.5 5696.3 5709.0 5710.7 5712.3 5717.6 5763.5 5786.0 5789.2 5801.7 5808.0 5417.2 5548.6 5577.7 5596.4 5634.9 5570.2 5571.5 5572.2 5576.2 5581.9 5312.0 5460.5 5509.5 5515.4 5559.6 5580.5 5584.5 5637.3 5731.3 5744.3 5555.3 5555.9 5560.0 5561.8 5594.8 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#1] ext.html Cycles:180 Average:47334.55 Median:39389.41 stddev:77353.15 (196.4%) stddev-sans-first:77490.59 10:28:52 INFO - PROCESS | 20479 | Values: 610.9 624.2 627.3 640.0 645.7 42860.1 44460.8 44464.0 48223.5 48341.3 44361.0 45037.8 45052.5 45065.5 45161.8 8722.8 8889.9 8915.1 8916.2 8920.3 8772.4 8857.2 8867.0 8872.8 8884.3 8901.2 8921.8 8947.1 8964.0 8974.6 8802.2 8834.6 8867.0 8880.0 8890.6 8702.0 8792.3 8799.9 8802.0 8803.9 41955.0 42291.6 42297.4 42368.0 42440.6 3350.6 3391.3 3396.2 3582.3 3597.5 32543.3 33178.2 33386.7 33432.3 33461.7 4367.6 4374.1 4409.8 4446.2 4543.6 359168.0 363545.0 363659.0 363786.0 365093.0 62385.0 62568.4 62770.7 62898.0 63017.6 65477.0 66003.3 66029.3 66084.0 66144.7 17124.2 17460.3 17461.4 17472.3 17474.9 13128.3 13195.1 13283.2 13284.9 13292.5 18487.1 19665.4 19836.8 19986.3 19991.8 7039.7 7153.9 7203.3 7220.8 7514.5 805.9 884.8 1007.2 1120.4 1162.5 31275.4 32583.8 32670.5 32912.3 33052.8 1146.9 1182.2 1203.0 1206.1 1217.5 16902.7 17100.3 17119.2 17245.4 17250.2 163563.0 164837.0 165219.0 166243.2 167428.0 57665.4 59074.4 59158.4 59214.7 59218.0 1270.9 1288.1 1304.7 1365.7 1376.5 25660.6 32353.0 33355.0 33499.7 33973.5 51508.5 51979.2 52179.5 52207.7 52230.2 316998.0 317270.0 317278.0 317778.0 317826.0 23909.5 28110.0 28220.0 28372.3 29774.4 46714.3 46773.3 47139.5 47701.5 47724.5 38114.6 39455.2 39548.2 39830.0 39871.4 37840.6 38195.8 38352.8 38746.6 39323.6 36339.8 38354.8 40901.0 40984.4 41872.8 35119.6 36807.3 37357.6 37366.8 37609.8 27589.0 27712.7 28136.7 28169.3 28407.7 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#2] jquery.html Cycles:180 Average:28803.99 Median:2365.47 stddev:81348.35 (3439.0%) stddev-sans-first:81548.56 10:28:52 INFO - PROCESS | 20479 | Values: 383.0 384.7 389.2 398.1 415.0 18549.4 18824.5 20103.2 20227.1 20234.3 11871.3 12513.7 12518.1 12543.6 18042.2 5069.2 5279.5 5309.8 5320.1 5327.1 3818.9 4123.3 5165.9 6444.6 6560.8 6310.7 6454.7 6469.7 6504.5 6518.6 6269.2 6388.3 6426.5 6466.8 6473.2 3732.0 5179.9 5421.4 5436.5 5715.1 13523.6 13791.6 13876.6 13945.9 14144.2 2077.8 2244.3 2285.1 2302.6 2428.3 9678.8 9797.3 10334.0 10584.9 14131.7 1886.8 1897.7 1904.3 1927.2 2010.7 78303.6 83758.0 83841.0 84010.6 85134.6 11195.0 11218.7 11325.6 11681.3 11811.6 15626.1 15654.0 15698.5 15717.1 15728.5 8056.0 8295.6 8377.0 8478.5 8513.1 8059.2 8107.4 8254.0 8367.2 8393.2 4702.2 4715.5 4788.4 4866.7 4928.3 1871.4 1936.1 1936.5 1947.9 1956.4 897.6 956.2 977.4 985.4 1023.7 17667.1 19128.0 19289.1 19388.0 19549.5 1011.7 1038.2 1043.0 1045.4 1051.2 10447.5 10907.7 10969.0 11019.3 11021.9 477818.0 484834.0 490649.0 503311.0 504811.0 93342.5 96810.0 97048.0 97478.0 97541.5 1010.4 1019.3 1036.9 1039.1 1041.2 17096.9 17148.9 17262.3 17320.6 17480.1 29504.0 37898.8 40086.6 40302.2 40447.8 55904.0 58229.0 58547.0 59762.1 60196.0 8521.2 8624.1 8691.0 8782.8 8918.1 9604.0 12343.0 13255.9 13284.2 13473.3 12018.3 12116.8 12175.0 12202.8 12333.5 11589.8 11899.7 11959.5 12160.1 12271.1 12020.0 12057.4 12191.9 12343.3 12478.3 8771.4 8778.6 8803.3 8829.4 8983.5 8984.9 11210.3 11820.2 12097.4 12118.5 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#3] mootools.html Cycles:180 Average:5658.63 Median:4626.82 stddev:3161.57 (68.3%) stddev-sans-first:3153.62 10:28:52 INFO - PROCESS | 20479 | Values: 1318.7 1507.8 1548.2 1638.3 1778.0 8351.1 8717.7 8719.5 8725.4 8731.7 8328.0 8509.6 8515.6 8519.7 8528.2 2020.2 2271.0 2294.0 2320.2 2362.6 2378.3 2388.7 2389.1 2390.2 2399.0 2317.3 2325.3 2341.7 2345.4 2346.3 1958.4 2209.4 2290.4 2295.3 2308.8 2268.9 2280.7 2295.4 2296.0 2298.1 8485.0 8556.5 8556.9 8570.2 8572.3 5099.1 5239.0 5242.9 5246.6 5251.1 3136.5 3290.1 3363.4 3368.6 3389.4 1120.5 1132.6 1135.9 1149.2 1180.0 11729.6 11955.7 11969.8 12001.4 12007.2 4459.9 4579.8 4656.2 4695.4 4699.3 10031.1 10040.8 10051.4 10052.0 10055.5 5174.4 5187.3 5188.0 5188.3 5189.7 4070.7 4505.3 4604.1 4613.7 4640.0 3852.4 3863.6 3918.1 3919.8 4045.2 1174.2 1175.7 1186.2 1201.3 1226.0 1010.8 1014.3 1015.9 1023.8 1029.1 5700.4 5937.1 5954.1 6006.5 6073.0 1008.9 1022.5 1025.2 1064.0 1145.9 4017.9 4089.5 4146.2 4203.9 4233.7 10406.8 10653.1 10701.9 10733.9 10734.6 10331.1 10612.5 10615.6 10632.4 10659.1 7751.7 7862.6 7880.9 7935.9 7996.3 5804.6 5885.6 5971.0 5974.6 6011.6 9400.4 9727.0 9727.9 9744.7 9785.3 9598.1 9847.8 9868.0 9936.2 9962.4 6845.5 7005.5 7326.3 7342.8 7364.3 7919.2 7963.7 7992.5 8010.2 8046.2 7086.4 7226.4 7314.6 7512.5 7624.5 7128.6 7285.3 7324.6 7331.9 7581.2 6959.2 6977.5 7014.6 7028.3 7032.7 4920.4 5015.2 5071.4 5244.0 5246.2 5179.5 5253.2 5282.6 5316.0 5481.3 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#4] prototype.html Cycles:180 Average:4587.68 Median:5311.67 stddev:1351.16 (25.4%) stddev-sans-first:1316.43 10:28:52 INFO - PROCESS | 20479 | Values: 319.7 327.4 330.8 331.1 336.3 5244.4 5314.5 5317.4 5320.3 5334.8 5229.2 5252.9 5275.6 5305.3 5316.6 3912.9 3965.1 4050.4 4051.6 4075.6 4049.5 4068.9 4070.2 4073.2 4084.0 3909.7 4019.9 4024.5 4034.9 4053.4 3804.3 3996.9 4046.8 4073.8 4117.5 3632.6 3639.4 3646.3 3646.5 3660.3 5023.9 5028.6 5030.8 5032.8 5036.1 4522.6 4650.2 4651.6 4682.5 4696.4 5276.8 5295.9 5296.2 5349.8 5401.8 3741.9 3845.3 3957.2 3984.9 4022.9 5604.1 5619.8 5622.2 5627.7 5629.4 3981.2 3991.4 3999.9 4002.9 4006.6 3920.2 4036.7 4051.8 4054.5 4100.7 4551.1 4613.7 4639.2 4639.4 4642.5 5376.1 5401.1 5422.7 5431.8 5432.3 1362.9 1389.3 1390.4 1403.0 1404.8 880.9 889.5 925.2 926.3 940.6 5199.9 5322.3 5327.7 5328.5 5329.7 5539.7 5573.5 5590.9 5619.7 5634.0 5015.7 5255.3 5304.7 5308.8 5335.6 2900.8 2959.8 2962.9 2963.9 2979.2 5705.0 5721.3 5721.6 5761.4 5776.8 5535.1 5559.5 5605.5 5659.8 5660.9 5728.7 5740.5 5747.7 5749.5 5764.8 5366.8 5578.1 5583.8 5588.3 5598.2 5529.9 5534.5 5539.9 5540.9 5544.0 5710.7 5794.5 5803.2 5817.2 5824.5 3700.6 3734.4 3822.3 4052.1 4064.1 5615.0 5648.8 5653.3 5658.9 5664.5 5521.3 5521.8 5531.4 5539.2 5546.5 5368.3 5377.0 5417.4 5422.1 5426.3 5134.6 5271.5 5322.4 5323.5 5343.4 5396.8 5492.5 5506.9 5517.0 5532.3 5305.4 5334.8 5335.5 5348.1 5381.8 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - PROCESS | 20479 | [#5] yui.html Cycles:180 Average:19957.93 Median:4996.71 stddev:27561.13 (551.6%) stddev-sans-first:27600.47 10:28:52 INFO - PROCESS | 20479 | Values: 687.8 712.6 764.8 801.2 824.6 15296.9 15483.2 16264.4 16291.7 16301.8 14394.0 14791.1 15270.7 15282.8 15308.9 808.0 808.5 819.0 819.2 820.3 679.1 801.3 816.7 820.7 826.9 844.1 846.1 846.2 846.8 848.1 712.4 840.4 841.2 841.3 842.3 608.7 612.5 612.8 619.1 624.8 14791.0 14941.9 14946.3 14967.0 14975.7 13311.4 14132.5 14223.3 14314.9 14546.7 12362.3 12587.7 12596.7 12611.9 12712.6 4456.1 4499.5 4518.2 4578.1 4585.6 77860.6 77874.0 77962.0 78257.2 78329.6 11219.6 11317.6 11625.2 11734.9 12094.2 21018.7 21019.3 21046.3 21102.3 21239.7 8522.4 8621.2 8904.0 8913.9 9071.9 4707.4 4875.6 4912.9 4932.5 5098.6 3459.9 3577.3 3579.3 3580.2 3580.8 576.8 580.4 587.3 587.4 599.6 643.6 657.3 672.4 688.2 696.4 9699.2 9764.0 9767.7 9798.8 9816.3 543.5 605.3 627.2 638.2 667.4 4782.6 4969.0 4995.3 4998.1 5002.9 71861.0 73680.3 74611.6 75076.6 117233.4 74237.0 75199.6 101879.0 105195.0 110652.4 88758.0 89363.0 89392.1 90543.5 91596.0 9165.8 9241.4 9312.8 9333.5 9586.9 51123.2 52821.5 53091.7 53721.7 54407.5 54944.7 74472.6 76383.6 76442.6 77368.6 11217.8 11643.4 11908.3 12252.2 13555.6 14169.9 14367.9 15065.5 15119.1 15162.3 13893.4 14256.3 14294.6 14494.9 14556.4 13796.8 14424.2 14482.8 14788.8 14857.3 13783.7 14100.4 14135.4 14213.9 14601.8 10094.0 10200.2 10308.2 10313.0 10780.2 11585.3 11747.6 11903.6 11978.9 12131.0 10:28:52 INFO - PROCESS | 20479 | -------- Summary: end -------- 10:28:52 INFO - PROCESS | 20479 | 10:28:52 INFO - TEST-INFO | 20479: exit 0 10:28:52 INFO - TEST-OK | dromaeo_css | took 1111941ms 10:28:52 INFO - TEST-START | kraken 10:28:52 INFO - operating with platform_type : linux_ 10:28:52 INFO - Initialising browser for kraken test... 10:28:52 INFO - TEST-INFO | started process 20657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoTBP6/profile http://localhost:42850/getInfo.html) 10:28:56 INFO - PROCESS | 20657 | __metrics Screen width/height:1600/1200 10:28:56 INFO - PROCESS | 20657 | colorDepth:24 10:28:56 INFO - PROCESS | 20657 | Browser inner width/height: 1024/697 10:28:56 INFO - PROCESS | 20657 | __metrics 10:28:57 ERROR - PROCESS | 20657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:28:57 INFO - TEST-INFO | 20657: exit 0 10:28:57 INFO - Browser initialized. 10:28:57 INFO - Running cycle 1/1 for kraken test... 10:28:57 INFO - TEST-INFO | started process 20737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoTBP6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:09 INFO - PROCESS | 20737 | RSS: Main: 156250112 10:29:09 INFO - PROCESS | 20737 | 10:29:12 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42850/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:13 INFO - PROCESS | 20737 | RSS: Main: 214429696 10:29:13 INFO - PROCESS | 20737 | 10:29:15 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42850/tests/kraken/driver.html?testName=audio-dft) 10:29:16 INFO - PROCESS | 20737 | RSS: Main: 197713920 10:29:16 INFO - PROCESS | 20737 | 10:29:19 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42850/tests/kraken/driver.html?testName=audio-fft) 10:29:19 INFO - PROCESS | 20737 | RSS: Main: 267997184 10:29:19 INFO - PROCESS | 20737 | 10:29:21 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42850/tests/kraken/driver.html?testName=audio-oscillator) 10:29:22 INFO - PROCESS | 20737 | RSS: Main: 179384320 10:29:22 INFO - PROCESS | 20737 | 10:29:24 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:25 INFO - PROCESS | 20737 | RSS: Main: 183287808 10:29:25 INFO - PROCESS | 20737 | 10:29:28 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42850/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:28 INFO - PROCESS | 20737 | RSS: Main: 217694208 10:29:28 INFO - PROCESS | 20737 | 10:29:32 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42850/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:32 INFO - PROCESS | 20737 | RSS: Main: 220176384 10:29:32 INFO - PROCESS | 20737 | 10:29:35 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42850/tests/kraken/driver.html?testName=json-parse-financial) 10:29:36 INFO - PROCESS | 20737 | RSS: Main: 220041216 10:29:36 INFO - PROCESS | 20737 | 10:29:37 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:38 INFO - PROCESS | 20737 | RSS: Main: 208814080 10:29:38 INFO - PROCESS | 20737 | 10:29:40 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:40 INFO - PROCESS | 20737 | RSS: Main: 210542592 10:29:40 INFO - PROCESS | 20737 | 10:29:42 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:43 INFO - PROCESS | 20737 | RSS: Main: 216870912 10:29:43 INFO - PROCESS | 20737 | 10:29:46 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:46 INFO - PROCESS | 20737 | RSS: Main: 222846976 10:29:46 INFO - PROCESS | 20737 | 10:29:49 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:49 INFO - PROCESS | 20737 | RSS: Main: 220209152 10:29:49 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | Cycle 1(1): loaded http://localhost:42850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42850/tests/kraken/driver.html?testName=ai-astar) 10:29:51 INFO - PROCESS | 20737 | RSS: Main: 262963200 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | __start_tp_report 10:29:51 INFO - PROCESS | 20737 | _x_x_mozilla_page_load 10:29:51 INFO - PROCESS | 20737 | _x_x_mozilla_page_load_details 10:29:51 INFO - PROCESS | 20737 | |i|pagename|runs| 10:29:51 INFO - PROCESS | 20737 | |0;ai-astar;111;105;111;111;110;111;111;109;109;109 10:29:51 INFO - PROCESS | 20737 | |1;audio-beat-detection;156;134;125;181;126;135;148;126;157;125 10:29:51 INFO - PROCESS | 20737 | |2;audio-dft;160;160;161;159;159;160;160;163;161;160 10:29:51 INFO - PROCESS | 20737 | |3;audio-fft;75;74;76;124;75;74;76;76;97;74 10:29:51 INFO - PROCESS | 20737 | |4;audio-oscillator;83;83;110;83;83;82;116;82;83;131 10:29:51 INFO - PROCESS | 20737 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;117;117 10:29:51 INFO - PROCESS | 20737 | |6;imaging-darkroom;146;145;146;146;146;145;147;146;146;145 10:29:51 INFO - PROCESS | 20737 | |7;imaging-desaturate;95;95;94;95;95;94;94;94;95;95 10:29:51 INFO - PROCESS | 20737 | |8;json-parse-financial;53;54;53;52;53;54;53;54;52;53 10:29:51 INFO - PROCESS | 20737 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;61;61;61 10:29:51 INFO - PROCESS | 20737 | |10;stanford-crypto-aes;79;79;86;87;81;80;81;81;118;80 10:29:51 INFO - PROCESS | 20737 | |11;stanford-crypto-ccm;127;123;121;134;121;118;125;121;140;122 10:29:51 INFO - PROCESS | 20737 | |12;stanford-crypto-pbkdf2;163;161;171;160;161;164;167;160;163;166 10:29:51 INFO - PROCESS | 20737 | |13;stanford-crypto-sha256-iterative;66;64;67;62;62;63;64;61;62;61 10:29:51 INFO - PROCESS | 20737 | __end_tp_report 10:29:51 INFO - PROCESS | 20737 | __start_cc_report 10:29:51 INFO - PROCESS | 20737 | _x_x_mozilla_cycle_collect,1621 10:29:51 INFO - PROCESS | 20737 | __end_cc_report 10:29:51 INFO - PROCESS | 20737 | __startTimestamp1464802191894__endTimestamp 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | ------- Summary: start ------- 10:29:51 INFO - PROCESS | 20737 | Number of tests: 14 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:1.94 10:29:51 INFO - PROCESS | 20737 | Values: 111.0 105.0 111.0 111.0 110.0 111.0 111.0 109.0 109.0 109.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:141.50 stddev:18.79 (13.3%) stddev-sans-first:19.16 10:29:51 INFO - PROCESS | 20737 | Values: 156.0 134.0 125.0 181.0 126.0 135.0 148.0 126.0 157.0 125.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 10:29:51 INFO - PROCESS | 20737 | Values: 160.0 160.0 161.0 159.0 159.0 160.0 160.0 163.0 161.0 160.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:16.29 (21.6%) stddev-sans-first:17.07 10:29:51 INFO - PROCESS | 20737 | Values: 75.0 74.0 76.0 124.0 75.0 74.0 76.0 76.0 97.0 74.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:18.26 (22.0%) stddev-sans-first:18.96 10:29:51 INFO - PROCESS | 20737 | Values: 83.0 83.0 110.0 83.0 83.0 82.0 116.0 82.0 83.0 131.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:29:51 INFO - PROCESS | 20737 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:29:51 INFO - PROCESS | 20737 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:29:51 INFO - PROCESS | 20737 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 10:29:51 INFO - PROCESS | 20737 | Values: 53.0 54.0 53.0 52.0 53.0 54.0 53.0 54.0 52.0 53.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 10:29:51 INFO - PROCESS | 20737 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:81.00 stddev:11.85 (14.6%) stddev-sans-first:12.35 10:29:51 INFO - PROCESS | 20737 | Values: 79.0 79.0 86.0 87.0 81.0 80.0 81.0 81.0 118.0 80.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.00 stddev:6.83 (5.5%) stddev-sans-first:7.21 10:29:51 INFO - PROCESS | 20737 | Values: 127.0 123.0 121.0 134.0 121.0 118.0 125.0 121.0 140.0 122.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.50 stddev:3.53 (2.2%) stddev-sans-first:3.74 10:29:51 INFO - PROCESS | 20737 | Values: 163.0 161.0 171.0 160.0 161.0 164.0 167.0 160.0 163.0 166.0 10:29:51 INFO - PROCESS | 20737 | 10:29:51 INFO - PROCESS | 20737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:2.04 (3.2%) stddev-sans-first:1.90 10:29:51 INFO - PROCESS | 20737 | Values: 66.0 64.0 67.0 62.0 62.0 63.0 64.0 61.0 62.0 61.0 10:29:51 INFO - PROCESS | 20737 | -------- Summary: end -------- 10:29:51 INFO - PROCESS | 20737 | 10:29:52 INFO - TEST-INFO | 20737: exit 0 10:29:52 INFO - TEST-OK | kraken | took 60036ms 10:29:52 INFO - SUITE-END | took 1171s 10:29:53 INFO - Completed test suite (00:19:32) 10:29:53 INFO - javascript benchmark 10:29:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.331787006859, 3069.7237248647625, 3085.6142982127235, 3096.4735994880866, 3128.6558478567354, 5162.303089082972, 5198.40218374887, 5259.421463639002, 5263.0263401270795, 5288.6562373445695, 5234.267202591631, 5236.005159019784, 5284.682919024852, 5290.576753859692, 5335.759890804913, 4813.518648135176, 4833.0, 4882.97558512207, 4887.511248875102, 5063.265826455162, 4929.063477939198, 4949.950500494985, 4950.529699678543, 4998.650094493387, 5027.622928280393, 4728.810847566093, 4756.904861902777, 4781.713097214179, 4814.614830813526, 4842.588379987706, 4800.879978000578, 4802.0, 4802.495737947535, 4803.063402636487, 4903.558679718807, 4808.783604737795, 4821.0, 4828.782704778293, 4830.3720516333005, 4891.290762839369, 5091.032703786269, 5215.765290561933, 5277.551408130314, 5280.1815718563685, 5293.4971177738435, 5755.827325180251, 5756.136579513065, 5764.625299355528, 5778.566607504454, 5780.653160810322, 5791.21818554494, 5805.216295800097, 5809.0, 5813.79651712188, 5813.854653633651, 5199.0, 5284.524392804666, 5326.680399176062, 5331.920021199724, 5397.0285348636835, 5867.911981320283, 5877.089051197071, 5879.735411906475, 5880.500157486576, 5882.264716910387, 5360.383555891044, 5660.2075709400715, 5669.886602267931, 5671.461211184931, 5674.744636491368, 5647.350554686263, 5697.088465845445, 5698.7435565399655, 5752.971235143881, 5753.252077229933, 5708.971455142698, 5714.114312281603, 5721.113227449669, 5731.971340143273, 5734.885302293931, 5489.286392768914, 5661.66030038199, 5701.942980570141, 5713.514351280104, 5714.3999880012, 4325.632321252729, 4354.085642015212, 4381.759003254851, 4420.336949457607, 4423.336499525032, 3877.747946383476, 3895.337792575269, 3910.550286717064, 3912.197999410114, 3936.527616685959, 5128.9230661540105, 5145.4597267287145, 5368.812091576776, 5455.09990851513, 5488.286522752017, 5715.828525144252, 5738.655680659173, 5774.480296773227, 5775.94224057754, 5827.446392592697, 5427.1316589345515, 5438.021156191923, 5444.346678398539, 5445.047116754552, 5448.182772584065, 4672.275797251432, 4854.053459575349, 4901.460839307673, 4956.179814379372, 5012.122878496249, 5875.500582450454, 5887.293524777054, 5889.970550147222, 5892.852678682982, 5934.525237980951, 5710.2862142232225, 5712.514436272963, 5717.22817419643, 5719.3136823581435, 5724.227229323988, 5643.35101463337, 5847.561432892635, 5866.765329386777, 5902.793402230901, 5935.525157987437, 5696.344920334214, 5709.0, 5710.685912274865, 5712.314522257356, 5717.599768016199, 5763.452472015152, 5786.045302525036, 5789.1895134680335, 5801.738921748616, 5808.0, 5417.187421886749, 5548.639338443149, 5577.721113944368, 5596.356419011703, 5634.915476267777, 5570.19232211319, 5571.470710282517, 5572.247746554163, 5576.191452239484, 5581.888362232651, 5312.043832110257, 5460.508554229979, 5509.531689806411, 5515.393306736336, 5559.610827242054, 5580.525655319181, 5584.46947539983, 5637.295338082739, 5731.254936858182, 5744.310682718101, 5555.2500412445415, 5555.8888822222525, 5559.972200138974, 5561.833145005657, 5594.832155035356], "value": 5263.297063716483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8686632374039, 624.2197253433209, 627.2535682537782, 640.0015975078877, 645.7255666341804, 42860.142797144035, 44460.77769611155, 44464.0, 48223.51776482234, 48341.274880876816, 44361.0, 45037.77481112598, 45052.54947450524, 45065.549344506544, 45161.77419112908, 8722.781930451758, 8889.866652000224, 8915.063918288584, 8916.15296546827, 8920.28637708985, 8772.429792063496, 8857.247133993586, 8867.024627290994, 8872.822543549157, 8884.289256859436, 8901.243394311492, 8921.776955576097, 8947.105289471034, 8964.0, 8974.59614317354, 8802.16379443955, 8834.646614135427, 8866.955665221698, 8879.95560022199, 8890.555472226428, 8702.042775294713, 8792.296616270683, 8799.912000880036, 8802.0, 8803.911960880438, 41955.0, 42291.57708422907, 42297.36553951693, 42368.0, 42440.57559424397, 3350.5811773528308, 3391.270876761508, 3396.218869659992, 3582.301451217014, 3597.460380942853, 32543.349133017444, 33178.170545736306, 33386.66613333884, 33432.33135337304, 33461.665383346095, 4367.628751556122, 4374.103308821684, 4409.845655402046, 4446.155230506226, 4543.5910768031035, 359168.0, 363545.0, 363658.9999999974, 363786.0, 365093.0, 62385.0, 62568.37431625716, 62770.68614656897, 62898.0, 63017.58876878575, 65477.0, 66003.33996659971, 66029.33970660232, 66084.0, 66144.66927665331, 17124.229409676595, 17460.30158793634, 17461.38885139014, 17472.30110795554, 17474.912625437046, 13128.34358282082, 13195.142315749446, 13283.203007819562, 13284.933575332061, 13292.534761283501, 18487.135112489774, 19665.410037698894, 19836.801631983497, 19986.300479483147, 19991.800081998994, 7039.683214255371, 7153.92846071543, 7203.279672032755, 7220.761563915203, 7514.511556748794, 805.899262592176, 884.7655371326604, 1007.2345017786535, 1120.4005856866538, 1162.4594563528, 31275.400042884397, 32583.83708081492, 32670.509942350884, 32912.3417531648, 33052.83473582617, 1146.9139814513944, 1182.2315494928366, 1203.0375699440413, 1206.1255589697575, 1217.4582310871576, 16902.74645880288, 17100.315987360616, 17119.22963466647, 17245.396411125552, 17250.223739931484, 163563.0, 164837.0, 165219.0, 166243.1687841553, 167428.0, 57665.423345766845, 59074.40925590775, 59158.40841591615, 59214.70392648009, 59218.0, 1270.8729127087217, 1288.0532808385829, 1304.6673098359859, 1365.7473367427058, 1376.4769387632837, 25660.61509077328, 32353.0, 33355.0, 33499.66500335063, 33973.49039764356, 51508.484915151865, 51979.2203116946, 52179.47820521746, 52207.73896130495, 52230.21654675259, 316998.0, 317270.0, 317278.0, 317778.0, 317826.0, 23909.52180956406, 28110.0, 28220.0, 28372.290692732848, 29774.404511909208, 46714.29928551142, 46773.29840052334, 47139.528604713516, 47701.522984769705, 47724.522754772006, 38114.61885381111, 39455.2108957825, 39548.209035819695, 39830.0, 39871.40192897051, 37840.62159378481, 38195.809020954715, 38352.80823595864, 38746.6125338743, 39323.606763931995, 36339.818300909385, 38354.80822595981, 40901.0, 40984.385234220914, 41872.79063604662, 35119.64880351266, 36807.26385472329, 37357.62642373541, 37366.813165934, 37609.81195094007, 27589.0, 27712.722872771013, 28136.71863281341, 28169.295767605974, 28407.715922840507], "value": 19487.542979129503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9889092795021, 384.73261083546936, 389.1749491078911, 398.09036351935833, 414.9917001659967, 18549.35077272296, 18824.529386765338, 20103.195872165114, 20227.089780959854, 20234.29179978701, 11871.287722736643, 12513.749725005495, 12518.12373133881, 12543.55749088855, 18042.18810153543, 5069.214271787879, 5279.524842764151, 5309.787608495675, 5320.122179840322, 5327.121025030885, 3818.9045273868096, 4123.257813593552, 5165.940982098679, 6444.581102228363, 6560.803175904731, 6310.716017779211, 6454.709538070774, 6469.74121035158, 6504.512161587876, 6518.608883466984, 6269.153664255313, 6388.329225431333, 6426.518011149135, 6466.805995820109, 6473.158489396372, 3731.9626803731885, 5179.870503237412, 5421.376541697677, 5436.483534064258, 5715.057015592422, 13523.59429217125, 13791.586252412444, 13876.58370248884, 13945.930270348685, 14144.151350918875, 2077.8129968302924, 2244.259394399844, 2285.0973865323103, 2302.6315789473606, 2428.307932239303, 9678.806423871483, 9797.265205109574, 10334.0, 10584.894151058468, 14131.717365652732, 1886.820752028555, 1897.7438045863908, 1904.2954106980367, 1927.152053096633, 2010.7486564179478, 78303.60848195723, 83758.0, 83841.0, 84010.57994709988, 85134.57432712796, 11195.0, 11218.66344009681, 11325.603603873826, 11681.299122052704, 11811.586594469152, 15626.062436253862, 15654.0, 15698.529044128694, 15717.135557544445, 15728.528144155694, 8055.959720201478, 8295.58522073906, 8377.036640786266, 8478.5336806475, 8513.148685131437, 8059.234372734581, 8107.4324797263625, 8253.95873020631, 8367.205115514016, 8393.202645748644, 4702.177119004161, 4715.528447155257, 4788.449328327218, 4866.7079975201605, 4928.310036594879, 1871.401151631492, 1936.1219616971516, 1936.5061909213061, 1947.9026048697508, 1956.434852118328, 897.5871099294267, 956.1872408452759, 977.4428575711776, 985.3939827006483, 1023.6775415744016, 17667.11664416774, 19128.0, 19289.131989060246, 19388.03059847002, 19549.51126221856, 1011.6560369474414, 1038.1850247555633, 1042.9843552346722, 1045.3884477580548, 1051.2431049644244, 10447.529861156267, 10907.727306817393, 10969.0, 11019.283746556448, 11021.889781102247, 477818.0, 484834.0, 490649.0, 503311.0, 504811.0, 93342.53328733314, 96810.0, 97048.0, 97478.0, 97541.51229243808, 1010.4089107871977, 1019.2661283875598, 1036.9014943580348, 1039.1115596165473, 1041.193075366597, 17096.914515427343, 17148.874792252023, 17262.309507619553, 17320.566985825455, 17480.12599370001, 29504.0, 37898.810505947295, 40086.599134009455, 40302.1939561213, 40447.79776101101, 55904.0, 58229.0, 58547.0, 59762.10356844564, 60196.0, 8521.233089022018, 8624.09447008055, 8691.0, 8782.780430489289, 8918.063603321558, 9604.0, 12343.0, 13255.867441325849, 13284.202947823162, 13473.32633368308, 12018.278903265833, 12116.818247726114, 12175.0, 12202.81695774582, 12333.50665973351, 11589.82615260755, 11899.702507437383, 11959.521619135137, 12160.148789584644, 12271.141020128505, 12020.0, 12057.397130143283, 12191.878081219074, 12343.321117338633, 12478.25130492137, 8771.429857059271, 8778.56107194625, 8803.339749518684, 8829.426087304304, 8983.46099234048, 8984.910150898408, 11210.327380356879, 11820.23168494045, 12097.395130243276, 12118.454669540068], "value": 9054.101192860966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.650557602235, 1507.7587585986244, 1548.1872017190974, 1638.2709694186092, 1777.9911100444497, 8351.123132071129, 8717.651293948235, 8719.520426376546, 8725.38922275441, 8731.738047858567, 8328.0, 8509.574521273928, 8515.574221288942, 8519.701810436636, 8528.232459078681, 2020.171729590868, 2270.9886450567724, 2293.9541209175804, 2320.2227253869974, 2362.586547354215, 2378.298401971414, 2388.725296590897, 2389.0682633772844, 2390.1634427950166, 2398.9880050599722, 2317.2700599311247, 2325.2791634593245, 2341.7424083350816, 2345.3901985483812, 2346.2843832631042, 1958.3831093205595, 2209.4365936686204, 2290.393045842853, 2295.254042436215, 2308.803751681109, 2268.875211863347, 2280.703508543879, 2295.3802473332107, 2296.0356650206954, 2298.092253559851, 8485.0, 8556.5293908835, 8556.871646925301, 8570.228679418882, 8572.314214862796, 5099.08216521026, 5239.0, 5242.895142097175, 5246.580273578143, 5251.054810134175, 3136.466800643896, 3290.1116698491514, 3363.394588973984, 3368.59576850777, 3389.3729660012978, 1120.490176969477, 1132.631894634239, 1135.8977692007759, 1149.1668540308294, 1180.0441642269789, 11729.64811055661, 11955.701107472383, 11969.760604787856, 12001.399930003465, 12007.159498834997, 4459.910801783946, 4579.771261260803, 4656.185167595657, 4695.436547614308, 4699.295105734167, 10031.147352474976, 10040.79918401628, 10051.447170405698, 10052.0, 10055.547500362354, 5174.404943431554, 5187.273781670569, 5187.974060129675, 5188.273641690166, 5189.662671926313, 4070.7354021988476, 4505.279155335131, 4604.148232576984, 4613.677042606985, 4639.9536004640195, 3852.3643598805884, 3863.594322596087, 3918.0792513759243, 3919.804009799556, 4045.231406032903, 1174.2074099982478, 1175.7178277213407, 1186.2348785033778, 1201.2732296960387, 1225.993870030662, 1010.7523656704154, 1014.3457469932, 1015.9085682288629, 1023.8003589300164, 1029.089256008423, 5700.40145784695, 5937.139114828326, 5954.10688396744, 6006.519478441714, 6073.0, 1008.8839783424853, 1022.4632068164274, 1025.2105878473683, 1063.9627613033506, 1145.851039364894, 4017.9397309040387, 4089.5092588889524, 4146.1914926589025, 4203.873883783492, 4233.724807887539, 10406.791864162675, 10653.094486968694, 10701.946490267499, 10733.946330268298, 10734.624288149877, 10331.12185464229, 10612.469376531142, 10615.628453004108, 10632.362058276529, 10659.093977011886, 7751.728689495841, 7862.567558784322, 7880.881786773203, 7935.880961785578, 7996.320312773363, 5804.622699524517, 5885.646861188171, 5970.984932561388, 5974.61165024272, 6011.579189456696, 9400.435973841591, 9727.027297270217, 9727.902720972983, 9744.707658770249, 9785.315027947976, 9598.088181622734, 9847.753806154904, 9867.950660246654, 9936.20510359184, 9962.402255864672, 6845.4865885057825, 7005.54463959841, 7326.3040011198855, 7342.816429589303, 7364.263573642593, 7919.208079192034, 7963.721269755531, 7992.480488768211, 8010.198980101944, 8046.155153708776, 7086.362227399559, 7226.4218862491925, 7314.597697126496, 7512.511686740344, 7624.504407213513, 7128.643567821485, 7285.307895749896, 7324.633768311456, 7331.8533629328185, 7581.166071732216, 6959.164900212007, 6977.476689248225, 7014.649267536704, 7028.332308430691, 7032.718691252498, 4920.36035315421, 5015.154596728953, 5071.39143302806, 5244.0, 5246.239295302236, 5179.48205179479, 5253.185756207794, 5282.603804714585, 5316.0, 5481.314835645544], "value": 4570.218498350442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7106618510249, 327.36327842346634, 330.7701147702347, 331.0531878826557, 336.2535171918342, 5244.423113457521, 5314.495122963317, 5317.388500322464, 5320.324097909156, 5334.786608535659, 5229.163333866582, 5252.925094587636, 5275.577953763699, 5305.310309659739, 5316.627836051478, 3912.902177445558, 3965.0682089708966, 4050.4126901599398, 4051.554329023805, 4075.551689314188, 4049.5140583130064, 4068.9389659155136, 4070.2470043041985, 4073.2260870434525, 4083.9591604084026, 3909.7263191576603, 4019.859304924328, 4024.5249171759306, 4034.878953631381, 4053.3919912013284, 3804.258169656918, 3996.9200615987515, 4046.7571945683208, 4073.775942323171, 4117.464729585135, 3632.5640923089136, 3639.4358874374248, 3646.3409148837213, 3646.507721457596, 3660.2679464107287, 5023.899522009576, 5028.647994640377, 5030.8239211627415, 5032.823851165192, 5036.143855544529, 4522.638188944877, 4650.232711602582, 4651.62786977041, 4682.531746825291, 4696.412948381452, 5276.7889284428575, 5295.947040529584, 5296.179092240709, 5349.839504814823, 5401.810936617199, 3741.8877433677035, 3845.3462911305146, 3957.248122856648, 3984.940225896614, 4022.859199928018, 5604.131359639263, 5619.831405057855, 5622.156676498517, 5627.746751396197, 5629.3526244482, 3981.1639555693628, 3991.3613821788376, 3999.9400008999305, 4002.939955900664, 4006.599340066028, 3920.196359746245, 4036.6972477064337, 4051.7974101294817, 4054.493188351456, 4100.671946244293, 4551.134035045616, 4613.700109492872, 4639.234526303122, 4639.396878405853, 4642.489326174118, 5376.086065368897, 5401.1358182691365, 5422.719254850837, 5431.755570999236, 5432.320959880015, 1362.9318534073257, 1389.3192335755407, 1390.3951780975308, 1402.95089671861, 1404.7752359622411, 880.9119088091139, 889.4840992224495, 925.2043242811177, 926.323783637948, 940.6331530703031, 5199.922001169985, 5322.28149199853, 5327.680339179662, 5328.4671532846405, 5329.733513324319, 5539.723013849291, 5573.526250268773, 5590.86022849432, 5619.7471113799975, 5634.0, 5015.749212539358, 5255.316808814906, 5304.655197412156, 5308.840734777963, 5335.626506144533, 2900.825165807809, 2959.792814502964, 2962.9111126666235, 2963.9259018524276, 2979.2254013956526, 5704.971475142681, 5721.313442386857, 5721.628094173865, 5761.423857614205, 5776.797812076557, 5535.1180598596675, 5559.527440167551, 5605.523530499871, 5659.830205093854, 5660.943390566124, 5728.713564321851, 5740.512056475163, 5747.700919632181, 5749.453801888814, 5764.798232061858, 5366.812161574326, 5578.135389014709, 5583.776648933997, 5588.30146231721, 5598.244237027949, 5529.944700552943, 5534.4742249486235, 5539.8892022160135, 5540.944590554042, 5543.972280138735, 5710.714464276853, 5794.507466865363, 5803.216565763568, 5817.185594016925, 5824.475797178275, 3700.5744339401313, 3734.383826668678, 3822.311983842824, 4052.149048699806, 4064.1058967027207, 5615.0, 5648.802291919763, 5653.293338332708, 5658.915116273177, 5664.49019588239, 5521.254630624975, 5521.751521181637, 5531.391546929754, 5539.169124631177, 5546.500814926676, 5368.32895888014, 5377.0, 5417.377001644862, 5422.105352616932, 5426.348838139448, 5134.640575159852, 5271.499207575274, 5322.387925388475, 5323.467653234646, 5343.3587969443915, 5396.757145928521, 5492.505674489155, 5506.944930550643, 5516.979358818631, 5532.28080349552, 5305.408377486816, 5334.75993580282, 5335.493128152819, 5348.1442969124755, 5381.75782089799], "value": 4156.553519573995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.8177283020001, 712.6127472965569, 764.762923493717, 801.194799226777, 824.6124321568865, 15296.923515382421, 15483.225838708076, 16264.43074492393, 16291.674166516663, 16301.83698163018, 14394.0, 14791.112533248013, 15270.694586108299, 15282.770758438632, 15308.923455382708, 807.9798005049892, 808.4906508899385, 818.9918100818975, 819.1971867569786, 820.2699597358355, 679.1001922452746, 801.3348920396087, 816.6855760532178, 820.7086484298078, 826.8511667899776, 844.0968164064453, 846.1369403208723, 846.1622993236682, 846.7713717296326, 848.0755975986174, 712.3517598984898, 840.3613253926999, 841.2176675691604, 841.2933136165589, 842.3008902610849, 608.7139044649008, 612.5252928980032, 612.770211170811, 619.0961196652892, 624.7875722254455, 14791.038582492103, 14941.925290373478, 14946.252687365697, 14967.0, 14975.700485990328, 13311.40098695561, 14132.505362312373, 14223.28883555818, 14314.92842535791, 14546.709065818624, 12362.320072396014, 12587.74824503514, 12596.748065038648, 12611.873881261161, 12712.618621441372, 4456.086502267028, 4499.52754960731, 4518.186726389248, 4578.10726908253, 4585.58729714324, 77860.61069694672, 77874.0, 77961.99999999943, 78257.21742782614, 78329.60835195845, 11219.551217951353, 11317.568406570117, 11625.18623696333, 11734.88265117355, 12094.213876098025, 21018.684719729215, 21019.264325748525, 21046.2633807816, 21102.2614208502, 21239.68140477894, 8522.446041007315, 8621.161939387877, 8903.955480222687, 8913.866292005625, 9071.909280907106, 4707.411573553306, 4875.609951203895, 4912.926306105412, 4932.482089380635, 5098.592112631055, 3459.930801383958, 3577.3203091412547, 3579.302036102935, 3580.2481478889204, 3580.820958952042, 576.8413686236235, 580.3731969472959, 587.3157771196594, 587.3509771702293, 599.5892813422819, 643.6138317009757, 657.2605818454239, 672.3612568060362, 688.2051230828401, 696.4463251714899, 9699.17557007648, 9764.0, 9767.658131965347, 9798.804023919623, 9816.312858099864, 543.4972650298458, 605.2779841351436, 627.1877918096077, 638.1544453599, 667.4491704134057, 4782.617390608743, 4968.975155124202, 4995.275685025724, 4998.136507068835, 5002.949970500321, 71861.0, 73680.26319736842, 74611.62694186495, 75076.62461687656, 117233.4138329303, 74237.0, 75199.62400187964, 101879.0, 105195.0, 110652.4467377658, 88758.0, 89363.0, 89392.10607893967, 90543.54728226448, 91596.0, 9165.77085572866, 9241.353105282566, 9312.767180820534, 9333.533323333942, 9586.856197156909, 51123.233151503504, 52821.471785281654, 53091.734541327045, 53721.73139134436, 54407.45592544024, 54944.72527637336, 74472.62763686146, 76383.61808190924, 76442.6177869107, 77368.61315693386, 11217.831732523855, 11643.359615221245, 11908.285502869856, 12252.203606765532, 13555.59333220005, 14169.929150354183, 14367.928160359132, 15065.47270845559, 15119.092854428769, 15162.3176957035, 13893.374798134311, 14256.287185640469, 14294.642633934234, 14494.927525362305, 14556.41774329015, 13796.793048104488, 14424.206668633326, 14482.782758258845, 14788.778168327268, 14857.257137143315, 13783.655408614864, 14100.36548355306, 14135.363908623931, 14213.857861421668, 14601.780973285622, 10094.0, 10200.183985281308, 10308.24001037098, 10313.0, 10780.245382823126, 11585.304881707125, 11747.588834390755, 11903.642890713292, 11978.92189702931, 12131.0], "value": 7506.277203393352, "unit": "score"}], "name": "dromaeo_css", "value": 7139.482484567945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 111.0, 110.0, 111.0, 111.0, 109.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 125.0, 181.0, 126.0, 135.0, 148.0, 126.0, 157.0, 125.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 159.0, 160.0, 160.0, 163.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 124.0, 75.0, 74.0, 76.0, 76.0, 97.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 83.0, 83.0, 82.0, 116.0, 82.0, 83.0, 131.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 53.0, 54.0, 53.0, 54.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 86.0, 87.0, 81.0, 80.0, 81.0, 81.0, 118.0, 80.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 121.0, 134.0, 121.0, 118.0, 125.0, 121.0, 140.0, 122.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 171.0, 160.0, 161.0, 164.0, 167.0, 160.0, 163.0, 166.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 62.0, 62.0, 63.0, 64.0, 61.0, 62.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1495.6000000000001, "alertThreshold": 2.0}]} 10:29:53 INFO - Return code: 0 10:29:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:53 ERROR - # TBPL SUCCESS # 10:29:53 INFO - Running post-action listener: _resource_record_post_action 10:29:53 INFO - ##### 10:29:53 INFO - ##### Finished run-tests step (success) 10:29:53 INFO - ##### 10:29:53 INFO - Running post-run listener: _resource_record_post_run 10:29:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 560205824; Read time: 0; Write time: 474736 10:29:53 INFO - TinderboxPrint: CPU usage
13.1% 10:29:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:29:53 INFO - TinderboxPrint: I/O write bytes / time
560,205,824 / 474,736 10:29:53 INFO - TinderboxPrint: CPU idle
8,248.5 (86.8%) 10:29:53 INFO - TinderboxPrint: CPU user
1,207.4 (12.7%) 10:29:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247713792; Read time: 0; Write time: 283116 10:29:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294293504; Read time: 0; Write time: 187000 10:29:53 INFO - Running post-run listener: _upload_blobber_files 10:29:53 INFO - Blob upload gear active. 10:29:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:53 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 10:29:53 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'] 10:29:53 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 10:29:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:55 INFO - (blobuploader) - INFO - Done attempting. 10:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:01 INFO - (blobuploader) - INFO - Done attempting. 10:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:01 INFO - (blobuploader) - INFO - Done attempting. 10:30:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:01 INFO - Return code: 0 10:30:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ce9066f06ac6a3b780e6834db29b1b401a5c78f3d623aac00470c06d089d95f11b969db11ae5d95671eaa6c6f2c18fd986751cf1176c0095370978c892b6563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f909de868abca35b511484e3f56e540694e3d597e8cb964283ad73840244c0a94395e87316ee8cbbf5c92301c3e5791cba7f53ca8ee921d4470e79205c7a578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffccb9625c90bff7f024f311fe33cb79ce5fa22e2b2471630b7418d7c9880abf56229f816efb5f223a353c8e61d9d01d213cfcb56b5f163c1ef11650a416e33c"} 10:30:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:01 INFO - Contents: 10:30:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ce9066f06ac6a3b780e6834db29b1b401a5c78f3d623aac00470c06d089d95f11b969db11ae5d95671eaa6c6f2c18fd986751cf1176c0095370978c892b6563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f909de868abca35b511484e3f56e540694e3d597e8cb964283ad73840244c0a94395e87316ee8cbbf5c92301c3e5791cba7f53ca8ee921d4470e79205c7a578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffccb9625c90bff7f024f311fe33cb79ce5fa22e2b2471630b7418d7c9880abf56229f816efb5f223a353c8e61d9d01d213cfcb56b5f163c1ef11650a416e33c"} 10:30:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:01 INFO - Copying logs to upload dir... 10:30:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.233993 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 10:30:01.355727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:30:01.359275) ========= 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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 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/2ce9066f06ac6a3b780e6834db29b1b401a5c78f3d623aac00470c06d089d95f11b969db11ae5d95671eaa6c6f2c18fd986751cf1176c0095370978c892b6563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f909de868abca35b511484e3f56e540694e3d597e8cb964283ad73840244c0a94395e87316ee8cbbf5c92301c3e5791cba7f53ca8ee921d4470e79205c7a578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffccb9625c90bff7f024f311fe33cb79ce5fa22e2b2471630b7418d7c9880abf56229f816efb5f223a353c8e61d9d01d213cfcb56b5f163c1ef11650a416e33c"} build_url:https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/Zs-46L-sTwyYTm4cmweuhA/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/2ce9066f06ac6a3b780e6834db29b1b401a5c78f3d623aac00470c06d089d95f11b969db11ae5d95671eaa6c6f2c18fd986751cf1176c0095370978c892b6563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f909de868abca35b511484e3f56e540694e3d597e8cb964283ad73840244c0a94395e87316ee8cbbf5c92301c3e5791cba7f53ca8ee921d4470e79205c7a578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffccb9625c90bff7f024f311fe33cb79ce5fa22e2b2471630b7418d7c9880abf56229f816efb5f223a353c8e61d9d01d213cfcb56b5f163c1ef11650a416e33c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:30:01.386446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:30:01.386947) ========= 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=826874ccc97bd7bf541b4875000001d5-1464800965.774946-545832900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:30:01.468044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:30:01.468399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:30:01.468762) ========= ========= Total master_lag: 0.17 =========