builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1464229069.23 results: success (0) buildid: 20160525163027 builduid: 7872e1c46449446a99e3ac4ff9a222e9 revision: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.227508) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.227962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.228235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.243548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.243849) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 19:17:49-- 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% 219M=0s 2016-05-25 19:17:49 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.381296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.381581) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022894 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.430136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:49.430444) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc --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 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc --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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 19:17:49,847 truncating revision to first 12 chars 2016-05-25 19:17:49,847 Setting DEBUG logging. 2016-05-25 19:17:49,847 attempt 1/10 2016-05-25 19:17:49,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/35574c1aa969?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 19:17:50,153 unpacking tar archive at: mozilla-inbound-35574c1aa969/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:50.101324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:50.102089) ========= script_repo_revision: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:50.103078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:50.103737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 19:17:50.118555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-25 19:17:50.118838) ========= /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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:50 INFO - MultiFileLogger online at 20160525 19:17:50 in /builds/slave/test 19:17:50 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 19:17:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:50 INFO - {'append_to_log': False, 19:17:50 INFO - 'base_work_dir': '/builds/slave/test', 19:17:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:17:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:50 INFO - 'branch': 'Mozilla-Inbound', 19:17:50 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:50 INFO - 'config_files': ('talos/linux_config.py',), 19:17:50 INFO - 'default_actions': ('clobber', 19:17:50 INFO - 'read-buildbot-config', 19:17:50 INFO - 'download-and-extract', 19:17:50 INFO - 'populate-webroot', 19:17:50 INFO - 'create-virtualenv', 19:17:50 INFO - 'install', 19:17:50 INFO - 'run-tests'), 19:17:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:50 INFO - 'download_minidump_stackwalk': True, 19:17:50 INFO - 'download_symbols': 'ondemand', 19:17:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:50 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:50 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:50 INFO - 'installer_path': 'installer.exe', 19:17:50 INFO - 'log_level': 'info', 19:17:50 INFO - 'log_name': 'talos', 19:17:50 INFO - 'log_to_console': True, 19:17:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:50 INFO - 'opt_config_files': (), 19:17:50 INFO - 'pip_index': False, 19:17:50 INFO - 'sps_profile': False, 19:17:50 INFO - 'sps_profile_interval': 0, 19:17:50 INFO - 'suite': 'dromaeojs', 19:17:50 INFO - 'system_bits': '32', 19:17:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:50 INFO - 'title': 'talos-linux64-ix-001', 19:17:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:50 INFO - 'use_talos_json': True, 19:17:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:50 INFO - 'work_dir': 'build'} 19:17:50 INFO - ##### 19:17:50 INFO - ##### Running clobber step. 19:17:50 INFO - ##### 19:17:50 INFO - Running pre-action listener: _resource_record_pre_action 19:17:50 INFO - Running main action method: clobber 19:17:50 INFO - rmtree: /builds/slave/test/build 19:17:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:51 INFO - Running post-action listener: _resource_record_post_action 19:17:51 INFO - ##### 19:17:51 INFO - ##### Finished clobber step (success) 19:17:51 INFO - ##### 19:17:51 INFO - ##### 19:17:51 INFO - ##### Running read-buildbot-config step. 19:17:51 INFO - ##### 19:17:51 INFO - Running pre-action listener: _resource_record_pre_action 19:17:51 INFO - Running main action method: read_buildbot_config 19:17:51 INFO - Using buildbot properties: 19:17:51 INFO - { 19:17:51 INFO - "project": "", 19:17:51 INFO - "product": "firefox", 19:17:51 INFO - "script_repo_revision": "production", 19:17:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:17:51 INFO - "repository": "", 19:17:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:17:51 INFO - "buildid": "20160525163027", 19:17:51 INFO - "pgo_build": "True", 19:17:51 INFO - "basedir": "/builds/slave/test", 19:17:51 INFO - "buildnumber": 1855, 19:17:51 INFO - "slavename": "talos-linux64-ix-001", 19:17:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:17:51 INFO - "platform": "ubuntu64_hw", 19:17:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:17:51 INFO - "branch": "mozilla-inbound", 19:17:51 INFO - "repo_path": "integration/mozilla-inbound", 19:17:51 INFO - "revision": "35574c1aa9697cb60f05ba4c9d7175d1ffc59efc", 19:17:51 INFO - "stage_platform": "linux64-pgo", 19:17:51 INFO - "builduid": "7872e1c46449446a99e3ac4ff9a222e9", 19:17:51 INFO - "slavebuilddir": "test" 19:17:51 INFO - } 19:17:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:17:51 INFO - Running post-action listener: _resource_record_post_action 19:17:51 INFO - ##### 19:17:51 INFO - ##### Finished read-buildbot-config step (success) 19:17:51 INFO - ##### 19:17:51 INFO - ##### 19:17:51 INFO - ##### Running download-and-extract step. 19:17:51 INFO - ##### 19:17:51 INFO - Running pre-action listener: _resource_record_pre_action 19:17:51 INFO - Running main action method: download_and_extract 19:17:51 INFO - mkdir: /builds/slave/test/build/tests 19:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:51 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:17:52 INFO - Downloaded 1361 bytes. 19:17:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:17:52 INFO - Using the following test package requirements: 19:17:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'jsshell-linux-x86_64.zip'], 19:17:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17: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')]} 19:17:52 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:17:53 INFO - Downloaded 24408173 bytes. 19:17:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:17:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:17:55 INFO - Return code: 0 19:17:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:18:01 INFO - Downloaded 24408173 bytes. 19:18:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:18:02 INFO - Return code: 0 19:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:02 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:18:03 INFO - Downloaded 10834034 bytes. 19:18:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:18:03 INFO - Return code: 0 19:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:03 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:18:05 INFO - Downloaded 58660152 bytes. 19:18:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:18:05 INFO - mkdir: /builds/slave/test/properties 19:18:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:05 INFO - Contents: 19:18:05 INFO - build_url:https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:18:05 INFO - Running post-action listener: _resource_record_post_action 19:18:05 INFO - Running post-action listener: set_extra_try_arguments 19:18:05 INFO - ##### 19:18:05 INFO - ##### Finished download-and-extract step (success) 19:18:05 INFO - ##### 19:18:05 INFO - ##### 19:18:05 INFO - ##### Running populate-webroot step. 19:18:05 INFO - ##### 19:18:05 INFO - Running pre-action listener: _resource_record_pre_action 19:18:05 INFO - Running main action method: populate_webroot 19:18:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:05 INFO - '--tppagecycles', 19:18:05 INFO - '7'], 19:18:05 INFO - 'tests': ['tsvgm']}}, 19:18:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['damp', 'tps']}, 19:18:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'tests': ['damp', 'tps']}, 19:18:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['dromaeo_dom']}, 19:18:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['a11yr', 19:18:05 INFO - 'ts_paint', 19:18:05 INFO - 'tpaint', 19:18:05 INFO - 'sessionrestore', 19:18:05 INFO - 'sessionrestore_no_auto_restore', 19:18:05 INFO - 'tabpaint']}, 19:18:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['tsvgx', 19:18:05 INFO - 'tsvgr_opacity', 19:18:05 INFO - 'tart', 19:18:05 INFO - 'tscrollx', 19:18:05 INFO - 'cart']}, 19:18:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:05 INFO - 'tsvgr_opacity', 19:18:05 INFO - 'tart', 19:18:05 INFO - 'tscrollx', 19:18:05 INFO - 'cart']}, 19:18:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'talos_options': ['--disable-e10s'], 19:18:05 INFO - 'tests': ['tp5o']}, 19:18:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'tests': ['tp5o']}, 19:18:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'talos_options': ['--disable-e10s', 19:18:05 INFO - '--xperf_path', 19:18:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:05 INFO - 'tests': ['tp5n']}, 19:18:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:05 INFO - 'talos_options': ['--xperf_path', 19:18:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:05 INFO - 'tests': ['tp5n']}}, 19:18:05 INFO - 'talos.zip': {'path': '', 19:18:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:05 INFO - Running post-action listener: _resource_record_post_action 19:18:05 INFO - ##### 19:18:05 INFO - ##### Finished populate-webroot step (success) 19:18:05 INFO - ##### 19:18:05 INFO - ##### 19:18:05 INFO - ##### Running create-virtualenv step. 19:18:05 INFO - ##### 19:18:05 INFO - Running pre-action listener: _resource_record_pre_action 19:18:05 INFO - Running main action method: create_virtualenv 19:18:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:18:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:05 INFO - Using real prefix '/usr' 19:18:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:06 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:08 INFO - Installing pip.................done. 19:18:08 INFO - Return code: 0 19:18:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:18:08 INFO - Using env: {'DISPLAY': ':0', 19:18:08 INFO - 'HOME': '/home/cltbld', 19:18:08 INFO - 'LANG': 'en_US.UTF-8', 19:18:08 INFO - 'LANGUAGE': 'en_US:en', 19:18:08 INFO - 'LOGNAME': 'cltbld', 19:18:08 INFO - 'MAIL': '/var/mail/cltbld', 19:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:08 INFO - 'MOZ_NO_REMOTE': '1', 19:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:08 INFO - 'NO_EM_RESTART': '1', 19:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:08 INFO - 'PWD': '/builds/slave/test', 19:18:08 INFO - 'SHELL': '/bin/bash', 19:18:08 INFO - 'SHLVL': '1', 19:18:08 INFO - 'TERM': 'linux', 19:18:08 INFO - 'TMOUT': '86400', 19:18:08 INFO - 'USER': 'cltbld', 19:18:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:08 INFO - '_': '/tools/buildbot/bin/python'} 19:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:18:08 INFO - Cleaning up... 19:18:08 INFO - Return code: 0 19:18:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:18:08 INFO - Using env: {'DISPLAY': ':0', 19:18:08 INFO - 'HOME': '/home/cltbld', 19:18:08 INFO - 'LANG': 'en_US.UTF-8', 19:18:08 INFO - 'LANGUAGE': 'en_US:en', 19:18:08 INFO - 'LOGNAME': 'cltbld', 19:18:08 INFO - 'MAIL': '/var/mail/cltbld', 19:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:08 INFO - 'MOZ_NO_REMOTE': '1', 19:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:08 INFO - 'NO_EM_RESTART': '1', 19:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:08 INFO - 'PWD': '/builds/slave/test', 19:18:08 INFO - 'SHELL': '/bin/bash', 19:18:08 INFO - 'SHLVL': '1', 19:18:08 INFO - 'TERM': 'linux', 19:18:08 INFO - 'TMOUT': '86400', 19:18:08 INFO - 'USER': 'cltbld', 19:18:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:08 INFO - '_': '/tools/buildbot/bin/python'} 19:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:08 INFO - Downloading/unpacking psutil>=3.1.1 19:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:10 INFO - Installing collected packages: psutil 19:18:10 INFO - Running setup.py install for psutil 19:18:10 INFO - building 'psutil._psutil_linux' extension 19:18:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:18:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:18:11 INFO - building 'psutil._psutil_posix' extension 19:18:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:18:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:11 INFO - Successfully installed psutil 19:18:11 INFO - Cleaning up... 19:18:11 INFO - Return code: 0 19:18:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:18:11 INFO - Using env: {'DISPLAY': ':0', 19:18:11 INFO - 'HOME': '/home/cltbld', 19:18:11 INFO - 'LANG': 'en_US.UTF-8', 19:18:11 INFO - 'LANGUAGE': 'en_US:en', 19:18:11 INFO - 'LOGNAME': 'cltbld', 19:18:11 INFO - 'MAIL': '/var/mail/cltbld', 19:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:11 INFO - 'MOZ_NO_REMOTE': '1', 19:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:11 INFO - 'NO_EM_RESTART': '1', 19:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:11 INFO - 'PWD': '/builds/slave/test', 19:18:11 INFO - 'SHELL': '/bin/bash', 19:18:11 INFO - 'SHLVL': '1', 19:18:11 INFO - 'TERM': 'linux', 19:18:11 INFO - 'TMOUT': '86400', 19:18:11 INFO - 'USER': 'cltbld', 19:18:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:11 INFO - '_': '/tools/buildbot/bin/python'} 19:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:13 INFO - Installing collected packages: mozsystemmonitor 19:18:13 INFO - Running setup.py install for mozsystemmonitor 19:18:13 INFO - Successfully installed mozsystemmonitor 19:18:13 INFO - Cleaning up... 19:18:13 INFO - Return code: 0 19:18:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:18:13 INFO - Using env: {'DISPLAY': ':0', 19:18:13 INFO - 'HOME': '/home/cltbld', 19:18:13 INFO - 'LANG': 'en_US.UTF-8', 19:18:13 INFO - 'LANGUAGE': 'en_US:en', 19:18:13 INFO - 'LOGNAME': 'cltbld', 19:18:13 INFO - 'MAIL': '/var/mail/cltbld', 19:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:13 INFO - 'MOZ_NO_REMOTE': '1', 19:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:13 INFO - 'NO_EM_RESTART': '1', 19:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:13 INFO - 'PWD': '/builds/slave/test', 19:18:13 INFO - 'SHELL': '/bin/bash', 19:18:13 INFO - 'SHLVL': '1', 19:18:13 INFO - 'TERM': 'linux', 19:18:13 INFO - 'TMOUT': '86400', 19:18:13 INFO - 'USER': 'cltbld', 19:18:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:13 INFO - '_': '/tools/buildbot/bin/python'} 19:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:16 INFO - Downloading docopt-0.6.1.tar.gz 19:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:16 INFO - Running setup.py install for blobuploader 19:18:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:16 INFO - Running setup.py install for requests 19:18:16 INFO - Running setup.py install for docopt 19:18:17 INFO - Successfully installed blobuploader requests docopt 19:18:17 INFO - Cleaning up... 19:18:17 INFO - Return code: 0 19:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:17 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 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:17 INFO - Using env: {'DISPLAY': ':0', 19:18:17 INFO - 'HOME': '/home/cltbld', 19:18:17 INFO - 'LANG': 'en_US.UTF-8', 19:18:17 INFO - 'LANGUAGE': 'en_US:en', 19:18:17 INFO - 'LOGNAME': 'cltbld', 19:18:17 INFO - 'MAIL': '/var/mail/cltbld', 19:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:17 INFO - 'MOZ_NO_REMOTE': '1', 19:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:17 INFO - 'NO_EM_RESTART': '1', 19:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:17 INFO - 'PWD': '/builds/slave/test', 19:18:17 INFO - 'SHELL': '/bin/bash', 19:18:17 INFO - 'SHLVL': '1', 19:18:17 INFO - 'TERM': 'linux', 19:18:17 INFO - 'TMOUT': '86400', 19:18:17 INFO - 'USER': 'cltbld', 19:18:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:17 INFO - '_': '/tools/buildbot/bin/python'} 19:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:17 INFO - Running setup.py (path:/tmp/pip-yGyOt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:17 INFO - Running setup.py (path:/tmp/pip-qLcthe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:17 INFO - Running setup.py (path:/tmp/pip-bWnyac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:17 INFO - Running setup.py (path:/tmp/pip-2pqhld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:17 INFO - Running setup.py (path:/tmp/pip-BT7rTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:17 INFO - Running setup.py (path:/tmp/pip-9kea_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:17 INFO - Running setup.py (path:/tmp/pip-pLeW55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:17 INFO - Running setup.py (path:/tmp/pip-MSFlsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:17 INFO - Running setup.py (path:/tmp/pip-87G4J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:17 INFO - Running setup.py (path:/tmp/pip-qTvn6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:18 INFO - Running setup.py (path:/tmp/pip-6mpQeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:18 INFO - Running setup.py (path:/tmp/pip-Nn0Btb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:18 INFO - Running setup.py (path:/tmp/pip-YBjyQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:18 INFO - Running setup.py (path:/tmp/pip-z47X11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:18 INFO - Running setup.py (path:/tmp/pip-UaJDWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:18 INFO - Running setup.py (path:/tmp/pip-QhBTMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:18 INFO - Running setup.py (path:/tmp/pip-RK7RhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:18 INFO - Running setup.py install for manifestparser 19:18:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:18 INFO - Running setup.py install for mozcrash 19:18:18 INFO - Running setup.py install for mozdebug 19:18:18 INFO - Running setup.py install for mozdevice 19:18:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:18 INFO - Running setup.py install for mozfile 19:18:19 INFO - Running setup.py install for mozhttpd 19:18:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for mozinfo 19:18:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for mozInstall 19:18:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for mozleak 19:18:19 INFO - Running setup.py install for mozlog 19:18:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for moznetwork 19:18:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for mozprocess 19:18:19 INFO - Running setup.py install for mozprofile 19:18:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:19 INFO - Running setup.py install for mozrunner 19:18:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:20 INFO - Running setup.py install for mozscreenshot 19:18:20 INFO - Running setup.py install for moztest 19:18:20 INFO - Running setup.py install for mozversion 19:18:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:20 INFO - Cleaning up... 19:18:20 INFO - Return code: 0 19:18:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:20 INFO - Using env: {'DISPLAY': ':0', 19:18:20 INFO - 'HOME': '/home/cltbld', 19:18:20 INFO - 'LANG': 'en_US.UTF-8', 19:18:20 INFO - 'LANGUAGE': 'en_US:en', 19:18:20 INFO - 'LOGNAME': 'cltbld', 19:18:20 INFO - 'MAIL': '/var/mail/cltbld', 19:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:20 INFO - 'MOZ_NO_REMOTE': '1', 19:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:20 INFO - 'NO_EM_RESTART': '1', 19:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:20 INFO - 'PWD': '/builds/slave/test', 19:18:20 INFO - 'SHELL': '/bin/bash', 19:18:20 INFO - 'SHLVL': '1', 19:18:20 INFO - 'TERM': 'linux', 19:18:20 INFO - 'TMOUT': '86400', 19:18:20 INFO - 'USER': 'cltbld', 19:18:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:20 INFO - '_': '/tools/buildbot/bin/python'} 19:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:20 INFO - Running setup.py (path:/tmp/pip-YU3LKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:20 INFO - Running setup.py (path:/tmp/pip-P304Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:20 INFO - Running setup.py (path:/tmp/pip-a7pMZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:20 INFO - Running setup.py (path:/tmp/pip-fdlUto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:20 INFO - Running setup.py (path:/tmp/pip-AmlmMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:20 INFO - Running setup.py (path:/tmp/pip-2uVGnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:20 INFO - Running setup.py (path:/tmp/pip-00IxA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:21 INFO - Running setup.py (path:/tmp/pip-zryuMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:21 INFO - Running setup.py (path:/tmp/pip-tfiLCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:21 INFO - Running setup.py (path:/tmp/pip-nhexI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:21 INFO - Running setup.py (path:/tmp/pip-uCyvd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:21 INFO - Running setup.py (path:/tmp/pip-up9Ire-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:21 INFO - Running setup.py (path:/tmp/pip-iDnBQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:21 INFO - Running setup.py (path:/tmp/pip-jJEGqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:21 INFO - Running setup.py (path:/tmp/pip-ssmSGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:21 INFO - Running setup.py (path:/tmp/pip-y12Bq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:21 INFO - Running setup.py (path:/tmp/pip-zanplw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:23 INFO - Downloading blessings-1.6.tar.gz 19:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:23 INFO - Installing collected packages: blessings 19:18:23 INFO - Running setup.py install for blessings 19:18:23 INFO - Successfully installed blessings 19:18:23 INFO - Cleaning up... 19:18:23 INFO - Return code: 0 19:18:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:24 INFO - Reading from file tmpfile_stdout 19:18:24 INFO - Current package versions: 19:18:24 INFO - argparse == 1.2.1 19:18:24 INFO - blessings == 1.6 19:18:24 INFO - blobuploader == 1.2.4 19:18:24 INFO - docopt == 0.6.1 19:18:24 INFO - manifestparser == 1.1 19:18:24 INFO - mozInstall == 1.12 19:18:24 INFO - mozcrash == 0.17 19:18:24 INFO - mozdebug == 0.1 19:18:24 INFO - mozdevice == 0.48 19:18:24 INFO - mozfile == 1.2 19:18:24 INFO - mozhttpd == 0.7 19:18:24 INFO - mozinfo == 0.9 19:18:24 INFO - mozleak == 0.1 19:18:24 INFO - mozlog == 3.2 19:18:24 INFO - moznetwork == 0.27 19:18:24 INFO - mozprocess == 0.22 19:18:24 INFO - mozprofile == 0.28 19:18:24 INFO - mozrunner == 6.11 19:18:24 INFO - mozscreenshot == 0.1 19:18:24 INFO - mozsystemmonitor == 0.3 19:18:24 INFO - moztest == 0.7 19:18:24 INFO - mozversion == 1.4 19:18:24 INFO - psutil == 3.1.1 19:18:24 INFO - requests == 1.2.3 19:18:24 INFO - wsgiref == 0.1.2 19:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:24 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 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:24 INFO - Using env: {'DISPLAY': ':0', 19:18:24 INFO - 'HOME': '/home/cltbld', 19:18:24 INFO - 'LANG': 'en_US.UTF-8', 19:18:24 INFO - 'LANGUAGE': 'en_US:en', 19:18:24 INFO - 'LOGNAME': 'cltbld', 19:18:24 INFO - 'MAIL': '/var/mail/cltbld', 19:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:24 INFO - 'MOZ_NO_REMOTE': '1', 19:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:24 INFO - 'NO_EM_RESTART': '1', 19:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:24 INFO - 'PWD': '/builds/slave/test', 19:18:24 INFO - 'SHELL': '/bin/bash', 19:18:24 INFO - 'SHLVL': '1', 19:18:24 INFO - 'TERM': 'linux', 19:18:24 INFO - 'TMOUT': '86400', 19:18:24 INFO - 'USER': 'cltbld', 19:18:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:24 INFO - '_': '/tools/buildbot/bin/python'} 19:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:24 INFO - Cleaning up... 19:18:24 INFO - Return code: 0 19:18:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:18:24 INFO - Using env: {'DISPLAY': ':0', 19:18:24 INFO - 'HOME': '/home/cltbld', 19:18:24 INFO - 'LANG': 'en_US.UTF-8', 19:18:24 INFO - 'LANGUAGE': 'en_US:en', 19:18:24 INFO - 'LOGNAME': 'cltbld', 19:18:24 INFO - 'MAIL': '/var/mail/cltbld', 19:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:24 INFO - 'MOZ_NO_REMOTE': '1', 19:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:24 INFO - 'NO_EM_RESTART': '1', 19:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:24 INFO - 'PWD': '/builds/slave/test', 19:18:24 INFO - 'SHELL': '/bin/bash', 19:18:24 INFO - 'SHLVL': '1', 19:18:24 INFO - 'TERM': 'linux', 19:18:24 INFO - 'TMOUT': '86400', 19:18:24 INFO - 'USER': 'cltbld', 19:18:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:24 INFO - '_': '/tools/buildbot/bin/python'} 19:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:24 INFO - Downloading/unpacking jsonschema 19:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:26 INFO - Downloading/unpacking functools32 (from jsonschema) 19:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:26 INFO - warning: no files found matching '*.txt' 19:18:26 INFO - no previously-included directories found matching 'build' 19:18:26 INFO - no previously-included directories found matching 'dist' 19:18:26 INFO - no previously-included directories found matching '.git*' 19:18:26 INFO - Installing collected packages: jsonschema, functools32 19:18:26 INFO - Running setup.py install for functools32 19:18:26 INFO - warning: no files found matching '*.txt' 19:18:26 INFO - no previously-included directories found matching 'build' 19:18:26 INFO - no previously-included directories found matching 'dist' 19:18:26 INFO - no previously-included directories found matching '.git*' 19:18:26 INFO - Successfully installed jsonschema functools32 19:18:26 INFO - Cleaning up... 19:18:26 INFO - Return code: 0 19:18:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa993a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:18:26 INFO - Using env: {'DISPLAY': ':0', 19:18:26 INFO - 'HOME': '/home/cltbld', 19:18:26 INFO - 'LANG': 'en_US.UTF-8', 19:18:26 INFO - 'LANGUAGE': 'en_US:en', 19:18:26 INFO - 'LOGNAME': 'cltbld', 19:18:26 INFO - 'MAIL': '/var/mail/cltbld', 19:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:26 INFO - 'MOZ_NO_REMOTE': '1', 19:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:26 INFO - 'NO_EM_RESTART': '1', 19:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:26 INFO - 'PWD': '/builds/slave/test', 19:18:26 INFO - 'SHELL': '/bin/bash', 19:18:26 INFO - 'SHLVL': '1', 19:18:26 INFO - 'TERM': 'linux', 19:18:26 INFO - 'TMOUT': '86400', 19:18:26 INFO - 'USER': 'cltbld', 19:18:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:26 INFO - '_': '/tools/buildbot/bin/python'} 19:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:27 INFO - Downloading/unpacking flake8 19:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:18:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:18:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:18:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:29 INFO - no previously-included directories found matching 'docs/_build' 19:18:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:18:29 INFO - Running setup.py install for pep8 19:18:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:29 INFO - no previously-included directories found matching 'docs/_build' 19:18:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:18:29 INFO - Cleaning up... 19:18:29 INFO - Return code: 0 19:18:29 INFO - Running post-action listener: _resource_record_post_action 19:18:29 INFO - Running post-action listener: _start_resource_monitoring 19:18:30 INFO - Starting resource monitoring. 19:18:30 INFO - ##### 19:18:30 INFO - ##### Finished create-virtualenv step (success) 19:18:30 INFO - ##### 19:18:30 INFO - ##### 19:18:30 INFO - ##### Running install step. 19:18:30 INFO - ##### 19:18:30 INFO - Running pre-action listener: _resource_record_pre_action 19:18:30 INFO - Running main action method: install 19:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:30 INFO - Reading from file tmpfile_stdout 19:18:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:30 INFO - Reading from file tmpfile_stdout 19:18:30 INFO - Output received: 19:18:30 INFO - Usage: mozinstall [options] installer 19:18:30 INFO - Options: 19:18:30 INFO - -h, --help show this help message and exit 19:18:30 INFO - -d DEST, --destination=DEST 19:18:30 INFO - Directory to install application into. [default: 19:18:30 INFO - "/builds/slave/test"] 19:18:30 INFO - --app=APP Application being installed. [default: firefox] 19:18:30 INFO - mkdir: /builds/slave/test/build/application 19:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:18:46 INFO - Reading from file tmpfile_stdout 19:18:46 INFO - Output received: 19:18:46 INFO - /builds/slave/test/build/application/firefox/firefox 19:18:46 INFO - Running post-action listener: _resource_record_post_action 19:18:46 INFO - ##### 19:18:46 INFO - ##### Finished install step (success) 19:18:46 INFO - ##### 19:18:46 INFO - ##### 19:18:46 INFO - ##### Running run-tests step. 19:18:46 INFO - ##### 19:18:46 INFO - Running pre-action listener: _resource_record_pre_action 19:18:46 INFO - Running main action method: run_tests 19:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:46 INFO - Python 2.7.3 19:18:46 INFO - Return code: 0 19:18:46 INFO - grabbing minidump binary from tooltool 19:18: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')]} 19:18:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:18:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:18:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:18:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:47 INFO - Return code: 0 19:18:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:18:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:18:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:18:47 INFO - Return code: 0 19:18:47 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/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:18:47 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/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:18:47 INFO - Using env: {'DISPLAY': ':0', 19:18:47 INFO - 'HOME': '/home/cltbld', 19:18:47 INFO - 'LANG': 'en_US.UTF-8', 19:18:47 INFO - 'LANGUAGE': 'en_US:en', 19:18:47 INFO - 'LOGNAME': 'cltbld', 19:18:47 INFO - 'MAIL': '/var/mail/cltbld', 19:18:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:47 INFO - 'MOZ_NO_REMOTE': '1', 19:18:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:47 INFO - 'NO_EM_RESTART': '1', 19:18:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:47 INFO - 'PWD': '/builds/slave/test', 19:18:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:47 INFO - 'SHELL': '/bin/bash', 19:18:47 INFO - 'SHLVL': '1', 19:18:47 INFO - 'TERM': 'linux', 19:18:47 INFO - 'TMOUT': '86400', 19:18:47 INFO - 'USER': 'cltbld', 19:18:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324', 19:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:47 INFO - '_': '/tools/buildbot/bin/python'} 19:18:47 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/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:18:48 INFO - mozversion application_buildid: 20160525163027 19:18:48 INFO - mozversion application_changeset: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc 19:18:48 INFO - mozversion application_display_name: Nightly 19:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:48 INFO - mozversion application_name: Firefox 19:18:48 INFO - mozversion application_remotingname: firefox 19:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:18:48 INFO - mozversion application_vendor: Mozilla 19:18:48 INFO - mozversion application_version: 49.0a1 19:18:48 INFO - mozversion platform_buildid: 20160525163027 19:18:48 INFO - mozversion platform_changeset: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc 19:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:18:48 INFO - mozversion platform_version: 49.0a1 19:18:48 INFO - using testdate: 1464229128 19:18:48 INFO - actual date: 1464229128 19:18:48 INFO - starting webserver on 'localhost:37615' 19:18:48 INFO - SUITE-START | Running 2 tests 19:18:48 INFO - TEST-START | dromaeo_css 19:18:48 INFO - operating with platform_type : linux_ 19:18:48 INFO - Initialising browser for dromaeo_css test... 19:18:48 INFO - TEST-INFO | started process 8620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMPNWnw/profile http://localhost:37615/getInfo.html) 19:18:52 INFO - PROCESS | 8620 | __metrics Screen width/height:1600/1200 19:18:52 INFO - PROCESS | 8620 | colorDepth:24 19:18:52 INFO - PROCESS | 8620 | Browser inner width/height: 1024/697 19:18:52 INFO - PROCESS | 8620 | __metrics 19:18:53 ERROR - PROCESS | 8620 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:18:54 INFO - TEST-INFO | 8620: exit 0 19:18:54 INFO - Browser initialized. 19:18:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:54 INFO - TEST-INFO | started process 8701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMPNWnw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:05 INFO - PROCESS | 8701 | RSS: Main: 155156480 19:19:05 INFO - PROCESS | 8701 | 19:19:57 INFO - PROCESS | 8701 | 1464229197609 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:22:05 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37615/tests/dromaeo/cssquery-ext.html) 19:22:06 INFO - PROCESS | 8701 | RSS: Main: 294768640 19:22:06 INFO - PROCESS | 8701 | 19:25:09 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-ext.html (next: http://localhost:37615/tests/dromaeo/cssquery-jquery.html) 19:25:09 INFO - PROCESS | 8701 | RSS: Main: 242151424 19:25:09 INFO - PROCESS | 8701 | 19:28:11 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37615/tests/dromaeo/cssquery-mootools.html) 19:28:12 INFO - PROCESS | 8701 | RSS: Main: 241266688 19:28:12 INFO - PROCESS | 8701 | 19:31:14 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37615/tests/dromaeo/cssquery-prototype.html) 19:31:14 INFO - PROCESS | 8701 | RSS: Main: 236806144 19:31:14 INFO - PROCESS | 8701 | 19:34:17 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37615/tests/dromaeo/cssquery-yui.html) 19:34:18 INFO - PROCESS | 8701 | RSS: Main: 225837056 19:34:18 INFO - PROCESS | 8701 | 19:37:20 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:37615/tests/dromaeo/cssquery-yui.html (next: http://localhost:37615/tests/dromaeo/cssquery-dojo.html) 19:37:21 INFO - PROCESS | 8701 | RSS: Main: 268259328 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | __start_tp_report 19:37:21 INFO - PROCESS | 8701 | _x_x_mozilla_page_load 19:37:21 INFO - PROCESS | 8701 | _x_x_mozilla_page_load_details 19:37:21 INFO - PROCESS | 8701 | |i|pagename|runs| 19:37:21 INFO - PROCESS | 8701 | |0;dojo.html;3091.1344823449435;3098.2254436390917;3123.094302652231;3133.2323580722727;3147.748180145587;5260.237265596486;5293.841184764454;5338.839834804957;5450.427705090963;5474.397816240215;5364.678119312844;5381.569474442045;5425.782968681248;5465.098258787295;5501.229827824108;4788.28175773635;4837.0325934813;5001.774920128585;5056.924146137811;5068.037072956145;4998.200287953928;5041.924371134436;5055.31753213317;5061.3420255366755;5104.464031276718;4862.708237505725;4907.288443175756;4916.336294600219;4936.407631084275;4943.159662857305;4959.983203443286;4966.081274964107;4967.403911530603;4975.203967365241;4979.800807967713;4912.042151780404;4919.385076865392;4923.8276660316715;4926.187179115442;4938.08645400602;5289.86775330616;5295.867603309909;5327.200919862013;5345.812896548641;5382.30030096085;5700.800471983461;5701.57238207132;5768.826935191909;5834.27071616048;5837.124431335291;5805.970970145122;5838.766449342022;5864.266966629171;5889.882202355929;5895.498882594985;5303.178007408857;5318.840434786963;5332.600054995891;5336.51971322579;5457.672539647634;5924.140999555127;5932.139839723216;5946.70266486674;5952.851178720567;5958.255218097738;5685.260916080883;5692.857678558069;5698.7435565399655;5701.059325211294;5701.572382071361;5637.098064309773;5719;5761.740721667535;5769.07694768835;5810.564207684441;5707.6290041147195;5712.171735098387;5727.770889164387;5770.826875193751;5787.276590426197;5553.194786755897;5731.312242530923;5787.363390027093;5788.334341550775;5790.71046447676;4275.722078064978;4315.07225946423;4356.128774245164;4368.060866913629;4374.868753937387;3872.53529576447;3879.476270703475;3897.4738410314812;3922.686185105185;3923.195744872294;5403.540699040625;5469.15228139631;5480.177973304037;5481.287432633732;5489.862753431116;5820.767169313265;5877.5591830612875;5892.6759028253;5900.911486327708;5930.258717660293;5524.640898341595;5553.139263414178;5568.972155139199;5570.972145139248;5572.888542229132;4940.8764780880765;4956.801727930914;4983.202687569971;5057.772400241998;5068.113080210948;6032.155498230251;6105.368770830132;6108.888502348253;6111.257501106137;6111.561351782648;5886.823395298148;5892.204552385373;5893.145493903275;5893.145493903275;5939.020061689773;5901.7639294427745;5928.525717942468;5931.6441013539325;6089.69551522431;6098.054801505774;5716.114002329646;5719.056355701429;5722.055860783091;5726.4273572642405;5776.624519406225;5761.884762304647;5802.245708057925;5811.593188476935;5812.505936995233;5821.417858214145;5558.055130627884;5670.092785154356;5677.432256774289;5718.771249149988;5726.255586773859;5715.371309156073;5717.571182161271;5720.170575266647;5724.169995350734;5734.053881109737;5585.245991791056;5629.718514074198;5630.0991841305195;5636.239107720406;5640.153976903333;5641.294838145232;5642.069058605448;5646.689432081275;5689.829305120853;5692.6299790513485;5613.943860561342;5649.406812284651;5653.067243904709;5659.6887171204335;5674.546036317002 19:37:21 INFO - PROCESS | 8701 | |1;ext.html;592.908099244617;633.6514916795762;640.9935900640992;653.9673016349183;656.5371413153728;31884.840575797145;32478.67521324786;34506.82746586267;34609.30781384377;34625.48061779075;44703;44880.775596121974;45553.31670024944;45701.314480282825;45805.541944580546;8567.70013049542;8905.95547022264;8912.376133670645;8919.687810926618;8923.375363724543;8061.193880611951;8267.95866020669;8853.424527405698;8984.41601295917;8987.325950553703;10468.842967355497;10810.35137891729;10831.187660925423;11061.170412219075;11104.333739975587;10640.0955918747;10708.464576771208;10713.089387402002;10720.35677859327;10722;10535.63125290611;10583.788324233472;10612.78774424515;10616.469176541219;10621.150307975344;42740.862956852034;42970.57029429697;43124.13751724948;43168.78415607933;43313.56686433127;2797.398559309758;3377.7973321600784;3455.58532976042;3626.1478552540134;3636.654517820803;30351;30866.537001944987;31179.84410077935;32140.517892231634;33449.49825752616;3971.543272523668;4051.6150965658217;4060.9593904060876;4093.2222877653153;4156.168766246733;295931.99999999785;296614;297812;298570;298931;35438.468422973674;35510.644893550736;35688;35879.82060089683;35900.820495897875;36241.093972650895;36583.81708091496;36670.266594667955;36674;36875;15415.229238538028;15635.921820390826;15652;15665;15678.216089195495;11126.221164518405;11143.888561114285;11167.106631469625;11178.776424471465;11268.211225214156;8216;8350.039745429232;8423.11557286476;8441.662333506714;8588.484690918565;6801.1838579369805;6975.686094125776;7191.64041797908;7261.092363454568;7369.484136110528;993.5529011944653;1043.6503771236721;1047.3558761361708;1121.9158563107637;1133.2860298012365;33616.83191584027;33888.15279618029;33996.49005264873;34001.65998340034;34145.487817682755;1152.3258893547368;1157.1032449851432;1170.0464121740754;1209.1354681402838;1270.2822905058613;17500.387486437914;17765.467035988942;17864;17898.5525361867;17931.193096310697;547470;552404;553006;553193;553472;60114.0982885257;61559;61666.383336166065;61736;61754;1344.5495758920872;1386.5563019833758;1388.6667199871958;1390.2492653966744;1392.6587985943306;31792.682073179898;33170.50244246387;33244.833775830964;33386;34333;53614.46385536095;53998.19002714884;54092;54142.729286353315;54184;359082;363580;365482;366268;366597;25222.873885630455;27744.306392340353;28791.5681264777;28831.423371532033;29313.413731725672;48664;49214.261786073956;49541.50458495513;49729;50526.494735053646;40564.79717601393;41826;42461.363079553215;42607.57392426036;42846.78576607097;41445.585544144174;41577.79211103925;41685;42310.7884460588;42795.57204427916;37071.81464092662;37085;37466.81266593649;37502.81248593739;42629.78685106679;35315.68694855011;36726.02205580931;37663.62336376601;37717;37768.244635107694;28571.571426428203;28861.27846803847;28864.278393040342;29213.561796573493;29236.853815731636 19:37:21 INFO - PROCESS | 8701 | |2;jquery.html;357.79963220596466;377.6318089862383;378.1963327928152;380.77343980331693;393.77554793767564;18202.271909123636;18535.536611584717;19507.317243896465;19514.70727939082;19875.105620247086;11143.442827858595;11269;11374;11393.715157121076;11399.088072954164;3868.5551161616354;4253.425787518692;5044.470330615288;5050.570701490377;5055.317532133152;3938.8030598470104;4049.898752531181;4053.695972802037;5259.474052594748;5521.503064724174;5463.426340234278;5588.469095435927;5591.552675785927;5594.888102237953;5597.048501754691;5774.5091667208335;5804.361520232771;5809.302883653967;5809.651420914737;5811.128330750379;3741.887743367676;5627;5634.830955071355;6400.647964361959;6869.4847886408215;24465.143719969714;25277.368065798317;25366.619500707504;25978.87010564954;26100.738992610022;2334.7315058768118;2356.8939397727145;2415.1064106280614;2495.413577809213;2621.973780262211;15498.690026199525;15843.841561584468;16127.113008784512;16451.341946322133;16690.83309166917;2107.93676189713;2166.19850655257;2251.414632195641;2407.170550381705;2514.635377870217;80218;84972.57513712515;95387.27676339442;96387;96707;13697.657558560917;17936;18127.90936045311;18292.268309267747;18889.81110188908;31343.68656313453;32036.519452208235;32191;32326;32359.35281294361;10107.444090574942;10177.796444071226;10300.536475858604;10311.639092631873;10389.272750907365;8151.673933042731;8399.412041157182;8427.95786021066;8432.030316513557;8523.914760852436;8616.655333786704;8643.654253829776;8673.52295623734;8755.781105472413;8963.148500892405;2805.340744924941;3337.6829201225846;3532.4877892705413;3556.7332450066347;3635.927281454356;903.810199858024;981.8527220916919;1012.5139932832282;1033.0423846810252;1141.828725691153;19113.81927338374;19423.8057619422;19532.85138634749;19553.217871285273;19634.11646475912;1000.5847573257163;1008.9344192627456;1014.3812274512542;1034.270839058462;1064.090202876545;10606.522706478227;10939.726506837234;10981.231313808117;11006.064484518745;11012.449377531091;471304;472104;478218;479521;482380;91557;93160;93549;94453.5277323609;94634.5268273668;943.8065196634674;951.509972364233;958.152035448619;962.9807403852024;997.875265591801;16648.750268746222;17164.141792910556;17261.482155535356;17434.47696569105;17749;31552;40946.59053409428;41544.37683434811;41603.375949360176;42365.78817105895;58190;60448.697756510934;60460.09309860268;61076;61119.38880611137;7964.920350796418;8115.79710507242;8289.378296627898;8331.208535189147;8511.36164787631;10757.30077544957;12688.74622507563;13166;13357.332133393096;13479.991807905419;11370.43147842588;11452.770944580896;11747.353895535827;11847.52609895629;11946.701332466759;11230.719232019264;11364;11441.427928603704;11668;11678.124140689652;11479.783949847491;11485.827712584485;11878.762424751283;11933.16467847277;12168.57409990646;8208.056073551617;8249.670013199404;8381.706640267805;8437.662493500191;8485.618147183268;10450.320729152581;11679.124065694938;11806.409679516162;12054.09594280415;12196.878031219574 19:37:21 INFO - PROCESS | 8701 | |3;mootools.html;1334.206147342331;1481.2223582619124;1508.834028256892;1666.3917670050428;1835.742995980563;8178.141295164011;8513.446625969307;8560.22957933785;8679.566021698905;8697.782555436117;8404.495730256189;8498.532580708059;8573.52845593492;8581.828363432727;8587.828243435144;1975.4073777866654;2237.4965632732587;2275.920342788003;2300.0454811253308;2310.9075636974585;2306.6770652108717;2310.7111611048617;2314.1206341590173;2315.3979965209;2315.9652605210936;2202.603531364354;2244.36035729817;2249.955000899981;2250.0999600159903;2250.8762018089;1937.205745644286;2192.6491761318193;2250.6061439248065;2255.605269077921;2263.038208761286;2146.969454661771;2162.8702277863376;2169.9566008679894;2172.055156007142;2204.327680057582;8477.872831907527;8601.096884827066;8607.913920860774;8610.655573777041;8612.18184272493;5067.138586440314;5201.427842937273;5214.478552144793;5221.843344699665;5225.059489291926;3148.874045038219;3223.09753269085;3250.5449237106823;3265.787723797969;3279.0652366132176;1004.3070281505737;1010.4392062405362;1013.3869009249445;1020.4234607446843;1020.8825985011745;11304.15218858589;11798.174127811057;11804.881951180465;12085.818712719316;12095.516179352815;4169.457970463881;4210.831566737296;4272;4274.31610942254;4297.656187504992;9121.726348209564;9156;9164.221041211571;9172.220361269234;9173.220276276592;4373.169097871394;4931.211006238985;4938.358013458227;4942.5304596063315;4943.382077240345;4166.291730405838;4208.410822484854;4208.789560522023;4614.100250451197;4769.165396055676;3622.836972336251;3696.963030369716;3737.5141231640255;3751.6248375162268;3786.7159963002887;1062.7396287909357;1114.3982249585133;1121.9495122719497;1131.8358837968449;1137.1300954769608;934.4206591913057;1024.8462730590322;1025.8974102589682;1027.244974943416;1030.3354336452946;5860.443257890493;5975.79084732041;6006;6092.025275955826;6200.321116374888;403.33449807817334;409.63951722484023;420.03392197944606;424.4121891180737;427.19686988461496;4140.358244472111;4227.513835908849;4236.279832428495;4238.936415953764;4274.252005899018;10503.947480262703;10890.891091088988;10918.945405273082;10947.890521094847;10961.890381096246;10606.15150787935;10781.730456738487;10810.405427701551;10813.62152324665;10819.080378167786;8166.632501537326;8193.959030204811;8204.589770511451;8214.958925205336;8228.465149765247;5934.080217566284;5971.820845374646;6115.84710382244;6160.383961603804;6184.257889053342;9639.951800240953;9829.705108846745;10002.649907253211;10036.146927511243;10076.748081298027;9907.207423405966;10225.181985440999;10254.846177307496;10281.280310378203;10290.3825770454;6667.733290668513;6984.580925144304;7157.964210178916;7195.8920616191845;7322.414206863545;8388.370872184732;8410.074891761778;8441.198086181803;8473.745787626382;8502.192291732275;7345.632718363953;7581.279778421262;7608.885866711893;7733.38132949374;7735.535867847947;7414.295641914009;7471.252874712485;7498.175200728025;7559.886601701089;7679.539227646359;6942.340477654615;6989.720411183495;7007.824804379931;7009.264027277062;7020.824479388056;5042.546170844642;5259.316288882421;5337.813176538958;5415.1335786274;5427.6472029317965;5224.660397074178;5279.973600131974;5331.297039388431;5483.7806487740045;5491.341039075177 19:37:21 INFO - PROCESS | 8701 | |4;prototype.html;292.27953095619307;302.9545568164776;307.6170168140665;308.34938280228715;311.1381473318908;5325.893482130355;5336.6531175473565;5345.90408966162;5346.625736198468;5364.865878353048;5002.699838009722;5136.460671629481;5237.162054071349;5270.235815806705;5297.417284098746;3985.2228815381013;4018.4374187613757;4020.618041286073;4022.7988600569856;4040.515138183422;4015.738976966488;4021.678265738734;4023.7384570003;4038.4144299076615;4040;3839.5008648875605;3965.9008524786823;4037.919241615166;4039.151778126582;4075.49056367954;3991.1618560102415;4015.277250094982;4019;4026.516817981861;4047.7166598338126;3559.6440355964196;3576.766015724571;3578.3737845876867;3583.283343331318;3597.316509863144;4868.707877527359;5117.33474648297;5130.640855140142;5140.3060586820675;5159.742012899377;4525.637948964108;4530.980529380896;4554.772261386951;4556.567126123013;4563.566461186182;5462;5478.534324582375;5481.67029012668;5488.368837583689;5517.282753242093;3701.463892484616;3766.2090960898245;3767.2088861339153;3906.7460615060213;3930.6069393060466;5694.316681998187;5697.515711164515;5738.971305143489;5813.418658134237;5817.767289308423;3927.5286965563746;3930.4693866328253;3939;3999.960000400017;4012.558618551957;3897.649211570972;4025.939610905839;4054.2702313583836;4054.7769872657286;4057.16828050249;4605.723656580616;4619.930701039487;4630.398048253705;4632.591052652601;4645.581897629229;5547.2511210986;5549.472800083986;5568.443155684399;5580.553555715533;5595.732779287143;1313.8094976228394;1343.40890008396;1371.6845125620964;1383.1424516799648;1392.3386391463973;865.1780808232205;870.7678634731784;875.7504111328241;881.9911800882037;882.8543290357147;4855.6601037927;4883.877903052381;4887.828925987645;4888.413390393175;4889.608831293488;5142.942822870881;5147.202183661539;5172.965406918632;5174.197999310113;5182.378114626269;4493.865184044484;4828;4887.242477416006;4891.755412229445;4909.459959404463;2625.750553697396;2668.3729323608936;2699.838009719423;2720.8775605097817;2733.808633395683;5113.616478764107;5203.791848326025;5215.226822880239;5223;5248.343957005374;5109.616778741609;5122.718250496258;5165.48345165488;5359.5712343012465;5835.94164058354;5915.438033386821;5931.911021334683;5935.376785437467;5948.940510594839;6017.638941663514;5753.583494932055;5785.9132113017495;5786.9131963019745;5812.157237200498;5814.5639077068545;5529.30883639545;5710.628809127394;5743.4256574342235;5758.913616295843;5773.797917072882;5984.431479009487;5992.910106348321;6013;6017.699115044318;6024.668643224665;3714.814259286971;3876.5929577393968;3885.970217892317;3897.9220415592094;3898.5126859142606;5439.836804895859;5771.8557036074435;5799.274341059695;5816.970915145397;5821.854453638693;5468.261784659179;5594.1608758686525;5604.6917419542315;5613.635113717595;5625.971870140623;5526.668399896019;5531.147065733025;5538;5571.637843540157;5596.83778665053;5231.450697676842;5439.9456005441025;5452.809151679672;5453.26380938584;5536.944630553643;5514.979728750194;5547.029269877675;5553.444655534414;5562.666240025612;5617.241672374341;5448.945510545002;5470.398256191896;5479.205515200353;5479.643823151482;5483.396826349019 19:37:21 INFO - PROCESS | 8701 | |5;yui.html;777.9144294127647;782.1162086841867;837.9581020948951;851.3317046118794;861.991380086199;16068.116253606062;16689;16696.081715505672;16770.74843877343;16784.748228776563;15717;15738.449154279573;15758;15826.604334891634;15841.603959901007;825.331481499984;834.4117397234966;834.9916500835005;835.1106072033265;835.2023817254537;684.8150999230205;790.1979490816825;822.8930239068912;826.1325608111489;828.7430896422098;856.3149480415674;856.8286342731448;860.6514361683528;862.3015357560365;862.8835107260534;858.2233079063458;858.7853036740814;859.072202021818;859.4113032572676;859.4241857955154;522.4279414041619;604.4106995679222;619.9752009919598;620.652434636605;621.6611946489174;13768.311584420739;13769.586912392644;13822;13823.861761382459;13843.723125537434;13161.473541058345;13298.933505332412;13450.394732237073;13539.308474035375;13709.245991470465;12037.699057523545;12153.696157596043;12363.949961340977;12706.872931270755;12996.935015324958;4348.543402942709;4377.7592232427205;4412.139632771611;4535.455745310584;4544.750038747868;58600.706996464745;58825;59011.40988590145;59098.40901590972;59713.62577368014;10981.945090274497;11020.393878336608;11141.610043648434;11474.426278686033;11506.309621422573;16741.665166696843;16748.497545073424;16765.497035088967;16782.496525104267;16805.41181058657;7738.922610773933;7920.207979202149;7936.6031698414845;7945.245201705829;8150.266476017068;4610.308453731967;4730.479647238801;4752.310914917318;4777.450593181759;4910.8281210157475;3395.898123056312;3480.756347055682;3487.128217945514;3490.877819276313;3491.249381382964;625.3152797686616;654.8199245207511;656.5535435903631;659.6075335175562;666.756633828649;611.3916652930362;637.4581605635173;677.6679427080695;701.8876979683226;749.8050506868144;8818.51498167594;9028.954855225813;9034.86447703285;9083.500407477652;9149.353116439104;525.5112745146973;582.8134996800983;642.078617184342;669.1067424987599;683.8256244657581;4374.737515749065;4420.84527041552;4510.909781804346;4616.261398176276;4650.3041159183485;71459.6427017872;73645.6317718408;73716.83982121307;74224.25775742173;74250;65201.67399162974;66330.33669663241;66507.66746166238;66640.02836978603;68104;59120.11319830206;59250.11124833131;59903.90336338207;60521.69739151364;60755.39244607586;9023.4134781239;9036.774080648036;9204.355695101278;9352.579133939125;9390.201832844285;36418.45372319364;37018.444723328634;37365.43951840779;38414.615853842224;39197.21605567815;48684;49175;49811.75094124506;50139;50202;12546.811797822857;12598.3070931096;12605;12664.430100645677;12766.234025958473;14119.64700882486;14237.715245695235;14246.297987216674;14458.204798736171;14472.565823025327;12158.696032599255;12339.62981110568;12426.192297500633;12505.312207828656;12855.29295888735;13428.19430834153;13534.79697804514;13595.32023398846;13639.795403068763;13885.791713124108;11751.236169648946;12167.574134905235;12175.208611440228;12363.814542781685;12393.814092788434;11158.832617510907;11161.665150045512;11426.314421134759;11565.768684626091;11748.412579370826;10562.8415573768;10599.140180412765;10759.89240107589;10823.134149268197;10832.404217767784 19:37:21 INFO - PROCESS | 8701 | __end_tp_report 19:37:21 INFO - PROCESS | 8701 | __start_cc_report 19:37:21 INFO - PROCESS | 8701 | _x_x_mozilla_cycle_collect,1217 19:37:21 INFO - PROCESS | 8701 | __end_cc_report 19:37:21 INFO - PROCESS | 8701 | __startTimestamp1464230241194__endTimestamp 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | ------- Summary: start ------- 19:37:21 INFO - PROCESS | 8701 | Number of tests: 6 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#0] dojo.html Cycles:165 Average:5389.94 Median:5637.10 stddev:625.56 (11.1%) stddev-sans-first:600.93 19:37:21 INFO - PROCESS | 8701 | Values: 3091.1 3098.2 3123.1 3133.2 3147.7 5260.2 5293.8 5338.8 5450.4 5474.4 5364.7 5381.6 5425.8 5465.1 5501.2 4788.3 4837.0 5001.8 5056.9 5068.0 4998.2 5041.9 5055.3 5061.3 5104.5 4862.7 4907.3 4916.3 4936.4 4943.2 4960.0 4966.1 4967.4 4975.2 4979.8 4912.0 4919.4 4923.8 4926.2 4938.1 5289.9 5295.9 5327.2 5345.8 5382.3 5700.8 5701.6 5768.8 5834.3 5837.1 5806.0 5838.8 5864.3 5889.9 5895.5 5303.2 5318.8 5332.6 5336.5 5457.7 5924.1 5932.1 5946.7 5952.9 5958.3 5685.3 5692.9 5698.7 5701.1 5701.6 5637.1 5719.0 5761.7 5769.1 5810.6 5707.6 5712.2 5727.8 5770.8 5787.3 5553.2 5731.3 5787.4 5788.3 5790.7 4275.7 4315.1 4356.1 4368.1 4374.9 3872.5 3879.5 3897.5 3922.7 3923.2 5403.5 5469.2 5480.2 5481.3 5489.9 5820.8 5877.6 5892.7 5900.9 5930.3 5524.6 5553.1 5569.0 5571.0 5572.9 4940.9 4956.8 4983.2 5057.8 5068.1 6032.2 6105.4 6108.9 6111.3 6111.6 5886.8 5892.2 5893.1 5893.1 5939.0 5901.8 5928.5 5931.6 6089.7 6098.1 5716.1 5719.1 5722.1 5726.4 5776.6 5761.9 5802.2 5811.6 5812.5 5821.4 5558.1 5670.1 5677.4 5718.8 5726.3 5715.4 5717.6 5720.2 5724.2 5734.1 5585.2 5629.7 5630.1 5636.2 5640.2 5641.3 5642.1 5646.7 5689.8 5692.6 5613.9 5649.4 5653.1 5659.7 5674.5 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#1] ext.html Cycles:180 Average:55816.71 Median:183603.07 stddev:111244.26 (60.6%) stddev-sans-first:111479.06 19:37:21 INFO - PROCESS | 8701 | Values: 592.9 633.7 641.0 654.0 656.5 31884.8 32478.7 34506.8 34609.3 34625.5 44703.0 44880.8 45553.3 45701.3 45805.5 8567.7 8906.0 8912.4 8919.7 8923.4 8061.2 8268.0 8853.4 8984.4 8987.3 10468.8 10810.4 10831.2 11061.2 11104.3 10640.1 10708.5 10713.1 10720.4 10722.0 10535.6 10583.8 10612.8 10616.5 10621.2 42740.9 42970.6 43124.1 43168.8 43313.6 2797.4 3377.8 3455.6 3626.1 3636.7 30351.0 30866.5 31179.8 32140.5 33449.5 3971.5 4051.6 4061.0 4093.2 4156.2 295932.0 296614.0 297812.0 298570.0 298931.0 35438.5 35510.6 35688.0 35879.8 35900.8 36241.1 36583.8 36670.3 36674.0 36875.0 15415.2 15635.9 15652.0 15665.0 15678.2 11126.2 11143.9 11167.1 11178.8 11268.2 8216.0 8350.0 8423.1 8441.7 8588.5 6801.2 6975.7 7191.6 7261.1 7369.5 993.6 1043.7 1047.4 1121.9 1133.3 33616.8 33888.2 33996.5 34001.7 34145.5 1152.3 1157.1 1170.0 1209.1 1270.3 17500.4 17765.5 17864.0 17898.6 17931.2 547470.0 552404.0 553006.0 553193.0 553472.0 60114.1 61559.0 61666.4 61736.0 61754.0 1344.5 1386.6 1388.7 1390.2 1392.7 31792.7 33170.5 33244.8 33386.0 34333.0 53614.5 53998.2 54092.0 54142.7 54184.0 359082.0 363580.0 365482.0 366268.0 366597.0 25222.9 27744.3 28791.6 28831.4 29313.4 48664.0 49214.3 49541.5 49729.0 50526.5 40564.8 41826.0 42461.4 42607.6 42846.8 41445.6 41577.8 41685.0 42310.8 42795.6 37071.8 37085.0 37466.8 37502.8 42629.8 35315.7 36726.0 37663.6 37717.0 37768.2 28571.6 28861.3 28864.3 29213.6 29236.9 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#2] jquery.html Cycles:180 Average:29744.26 Median:31794.26 stddev:78825.66 (247.9%) stddev-sans-first:79015.90 19:37:21 INFO - PROCESS | 8701 | Values: 357.8 377.6 378.2 380.8 393.8 18202.3 18535.5 19507.3 19514.7 19875.1 11143.4 11269.0 11374.0 11393.7 11399.1 3868.6 4253.4 5044.5 5050.6 5055.3 3938.8 4049.9 4053.7 5259.5 5521.5 5463.4 5588.5 5591.6 5594.9 5597.0 5774.5 5804.4 5809.3 5809.7 5811.1 3741.9 5627.0 5634.8 6400.6 6869.5 24465.1 25277.4 25366.6 25978.9 26100.7 2334.7 2356.9 2415.1 2495.4 2622.0 15498.7 15843.8 16127.1 16451.3 16690.8 2107.9 2166.2 2251.4 2407.2 2514.6 80218.0 84972.6 95387.3 96387.0 96707.0 13697.7 17936.0 18127.9 18292.3 18889.8 31343.7 32036.5 32191.0 32326.0 32359.4 10107.4 10177.8 10300.5 10311.6 10389.3 8151.7 8399.4 8428.0 8432.0 8523.9 8616.7 8643.7 8673.5 8755.8 8963.1 2805.3 3337.7 3532.5 3556.7 3635.9 903.8 981.9 1012.5 1033.0 1141.8 19113.8 19423.8 19532.9 19553.2 19634.1 1000.6 1008.9 1014.4 1034.3 1064.1 10606.5 10939.7 10981.2 11006.1 11012.4 471304.0 472104.0 478218.0 479521.0 482380.0 91557.0 93160.0 93549.0 94453.5 94634.5 943.8 951.5 958.2 963.0 997.9 16648.8 17164.1 17261.5 17434.5 17749.0 31552.0 40946.6 41544.4 41603.4 42365.8 58190.0 60448.7 60460.1 61076.0 61119.4 7964.9 8115.8 8289.4 8331.2 8511.4 10757.3 12688.7 13166.0 13357.3 13480.0 11370.4 11452.8 11747.4 11847.5 11946.7 11230.7 11364.0 11441.4 11668.0 11678.1 11479.8 11485.8 11878.8 11933.2 12168.6 8208.1 8249.7 8381.7 8437.7 8485.6 10450.3 11679.1 11806.4 12054.1 12196.9 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#3] mootools.html Cycles:180 Average:5638.57 Median:4273.13 stddev:3242.59 (75.9%) stddev-sans-first:3235.55 19:37:21 INFO - PROCESS | 8701 | Values: 1334.2 1481.2 1508.8 1666.4 1835.7 8178.1 8513.4 8560.2 8679.6 8697.8 8404.5 8498.5 8573.5 8581.8 8587.8 1975.4 2237.5 2275.9 2300.0 2310.9 2306.7 2310.7 2314.1 2315.4 2316.0 2202.6 2244.4 2250.0 2250.1 2250.9 1937.2 2192.6 2250.6 2255.6 2263.0 2147.0 2162.9 2170.0 2172.1 2204.3 8477.9 8601.1 8607.9 8610.7 8612.2 5067.1 5201.4 5214.5 5221.8 5225.1 3148.9 3223.1 3250.5 3265.8 3279.1 1004.3 1010.4 1013.4 1020.4 1020.9 11304.2 11798.2 11804.9 12085.8 12095.5 4169.5 4210.8 4272.0 4274.3 4297.7 9121.7 9156.0 9164.2 9172.2 9173.2 4373.2 4931.2 4938.4 4942.5 4943.4 4166.3 4208.4 4208.8 4614.1 4769.2 3622.8 3697.0 3737.5 3751.6 3786.7 1062.7 1114.4 1121.9 1131.8 1137.1 934.4 1024.8 1025.9 1027.2 1030.3 5860.4 5975.8 6006.0 6092.0 6200.3 403.3 409.6 420.0 424.4 427.2 4140.4 4227.5 4236.3 4238.9 4274.3 10503.9 10890.9 10918.9 10947.9 10961.9 10606.2 10781.7 10810.4 10813.6 10819.1 8166.6 8194.0 8204.6 8215.0 8228.5 5934.1 5971.8 6115.8 6160.4 6184.3 9640.0 9829.7 10002.6 10036.1 10076.7 9907.2 10225.2 10254.8 10281.3 10290.4 6667.7 6984.6 7158.0 7195.9 7322.4 8388.4 8410.1 8441.2 8473.7 8502.2 7345.6 7581.3 7608.9 7733.4 7735.5 7414.3 7471.3 7498.2 7559.9 7679.5 6942.3 6989.7 7007.8 7009.3 7020.8 5042.5 5259.3 5337.8 5415.1 5427.6 5224.7 5280.0 5331.3 5483.8 5491.3 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#4] prototype.html Cycles:180 Average:4562.40 Median:5153.47 stddev:1382.22 (26.8%) stddev-sans-first:1348.43 19:37:21 INFO - PROCESS | 8701 | Values: 292.3 303.0 307.6 308.3 311.1 5325.9 5336.7 5345.9 5346.6 5364.9 5002.7 5136.5 5237.2 5270.2 5297.4 3985.2 4018.4 4020.6 4022.8 4040.5 4015.7 4021.7 4023.7 4038.4 4040.0 3839.5 3965.9 4037.9 4039.2 4075.5 3991.2 4015.3 4019.0 4026.5 4047.7 3559.6 3576.8 3578.4 3583.3 3597.3 4868.7 5117.3 5130.6 5140.3 5159.7 4525.6 4531.0 4554.8 4556.6 4563.6 5462.0 5478.5 5481.7 5488.4 5517.3 3701.5 3766.2 3767.2 3906.7 3930.6 5694.3 5697.5 5739.0 5813.4 5817.8 3927.5 3930.5 3939.0 4000.0 4012.6 3897.6 4025.9 4054.3 4054.8 4057.2 4605.7 4619.9 4630.4 4632.6 4645.6 5547.3 5549.5 5568.4 5580.6 5595.7 1313.8 1343.4 1371.7 1383.1 1392.3 865.2 870.8 875.8 882.0 882.9 4855.7 4883.9 4887.8 4888.4 4889.6 5142.9 5147.2 5173.0 5174.2 5182.4 4493.9 4828.0 4887.2 4891.8 4909.5 2625.8 2668.4 2699.8 2720.9 2733.8 5113.6 5203.8 5215.2 5223.0 5248.3 5109.6 5122.7 5165.5 5359.6 5835.9 5915.4 5931.9 5935.4 5948.9 6017.6 5753.6 5785.9 5786.9 5812.2 5814.6 5529.3 5710.6 5743.4 5758.9 5773.8 5984.4 5992.9 6013.0 6017.7 6024.7 3714.8 3876.6 3886.0 3897.9 3898.5 5439.8 5771.9 5799.3 5817.0 5821.9 5468.3 5594.2 5604.7 5613.6 5626.0 5526.7 5531.1 5538.0 5571.6 5596.8 5231.5 5439.9 5452.8 5453.3 5536.9 5515.0 5547.0 5553.4 5562.7 5617.2 5448.9 5470.4 5479.2 5479.6 5483.4 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - PROCESS | 8701 | [#5] yui.html Cycles:180 Average:16213.75 Median:4690.39 stddev:19907.60 (424.4%) stddev-sans-first:19929.70 19:37:21 INFO - PROCESS | 8701 | Values: 777.9 782.1 838.0 851.3 862.0 16068.1 16689.0 16696.1 16770.7 16784.7 15717.0 15738.4 15758.0 15826.6 15841.6 825.3 834.4 835.0 835.1 835.2 684.8 790.2 822.9 826.1 828.7 856.3 856.8 860.7 862.3 862.9 858.2 858.8 859.1 859.4 859.4 522.4 604.4 620.0 620.7 621.7 13768.3 13769.6 13822.0 13823.9 13843.7 13161.5 13298.9 13450.4 13539.3 13709.2 12037.7 12153.7 12363.9 12706.9 12996.9 4348.5 4377.8 4412.1 4535.5 4544.8 58600.7 58825.0 59011.4 59098.4 59713.6 10981.9 11020.4 11141.6 11474.4 11506.3 16741.7 16748.5 16765.5 16782.5 16805.4 7738.9 7920.2 7936.6 7945.2 8150.3 4610.3 4730.5 4752.3 4777.5 4910.8 3395.9 3480.8 3487.1 3490.9 3491.2 625.3 654.8 656.6 659.6 666.8 611.4 637.5 677.7 701.9 749.8 8818.5 9029.0 9034.9 9083.5 9149.4 525.5 582.8 642.1 669.1 683.8 4374.7 4420.8 4510.9 4616.3 4650.3 71459.6 73645.6 73716.8 74224.3 74250.0 65201.7 66330.3 66507.7 66640.0 68104.0 59120.1 59250.1 59903.9 60521.7 60755.4 9023.4 9036.8 9204.4 9352.6 9390.2 36418.5 37018.4 37365.4 38414.6 39197.2 48684.0 49175.0 49811.8 50139.0 50202.0 12546.8 12598.3 12605.0 12664.4 12766.2 14119.6 14237.7 14246.3 14458.2 14472.6 12158.7 12339.6 12426.2 12505.3 12855.3 13428.2 13534.8 13595.3 13639.8 13885.8 11751.2 12167.6 12175.2 12363.8 12393.8 11158.8 11161.7 11426.3 11565.8 11748.4 10562.8 10599.1 10759.9 10823.1 10832.4 19:37:21 INFO - PROCESS | 8701 | -------- Summary: end -------- 19:37:21 INFO - PROCESS | 8701 | 19:37:21 INFO - TEST-INFO | 8701: exit 0 19:37:21 INFO - TEST-OK | dromaeo_css | took 1113748ms 19:37:21 INFO - TEST-START | kraken 19:37:21 INFO - operating with platform_type : linux_ 19:37:21 INFO - Initialising browser for kraken test... 19:37:21 INFO - TEST-INFO | started process 8886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplb8ZuQ/profile http://localhost:37615/getInfo.html) 19:37:26 INFO - PROCESS | 8886 | __metrics Screen width/height:1600/1200 19:37:26 INFO - PROCESS | 8886 | colorDepth:24 19:37:26 INFO - PROCESS | 8886 | Browser inner width/height: 1024/697 19:37:26 INFO - PROCESS | 8886 | __metrics 19:37:26 ERROR - PROCESS | 8886 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:37:27 INFO - TEST-INFO | 8886: exit 0 19:37:27 INFO - Browser initialized. 19:37:27 INFO - Running cycle 1/1 for kraken test... 19:37:27 INFO - TEST-INFO | started process 8966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplb8ZuQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:39 INFO - PROCESS | 8966 | RSS: Main: 154984448 19:37:39 INFO - PROCESS | 8966 | 19:37:42 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37615/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:42 INFO - PROCESS | 8966 | RSS: Main: 211632128 19:37:42 INFO - PROCESS | 8966 | 19:37:45 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37615/tests/kraken/driver.html?testName=audio-dft) 19:37:46 INFO - PROCESS | 8966 | RSS: Main: 199737344 19:37:46 INFO - PROCESS | 8966 | 19:37:49 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37615/tests/kraken/driver.html?testName=audio-fft) 19:37:50 INFO - PROCESS | 8966 | RSS: Main: 268173312 19:37:50 INFO - PROCESS | 8966 | 19:37:52 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37615/tests/kraken/driver.html?testName=audio-oscillator) 19:37:52 INFO - PROCESS | 8966 | RSS: Main: 177524736 19:37:52 INFO - PROCESS | 8966 | 19:37:54 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:55 INFO - PROCESS | 8966 | RSS: Main: 181780480 19:37:55 INFO - PROCESS | 8966 | 19:37:58 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37615/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:59 INFO - PROCESS | 8966 | RSS: Main: 218177536 19:37:59 INFO - PROCESS | 8966 | 19:38:02 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37615/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:03 INFO - PROCESS | 8966 | RSS: Main: 217731072 19:38:03 INFO - PROCESS | 8966 | 19:38:06 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37615/tests/kraken/driver.html?testName=json-parse-financial) 19:38:06 INFO - PROCESS | 8966 | RSS: Main: 218361856 19:38:06 INFO - PROCESS | 8966 | 19:38:08 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:08 INFO - PROCESS | 8966 | RSS: Main: 211554304 19:38:08 INFO - PROCESS | 8966 | 19:38:10 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:38:11 INFO - PROCESS | 8966 | RSS: Main: 210206720 19:38:11 INFO - PROCESS | 8966 | 19:38:13 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:38:13 INFO - PROCESS | 8966 | RSS: Main: 220921856 19:38:13 INFO - PROCESS | 8966 | 19:38:16 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:16 INFO - PROCESS | 8966 | RSS: Main: 227897344 19:38:16 INFO - PROCESS | 8966 | 19:38:19 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:20 INFO - PROCESS | 8966 | RSS: Main: 225243136 19:38:20 INFO - PROCESS | 8966 | 19:38:21 INFO - PROCESS | 8966 | Cycle 1(1): loaded http://localhost:37615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37615/tests/kraken/driver.html?testName=ai-astar) 19:38:22 INFO - PROCESS | 8966 | RSS: Main: 271458304 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | __start_tp_report 19:38:22 INFO - PROCESS | 8966 | _x_x_mozilla_page_load 19:38:22 INFO - PROCESS | 8966 | _x_x_mozilla_page_load_details 19:38:22 INFO - PROCESS | 8966 | |i|pagename|runs| 19:38:22 INFO - PROCESS | 8966 | |0;ai-astar;112;106;111;109;111;113;110;115;110;109 19:38:22 INFO - PROCESS | 8966 | |1;audio-beat-detection;150;128;127;203;132;134;157;136;162;132 19:38:22 INFO - PROCESS | 8966 | |2;audio-dft;160;161;160;162;162;161;160;161;161;160 19:38:22 INFO - PROCESS | 8966 | |3;audio-fft;74;74;75;113;75;76;76;74;99;75 19:38:22 INFO - PROCESS | 8966 | |4;audio-oscillator;82;82;122;83;82;83;123;82;82;126 19:38:22 INFO - PROCESS | 8966 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;117;116;117 19:38:22 INFO - PROCESS | 8966 | |6;imaging-darkroom;146;146;145;146;146;146;146;147;147;147 19:38:22 INFO - PROCESS | 8966 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 19:38:22 INFO - PROCESS | 8966 | |8;json-parse-financial;53;53;52;53;54;54;55;68;52;51 19:38:22 INFO - PROCESS | 8966 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;62;62 19:38:22 INFO - PROCESS | 8966 | |10;stanford-crypto-aes;80;80;80;84;80;80;81;81;85;80 19:38:22 INFO - PROCESS | 8966 | |11;stanford-crypto-ccm;125;121;127;119;128;123;119;118;161;121 19:38:22 INFO - PROCESS | 8966 | |12;stanford-crypto-pbkdf2;160;161;161;157;157;162;159;159;156;155 19:38:22 INFO - PROCESS | 8966 | |13;stanford-crypto-sha256-iterative;65;63;62;62;61;62;63;61;64;63 19:38:22 INFO - PROCESS | 8966 | __end_tp_report 19:38:22 INFO - PROCESS | 8966 | __start_cc_report 19:38:22 INFO - PROCESS | 8966 | _x_x_mozilla_cycle_collect,1702 19:38:22 INFO - PROCESS | 8966 | __end_cc_report 19:38:22 INFO - PROCESS | 8966 | __startTimestamp1464230302173__endTimestamp 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | ------- Summary: start ------- 19:38:22 INFO - PROCESS | 8966 | Number of tests: 14 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.46 (2.2%) stddev-sans-first:2.55 19:38:22 INFO - PROCESS | 8966 | Values: 112.0 106.0 111.0 109.0 111.0 113.0 110.0 115.0 110.0 109.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:143.00 stddev:23.48 (16.4%) stddev-sans-first:24.86 19:38:22 INFO - PROCESS | 8966 | Values: 150.0 128.0 127.0 203.0 132.0 134.0 157.0 136.0 162.0 132.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 19:38:22 INFO - PROCESS | 8966 | Values: 160.0 161.0 160.0 162.0 162.0 161.0 160.0 161.0 161.0 160.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.55 (18.1%) stddev-sans-first:14.13 19:38:22 INFO - PROCESS | 8966 | Values: 74.0 74.0 75.0 113.0 75.0 76.0 76.0 74.0 99.0 75.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:82.00 stddev:20.02 (24.4%) stddev-sans-first:20.70 19:38:22 INFO - PROCESS | 8966 | Values: 82.0 82.0 122.0 83.0 82.0 83.0 123.0 82.0 82.0 126.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:38:22 INFO - PROCESS | 8966 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:38:22 INFO - PROCESS | 8966 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:38:22 INFO - PROCESS | 8966 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:53.50 stddev:4.88 (9.1%) stddev-sans-first:5.15 19:38:22 INFO - PROCESS | 8966 | Values: 53.0 53.0 52.0 53.0 54.0 54.0 55.0 68.0 52.0 51.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 19:38:22 INFO - PROCESS | 8966 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:1.85 (2.3%) stddev-sans-first:1.92 19:38:22 INFO - PROCESS | 8966 | Values: 80.0 80.0 80.0 84.0 80.0 80.0 81.0 81.0 85.0 80.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:124.00 stddev:12.70 (10.2%) stddev-sans-first:13.46 19:38:22 INFO - PROCESS | 8966 | Values: 125.0 121.0 127.0 119.0 128.0 123.0 119.0 118.0 161.0 121.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.36 (1.5%) stddev-sans-first:2.46 19:38:22 INFO - PROCESS | 8966 | Values: 160.0 161.0 161.0 157.0 157.0 162.0 159.0 159.0 156.0 155.0 19:38:22 INFO - PROCESS | 8966 | 19:38:22 INFO - PROCESS | 8966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.00 19:38:22 INFO - PROCESS | 8966 | Values: 65.0 63.0 62.0 62.0 61.0 62.0 63.0 61.0 64.0 63.0 19:38:22 INFO - PROCESS | 8966 | -------- Summary: end -------- 19:38:22 INFO - PROCESS | 8966 | 19:38:23 INFO - TEST-INFO | 8966: exit 0 19:38:23 INFO - TEST-OK | kraken | took 61219ms 19:38:23 INFO - SUITE-END | took 1174s 19:38:23 INFO - Completed test suite (00:19:35) 19:38:23 INFO - javascript benchmark 19:38:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.1344823449435, 3098.2254436390917, 3123.094302652231, 3133.2323580722727, 3147.748180145587, 5260.237265596486, 5293.841184764454, 5338.839834804957, 5450.427705090963, 5474.397816240215, 5364.678119312844, 5381.569474442045, 5425.782968681248, 5465.098258787295, 5501.229827824108, 4788.28175773635, 4837.0325934813, 5001.774920128585, 5056.924146137811, 5068.037072956145, 4998.200287953928, 5041.924371134436, 5055.31753213317, 5061.3420255366755, 5104.464031276718, 4862.708237505725, 4907.288443175756, 4916.336294600219, 4936.407631084275, 4943.159662857305, 4959.983203443286, 4966.081274964107, 4967.403911530603, 4975.203967365241, 4979.800807967713, 4912.042151780404, 4919.385076865392, 4923.8276660316715, 4926.187179115442, 4938.08645400602, 5289.86775330616, 5295.867603309909, 5327.200919862013, 5345.812896548641, 5382.30030096085, 5700.800471983461, 5701.57238207132, 5768.826935191909, 5834.27071616048, 5837.124431335291, 5805.970970145122, 5838.766449342022, 5864.266966629171, 5889.882202355929, 5895.498882594985, 5303.178007408857, 5318.840434786963, 5332.600054995891, 5336.51971322579, 5457.672539647634, 5924.140999555127, 5932.139839723216, 5946.70266486674, 5952.851178720567, 5958.255218097738, 5685.260916080883, 5692.857678558069, 5698.7435565399655, 5701.059325211294, 5701.572382071361, 5637.098064309773, 5719.0, 5761.740721667535, 5769.07694768835, 5810.564207684441, 5707.6290041147195, 5712.171735098387, 5727.770889164387, 5770.826875193751, 5787.276590426197, 5553.194786755897, 5731.312242530923, 5787.363390027093, 5788.334341550775, 5790.71046447676, 4275.722078064978, 4315.07225946423, 4356.128774245164, 4368.060866913629, 4374.868753937387, 3872.53529576447, 3879.476270703475, 3897.4738410314812, 3922.686185105185, 3923.195744872294, 5403.540699040625, 5469.15228139631, 5480.177973304037, 5481.287432633732, 5489.862753431116, 5820.767169313265, 5877.5591830612875, 5892.6759028253, 5900.911486327708, 5930.258717660293, 5524.640898341595, 5553.139263414178, 5568.972155139199, 5570.972145139248, 5572.888542229132, 4940.8764780880765, 4956.801727930914, 4983.202687569971, 5057.772400241998, 5068.113080210948, 6032.155498230251, 6105.368770830132, 6108.888502348253, 6111.257501106137, 6111.561351782648, 5886.823395298148, 5892.204552385373, 5893.145493903275, 5893.145493903275, 5939.020061689773, 5901.7639294427745, 5928.525717942468, 5931.6441013539325, 6089.69551522431, 6098.054801505774, 5716.114002329646, 5719.056355701429, 5722.055860783091, 5726.4273572642405, 5776.624519406225, 5761.884762304647, 5802.245708057925, 5811.593188476935, 5812.505936995233, 5821.417858214145, 5558.055130627884, 5670.092785154356, 5677.432256774289, 5718.771249149988, 5726.255586773859, 5715.371309156073, 5717.571182161271, 5720.170575266647, 5724.169995350734, 5734.053881109737, 5585.245991791056, 5629.718514074198, 5630.0991841305195, 5636.239107720406, 5640.153976903333, 5641.294838145232, 5642.069058605448, 5646.689432081275, 5689.829305120853, 5692.6299790513485, 5613.943860561342, 5649.406812284651, 5653.067243904709, 5659.6887171204335, 5674.546036317002], "value": 5346.58827932484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.908099244617, 633.6514916795762, 640.9935900640992, 653.9673016349183, 656.5371413153728, 31884.840575797145, 32478.67521324786, 34506.82746586267, 34609.30781384377, 34625.48061779075, 44703.0, 44880.775596121974, 45553.31670024944, 45701.314480282825, 45805.541944580546, 8567.70013049542, 8905.95547022264, 8912.376133670645, 8919.687810926618, 8923.375363724543, 8061.193880611951, 8267.95866020669, 8853.424527405698, 8984.41601295917, 8987.325950553703, 10468.842967355497, 10810.35137891729, 10831.187660925423, 11061.170412219075, 11104.333739975587, 10640.0955918747, 10708.464576771208, 10713.089387402002, 10720.35677859327, 10722.0, 10535.63125290611, 10583.788324233472, 10612.78774424515, 10616.469176541219, 10621.150307975344, 42740.862956852034, 42970.57029429697, 43124.13751724948, 43168.78415607933, 43313.56686433127, 2797.398559309758, 3377.7973321600784, 3455.58532976042, 3626.1478552540134, 3636.654517820803, 30351.0, 30866.537001944987, 31179.84410077935, 32140.517892231634, 33449.49825752616, 3971.543272523668, 4051.6150965658217, 4060.9593904060876, 4093.2222877653153, 4156.168766246733, 295931.99999999785, 296614.0, 297812.0, 298570.0, 298931.0, 35438.468422973674, 35510.644893550736, 35688.0, 35879.82060089683, 35900.820495897875, 36241.093972650895, 36583.81708091496, 36670.266594667955, 36674.0, 36875.0, 15415.229238538028, 15635.921820390826, 15652.0, 15665.0, 15678.216089195495, 11126.221164518405, 11143.888561114285, 11167.106631469625, 11178.776424471465, 11268.211225214156, 8216.0, 8350.039745429232, 8423.11557286476, 8441.662333506714, 8588.484690918565, 6801.1838579369805, 6975.686094125776, 7191.64041797908, 7261.092363454568, 7369.484136110528, 993.5529011944653, 1043.6503771236721, 1047.3558761361708, 1121.9158563107637, 1133.2860298012365, 33616.83191584027, 33888.15279618029, 33996.49005264873, 34001.65998340034, 34145.487817682755, 1152.3258893547368, 1157.1032449851432, 1170.0464121740754, 1209.1354681402838, 1270.2822905058613, 17500.387486437914, 17765.467035988942, 17864.0, 17898.5525361867, 17931.193096310697, 547470.0, 552404.0, 553006.0, 553193.0, 553472.0, 60114.0982885257, 61559.0, 61666.383336166065, 61736.0, 61754.0, 1344.5495758920872, 1386.5563019833758, 1388.6667199871958, 1390.2492653966744, 1392.6587985943306, 31792.682073179898, 33170.50244246387, 33244.833775830964, 33386.0, 34333.0, 53614.46385536095, 53998.19002714884, 54092.0, 54142.729286353315, 54184.0, 359082.0, 363580.0, 365482.0, 366268.0, 366597.0, 25222.873885630455, 27744.306392340353, 28791.5681264777, 28831.423371532033, 29313.413731725672, 48664.0, 49214.261786073956, 49541.50458495513, 49729.0, 50526.494735053646, 40564.79717601393, 41826.0, 42461.363079553215, 42607.57392426036, 42846.78576607097, 41445.585544144174, 41577.79211103925, 41685.0, 42310.7884460588, 42795.57204427916, 37071.81464092662, 37085.0, 37466.81266593649, 37502.81248593739, 42629.78685106679, 35315.68694855011, 36726.02205580931, 37663.62336376601, 37717.0, 37768.244635107694, 28571.571426428203, 28861.27846803847, 28864.278393040342, 29213.561796573493, 29236.853815731636], "value": 19218.20453373164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.79963220596466, 377.6318089862383, 378.1963327928152, 380.77343980331693, 393.77554793767564, 18202.271909123636, 18535.536611584717, 19507.317243896465, 19514.70727939082, 19875.105620247086, 11143.442827858595, 11269.0, 11374.0, 11393.715157121076, 11399.088072954164, 3868.5551161616354, 4253.425787518692, 5044.470330615288, 5050.570701490377, 5055.317532133152, 3938.8030598470104, 4049.898752531181, 4053.695972802037, 5259.474052594748, 5521.503064724174, 5463.426340234278, 5588.469095435927, 5591.552675785927, 5594.888102237953, 5597.048501754691, 5774.5091667208335, 5804.361520232771, 5809.302883653967, 5809.651420914737, 5811.128330750379, 3741.887743367676, 5627.0, 5634.830955071355, 6400.647964361959, 6869.4847886408215, 24465.143719969714, 25277.368065798317, 25366.619500707504, 25978.87010564954, 26100.738992610022, 2334.7315058768118, 2356.8939397727145, 2415.1064106280614, 2495.413577809213, 2621.973780262211, 15498.690026199525, 15843.841561584468, 16127.113008784512, 16451.341946322133, 16690.83309166917, 2107.93676189713, 2166.19850655257, 2251.414632195641, 2407.170550381705, 2514.635377870217, 80218.0, 84972.57513712515, 95387.27676339442, 96387.0, 96707.0, 13697.657558560917, 17936.0, 18127.90936045311, 18292.268309267747, 18889.81110188908, 31343.68656313453, 32036.519452208235, 32191.0, 32326.0, 32359.35281294361, 10107.444090574942, 10177.796444071226, 10300.536475858604, 10311.639092631873, 10389.272750907365, 8151.673933042731, 8399.412041157182, 8427.95786021066, 8432.030316513557, 8523.914760852436, 8616.655333786704, 8643.654253829776, 8673.52295623734, 8755.781105472413, 8963.148500892405, 2805.340744924941, 3337.6829201225846, 3532.4877892705413, 3556.7332450066347, 3635.927281454356, 903.810199858024, 981.8527220916919, 1012.5139932832282, 1033.0423846810252, 1141.828725691153, 19113.81927338374, 19423.8057619422, 19532.85138634749, 19553.217871285273, 19634.11646475912, 1000.5847573257163, 1008.9344192627456, 1014.3812274512542, 1034.270839058462, 1064.090202876545, 10606.522706478227, 10939.726506837234, 10981.231313808117, 11006.064484518745, 11012.449377531091, 471304.0, 472104.0, 478218.0, 479521.0, 482380.0, 91557.0, 93160.0, 93549.0, 94453.5277323609, 94634.5268273668, 943.8065196634674, 951.509972364233, 958.152035448619, 962.9807403852024, 997.875265591801, 16648.750268746222, 17164.141792910556, 17261.482155535356, 17434.47696569105, 17749.0, 31552.0, 40946.59053409428, 41544.37683434811, 41603.375949360176, 42365.78817105895, 58190.0, 60448.697756510934, 60460.09309860268, 61076.0, 61119.38880611137, 7964.920350796418, 8115.79710507242, 8289.378296627898, 8331.208535189147, 8511.36164787631, 10757.30077544957, 12688.74622507563, 13166.0, 13357.332133393096, 13479.991807905419, 11370.43147842588, 11452.770944580896, 11747.353895535827, 11847.52609895629, 11946.701332466759, 11230.719232019264, 11364.0, 11441.427928603704, 11668.0, 11678.124140689652, 11479.783949847491, 11485.827712584485, 11878.762424751283, 11933.16467847277, 12168.57409990646, 8208.056073551617, 8249.670013199404, 8381.706640267805, 8437.662493500191, 8485.618147183268, 10450.320729152581, 11679.124065694938, 11806.409679516162, 12054.09594280415, 12196.878031219574], "value": 9853.07382355718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.206147342331, 1481.2223582619124, 1508.834028256892, 1666.3917670050428, 1835.742995980563, 8178.141295164011, 8513.446625969307, 8560.22957933785, 8679.566021698905, 8697.782555436117, 8404.495730256189, 8498.532580708059, 8573.52845593492, 8581.828363432727, 8587.828243435144, 1975.4073777866654, 2237.4965632732587, 2275.920342788003, 2300.0454811253308, 2310.9075636974585, 2306.6770652108717, 2310.7111611048617, 2314.1206341590173, 2315.3979965209, 2315.9652605210936, 2202.603531364354, 2244.36035729817, 2249.955000899981, 2250.0999600159903, 2250.8762018089, 1937.205745644286, 2192.6491761318193, 2250.6061439248065, 2255.605269077921, 2263.038208761286, 2146.969454661771, 2162.8702277863376, 2169.9566008679894, 2172.055156007142, 2204.327680057582, 8477.872831907527, 8601.096884827066, 8607.913920860774, 8610.655573777041, 8612.18184272493, 5067.138586440314, 5201.427842937273, 5214.478552144793, 5221.843344699665, 5225.059489291926, 3148.874045038219, 3223.09753269085, 3250.5449237106823, 3265.787723797969, 3279.0652366132176, 1004.3070281505737, 1010.4392062405362, 1013.3869009249445, 1020.4234607446843, 1020.8825985011745, 11304.15218858589, 11798.174127811057, 11804.881951180465, 12085.818712719316, 12095.516179352815, 4169.457970463881, 4210.831566737296, 4272.0, 4274.31610942254, 4297.656187504992, 9121.726348209564, 9156.0, 9164.221041211571, 9172.220361269234, 9173.220276276592, 4373.169097871394, 4931.211006238985, 4938.358013458227, 4942.5304596063315, 4943.382077240345, 4166.291730405838, 4208.410822484854, 4208.789560522023, 4614.100250451197, 4769.165396055676, 3622.836972336251, 3696.963030369716, 3737.5141231640255, 3751.6248375162268, 3786.7159963002887, 1062.7396287909357, 1114.3982249585133, 1121.9495122719497, 1131.8358837968449, 1137.1300954769608, 934.4206591913057, 1024.8462730590322, 1025.8974102589682, 1027.244974943416, 1030.3354336452946, 5860.443257890493, 5975.79084732041, 6006.0, 6092.025275955826, 6200.321116374888, 403.33449807817334, 409.63951722484023, 420.03392197944606, 424.4121891180737, 427.19686988461496, 4140.358244472111, 4227.513835908849, 4236.279832428495, 4238.936415953764, 4274.252005899018, 10503.947480262703, 10890.891091088988, 10918.945405273082, 10947.890521094847, 10961.890381096246, 10606.15150787935, 10781.730456738487, 10810.405427701551, 10813.62152324665, 10819.080378167786, 8166.632501537326, 8193.959030204811, 8204.589770511451, 8214.958925205336, 8228.465149765247, 5934.080217566284, 5971.820845374646, 6115.84710382244, 6160.383961603804, 6184.257889053342, 9639.951800240953, 9829.705108846745, 10002.649907253211, 10036.146927511243, 10076.748081298027, 9907.207423405966, 10225.181985440999, 10254.846177307496, 10281.280310378203, 10290.3825770454, 6667.733290668513, 6984.580925144304, 7157.964210178916, 7195.8920616191845, 7322.414206863545, 8388.370872184732, 8410.074891761778, 8441.198086181803, 8473.745787626382, 8502.192291732275, 7345.632718363953, 7581.279778421262, 7608.885866711893, 7733.38132949374, 7735.535867847947, 7414.295641914009, 7471.252874712485, 7498.175200728025, 7559.886601701089, 7679.539227646359, 6942.340477654615, 6989.720411183495, 7007.824804379931, 7009.264027277062, 7020.824479388056, 5042.546170844642, 5259.316288882421, 5337.813176538958, 5415.1335786274, 5427.6472029317965, 5224.660397074178, 5279.973600131974, 5331.297039388431, 5483.7806487740045, 5491.341039075177], "value": 4408.187060008177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.27953095619307, 302.9545568164776, 307.6170168140665, 308.34938280228715, 311.1381473318908, 5325.893482130355, 5336.6531175473565, 5345.90408966162, 5346.625736198468, 5364.865878353048, 5002.699838009722, 5136.460671629481, 5237.162054071349, 5270.235815806705, 5297.417284098746, 3985.2228815381013, 4018.4374187613757, 4020.618041286073, 4022.7988600569856, 4040.515138183422, 4015.738976966488, 4021.678265738734, 4023.7384570003, 4038.4144299076615, 4040.0, 3839.5008648875605, 3965.9008524786823, 4037.919241615166, 4039.151778126582, 4075.49056367954, 3991.1618560102415, 4015.277250094982, 4019.0, 4026.516817981861, 4047.7166598338126, 3559.6440355964196, 3576.766015724571, 3578.3737845876867, 3583.283343331318, 3597.316509863144, 4868.707877527359, 5117.33474648297, 5130.640855140142, 5140.3060586820675, 5159.742012899377, 4525.637948964108, 4530.980529380896, 4554.772261386951, 4556.567126123013, 4563.566461186182, 5462.0, 5478.534324582375, 5481.67029012668, 5488.368837583689, 5517.282753242093, 3701.463892484616, 3766.2090960898245, 3767.2088861339153, 3906.7460615060213, 3930.6069393060466, 5694.316681998187, 5697.515711164515, 5738.971305143489, 5813.418658134237, 5817.767289308423, 3927.5286965563746, 3930.4693866328253, 3939.0, 3999.960000400017, 4012.558618551957, 3897.649211570972, 4025.939610905839, 4054.2702313583836, 4054.7769872657286, 4057.16828050249, 4605.723656580616, 4619.930701039487, 4630.398048253705, 4632.591052652601, 4645.581897629229, 5547.2511210986, 5549.472800083986, 5568.443155684399, 5580.553555715533, 5595.732779287143, 1313.8094976228394, 1343.40890008396, 1371.6845125620964, 1383.1424516799648, 1392.3386391463973, 865.1780808232205, 870.7678634731784, 875.7504111328241, 881.9911800882037, 882.8543290357147, 4855.6601037927, 4883.877903052381, 4887.828925987645, 4888.413390393175, 4889.608831293488, 5142.942822870881, 5147.202183661539, 5172.965406918632, 5174.197999310113, 5182.378114626269, 4493.865184044484, 4828.0, 4887.242477416006, 4891.755412229445, 4909.459959404463, 2625.750553697396, 2668.3729323608936, 2699.838009719423, 2720.8775605097817, 2733.808633395683, 5113.616478764107, 5203.791848326025, 5215.226822880239, 5223.0, 5248.343957005374, 5109.616778741609, 5122.718250496258, 5165.48345165488, 5359.5712343012465, 5835.94164058354, 5915.438033386821, 5931.911021334683, 5935.376785437467, 5948.940510594839, 6017.638941663514, 5753.583494932055, 5785.9132113017495, 5786.9131963019745, 5812.157237200498, 5814.5639077068545, 5529.30883639545, 5710.628809127394, 5743.4256574342235, 5758.913616295843, 5773.797917072882, 5984.431479009487, 5992.910106348321, 6013.0, 6017.699115044318, 6024.668643224665, 3714.814259286971, 3876.5929577393968, 3885.970217892317, 3897.9220415592094, 3898.5126859142606, 5439.836804895859, 5771.8557036074435, 5799.274341059695, 5816.970915145397, 5821.854453638693, 5468.261784659179, 5594.1608758686525, 5604.6917419542315, 5613.635113717595, 5625.971870140623, 5526.668399896019, 5531.147065733025, 5538.0, 5571.637843540157, 5596.83778665053, 5231.450697676842, 5439.9456005441025, 5452.809151679672, 5453.26380938584, 5536.944630553643, 5514.979728750194, 5547.029269877675, 5553.444655534414, 5562.666240025612, 5617.241672374341, 5448.945510545002, 5470.398256191896, 5479.205515200353, 5479.643823151482, 5483.396826349019], "value": 4112.7096057063445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.9144294127647, 782.1162086841867, 837.9581020948951, 851.3317046118794, 861.991380086199, 16068.116253606062, 16689.0, 16696.081715505672, 16770.74843877343, 16784.748228776563, 15717.0, 15738.449154279573, 15758.0, 15826.604334891634, 15841.603959901007, 825.331481499984, 834.4117397234966, 834.9916500835005, 835.1106072033265, 835.2023817254537, 684.8150999230205, 790.1979490816825, 822.8930239068912, 826.1325608111489, 828.7430896422098, 856.3149480415674, 856.8286342731448, 860.6514361683528, 862.3015357560365, 862.8835107260534, 858.2233079063458, 858.7853036740814, 859.072202021818, 859.4113032572676, 859.4241857955154, 522.4279414041619, 604.4106995679222, 619.9752009919598, 620.652434636605, 621.6611946489174, 13768.311584420739, 13769.586912392644, 13822.0, 13823.861761382459, 13843.723125537434, 13161.473541058345, 13298.933505332412, 13450.394732237073, 13539.308474035375, 13709.245991470465, 12037.699057523545, 12153.696157596043, 12363.949961340977, 12706.872931270755, 12996.935015324958, 4348.543402942709, 4377.7592232427205, 4412.139632771611, 4535.455745310584, 4544.750038747868, 58600.706996464745, 58825.0, 59011.40988590145, 59098.40901590972, 59713.62577368014, 10981.945090274497, 11020.393878336608, 11141.610043648434, 11474.426278686033, 11506.309621422573, 16741.665166696843, 16748.497545073424, 16765.497035088967, 16782.496525104267, 16805.41181058657, 7738.922610773933, 7920.207979202149, 7936.6031698414845, 7945.245201705829, 8150.266476017068, 4610.308453731967, 4730.479647238801, 4752.310914917318, 4777.450593181759, 4910.8281210157475, 3395.898123056312, 3480.756347055682, 3487.128217945514, 3490.877819276313, 3491.249381382964, 625.3152797686616, 654.8199245207511, 656.5535435903631, 659.6075335175562, 666.756633828649, 611.3916652930362, 637.4581605635173, 677.6679427080695, 701.8876979683226, 749.8050506868144, 8818.51498167594, 9028.954855225813, 9034.86447703285, 9083.500407477652, 9149.353116439104, 525.5112745146973, 582.8134996800983, 642.078617184342, 669.1067424987599, 683.8256244657581, 4374.737515749065, 4420.84527041552, 4510.909781804346, 4616.261398176276, 4650.3041159183485, 71459.6427017872, 73645.6317718408, 73716.83982121307, 74224.25775742173, 74250.0, 65201.67399162974, 66330.33669663241, 66507.66746166238, 66640.02836978603, 68104.0, 59120.11319830206, 59250.11124833131, 59903.90336338207, 60521.69739151364, 60755.39244607586, 9023.4134781239, 9036.774080648036, 9204.355695101278, 9352.579133939125, 9390.201832844285, 36418.45372319364, 37018.444723328634, 37365.43951840779, 38414.615853842224, 39197.21605567815, 48684.0, 49175.0, 49811.75094124506, 50139.0, 50202.0, 12546.811797822857, 12598.3070931096, 12605.0, 12664.430100645677, 12766.234025958473, 14119.64700882486, 14237.715245695235, 14246.297987216674, 14458.204798736171, 14472.565823025327, 12158.696032599255, 12339.62981110568, 12426.192297500633, 12505.312207828656, 12855.29295888735, 13428.19430834153, 13534.79697804514, 13595.32023398846, 13639.795403068763, 13885.791713124108, 11751.236169648946, 12167.574134905235, 12175.208611440228, 12363.814542781685, 12393.814092788434, 11158.832617510907, 11161.665150045512, 11426.314421134759, 11565.768684626091, 11748.412579370826, 10562.8415573768, 10599.140180412765, 10759.89240107589, 10823.134149268197, 10832.404217767784], "value": 6982.300433355805, "unit": "score"}], "name": "dromaeo_css", "value": 7100.667651961058, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 109.0, 111.0, 113.0, 110.0, 115.0, 110.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 127.0, 203.0, 132.0, 134.0, 157.0, 136.0, 162.0, 132.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 113.0, 75.0, 76.0, 76.0, 74.0, 99.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 122.0, 83.0, 82.0, 83.0, 123.0, 82.0, 82.0, 126.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 54.0, 54.0, 55.0, 68.0, 52.0, 51.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 84.0, 80.0, 80.0, 81.0, 81.0, 85.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 121.0, 127.0, 119.0, 128.0, 123.0, 119.0, 118.0, 161.0, 121.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 157.0, 157.0, 162.0, 159.0, 159.0, 156.0, 155.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 62.0, 61.0, 62.0, 63.0, 61.0, 64.0, 63.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1496.1000000000001, "alertThreshold": 2.0}]} 19:38:23 INFO - Return code: 0 19:38:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:38:23 ERROR - # TBPL SUCCESS # 19:38:23 INFO - Running post-action listener: _resource_record_post_action 19:38:23 INFO - ##### 19:38:23 INFO - ##### Finished run-tests step (success) 19:38:23 INFO - ##### 19:38:23 INFO - Running post-run listener: _resource_record_post_run 19:38:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538329088; Read time: 392; Write time: 428260 19:38:23 INFO - TinderboxPrint: CPU usage
13.2% 19:38:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 392 19:38:23 INFO - TinderboxPrint: I/O write bytes / time
538,329,088 / 428,260 19:38:23 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 19:38:23 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 19:38:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:38:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246566912; Read time: 0; Write time: 259644 19:38:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291147776; Read time: 392; Write time: 168616 19:38:24 INFO - Running post-run listener: _upload_blobber_files 19:38:24 INFO - Blob upload gear active. 19:38:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:38:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:38:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:28 INFO - (blobuploader) - INFO - Done attempting. 19:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:29 INFO - (blobuploader) - INFO - Done attempting. 19:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:30 INFO - (blobuploader) - INFO - Done attempting. 19:38:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:30 INFO - Return code: 0 19:38:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecd685d37364d99e3a318b0aac5988bc9419bdf5641f88ecd0c751aa0d8b8c9796eb2f464768d49cf39ff6904b8b3b3167de3b69aa4f717a8d12dd096e9d1a51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/284d921db58fc04b24c8b49a2f2c7e5e1786fcf807b646e572c69949c691e88d4f7da980c920de0cf77e9d490fdd7926dad58b88a7f8e3c5e51e0ad185cb1ce1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ac733776484c15b027574897d978958edc910191805ca08572a11127a79a42966fa865d2954bdc0d0445763c67a0f4a1f4260ffe97200a16cfa42feb39cd6d"} 19:38:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:30 INFO - Contents: 19:38:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecd685d37364d99e3a318b0aac5988bc9419bdf5641f88ecd0c751aa0d8b8c9796eb2f464768d49cf39ff6904b8b3b3167de3b69aa4f717a8d12dd096e9d1a51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/284d921db58fc04b24c8b49a2f2c7e5e1786fcf807b646e572c69949c691e88d4f7da980c920de0cf77e9d490fdd7926dad58b88a7f8e3c5e51e0ad185cb1ce1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ac733776484c15b027574897d978958edc910191805ca08572a11127a79a42966fa865d2954bdc0d0445763c67a0f4a1f4260ffe97200a16cfa42feb39cd6d"} 19:38:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:30 INFO - Copying logs to upload dir... 19:38:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.737898 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-25 19:38:29.878216) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 19:38:29.882184) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 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/ecd685d37364d99e3a318b0aac5988bc9419bdf5641f88ecd0c751aa0d8b8c9796eb2f464768d49cf39ff6904b8b3b3167de3b69aa4f717a8d12dd096e9d1a51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/284d921db58fc04b24c8b49a2f2c7e5e1786fcf807b646e572c69949c691e88d4f7da980c920de0cf77e9d490fdd7926dad58b88a7f8e3c5e51e0ad185cb1ce1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ac733776484c15b027574897d978958edc910191805ca08572a11127a79a42966fa865d2954bdc0d0445763c67a0f4a1f4260ffe97200a16cfa42feb39cd6d"} build_url:https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/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/ecd685d37364d99e3a318b0aac5988bc9419bdf5641f88ecd0c751aa0d8b8c9796eb2f464768d49cf39ff6904b8b3b3167de3b69aa4f717a8d12dd096e9d1a51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/284d921db58fc04b24c8b49a2f2c7e5e1786fcf807b646e572c69949c691e88d4f7da980c920de0cf77e9d490fdd7926dad58b88a7f8e3c5e51e0ad185cb1ce1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ac733776484c15b027574897d978958edc910191805ca08572a11127a79a42966fa865d2954bdc0d0445763c67a0f4a1f4260ffe97200a16cfa42feb39cd6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 19:38:29.911646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:38:29.911994) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464222361.758298-1231224324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:38:29.993482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 19:38:29.995004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 19:38:29.995622) ========= ========= Total master_lag: 0.17 =========