builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1463761280.26 results: success (0) buildid: 20160520063516 builduid: c6abe845d2f04de6be1ed04f3c667eaf revision: 44e878aba14a9fc466e4e86e739ff513bae375b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.258262) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.258821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.259144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.278304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.278692) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 09:21:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-20 09:21:21 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.414209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.414776) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015958 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.465307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:20.465677) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44e878aba14a9fc466e4e86e739ff513bae375b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44e878aba14a9fc466e4e86e739ff513bae375b5 --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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 09:21:21,734 truncating revision to first 12 chars 2016-05-20 09:21:21,734 Setting DEBUG logging. 2016-05-20 09:21:21,734 attempt 1/10 2016-05-20 09:21:21,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/44e878aba14a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 09:21:22,151 unpacking tar archive at: mozilla-beta-44e878aba14a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.197548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.198230) ========= script_repo_revision: 44e878aba14a9fc466e4e86e739ff513bae375b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.198896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.199231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 09:21:21.211931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-20 09:21:21.212253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:22 INFO - MultiFileLogger online at 20160520 09:21:22 in /builds/slave/test 09:21:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:21:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:22 INFO - {'append_to_log': False, 09:21:22 INFO - 'base_work_dir': '/builds/slave/test', 09:21:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:21:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:22 INFO - 'branch': 'Mozilla-Beta', 09:21:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:22 INFO - 'config_files': ('talos/linux_config.py',), 09:21:22 INFO - 'default_actions': ('clobber', 09:21:22 INFO - 'read-buildbot-config', 09:21:22 INFO - 'download-and-extract', 09:21:22 INFO - 'populate-webroot', 09:21:22 INFO - 'create-virtualenv', 09:21:22 INFO - 'install', 09:21:22 INFO - 'run-tests'), 09:21:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:22 INFO - 'download_minidump_stackwalk': True, 09:21:22 INFO - 'download_symbols': 'ondemand', 09:21:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:22 INFO - 'installer_path': 'installer.exe', 09:21:22 INFO - 'log_level': 'info', 09:21:22 INFO - 'log_name': 'talos', 09:21:22 INFO - 'log_to_console': True, 09:21:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:22 INFO - 'opt_config_files': (), 09:21:22 INFO - 'pip_index': False, 09:21:22 INFO - 'sps_profile': False, 09:21:22 INFO - 'sps_profile_interval': 0, 09:21:22 INFO - 'suite': 'dromaeojs', 09:21:22 INFO - 'system_bits': '32', 09:21:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:22 INFO - 'title': 'talos-linux64-ix-051', 09:21:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:22 INFO - 'use_talos_json': True, 09:21:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:22 INFO - 'work_dir': 'build'} 09:21:22 INFO - ##### 09:21:22 INFO - ##### Running clobber step. 09:21:22 INFO - ##### 09:21:22 INFO - Running pre-action listener: _resource_record_pre_action 09:21:22 INFO - Running main action method: clobber 09:21:22 INFO - rmtree: /builds/slave/test/build 09:21:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:23 INFO - Running post-action listener: _resource_record_post_action 09:21:23 INFO - ##### 09:21:23 INFO - ##### Running read-buildbot-config step. 09:21:23 INFO - ##### 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: read_buildbot_config 09:21:23 INFO - Using buildbot properties: 09:21:23 INFO - { 09:21:23 INFO - "project": "", 09:21:23 INFO - "product": "firefox", 09:21:23 INFO - "script_repo_revision": "production", 09:21:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:21:23 INFO - "repository": "", 09:21:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:21:23 INFO - "buildid": "20160520063516", 09:21:23 INFO - "pgo_build": "True", 09:21:23 INFO - "basedir": "/builds/slave/test", 09:21:23 INFO - "buildnumber": 16, 09:21:23 INFO - "slavename": "talos-linux64-ix-051", 09:21:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:21:23 INFO - "platform": "ubuntu64_hw", 09:21:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:21:23 INFO - "branch": "mozilla-beta", 09:21:23 INFO - "repo_path": "releases/mozilla-beta", 09:21:23 INFO - "revision": "44e878aba14a9fc466e4e86e739ff513bae375b5", 09:21:23 INFO - "stage_platform": "linux64-pgo", 09:21:23 INFO - "builduid": "c6abe845d2f04de6be1ed04f3c667eaf", 09:21:23 INFO - "slavebuilddir": "test" 09:21:23 INFO - } 09:21:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:21:23 INFO - Running post-action listener: _resource_record_post_action 09:21:23 INFO - ##### 09:21:23 INFO - ##### Running download-and-extract step. 09:21:23 INFO - ##### 09:21:23 INFO - Running pre-action listener: _resource_record_pre_action 09:21:23 INFO - Running main action method: download_and_extract 09:21:23 INFO - mkdir: /builds/slave/test/build/tests 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:23 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:21:26 INFO - Downloaded 1412 bytes. 09:21:26 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:21:26 INFO - Using the following test package requirements: 09:21:26 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:26 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:26 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:21:26 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'jsshell-linux-x86_64.zip'], 09:21:26 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:26 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:26 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:21:26 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:21:26 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:26 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:21:26 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:21:26 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:26 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21: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')]} 09:21:26 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:29 INFO - Downloaded 23364975 bytes. 09:21:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:30 INFO - Return code: 0 09:21:30 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21:30 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')]} 09:21:30 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:38 INFO - Downloaded 23364975 bytes. 09:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:39 INFO - Return code: 0 09:21:39 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')]} 09:21:39 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:41 INFO - Downloaded 10845194 bytes. 09:21:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:21:41 INFO - Return code: 0 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:41 INFO - https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:21:42 INFO - Downloaded 53798215 bytes. 09:21:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:42 INFO - mkdir: /builds/slave/test/properties 09:21:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:42 INFO - Contents: 09:21:42 INFO - build_url:https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:21:43 INFO - Running post-action listener: _resource_record_post_action 09:21:43 INFO - Running post-action listener: set_extra_try_arguments 09:21:43 INFO - ##### 09:21:43 INFO - ##### Running populate-webroot step. 09:21:43 INFO - ##### 09:21:43 INFO - Running pre-action listener: _resource_record_pre_action 09:21:43 INFO - Running main action method: populate_webroot 09:21:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:43 INFO - '--tppagecycles', 09:21:43 INFO - '7'], 09:21:43 INFO - 'tests': ['tsvgm']}}, 09:21:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:21:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:21:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'tests': ['damp', 'tps']}, 09:21:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['damp', 'tps']}, 09:21:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:21:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:43 INFO - 'other': {'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'other_l64': {'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'other_nol64': {'tests': ['a11yr', 09:21:43 INFO - 'ts_paint', 09:21:43 INFO - 'tpaint', 09:21:43 INFO - 'sessionrestore', 09:21:43 INFO - 'sessionrestore_no_auto_restore', 09:21:43 INFO - 'tabpaint']}, 09:21:43 INFO - 'svgr': {'tests': ['tsvgx', 09:21:43 INFO - 'tsvgr_opacity', 09:21:43 INFO - 'tart', 09:21:43 INFO - 'tscrollx', 09:21:43 INFO - 'cart']}, 09:21:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['tsvgx', 09:21:43 INFO - 'tsvgr_opacity', 09:21:43 INFO - 'tart', 09:21:43 INFO - 'tscrollx', 09:21:43 INFO - 'cart']}, 09:21:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'tests': ['tp5o']}, 09:21:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'talos_options': ['--e10s'], 09:21:43 INFO - 'tests': ['tp5o']}, 09:21:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'talos_options': ['--xperf_path', 09:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:43 INFO - 'tests': ['tp5n']}, 09:21:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:43 INFO - 'talos_options': ['--e10s', 09:21:43 INFO - '--xperf_path', 09:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:43 INFO - 'tests': ['tp5n']}}, 09:21:43 INFO - 'talos.zip': {'path': '', 09:21:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:43 INFO - Running post-action listener: _resource_record_post_action 09:21:43 INFO - ##### 09:21:43 INFO - ##### Running create-virtualenv step. 09:21:43 INFO - ##### 09:21:43 INFO - Running pre-action listener: _resource_record_pre_action 09:21:43 INFO - Running main action method: create_virtualenv 09:21:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:43 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 09:21:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:43 INFO - Using real prefix '/usr' 09:21:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:46 INFO - Installing pip.................done. 09:21:46 INFO - Return code: 0 09:21:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:21:46 INFO - Using env: {'DISPLAY': ':0', 09:21:46 INFO - 'HOME': '/home/cltbld', 09:21:46 INFO - 'LANG': 'en_US.UTF-8', 09:21:46 INFO - 'LANGUAGE': 'en_US:en', 09:21:46 INFO - 'LOGNAME': 'cltbld', 09:21:46 INFO - 'MAIL': '/var/mail/cltbld', 09:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:46 INFO - 'MOZ_NO_REMOTE': '1', 09:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:46 INFO - 'NO_EM_RESTART': '1', 09:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:46 INFO - 'PWD': '/builds/slave/test', 09:21:46 INFO - 'SHELL': '/bin/bash', 09:21:46 INFO - 'SHLVL': '1', 09:21:46 INFO - 'TERM': 'linux', 09:21:46 INFO - 'TMOUT': '86400', 09:21:46 INFO - 'USER': 'cltbld', 09:21:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:46 INFO - '_': '/tools/buildbot/bin/python'} 09:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:46 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 09:21:46 INFO - Cleaning up... 09:21:46 INFO - Return code: 0 09:21:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:21:46 INFO - Using env: {'DISPLAY': ':0', 09:21:46 INFO - 'HOME': '/home/cltbld', 09:21:46 INFO - 'LANG': 'en_US.UTF-8', 09:21:46 INFO - 'LANGUAGE': 'en_US:en', 09:21:46 INFO - 'LOGNAME': 'cltbld', 09:21:46 INFO - 'MAIL': '/var/mail/cltbld', 09:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:46 INFO - 'MOZ_NO_REMOTE': '1', 09:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:46 INFO - 'NO_EM_RESTART': '1', 09:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:46 INFO - 'PWD': '/builds/slave/test', 09:21:46 INFO - 'SHELL': '/bin/bash', 09:21:46 INFO - 'SHLVL': '1', 09:21:46 INFO - 'TERM': 'linux', 09:21:46 INFO - 'TMOUT': '86400', 09:21:46 INFO - 'USER': 'cltbld', 09:21:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:46 INFO - '_': '/tools/buildbot/bin/python'} 09:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:46 INFO - Downloading/unpacking psutil>=0.7.1 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:48 INFO - Installing collected packages: psutil 09:21:48 INFO - Running setup.py install for psutil 09:21:48 INFO - building 'psutil._psutil_linux' extension 09:21:48 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 09:21:48 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 09:21:48 INFO - building 'psutil._psutil_posix' extension 09:21:48 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 09:21:49 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 09:21:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:49 INFO - Successfully installed psutil 09:21:49 INFO - Cleaning up... 09:21:49 INFO - Return code: 0 09:21:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:49 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:49 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.0.0'] in /builds/slave/test/build 09:21:49 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.0.0 09:21:49 INFO - Using env: {'DISPLAY': ':0', 09:21:49 INFO - 'HOME': '/home/cltbld', 09:21:49 INFO - 'LANG': 'en_US.UTF-8', 09:21:49 INFO - 'LANGUAGE': 'en_US:en', 09:21:49 INFO - 'LOGNAME': 'cltbld', 09:21:49 INFO - 'MAIL': '/var/mail/cltbld', 09:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:49 INFO - 'MOZ_NO_REMOTE': '1', 09:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:49 INFO - 'NO_EM_RESTART': '1', 09:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:49 INFO - 'PWD': '/builds/slave/test', 09:21:49 INFO - 'SHELL': '/bin/bash', 09:21:49 INFO - 'SHLVL': '1', 09:21:49 INFO - 'TERM': 'linux', 09:21:49 INFO - 'TMOUT': '86400', 09:21:49 INFO - 'USER': 'cltbld', 09:21:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:49 INFO - '_': '/tools/buildbot/bin/python'} 09:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:21:51 INFO - Installing collected packages: mozsystemmonitor 09:21:51 INFO - Running setup.py install for mozsystemmonitor 09:21:51 INFO - Successfully installed mozsystemmonitor 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:54 INFO - Downloading docopt-0.6.1.tar.gz 09:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:54 INFO - Running setup.py install for blobuploader 09:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:54 INFO - Running setup.py install for requests 09:21:54 INFO - Running setup.py install for docopt 09:21:54 INFO - Successfully installed blobuploader requests docopt 09:21:54 INFO - Cleaning up... 09:21:55 INFO - Return code: 0 09:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:55 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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:55 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 09:21:55 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 09:21:55 INFO - Using env: {'DISPLAY': ':0', 09:21:55 INFO - 'HOME': '/home/cltbld', 09:21:55 INFO - 'LANG': 'en_US.UTF-8', 09:21:55 INFO - 'LANGUAGE': 'en_US:en', 09:21:55 INFO - 'LOGNAME': 'cltbld', 09:21:55 INFO - 'MAIL': '/var/mail/cltbld', 09:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:55 INFO - 'MOZ_NO_REMOTE': '1', 09:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:55 INFO - 'NO_EM_RESTART': '1', 09:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:55 INFO - 'PWD': '/builds/slave/test', 09:21:55 INFO - 'SHELL': '/bin/bash', 09:21:55 INFO - 'SHLVL': '1', 09:21:55 INFO - 'TERM': 'linux', 09:21:55 INFO - 'TMOUT': '86400', 09:21:55 INFO - 'USER': 'cltbld', 09:21:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:55 INFO - '_': '/tools/buildbot/bin/python'} 09:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:55 INFO - Running setup.py (path:/tmp/pip-xCsn1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:55 INFO - Running setup.py (path:/tmp/pip-0KDIT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:55 INFO - Running setup.py (path:/tmp/pip-HhShJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:55 INFO - Running setup.py (path:/tmp/pip-EbxIj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:55 INFO - Running setup.py (path:/tmp/pip-Wii4sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:55 INFO - Running setup.py (path:/tmp/pip-tn8WgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:55 INFO - Running setup.py (path:/tmp/pip-xLoWQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:55 INFO - Running setup.py (path:/tmp/pip-xcw2zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:55 INFO - Running setup.py (path:/tmp/pip-OijHjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:55 INFO - Running setup.py (path:/tmp/pip-zucflv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:55 INFO - Running setup.py (path:/tmp/pip-cHAT2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:56 INFO - Running setup.py (path:/tmp/pip-ysy67_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:56 INFO - Running setup.py (path:/tmp/pip-uSHU9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:56 INFO - Running setup.py (path:/tmp/pip-s_uSyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:56 INFO - Running setup.py (path:/tmp/pip-VOZkWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:56 INFO - Running setup.py (path:/tmp/pip-5f8erW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:56 INFO - Running setup.py (path:/tmp/pip-Yo0qI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:56 INFO - Running setup.py install for manifestparser 09:21:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:56 INFO - Running setup.py install for mozcrash 09:21:56 INFO - Running setup.py install for mozdebug 09:21:56 INFO - Running setup.py install for mozdevice 09:21:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:56 INFO - Running setup.py install for mozfile 09:21:56 INFO - Running setup.py install for mozhttpd 09:21:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozinfo 09:21:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozInstall 09:21:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozleak 09:21:57 INFO - Running setup.py install for mozlog 09:21:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for moznetwork 09:21:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozprocess 09:21:57 INFO - Running setup.py install for mozprofile 09:21:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozrunner 09:21:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:57 INFO - Running setup.py install for mozscreenshot 09:21:58 INFO - Running setup.py install for moztest 09:21:58 INFO - Running setup.py install for mozversion 09:21:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:58 INFO - Cleaning up... 09:21:58 INFO - Return code: 0 09:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:21:58 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 09:21:58 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 09:21:58 INFO - Using env: {'DISPLAY': ':0', 09:21:58 INFO - 'HOME': '/home/cltbld', 09:21:58 INFO - 'LANG': 'en_US.UTF-8', 09:21:58 INFO - 'LANGUAGE': 'en_US:en', 09:21:58 INFO - 'LOGNAME': 'cltbld', 09:21:58 INFO - 'MAIL': '/var/mail/cltbld', 09:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:58 INFO - 'MOZ_NO_REMOTE': '1', 09:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:58 INFO - 'NO_EM_RESTART': '1', 09:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:58 INFO - 'PWD': '/builds/slave/test', 09:21:58 INFO - 'SHELL': '/bin/bash', 09:21:58 INFO - 'SHLVL': '1', 09:21:58 INFO - 'TERM': 'linux', 09:21:58 INFO - 'TMOUT': '86400', 09:21:58 INFO - 'USER': 'cltbld', 09:21:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:58 INFO - '_': '/tools/buildbot/bin/python'} 09:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:58 INFO - Running setup.py (path:/tmp/pip-ph4qmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:58 INFO - Running setup.py (path:/tmp/pip-lNA140-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:58 INFO - Running setup.py (path:/tmp/pip-maizI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:58 INFO - Running setup.py (path:/tmp/pip-_bgixO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:58 INFO - Running setup.py (path:/tmp/pip-YgXq4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:58 INFO - Running setup.py (path:/tmp/pip-yu4yVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:58 INFO - Running setup.py (path:/tmp/pip-X6plcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:58 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)) 09:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:58 INFO - Running setup.py (path:/tmp/pip-BLoXWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:59 INFO - Running setup.py (path:/tmp/pip-55j5yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:59 INFO - Running setup.py (path:/tmp/pip-JaZtpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:59 INFO - Running setup.py (path:/tmp/pip-VvlIb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:59 INFO - Running setup.py (path:/tmp/pip-Jc7VFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:59 INFO - Running setup.py (path:/tmp/pip-CZAsUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:59 INFO - Running setup.py (path:/tmp/pip-fcosKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:59 INFO - Running setup.py (path:/tmp/pip-3yBZjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:59 INFO - Running setup.py (path:/tmp/pip-ccIR41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:59 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)) 09:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:59 INFO - Running setup.py (path:/tmp/pip-qzC3nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:59 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)) 09:21:59 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)) 09:21:59 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)) 09:21:59 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)) 09:21:59 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)) 09:21:59 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)) 09:21:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:01 INFO - Downloading blessings-1.6.tar.gz 09:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:01 INFO - Installing collected packages: blessings 09:22:01 INFO - Running setup.py install for blessings 09:22:01 INFO - Successfully installed blessings 09:22:01 INFO - Cleaning up... 09:22:01 INFO - Return code: 0 09:22:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:02 INFO - Reading from file tmpfile_stdout 09:22:02 INFO - Current package versions: 09:22:02 INFO - argparse == 1.2.1 09:22:02 INFO - blessings == 1.6 09:22:02 INFO - blobuploader == 1.2.4 09:22:02 INFO - docopt == 0.6.1 09:22:02 INFO - manifestparser == 1.1 09:22:02 INFO - mozInstall == 1.12 09:22:02 INFO - mozcrash == 0.17 09:22:02 INFO - mozdebug == 0.1 09:22:02 INFO - mozdevice == 0.48 09:22:02 INFO - mozfile == 1.2 09:22:02 INFO - mozhttpd == 0.7 09:22:02 INFO - mozinfo == 0.9 09:22:02 INFO - mozleak == 0.1 09:22:02 INFO - mozlog == 3.1 09:22:02 INFO - moznetwork == 0.27 09:22:02 INFO - mozprocess == 0.22 09:22:02 INFO - mozprofile == 0.28 09:22:02 INFO - mozrunner == 6.11 09:22:02 INFO - mozscreenshot == 0.1 09:22:02 INFO - mozsystemmonitor == 0.0 09:22:02 INFO - moztest == 0.7 09:22:02 INFO - mozversion == 1.4 09:22:02 INFO - psutil == 3.1.1 09:22:02 INFO - requests == 1.2.3 09:22:02 INFO - wsgiref == 0.1.2 09:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:22:02 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 09:22:02 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 09:22:02 INFO - Using env: {'DISPLAY': ':0', 09:22:02 INFO - 'HOME': '/home/cltbld', 09:22:02 INFO - 'LANG': 'en_US.UTF-8', 09:22:02 INFO - 'LANGUAGE': 'en_US:en', 09:22:02 INFO - 'LOGNAME': 'cltbld', 09:22:02 INFO - 'MAIL': '/var/mail/cltbld', 09:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:02 INFO - 'MOZ_NO_REMOTE': '1', 09:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:02 INFO - 'NO_EM_RESTART': '1', 09:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:02 INFO - 'PWD': '/builds/slave/test', 09:22:02 INFO - 'SHELL': '/bin/bash', 09:22:02 INFO - 'SHLVL': '1', 09:22:02 INFO - 'TERM': 'linux', 09:22:02 INFO - 'TMOUT': '86400', 09:22:02 INFO - 'USER': 'cltbld', 09:22:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:02 INFO - '_': '/tools/buildbot/bin/python'} 09:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 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)) 09:22:02 INFO - Cleaning up... 09:22:02 INFO - Return code: 0 09:22:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:02 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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:22:02 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 09:22:02 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 09:22:02 INFO - Using env: {'DISPLAY': ':0', 09:22:02 INFO - 'HOME': '/home/cltbld', 09:22:02 INFO - 'LANG': 'en_US.UTF-8', 09:22:02 INFO - 'LANGUAGE': 'en_US:en', 09:22:02 INFO - 'LOGNAME': 'cltbld', 09:22:02 INFO - 'MAIL': '/var/mail/cltbld', 09:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:02 INFO - 'MOZ_NO_REMOTE': '1', 09:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:02 INFO - 'NO_EM_RESTART': '1', 09:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:02 INFO - 'PWD': '/builds/slave/test', 09:22:02 INFO - 'SHELL': '/bin/bash', 09:22:02 INFO - 'SHLVL': '1', 09:22:02 INFO - 'TERM': 'linux', 09:22:02 INFO - 'TMOUT': '86400', 09:22:02 INFO - 'USER': 'cltbld', 09:22:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:02 INFO - '_': '/tools/buildbot/bin/python'} 09:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:02 INFO - Downloading/unpacking jsonschema 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:04 INFO - Downloading/unpacking functools32 (from jsonschema) 09:22:04 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 09:22:04 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 09:22:04 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 09:22:04 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 09:22:04 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 09:22:04 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 09:22:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:04 INFO - warning: no files found matching '*.txt' 09:22:04 INFO - no previously-included directories found matching 'build' 09:22:04 INFO - no previously-included directories found matching 'dist' 09:22:04 INFO - no previously-included directories found matching '.git*' 09:22:04 INFO - Installing collected packages: jsonschema, functools32 09:22:04 INFO - Running setup.py install for functools32 09:22:04 INFO - warning: no files found matching '*.txt' 09:22:04 INFO - no previously-included directories found matching 'build' 09:22:04 INFO - no previously-included directories found matching 'dist' 09:22:04 INFO - no previously-included directories found matching '.git*' 09:22:04 INFO - Successfully installed jsonschema functools32 09:22:04 INFO - Cleaning up... 09:22:04 INFO - Return code: 0 09:22:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:22:04 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')]} 09:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:04 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')]} 09:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:04 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 0x7fa8442a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', '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 09:22:04 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 09:22:04 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 09:22:04 INFO - Using env: {'DISPLAY': ':0', 09:22:04 INFO - 'HOME': '/home/cltbld', 09:22:04 INFO - 'LANG': 'en_US.UTF-8', 09:22:04 INFO - 'LANGUAGE': 'en_US:en', 09:22:04 INFO - 'LOGNAME': 'cltbld', 09:22:04 INFO - 'MAIL': '/var/mail/cltbld', 09:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:04 INFO - 'MOZ_NO_REMOTE': '1', 09:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:04 INFO - 'NO_EM_RESTART': '1', 09:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:04 INFO - 'PWD': '/builds/slave/test', 09:22:04 INFO - 'SHELL': '/bin/bash', 09:22:04 INFO - 'SHLVL': '1', 09:22:04 INFO - 'TERM': 'linux', 09:22:04 INFO - 'TMOUT': '86400', 09:22:04 INFO - 'USER': 'cltbld', 09:22:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:04 INFO - '_': '/tools/buildbot/bin/python'} 09:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:05 INFO - Downloading/unpacking flake8 09:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:06 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 09:22:06 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 09:22:06 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 09:22:06 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 09:22:06 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 09:22:06 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 09:22:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 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 09:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:07 INFO - no previously-included directories found matching 'docs/_build' 09:22:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:07 INFO - Running setup.py install for pep8 09:22:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:07 INFO - no previously-included directories found matching 'docs/_build' 09:22:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:22:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:07 INFO - Cleaning up... 09:22:07 INFO - Return code: 0 09:22:07 INFO - Running post-action listener: _resource_record_post_action 09:22:07 INFO - Running post-action listener: _start_resource_monitoring 09:22:07 INFO - Starting resource monitoring. 09:22:07 INFO - ##### 09:22:07 INFO - ##### Running install step. 09:22:07 INFO - ##### 09:22:07 INFO - Running pre-action listener: _resource_record_pre_action 09:22:07 INFO - Running main action method: install 09:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:08 INFO - Reading from file tmpfile_stdout 09:22:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:08 INFO - Reading from file tmpfile_stdout 09:22:08 INFO - Output received: 09:22:08 INFO - Usage: mozinstall [options] installer 09:22:08 INFO - Options: 09:22:08 INFO - -h, --help show this help message and exit 09:22:08 INFO - -d DEST, --destination=DEST 09:22:08 INFO - Directory to install application into. [default: 09:22:08 INFO - "/builds/slave/test"] 09:22:08 INFO - --app=APP Application being installed. [default: firefox] 09:22:08 INFO - mkdir: /builds/slave/test/build/application 09:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:20 INFO - Reading from file tmpfile_stdout 09:22:20 INFO - Output received: 09:22:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:20 INFO - Running post-action listener: _resource_record_post_action 09:22:20 INFO - ##### 09:22:20 INFO - ##### Running run-tests step. 09:22:20 INFO - ##### 09:22:20 INFO - Running pre-action listener: _resource_record_pre_action 09:22:20 INFO - Running main action method: run_tests 09:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:20 INFO - Python 2.7.3 09:22:20 INFO - Return code: 0 09:22:20 INFO - grabbing minidump binary from tooltool 09:22: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')]} 09:22:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1130160>, '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 0x1131060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11314f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:22:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:22:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:21 INFO - Return code: 0 09:22:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:22:22 INFO - Return code: 0 09:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:22:22 INFO - Using env: {'DISPLAY': ':0', 09:22:22 INFO - 'HOME': '/home/cltbld', 09:22:22 INFO - 'LANG': 'en_US.UTF-8', 09:22:22 INFO - 'LANGUAGE': 'en_US:en', 09:22:22 INFO - 'LOGNAME': 'cltbld', 09:22:22 INFO - 'MAIL': '/var/mail/cltbld', 09:22:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:22 INFO - 'MOZ_NO_REMOTE': '1', 09:22:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:22 INFO - 'NO_EM_RESTART': '1', 09:22:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:22 INFO - 'PWD': '/builds/slave/test', 09:22:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:22 INFO - 'SHELL': '/bin/bash', 09:22:22 INFO - 'SHLVL': '1', 09:22:22 INFO - 'TERM': 'linux', 09:22:22 INFO - 'TMOUT': '86400', 09:22:22 INFO - 'USER': 'cltbld', 09:22:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337', 09:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:22 INFO - '_': '/tools/buildbot/bin/python'} 09:22:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:22:22 INFO - mozversion application_buildid: 20160520063516 09:22:22 INFO - mozversion application_changeset: 44e878aba14a9fc466e4e86e739ff513bae375b5 09:22:22 INFO - mozversion application_display_name: Firefox 09:22:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:22 INFO - mozversion application_name: Firefox 09:22:22 INFO - mozversion application_remotingname: firefox 09:22:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:22 INFO - mozversion application_vendor: Mozilla 09:22:22 INFO - mozversion application_version: 47.0 09:22:22 INFO - mozversion platform_buildid: 20160520063516 09:22:22 INFO - mozversion platform_changeset: 44e878aba14a9fc466e4e86e739ff513bae375b5 09:22:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:22:22 INFO - mozversion platform_version: 47.0 09:22:22 INFO - using testdate: 1463761342 09:22:22 INFO - actual date: 1463761342 09:22:22 INFO - starting webserver on 'localhost:39842' 09:22:22 INFO - SUITE-START | Running 2 tests 09:22:22 INFO - TEST-START | dromaeo_css 09:22:22 INFO - operating with platform_type : linux_ 09:22:22 INFO - Initialising browser for dromaeo_css test... 09:22:22 INFO - TEST-INFO | started process 26514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAKnDtV/profile http://localhost:39842/getInfo.html) 09:22:26 INFO - PROCESS | 26514 | __metrics Screen width/height:1600/1200 09:22:26 INFO - PROCESS | 26514 | colorDepth:24 09:22:26 INFO - PROCESS | 26514 | Browser inner width/height: 1024/697 09:22:26 INFO - PROCESS | 26514 | __metrics 09:22:27 INFO - PROCESS | 26514 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:28 INFO - TEST-INFO | 26514: exit 0 09:22:28 INFO - Browser initialized. 09:22:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:28 INFO - TEST-INFO | started process 26604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAKnDtV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:39 INFO - PROCESS | 26604 | RSS: Main: 139333632 09:22:39 INFO - PROCESS | 26604 | 09:23:31 INFO - PROCESS | 26604 | 1463761411358 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] 09:25:38 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39842/tests/dromaeo/cssquery-ext.html) 09:25:39 INFO - PROCESS | 26604 | RSS: Main: 219688960 09:25:39 INFO - PROCESS | 26604 | 09:28:41 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-ext.html (next: http://localhost:39842/tests/dromaeo/cssquery-jquery.html) 09:28:42 INFO - PROCESS | 26604 | RSS: Main: 221908992 09:28:42 INFO - PROCESS | 26604 | 09:31:44 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39842/tests/dromaeo/cssquery-mootools.html) 09:31:44 INFO - PROCESS | 26604 | RSS: Main: 216735744 09:31:44 INFO - PROCESS | 26604 | 09:34:46 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39842/tests/dromaeo/cssquery-prototype.html) 09:34:46 INFO - PROCESS | 26604 | RSS: Main: 188289024 09:34:46 INFO - PROCESS | 26604 | 09:37:49 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39842/tests/dromaeo/cssquery-yui.html) 09:37:49 INFO - PROCESS | 26604 | RSS: Main: 208986112 09:37:49 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:39842/tests/dromaeo/cssquery-yui.html (next: http://localhost:39842/tests/dromaeo/cssquery-dojo.html) 09:40:52 INFO - PROCESS | 26604 | RSS: Main: 253173760 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | __start_tp_report 09:40:52 INFO - PROCESS | 26604 | _x_x_mozilla_page_load 09:40:52 INFO - PROCESS | 26604 | _x_x_mozilla_page_load_details 09:40:52 INFO - PROCESS | 26604 | |i|pagename|runs| 09:40:52 INFO - PROCESS | 26604 | |0;dojo.html;3279.688429599188;3320.568326117606;3336;3350.11222026163;3398.9490157647633;5370.194470829378;5385.488378604036;5388.43421440749;5415.404305526394;5432.402435732066;5375.193720941861;5395.838124856251;5425.2675888755;5432.2123292122615;5434.673919564829;4871.464138944713;4918.975405122978;4979.153543897528;5002.9499705002845;5037.59699224063;4853.733044682541;4914.361133052698;4922.26166075088;4922.384701912261;4929.235968424882;4904.5340692634145;4915.606751459893;4965.950340496585;4982.476839931809;5005.0990821652085;4936.111499930011;4965.652404331699;4969.2049272116465;4980.7509624518625;5005.6496045276845;4810.831620893252;4910.631702622282;4936.975315123437;4953.851384458436;4965.776540055706;5147.047796157723;5187.273781670569;5189.299444574972;5192.091384007821;5192.1432963560965;5778.162166485878;5796.82609521715;5798.159266906275;5801.448862358069;5809.941900580982;5748.42515748426;5755;5802.100674395476;5820.447057529528;5841.766329346821;5443.727813609304;5454.263674403905;5454.781808727646;5459.890802183934;5486;5916.437938395846;5919.052951527735;5928.347881733006;5929.673867937218;5935.881282374328;5629.915551266734;5691.8292451226525;5705.74324155414;5710.885782284414;5750.367459579443;5811.244538210006;5821.79623713168;5827.300723913073;5830.679312637845;5839.9124013139835;5789.478946894799;5797.9420205797405;5801.216835727208;5801.7389217485315;5816.621919575214;5710.7430165642645;5758.856028599319;5791.333996590446;5830.446107619854;5839.416058394211;4419.027813880941;4429.269170586817;4432;4435.090806384684;4453.332000199931;3998.100427403869;4017.2568074906235;4018.095928416083;4034.293998550242;4049.1294371710223;5445.564354851603;5503.779848806083;5535.03136951032;5538.86152846174;5566.721663916869;5772.5959182856795;5799.449052340021;5801.042827933428;5802.941970580325;5805.10020946754;5429.592780541475;5485.753141108659;5517.034518959166;5520.171974203821;5529.087700529368;4961.578265847371;5024.271480635288;5040.143175660147;5044.066847633199;5077.060743762416;5988.520918326523;5992.970035149883;5993.041113421831;5995.760169593254;6011.7595296187665;5734.455226753452;5769.423057694197;5798.362180160263;5798.739056742373;5801.216835727208;6075.878482430238;6120.90429240112;6126.914660831389;6128.717018009172;6136.764169924236;5759.769609215752;5788.507976822018;5797.159411885337;5811.622244554091;5815.3603103657715;5699.800506982236;5789.218455508452;5847.181394604674;5881.147233651011;5911.704414779329;5689.032864412977;5694.202811606461;5699.458551437607;5704.857378565569;5706.572007099568;5644.915326270027;5656.660600363992;5681.261436013292;5696.743646535833;5706.001449746361;5481.397046324981;5555.0834112371;5596.104623260258;5603.663780173202;5637.915431268452;5534.418886016911;5688.8577785554035;5745.8563535911935;5754.798582049608;5779.682117483579;5491.75287112073;5514.310711161105;5529.032419326682;5538.196961440649;5568.9443105568425 09:40:52 INFO - PROCESS | 26604 | |1;ext.html;543.0523736080539;548.9478499542545;550.2131951309628;586.6186978463995;623.8159742875854;38611.22777544447;39142.60857391425;39158.41262381067;39173.608263917355;39180;43656;44695.55304446963;44815.77592112043;44818.55181448185;44826;8785.297176225886;8962.820743585124;8996.910030899706;9011;9014.278857691368;8769;8918.73243802687;8921.197092261695;8921.286297096249;8930.240929520998;8912.8663070054;8986.775330616721;9005.099490050976;9007.414518056337;9010.819783604324;8859.77850553738;8945.463272203624;8947.418417802823;8949.194572488475;8951;8799.516026618534;8973.416727912665;8998.685046023424;9000.279977601776;9000.639974401016;39949.60050399488;40226.798866005774;40279.39580906289;40357.59642403568;40540.797296013625;2593.7276585958393;3780.1494663700723;4148.585141485857;4372.103718737651;4387.912241755179;28537.286567835763;28849.711502885122;28966;28999.710002900123;29383.11850644484;4068.2270368629866;4114.506259248909;4184.267753143218;4221.927718046575;4228.978855105735;196604;198513;199410;199765;252787;60356.39643603595;60761.392386076455;61346.693266534276;63989;65428;57206;57397.71301143467;57797.71101144468;57839;58037;17069.40257090996;17151.485455436356;17169.31322747101;17236.741448878278;17267.3956411525;13946.302684865715;13991.860081399056;14057.086289391156;14081;14104.012719109769;20959.79040209609;20999.685004724943;21064.684029739565;21073.683894741593;21083.156673733185;7703.4992725473785;7787.182345853717;7817.452778305464;7916.604169791487;8017.599120044091;967.6081187119228;1067.9572817087385;1087.842262871895;1122.4724379541603;1236.9319687417278;30283.69716302853;30538.38923221523;30626;30799.692003079683;31266;1147.512307269424;1147.8737338892715;1203.1638011581867;1206.6440400081822;1296.183404455206;15600.759696121642;15828.446004390022;15855.682886342209;15977.840221597868;16349.264283107288;344780;345192;346260;347910;349823;57901.13148302779;58181.4181858176;58254;58267.70866145727;58424.70787646034;1319.6568892087935;1336.411978729356;1443.6607397261635;1467.0464198270995;1471.6100233438146;26903.327416814736;27082.879277209133;27440.725592744617;27817.44365112727;29777.404451910406;46295.53704462912;46569.53430465652;46659.76670116628;46715;46715.53284467112;189074;189926;190282;190307;190648;29442.411151777273;33382.83308583441;33595.49606755949;33945.3210935775;34935.475967859995;39831.800840996766;40308.39537407;50744.49255507398;51954.48045519648;52382.73808630933;37964.810175948944;38478.23043539058;38481;38505.80747096246;38658.42012369873;36596.81701591582;36850;37292.254154916205;37356.06609834667;38145.2370952585;37879.81060094682;38392;38565;38581;38978.61021389863;33564.160895977795;34248.82875585606;34565.65434345624;34570.30859382748;34797.82601086979;25979.870100649376;26773.598396024467;26859.865700671373;26929;27074.34875820096 09:40:52 INFO - PROCESS | 26604 | |2;jquery.html;376.33952413514277;380.1219183685685;383.3176945037832;383.7812446905264;387.6453045463401;18151.455456336316;18878.24487020519;19330.32343867965;19457.31899383522;19523.902380488114;11408.372539510323;11957.940210298959;11983;11990.16068875179;12000.7599848003;5073.670211436254;5172.146595811687;5355.357357117151;5453.536449401806;5456.890862182754;5331.147016477365;5391.460853914617;5401.648892821954;5419.458054194589;5435.0488664483755;5369.5167434930845;5405.567554595643;5415.6479828811;5422.105352616833;5585.078462053756;5512.972435137819;5535.778568857241;5550.72246387683;5577.860553486175;5581.720913954286;5307.363116426053;5394.244805727201;5513.421090785449;5625.718714064321;5636.928983493123;12922.353882305848;13179.934100329438;13308.667283317898;13945.511907083304;14059.78910316346;2389.2235023617395;2404.338806828119;2406.31420045288;2490.0413340863715;2724.4687285979244;9721.756956076084;9887.80224395508;9997.500124993794;10140.594376224943;10310.587576496931;1940.078462730206;1945.1441365799003;1963.4993076765477;1983.206717313072;1985.1067019840984;52126.73936630293;63274.68362658157;63861.68069159671;65040;69519.30480695229;10086;10183.963207358558;10359.948200259101;10470.685879423629;10476.68569942903;13112.475500979854;14171.92914035444;14746.63133421673;14759.557213283619;14809.777853332209;7789.80525486856;7827.9608601956625;8296.377771667148;8364.832703345899;8441.957790211132;8254.380921430917;8298.751037468886;8352.8329433411;8424.705135320357;8452.915470845335;4582.88542786433;4741.95258047422;4744.857654270378;4771;4777.4267087949665;1794.5334213104686;1834.257125864027;1862.1992543206281;1884.8209420105068;1893.1670065171281;905.9864102038474;993.4734590666958;1009.9899001009895;1016.4358780876685;1074.6775967209805;17493.82506174922;17853;17869.7319540207;18141.45575632733;18150.45548633543;971.6987733802544;1000.3147843726924;1027.0705011964185;1028.0798685176726;1047.3035431438161;10014.899851001397;10422;10451.477426128664;10483;10501;436622;439158;442637;448753;453136;79513.20486795058;82272.58863705643;82533;85247.57376213203;85478.57260713782;1057.4818339013827;1088.216484131424;1098.5386137822134;1101.7245688577855;1153.81538953767;15985.600359991093;16151.919240403722;16431.424900128437;16481.423150189687;17208.74186887223;34571.82714086414;35631.82184089063;35962.28075438424;36288.63711362958;36834.8158259207;47638.523614763406;49936.50063499464;51819.48180518297;54527.18209226785;54990.450095498534;8591.398602097794;8676;8693.174148455886;8840;8896.243819275434;10204.846927296245;13535.661608459868;13618.18290902549;13655.04414690962;13843.515476958259;11465.197436179387;11563.6530904073;11742.823857642314;11813.468393922121;11963.521459141537;11377.601783937522;11414.543418263176;11841.46713397882;11939.940300298444;12110.818337724764;11637.301761894314;11915.940420297842;12039.398030098635;12066.51733930668;12231.143819932875;8603.82792344162;8697.956510217662;8714.564271786512;8918.375713700238;8925.062868398725;11023.61417350389;11633.53465861356;11713.41432928333;11740.88259117432;11958.58144964922 09:40:52 INFO - PROCESS | 26604 | |3;mootools.html;1413.7737961926093;1585.7779910812485;1590.4592438570883;1852.5090850924507;1957.7650681918162;7917.089534703511;8044;8047.758567242992;8053.476524025934;8074.878876816852;7993.680252789882;8179.672813087484;8202;8203.138670439608;8209.97375328084;2394.7006624172022;2416;2425.9029638814513;2425.9393515162087;2426.7694569015916;2399.3042017814814;2427.2232885476656;2434.573949558829;2447.877606119696;2450.9509809803794;2347.5187586544803;2360.5160942006846;2364.43253619131;2394.916177933773;2398.5202959408102;2364.1370899621515;2390.127603424755;2394.964075538868;2405.6151015837468;2406.8435551689086;2390.2351247600773;2432.793212576933;2449.620308852113;2449.8162637802056;2462.6675398821108;8309.667613295462;8354.749357519284;8360.83278334436;8361.205685459872;8380.20388063133;5079.79680812767;5231.738413079331;5241.606879484016;5241.633085684004;5256.947430525723;3164.398764234788;3166.176794033545;3209.5025271082786;3262.9021129366156;3264.755143364257;989.4656885281939;1002.3735165521549;1011.5650270383732;1036.9481525923673;1045.9633912813015;11583.826242606368;11599.304041757521;11601.361925094116;11603.477843497063;11609.303441793434;4468.597826195593;4545.977270113628;4591.95408045922;4623.69945953512;4632.189366860786;9801.656942006995;9824.557894894748;9844;9850.359726617748;9854.753631159278;5155.819546315861;5156.04613146569;5169.508896654812;5179.22311653255;5181.248718935809;4172.7704976226;4613.331066995334;4661.557152070548;4750.287456881495;4756.048790241965;3801.2967600993907;3838.7504812187117;3868.729188956746;3886.7862267575556;3887.5529314129235;1219.7255617485994;1221.4625564751482;1233.4881024374963;1243.6579940516249;1250.3998080921208;1209.1415095282448;1225.026104247108;1228.846394200725;1486.5540337898587;1503.9022463540055;7906.802329941683;7988.360931125496;8027.07688615805;8053.516788992679;8053.758387248392;497.14242930944556;525.9421463638996;526.2133110999081;527.7625068719092;534.1571578055723;6206.100115483229;6216.471599913967;6230.532710046765;6275.780347687809;6278.937210627927;10472.424016679155;10808.675739727822;10824.512896919658;10838.729031774112;10842.96991785779;10326.845097323547;10578.62974795894;10646.520906559223;10665.786684266272;10722.195835312383;8198.180181981754;8356.832863342821;8415.915840841513;8417.032041315204;8418.284445822173;7655.846883062419;7697.730579429693;7698.0762308523335;7713.652885620273;7727.884081738891;9381.343305968516;9424.764380890532;9555.856662149934;9611.759706007126;9642.132208101304;9020.774480637774;9073.364864459425;9081.59132839037;9836.311458197857;9865.556049977624;7121.181064177686;7150.392216661642;7269.0550228472075;7795.41534384912;7910.960445197968;7865.4494185406475;7874.645640946285;7947.8807817881625;7948.8807667883875;7955.5226686399;6962;7338.449616278694;7398.630068496661;7415.406767458482;7480.588567628833;7169.677364518713;7191.7842464726145;7263.527870688388;7390.408767298711;7434.256574342522;7607.35337496319;7612.429067819825;7642.388608911385;7653.617319134132;7658.4639075264195;6966.3730264276455;7003.5797852129035;7049.118860142482;7049.541779784297;7054.858902822018;7030.2969703029285;7077.610731409822;7077.7168913242895;7084.397826184832;7093.538919970186 09:40:52 INFO - PROCESS | 26604 | |4;prototype.html;347.52562751843726;353.3322021379593;359.6888691282042;362.3712858191039;369.23752451188295;5945.643261404313;5958.463738263556;6001.66990815505;6006.51947844172;6014.338422773491;5914.260717410324;5914.674692891889;5928.318243401999;5930.229070220866;5948.958932186861;4436.134953684033;4528.388667529891;4544.795484203219;4640.814367425316;4661.184292748764;4626.028534007863;4638.304254361839;4660.347551342815;4697.600703940169;4705.106029854317;4635.165670179366;4645.468219820189;4653.302004699305;4654.2785868190485;4655.790489427967;4402.8679139625865;4534.274516077428;4643.791029403685;4651.558101980307;4678.883027924295;4142.130152667944;4148.315527937887;4149.232392007489;4156.750594964312;4161.83352665893;5696.060150075233;5700.543956483471;5712.11462223356;5712.742926568314;5718.914216286759;5446.428125046853;5451.536619387357;5463.590230732671;5464.371597266286;5467.20725494805;6299.716512756937;6307.369263073701;6310.085037669558;6321.620702757849;6327.335629758901;4331.631811296043;4476.8880777980485;4496.303073023687;4509;4640.09518143962;6548.770793022269;6576.243731970789;6600.174978127734;6611.23970743361;6618.635975021371;4603.217453032992;4609.124266389375;4613.792379342871;4614.353990441341;4617.984043510422;4667.159911216014;4670.95329046712;4672.135654903854;4673.112108699336;4682.321063445781;5343.251944727741;5348.331458567679;5353.661584603849;5357.571394288448;5362.65142765719;6243.75024999004;6357.459615932605;6358.904616430757;6374.4701271695385;6378.744850206032;1619.2146808797725;1627.7558366245157;1635.8282380349892;1638.189096397291;1639.639279358563;1014.6702321745462;1074.8334008228737;1078.3637653784306;1103.0568863621647;1109.611635927419;6035.698215089228;6046.3349031606485;6056.212692349966;6065.150878876961;6159.599626024294;6494.707738151795;6498.967505162444;6507.707153178024;6518.120053792677;6520.902186467207;6125.050617154348;6132.141500189977;6132.877342453126;6133.539984501181;6154.7230374633245;3471.791692498408;3507.6141624421803;3509.842057107436;3511.122219445139;3514.6309637488207;6652.600843949379;6722.394984451423;6873.931260687329;6898.241193468714;6907.067545881342;6796.898046529306;6802.863942721118;6821.522493425413;6880.759173429006;6880.931190688029;6833.350831670983;6855.383015528626;6874.65626718662;6874.828129296708;6884.311568843075;6619.635920024445;6619.867602648016;6630.436412904764;6631.469482441489;6640.535162538769;6277.591956522811;6510.251321098134;6512.544121911421;6545.410913017851;6551.082848401133;6842.144731908512;6876.862462750817;6878.793636190922;6883.621400823003;6890.173179218526;4574.88562785933;4615.0539139477;4619.86140415788;4621;4623.56076172763;6618.602883826986;6619.669016549057;6624.138861947916;6626.237982632059;6633.170853643294;6329.7151628175925;6364.6181229126405;6425.742970281136;6432.485401167989;6434.195725534309;6396.200474940632;6436;6441.903371449525;6444.645544495098;6449.226462722601;6300.369963003663;6303.527235457267;6306.747730090745;6310.936890631035;6317.9052314214405;6381.8085457436355;6456.031595260561;6459.192600924885;6464.967675161594;6478.060681201294;5990.7903223386975;6108.908366374597;6254.562180647311;6263.342349053284;6309.873802524015 09:40:52 INFO - PROCESS | 26604 | |5;yui.html;788.964496597653;793.7737744742745;912.5984566790612;914.6844338703145;918.7565295196772;14834.999999999987;14864.925675371622;15088.396464141435;15373.385064597403;15406.30671619777;14481.131132132079;14565.927170364133;14586.635334116625;14630.634234144152;14658.560243192695;778.5756762564388;936.6113063078814;938.4697645830119;965.1265604627823;969.4764826993415;938.080680932683;940.4498368454463;944.707140786355;949.4398305000049;950.2018304624114;1008.0222184481041;1008.0373243552426;1008.425197637347;1008.7024327823273;1008.9798204035915;816.7345612675874;984.901509849013;993.2749093162032;998.8651532043153;1000.9949950250275;728.3626826526789;733.6331834082958;733.7431898835418;733.9596322202277;734.5042096584784;14391.496297629532;14423.78364324536;14482.637934051732;14495.275236238145;14523.346449409803;14452.710945781026;14648.780268295985;14822.184779837105;14865.925670371687;14907.329170187368;11872.347020913847;11876.881231187665;11934.582289619822;12040.21738586989;12113.818292725617;3946.8223929923224;4003.199360127957;4005.619466150711;4012.3580227163807;4012.779297138656;51608;52175.217371739454;53636;53801.73099134479;54083.729581352236;11241.49413276388;11264.831027534594;11410.543578256777;11485.540578376938;11502.654920352403;21389.14443422277;21645.675314869975;21712.457188570414;21802.345929622137;21811.78188218129;8475.957620211859;8636.827263454696;8702.173293537104;8722.171393717586;8942.239909607626;4570.245909424908;4690.15577196108;4815.518448155157;4837.927431088537;4839.758012099381;3530.91172720684;3551.4140166872176;3571.714262858965;3582.3193593217725;3583.050491619723;551.5256879083985;564.6978866306506;586.3052283044606;653.0791583866725;671.9059331693567;617.8887800195918;653.5882394091692;686.9107016087877;770.9768706938801;795.2604078207207;9068.365214434927;9222.077792220723;9328.906710932804;9461.621535138655;9511.66709165176;661.507177153024;679.9762008329685;734.7318228846433;758.2152472191256;772.3975299266468;4178.832846686159;4197.559256278108;4221.7255878367805;4427.056007754872;4489.842855500042;59136.70431647814;62338.68830655818;62648;62787;63371.683141584;53763.462365376625;55049.1742623861;55157.724211379485;56138.43861561332;56286.718566406904;48573.02853942901;50366.748166258934;50803;50811;51163;9296.72109836706;9302.116298951589;9502.382345147544;9511.904880951379;9724.70825875225;34831.47752783761;37167.62832371642;38192.61807381891;38741.41887871628;39350;46560;46870.53129468798;50686.49313506818;50693;50765;12097.81853272184;12126.878731212575;12197.75604487923;12200.694982625506;12407.813882791947;13129.212247265195;13496.730065398833;13626.250556219504;13691.520796772065;13717.17696938187;12202.206856554296;12348.938255309025;12480.313582753035;12751.61745147647;12935.805962910375;12348.506059757508;12708.872911271139;12781.297028663514;13030.283334416697;13061.673458163243;11972.58095966637;12162.878371216175;12169.452374642986;12170.634880953585;12443.626691198917;10340.586376544854;10470.581176752845;10697.197710171924;10823.296485728402;10880.510377033212;10398.58405663765;10807.783844322912;10851.945740271249;10904.890951090387;10911.345319280868 09:40:52 INFO - PROCESS | 26604 | __end_tp_report 09:40:52 INFO - PROCESS | 26604 | __start_cc_report 09:40:52 INFO - PROCESS | 26604 | _x_x_mozilla_cycle_collect,865 09:40:52 INFO - PROCESS | 26604 | __end_cc_report 09:40:52 INFO - PROCESS | 26604 | __startTimestamp1463762452275__endTimestamp 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | ------- Summary: start ------- 09:40:52 INFO - PROCESS | 26604 | Number of tests: 6 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#0] dojo.html Cycles:165 Average:5397.62 Median:5568.94 stddev:588.79 (10.6%) stddev-sans-first:566.67 09:40:52 INFO - PROCESS | 26604 | Values: 3279.7 3320.6 3336.0 3350.1 3398.9 5370.2 5385.5 5388.4 5415.4 5432.4 5375.2 5395.8 5425.3 5432.2 5434.7 4871.5 4919.0 4979.2 5002.9 5037.6 4853.7 4914.4 4922.3 4922.4 4929.2 4904.5 4915.6 4966.0 4982.5 5005.1 4936.1 4965.7 4969.2 4980.8 5005.6 4810.8 4910.6 4937.0 4953.9 4965.8 5147.0 5187.3 5189.3 5192.1 5192.1 5778.2 5796.8 5798.2 5801.4 5809.9 5748.4 5755.0 5802.1 5820.4 5841.8 5443.7 5454.3 5454.8 5459.9 5486.0 5916.4 5919.1 5928.3 5929.7 5935.9 5629.9 5691.8 5705.7 5710.9 5750.4 5811.2 5821.8 5827.3 5830.7 5839.9 5789.5 5797.9 5801.2 5801.7 5816.6 5710.7 5758.9 5791.3 5830.4 5839.4 4419.0 4429.3 4432.0 4435.1 4453.3 3998.1 4017.3 4018.1 4034.3 4049.1 5445.6 5503.8 5535.0 5538.9 5566.7 5772.6 5799.4 5801.0 5802.9 5805.1 5429.6 5485.8 5517.0 5520.2 5529.1 4961.6 5024.3 5040.1 5044.1 5077.1 5988.5 5993.0 5993.0 5995.8 6011.8 5734.5 5769.4 5798.4 5798.7 5801.2 6075.9 6120.9 6126.9 6128.7 6136.8 5759.8 5788.5 5797.2 5811.6 5815.4 5699.8 5789.2 5847.2 5881.1 5911.7 5689.0 5694.2 5699.5 5704.9 5706.6 5644.9 5656.7 5681.3 5696.7 5706.0 5481.4 5555.1 5596.1 5603.7 5637.9 5534.4 5688.9 5745.9 5754.8 5779.7 5491.8 5514.3 5529.0 5538.2 5568.9 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#1] ext.html Cycles:180 Average:43632.80 Median:38493.40 stddev:67664.61 (175.8%) stddev-sans-first:67777.08 09:40:52 INFO - PROCESS | 26604 | Values: 543.1 548.9 550.2 586.6 623.8 38611.2 39142.6 39158.4 39173.6 39180.0 43656.0 44695.6 44815.8 44818.6 44826.0 8785.3 8962.8 8996.9 9011.0 9014.3 8769.0 8918.7 8921.2 8921.3 8930.2 8912.9 8986.8 9005.1 9007.4 9010.8 8859.8 8945.5 8947.4 8949.2 8951.0 8799.5 8973.4 8998.7 9000.3 9000.6 39949.6 40226.8 40279.4 40357.6 40540.8 2593.7 3780.1 4148.6 4372.1 4387.9 28537.3 28849.7 28966.0 28999.7 29383.1 4068.2 4114.5 4184.3 4221.9 4229.0 196604.0 198513.0 199410.0 199765.0 252787.0 60356.4 60761.4 61346.7 63989.0 65428.0 57206.0 57397.7 57797.7 57839.0 58037.0 17069.4 17151.5 17169.3 17236.7 17267.4 13946.3 13991.9 14057.1 14081.0 14104.0 20959.8 20999.7 21064.7 21073.7 21083.2 7703.5 7787.2 7817.5 7916.6 8017.6 967.6 1068.0 1087.8 1122.5 1236.9 30283.7 30538.4 30626.0 30799.7 31266.0 1147.5 1147.9 1203.2 1206.6 1296.2 15600.8 15828.4 15855.7 15977.8 16349.3 344780.0 345192.0 346260.0 347910.0 349823.0 57901.1 58181.4 58254.0 58267.7 58424.7 1319.7 1336.4 1443.7 1467.0 1471.6 26903.3 27082.9 27440.7 27817.4 29777.4 46295.5 46569.5 46659.8 46715.0 46715.5 189074.0 189926.0 190282.0 190307.0 190648.0 29442.4 33382.8 33595.5 33945.3 34935.5 39831.8 40308.4 50744.5 51954.5 52382.7 37964.8 38478.2 38481.0 38505.8 38658.4 36596.8 36850.0 37292.3 37356.1 38145.2 37879.8 38392.0 38565.0 38581.0 38978.6 33564.2 34248.8 34565.7 34570.3 34797.8 25979.9 26773.6 26859.9 26929.0 27074.3 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#2] jquery.html Cycles:180 Average:26027.72 Median:2405.33 stddev:72981.43 (3034.2%) stddev-sans-first:73160.74 09:40:52 INFO - PROCESS | 26604 | Values: 376.3 380.1 383.3 383.8 387.6 18151.5 18878.2 19330.3 19457.3 19523.9 11408.4 11957.9 11983.0 11990.2 12000.8 5073.7 5172.1 5355.4 5453.5 5456.9 5331.1 5391.5 5401.6 5419.5 5435.0 5369.5 5405.6 5415.6 5422.1 5585.1 5513.0 5535.8 5550.7 5577.9 5581.7 5307.4 5394.2 5513.4 5625.7 5636.9 12922.4 13179.9 13308.7 13945.5 14059.8 2389.2 2404.3 2406.3 2490.0 2724.5 9721.8 9887.8 9997.5 10140.6 10310.6 1940.1 1945.1 1963.5 1983.2 1985.1 52126.7 63274.7 63861.7 65040.0 69519.3 10086.0 10184.0 10359.9 10470.7 10476.7 13112.5 14171.9 14746.6 14759.6 14809.8 7789.8 7828.0 8296.4 8364.8 8442.0 8254.4 8298.8 8352.8 8424.7 8452.9 4582.9 4742.0 4744.9 4771.0 4777.4 1794.5 1834.3 1862.2 1884.8 1893.2 906.0 993.5 1010.0 1016.4 1074.7 17493.8 17853.0 17869.7 18141.5 18150.5 971.7 1000.3 1027.1 1028.1 1047.3 10014.9 10422.0 10451.5 10483.0 10501.0 436622.0 439158.0 442637.0 448753.0 453136.0 79513.2 82272.6 82533.0 85247.6 85478.6 1057.5 1088.2 1098.5 1101.7 1153.8 15985.6 16151.9 16431.4 16481.4 17208.7 34571.8 35631.8 35962.3 36288.6 36834.8 47638.5 49936.5 51819.5 54527.2 54990.5 8591.4 8676.0 8693.2 8840.0 8896.2 10204.8 13535.7 13618.2 13655.0 13843.5 11465.2 11563.7 11742.8 11813.5 11963.5 11377.6 11414.5 11841.5 11939.9 12110.8 11637.3 11915.9 12039.4 12066.5 12231.1 8603.8 8698.0 8714.6 8918.4 8925.1 11023.6 11633.5 11713.4 11740.9 11958.6 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#3] mootools.html Cycles:180 Average:5907.84 Median:2891.58 stddev:3148.08 (108.9%) stddev-sans-first:3138.79 09:40:52 INFO - PROCESS | 26604 | Values: 1413.8 1585.8 1590.5 1852.5 1957.8 7917.1 8044.0 8047.8 8053.5 8074.9 7993.7 8179.7 8202.0 8203.1 8210.0 2394.7 2416.0 2425.9 2425.9 2426.8 2399.3 2427.2 2434.6 2447.9 2451.0 2347.5 2360.5 2364.4 2394.9 2398.5 2364.1 2390.1 2395.0 2405.6 2406.8 2390.2 2432.8 2449.6 2449.8 2462.7 8309.7 8354.7 8360.8 8361.2 8380.2 5079.8 5231.7 5241.6 5241.6 5256.9 3164.4 3166.2 3209.5 3262.9 3264.8 989.5 1002.4 1011.6 1036.9 1046.0 11583.8 11599.3 11601.4 11603.5 11609.3 4468.6 4546.0 4592.0 4623.7 4632.2 9801.7 9824.6 9844.0 9850.4 9854.8 5155.8 5156.0 5169.5 5179.2 5181.2 4172.8 4613.3 4661.6 4750.3 4756.0 3801.3 3838.8 3868.7 3886.8 3887.6 1219.7 1221.5 1233.5 1243.7 1250.4 1209.1 1225.0 1228.8 1486.6 1503.9 7906.8 7988.4 8027.1 8053.5 8053.8 497.1 525.9 526.2 527.8 534.2 6206.1 6216.5 6230.5 6275.8 6278.9 10472.4 10808.7 10824.5 10838.7 10843.0 10326.8 10578.6 10646.5 10665.8 10722.2 8198.2 8356.8 8415.9 8417.0 8418.3 7655.8 7697.7 7698.1 7713.7 7727.9 9381.3 9424.8 9555.9 9611.8 9642.1 9020.8 9073.4 9081.6 9836.3 9865.6 7121.2 7150.4 7269.1 7795.4 7911.0 7865.4 7874.6 7947.9 7948.9 7955.5 6962.0 7338.4 7398.6 7415.4 7480.6 7169.7 7191.8 7263.5 7390.4 7434.3 7607.4 7612.4 7642.4 7653.6 7658.5 6966.4 7003.6 7049.1 7049.5 7054.9 7030.3 7077.6 7077.7 7084.4 7093.5 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#4] prototype.html Cycles:180 Average:5357.03 Median:6025.02 stddev:1601.18 (26.6%) stddev-sans-first:1560.90 09:40:52 INFO - PROCESS | 26604 | Values: 347.5 353.3 359.7 362.4 369.2 5945.6 5958.5 6001.7 6006.5 6014.3 5914.3 5914.7 5928.3 5930.2 5949.0 4436.1 4528.4 4544.8 4640.8 4661.2 4626.0 4638.3 4660.3 4697.6 4705.1 4635.2 4645.5 4653.3 4654.3 4655.8 4402.9 4534.3 4643.8 4651.6 4678.9 4142.1 4148.3 4149.2 4156.8 4161.8 5696.1 5700.5 5712.1 5712.7 5718.9 5446.4 5451.5 5463.6 5464.4 5467.2 6299.7 6307.4 6310.1 6321.6 6327.3 4331.6 4476.9 4496.3 4509.0 4640.1 6548.8 6576.2 6600.2 6611.2 6618.6 4603.2 4609.1 4613.8 4614.4 4618.0 4667.2 4671.0 4672.1 4673.1 4682.3 5343.3 5348.3 5353.7 5357.6 5362.7 6243.8 6357.5 6358.9 6374.5 6378.7 1619.2 1627.8 1635.8 1638.2 1639.6 1014.7 1074.8 1078.4 1103.1 1109.6 6035.7 6046.3 6056.2 6065.2 6159.6 6494.7 6499.0 6507.7 6518.1 6520.9 6125.1 6132.1 6132.9 6133.5 6154.7 3471.8 3507.6 3509.8 3511.1 3514.6 6652.6 6722.4 6873.9 6898.2 6907.1 6796.9 6802.9 6821.5 6880.8 6880.9 6833.4 6855.4 6874.7 6874.8 6884.3 6619.6 6619.9 6630.4 6631.5 6640.5 6277.6 6510.3 6512.5 6545.4 6551.1 6842.1 6876.9 6878.8 6883.6 6890.2 4574.9 4615.1 4619.9 4621.0 4623.6 6618.6 6619.7 6624.1 6626.2 6633.2 6329.7 6364.6 6425.7 6432.5 6434.2 6396.2 6436.0 6441.9 6444.6 6449.2 6300.4 6303.5 6306.7 6310.9 6317.9 6381.8 6456.0 6459.2 6465.0 6478.1 5990.8 6108.9 6254.6 6263.3 6309.9 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - PROCESS | 26604 | [#5] yui.html Cycles:180 Average:15212.73 Median:4095.81 stddev:17317.57 (422.8%) stddev-sans-first:17332.28 09:40:52 INFO - PROCESS | 26604 | Values: 789.0 793.8 912.6 914.7 918.8 14835.0 14864.9 15088.4 15373.4 15406.3 14481.1 14565.9 14586.6 14630.6 14658.6 778.6 936.6 938.5 965.1 969.5 938.1 940.4 944.7 949.4 950.2 1008.0 1008.0 1008.4 1008.7 1009.0 816.7 984.9 993.3 998.9 1001.0 728.4 733.6 733.7 734.0 734.5 14391.5 14423.8 14482.6 14495.3 14523.3 14452.7 14648.8 14822.2 14865.9 14907.3 11872.3 11876.9 11934.6 12040.2 12113.8 3946.8 4003.2 4005.6 4012.4 4012.8 51608.0 52175.2 53636.0 53801.7 54083.7 11241.5 11264.8 11410.5 11485.5 11502.7 21389.1 21645.7 21712.5 21802.3 21811.8 8476.0 8636.8 8702.2 8722.2 8942.2 4570.2 4690.2 4815.5 4837.9 4839.8 3530.9 3551.4 3571.7 3582.3 3583.1 551.5 564.7 586.3 653.1 671.9 617.9 653.6 686.9 771.0 795.3 9068.4 9222.1 9328.9 9461.6 9511.7 661.5 680.0 734.7 758.2 772.4 4178.8 4197.6 4221.7 4427.1 4489.8 59136.7 62338.7 62648.0 62787.0 63371.7 53763.5 55049.2 55157.7 56138.4 56286.7 48573.0 50366.7 50803.0 50811.0 51163.0 9296.7 9302.1 9502.4 9511.9 9724.7 34831.5 37167.6 38192.6 38741.4 39350.0 46560.0 46870.5 50686.5 50693.0 50765.0 12097.8 12126.9 12197.8 12200.7 12407.8 13129.2 13496.7 13626.3 13691.5 13717.2 12202.2 12348.9 12480.3 12751.6 12935.8 12348.5 12708.9 12781.3 13030.3 13061.7 11972.6 12162.9 12169.5 12170.6 12443.6 10340.6 10470.6 10697.2 10823.3 10880.5 10398.6 10807.8 10851.9 10904.9 10911.3 09:40:52 INFO - PROCESS | 26604 | -------- Summary: end -------- 09:40:52 INFO - PROCESS | 26604 | 09:40:52 INFO - TEST-INFO | 26604: exit 0 09:40:52 INFO - TEST-OK | dromaeo_css | took 1110708ms 09:40:52 INFO - TEST-START | kraken 09:40:52 INFO - operating with platform_type : linux_ 09:40:52 INFO - Initialising browser for kraken test... 09:40:52 INFO - TEST-INFO | started process 26810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbgQre/profile http://localhost:39842/getInfo.html) 09:40:56 INFO - PROCESS | 26810 | __metrics Screen width/height:1600/1200 09:40:56 INFO - PROCESS | 26810 | colorDepth:24 09:40:56 INFO - PROCESS | 26810 | Browser inner width/height: 1024/697 09:40:56 INFO - PROCESS | 26810 | __metrics 09:40:57 INFO - PROCESS | 26810 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:58 INFO - TEST-INFO | 26810: exit 0 09:40:58 INFO - Browser initialized. 09:40:58 INFO - Running cycle 1/1 for kraken test... 09:40:58 INFO - TEST-INFO | started process 26899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbgQre/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:10 INFO - PROCESS | 26899 | RSS: Main: 139206656 09:41:10 INFO - PROCESS | 26899 | 09:41:12 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39842/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:13 INFO - PROCESS | 26899 | RSS: Main: 174972928 09:41:13 INFO - PROCESS | 26899 | 09:41:15 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39842/tests/kraken/driver.html?testName=audio-dft) 09:41:16 INFO - PROCESS | 26899 | RSS: Main: 173690880 09:41:16 INFO - PROCESS | 26899 | 09:41:19 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39842/tests/kraken/driver.html?testName=audio-fft) 09:41:19 INFO - PROCESS | 26899 | RSS: Main: 170340352 09:41:19 INFO - PROCESS | 26899 | 09:41:21 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39842/tests/kraken/driver.html?testName=audio-oscillator) 09:41:22 INFO - PROCESS | 26899 | RSS: Main: 170950656 09:41:22 INFO - PROCESS | 26899 | 09:41:24 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:25 INFO - PROCESS | 26899 | RSS: Main: 168607744 09:41:25 INFO - PROCESS | 26899 | 09:41:28 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39842/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:28 INFO - PROCESS | 26899 | RSS: Main: 168636416 09:41:28 INFO - PROCESS | 26899 | 09:41:32 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39842/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:32 INFO - PROCESS | 26899 | RSS: Main: 169238528 09:41:32 INFO - PROCESS | 26899 | 09:41:35 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39842/tests/kraken/driver.html?testName=json-parse-financial) 09:41:36 INFO - PROCESS | 26899 | RSS: Main: 169181184 09:41:36 INFO - PROCESS | 26899 | 09:41:37 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:38 INFO - PROCESS | 26899 | RSS: Main: 175681536 09:41:38 INFO - PROCESS | 26899 | 09:41:39 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:40 INFO - PROCESS | 26899 | RSS: Main: 173096960 09:41:40 INFO - PROCESS | 26899 | 09:41:42 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:43 INFO - PROCESS | 26899 | RSS: Main: 179187712 09:41:43 INFO - PROCESS | 26899 | 09:41:45 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:46 INFO - PROCESS | 26899 | RSS: Main: 185057280 09:41:46 INFO - PROCESS | 26899 | 09:41:48 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:49 INFO - PROCESS | 26899 | RSS: Main: 182878208 09:41:49 INFO - PROCESS | 26899 | 09:41:50 INFO - PROCESS | 26899 | Cycle 1(1): loaded http://localhost:39842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39842/tests/kraken/driver.html?testName=ai-astar) 09:41:51 INFO - PROCESS | 26899 | RSS: Main: 245346304 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | __start_tp_report 09:41:51 INFO - PROCESS | 26899 | _x_x_mozilla_page_load 09:41:51 INFO - PROCESS | 26899 | _x_x_mozilla_page_load_details 09:41:51 INFO - PROCESS | 26899 | |i|pagename|runs| 09:41:51 INFO - PROCESS | 26899 | |0;ai-astar;111;114;107;114;113;111;100;111;110;113 09:41:51 INFO - PROCESS | 26899 | |1;audio-beat-detection;164;127;158;165;127;151;157;139;167;128 09:41:51 INFO - PROCESS | 26899 | |2;audio-dft;162;161;159;160;160;162;162;164;160;162 09:41:51 INFO - PROCESS | 26899 | |3;audio-fft;75;79;75;164;77;76;76;75;171;74 09:41:51 INFO - PROCESS | 26899 | |4;audio-oscillator;93;93;144;94;93;94;144;94;93;136 09:41:51 INFO - PROCESS | 26899 | |5;imaging-gaussian-blur;117;116;116;117;116;117;116;117;116;116 09:41:51 INFO - PROCESS | 26899 | |6;imaging-darkroom;146;146;146;146;145;146;145;147;146;146 09:41:51 INFO - PROCESS | 26899 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 09:41:51 INFO - PROCESS | 26899 | |8;json-parse-financial;55;56;57;55;54;55;57;54;54;54 09:41:51 INFO - PROCESS | 26899 | |9;json-stringify-tinderbox;65;66;66;67;66;66;67;67;67;66 09:41:51 INFO - PROCESS | 26899 | |10;stanford-crypto-aes;86;79;80;79;80;78;82;79;87;86 09:41:51 INFO - PROCESS | 26899 | |11;stanford-crypto-ccm;112;111;112;125;113;115;111;117;114;111 09:41:51 INFO - PROCESS | 26899 | |12;stanford-crypto-pbkdf2;146;134;142;142;145;135;142;141;141;146 09:41:51 INFO - PROCESS | 26899 | |13;stanford-crypto-sha256-iterative;66;67;67;65;67;65;67;65;66;63 09:41:51 INFO - PROCESS | 26899 | __end_tp_report 09:41:51 INFO - PROCESS | 26899 | __start_cc_report 09:41:51 INFO - PROCESS | 26899 | _x_x_mozilla_cycle_collect,1057 09:41:51 INFO - PROCESS | 26899 | __end_cc_report 09:41:51 INFO - PROCESS | 26899 | __startTimestamp1463762511079__endTimestamp 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | ------- Summary: start ------- 09:41:51 INFO - PROCESS | 26899 | Number of tests: 14 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:4.22 (3.8%) stddev-sans-first:4.47 09:41:51 INFO - PROCESS | 26899 | Values: 111.0 114.0 107.0 114.0 113.0 111.0 100.0 111.0 110.0 113.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:157.50 stddev:16.53 (10.5%) stddev-sans-first:16.52 09:41:51 INFO - PROCESS | 26899 | Values: 164.0 127.0 158.0 165.0 127.0 151.0 157.0 139.0 167.0 128.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.54 09:41:51 INFO - PROCESS | 26899 | Values: 162.0 161.0 159.0 160.0 160.0 162.0 162.0 164.0 160.0 162.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:38.69 (51.2%) stddev-sans-first:40.41 09:41:51 INFO - PROCESS | 26899 | Values: 75.0 79.0 75.0 164.0 77.0 76.0 76.0 75.0 171.0 74.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.25 (25.0%) stddev-sans-first:24.03 09:41:51 INFO - PROCESS | 26899 | Values: 93.0 93.0 144.0 94.0 93.0 94.0 144.0 94.0 93.0 136.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:41:51 INFO - PROCESS | 26899 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:41:51 INFO - PROCESS | 26899 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 147.0 146.0 146.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:41:51 INFO - PROCESS | 26899 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.27 09:41:51 INFO - PROCESS | 26899 | Values: 55.0 56.0 57.0 55.0 54.0 55.0 57.0 54.0 54.0 54.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 09:41:51 INFO - PROCESS | 26899 | Values: 65.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 67.0 66.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.44 (4.2%) stddev-sans-first:3.26 09:41:51 INFO - PROCESS | 26899 | Values: 86.0 79.0 80.0 79.0 80.0 78.0 82.0 79.0 87.0 86.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:113.50 stddev:4.31 (3.8%) stddev-sans-first:4.50 09:41:51 INFO - PROCESS | 26899 | Values: 112.0 111.0 112.0 125.0 113.0 115.0 111.0 117.0 114.0 111.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.00 stddev:4.12 (2.9%) stddev-sans-first:4.01 09:41:51 INFO - PROCESS | 26899 | Values: 146.0 134.0 142.0 142.0 145.0 135.0 142.0 141.0 141.0 146.0 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - PROCESS | 26899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.39 09:41:51 INFO - PROCESS | 26899 | Values: 66.0 67.0 67.0 65.0 67.0 65.0 67.0 65.0 66.0 63.0 09:41:51 INFO - PROCESS | 26899 | -------- Summary: end -------- 09:41:51 INFO - PROCESS | 26899 | 09:41:51 INFO - TEST-INFO | 26899: exit 0 09:41:52 INFO - TEST-OK | kraken | took 59061ms 09:41:52 INFO - SUITE-END | took 1169s 09:41:52 INFO - Completed test suite (00:19:30) 09:41:52 INFO - javascript benchmark 09:41:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3279.688429599188, 3320.568326117606, 3336.0, 3350.11222026163, 3398.9490157647633, 5370.194470829378, 5385.488378604036, 5388.43421440749, 5415.404305526394, 5432.402435732066, 5375.193720941861, 5395.838124856251, 5425.2675888755, 5432.2123292122615, 5434.673919564829, 4871.464138944713, 4918.975405122978, 4979.153543897528, 5002.9499705002845, 5037.59699224063, 4853.733044682541, 4914.361133052698, 4922.26166075088, 4922.384701912261, 4929.235968424882, 4904.5340692634145, 4915.606751459893, 4965.950340496585, 4982.476839931809, 5005.0990821652085, 4936.111499930011, 4965.652404331699, 4969.2049272116465, 4980.7509624518625, 5005.6496045276845, 4810.831620893252, 4910.631702622282, 4936.975315123437, 4953.851384458436, 4965.776540055706, 5147.047796157723, 5187.273781670569, 5189.299444574972, 5192.091384007821, 5192.1432963560965, 5778.162166485878, 5796.82609521715, 5798.159266906275, 5801.448862358069, 5809.941900580982, 5748.42515748426, 5755.0, 5802.100674395476, 5820.447057529528, 5841.766329346821, 5443.727813609304, 5454.263674403905, 5454.781808727646, 5459.890802183934, 5486.0, 5916.437938395846, 5919.052951527735, 5928.347881733006, 5929.673867937218, 5935.881282374328, 5629.915551266734, 5691.8292451226525, 5705.74324155414, 5710.885782284414, 5750.367459579443, 5811.244538210006, 5821.79623713168, 5827.300723913073, 5830.679312637845, 5839.9124013139835, 5789.478946894799, 5797.9420205797405, 5801.216835727208, 5801.7389217485315, 5816.621919575214, 5710.7430165642645, 5758.856028599319, 5791.333996590446, 5830.446107619854, 5839.416058394211, 4419.027813880941, 4429.269170586817, 4432.0, 4435.090806384684, 4453.332000199931, 3998.100427403869, 4017.2568074906235, 4018.095928416083, 4034.293998550242, 4049.1294371710223, 5445.564354851603, 5503.779848806083, 5535.03136951032, 5538.86152846174, 5566.721663916869, 5772.5959182856795, 5799.449052340021, 5801.042827933428, 5802.941970580325, 5805.10020946754, 5429.592780541475, 5485.753141108659, 5517.034518959166, 5520.171974203821, 5529.087700529368, 4961.578265847371, 5024.271480635288, 5040.143175660147, 5044.066847633199, 5077.060743762416, 5988.520918326523, 5992.970035149883, 5993.041113421831, 5995.760169593254, 6011.7595296187665, 5734.455226753452, 5769.423057694197, 5798.362180160263, 5798.739056742373, 5801.216835727208, 6075.878482430238, 6120.90429240112, 6126.914660831389, 6128.717018009172, 6136.764169924236, 5759.769609215752, 5788.507976822018, 5797.159411885337, 5811.622244554091, 5815.3603103657715, 5699.800506982236, 5789.218455508452, 5847.181394604674, 5881.147233651011, 5911.704414779329, 5689.032864412977, 5694.202811606461, 5699.458551437607, 5704.857378565569, 5706.572007099568, 5644.915326270027, 5656.660600363992, 5681.261436013292, 5696.743646535833, 5706.001449746361, 5481.397046324981, 5555.0834112371, 5596.104623260258, 5603.663780173202, 5637.915431268452, 5534.418886016911, 5688.8577785554035, 5745.8563535911935, 5754.798582049608, 5779.682117483579, 5491.75287112073, 5514.310711161105, 5529.032419326682, 5538.196961440649, 5568.9443105568425], "unit": "score", "name": "dojo.html", "value": 5360.45560209898}, {"lowerIsBetter": false, "replicates": [543.0523736080539, 548.9478499542545, 550.2131951309628, 586.6186978463995, 623.8159742875854, 38611.22777544447, 39142.60857391425, 39158.41262381067, 39173.608263917355, 39180.0, 43656.0, 44695.55304446963, 44815.77592112043, 44818.55181448185, 44826.0, 8785.297176225886, 8962.820743585124, 8996.910030899706, 9011.0, 9014.278857691368, 8769.0, 8918.73243802687, 8921.197092261695, 8921.286297096249, 8930.240929520998, 8912.8663070054, 8986.775330616721, 9005.099490050976, 9007.414518056337, 9010.819783604324, 8859.77850553738, 8945.463272203624, 8947.418417802823, 8949.194572488475, 8951.0, 8799.516026618534, 8973.416727912665, 8998.685046023424, 9000.279977601776, 9000.639974401016, 39949.60050399488, 40226.798866005774, 40279.39580906289, 40357.59642403568, 40540.797296013625, 2593.7276585958393, 3780.1494663700723, 4148.585141485857, 4372.103718737651, 4387.912241755179, 28537.286567835763, 28849.711502885122, 28966.0, 28999.710002900123, 29383.11850644484, 4068.2270368629866, 4114.506259248909, 4184.267753143218, 4221.927718046575, 4228.978855105735, 196604.0, 198513.0, 199410.0, 199765.0, 252787.0, 60356.39643603595, 60761.392386076455, 61346.693266534276, 63989.0, 65428.0, 57206.0, 57397.71301143467, 57797.71101144468, 57839.0, 58037.0, 17069.40257090996, 17151.485455436356, 17169.31322747101, 17236.741448878278, 17267.3956411525, 13946.302684865715, 13991.860081399056, 14057.086289391156, 14081.0, 14104.012719109769, 20959.79040209609, 20999.685004724943, 21064.684029739565, 21073.683894741593, 21083.156673733185, 7703.4992725473785, 7787.182345853717, 7817.452778305464, 7916.604169791487, 8017.599120044091, 967.6081187119228, 1067.9572817087385, 1087.842262871895, 1122.4724379541603, 1236.9319687417278, 30283.69716302853, 30538.38923221523, 30626.0, 30799.692003079683, 31266.0, 1147.512307269424, 1147.8737338892715, 1203.1638011581867, 1206.6440400081822, 1296.183404455206, 15600.759696121642, 15828.446004390022, 15855.682886342209, 15977.840221597868, 16349.264283107288, 344780.0, 345192.0, 346260.0, 347910.0, 349823.0, 57901.13148302779, 58181.4181858176, 58254.0, 58267.70866145727, 58424.70787646034, 1319.6568892087935, 1336.411978729356, 1443.6607397261635, 1467.0464198270995, 1471.6100233438146, 26903.327416814736, 27082.879277209133, 27440.725592744617, 27817.44365112727, 29777.404451910406, 46295.53704462912, 46569.53430465652, 46659.76670116628, 46715.0, 46715.53284467112, 189074.0, 189926.0, 190282.0, 190307.0, 190648.0, 29442.411151777273, 33382.83308583441, 33595.49606755949, 33945.3210935775, 34935.475967859995, 39831.800840996766, 40308.39537407, 50744.49255507398, 51954.48045519648, 52382.73808630933, 37964.810175948944, 38478.23043539058, 38481.0, 38505.80747096246, 38658.42012369873, 36596.81701591582, 36850.0, 37292.254154916205, 37356.06609834667, 38145.2370952585, 37879.81060094682, 38392.0, 38565.0, 38581.0, 38978.61021389863, 33564.160895977795, 34248.82875585606, 34565.65434345624, 34570.30859382748, 34797.82601086979, 25979.870100649376, 26773.598396024467, 26859.865700671373, 26929.0, 27074.34875820096], "unit": "score", "name": "ext.html", "value": 19023.05522837906}, {"lowerIsBetter": false, "replicates": [376.33952413514277, 380.1219183685685, 383.3176945037832, 383.7812446905264, 387.6453045463401, 18151.455456336316, 18878.24487020519, 19330.32343867965, 19457.31899383522, 19523.902380488114, 11408.372539510323, 11957.940210298959, 11983.0, 11990.16068875179, 12000.7599848003, 5073.670211436254, 5172.146595811687, 5355.357357117151, 5453.536449401806, 5456.890862182754, 5331.147016477365, 5391.460853914617, 5401.648892821954, 5419.458054194589, 5435.0488664483755, 5369.5167434930845, 5405.567554595643, 5415.6479828811, 5422.105352616833, 5585.078462053756, 5512.972435137819, 5535.778568857241, 5550.72246387683, 5577.860553486175, 5581.720913954286, 5307.363116426053, 5394.244805727201, 5513.421090785449, 5625.718714064321, 5636.928983493123, 12922.353882305848, 13179.934100329438, 13308.667283317898, 13945.511907083304, 14059.78910316346, 2389.2235023617395, 2404.338806828119, 2406.31420045288, 2490.0413340863715, 2724.4687285979244, 9721.756956076084, 9887.80224395508, 9997.500124993794, 10140.594376224943, 10310.587576496931, 1940.078462730206, 1945.1441365799003, 1963.4993076765477, 1983.206717313072, 1985.1067019840984, 52126.73936630293, 63274.68362658157, 63861.68069159671, 65040.0, 69519.30480695229, 10086.0, 10183.963207358558, 10359.948200259101, 10470.685879423629, 10476.68569942903, 13112.475500979854, 14171.92914035444, 14746.63133421673, 14759.557213283619, 14809.777853332209, 7789.80525486856, 7827.9608601956625, 8296.377771667148, 8364.832703345899, 8441.957790211132, 8254.380921430917, 8298.751037468886, 8352.8329433411, 8424.705135320357, 8452.915470845335, 4582.88542786433, 4741.95258047422, 4744.857654270378, 4771.0, 4777.4267087949665, 1794.5334213104686, 1834.257125864027, 1862.1992543206281, 1884.8209420105068, 1893.1670065171281, 905.9864102038474, 993.4734590666958, 1009.9899001009895, 1016.4358780876685, 1074.6775967209805, 17493.82506174922, 17853.0, 17869.7319540207, 18141.45575632733, 18150.45548633543, 971.6987733802544, 1000.3147843726924, 1027.0705011964185, 1028.0798685176726, 1047.3035431438161, 10014.899851001397, 10422.0, 10451.477426128664, 10483.0, 10501.0, 436622.0, 439158.0, 442637.0, 448753.0, 453136.0, 79513.20486795058, 82272.58863705643, 82533.0, 85247.57376213203, 85478.57260713782, 1057.4818339013827, 1088.216484131424, 1098.5386137822134, 1101.7245688577855, 1153.81538953767, 15985.600359991093, 16151.919240403722, 16431.424900128437, 16481.423150189687, 17208.74186887223, 34571.82714086414, 35631.82184089063, 35962.28075438424, 36288.63711362958, 36834.8158259207, 47638.523614763406, 49936.50063499464, 51819.48180518297, 54527.18209226785, 54990.450095498534, 8591.398602097794, 8676.0, 8693.174148455886, 8840.0, 8896.243819275434, 10204.846927296245, 13535.661608459868, 13618.18290902549, 13655.04414690962, 13843.515476958259, 11465.197436179387, 11563.6530904073, 11742.823857642314, 11813.468393922121, 11963.521459141537, 11377.601783937522, 11414.543418263176, 11841.46713397882, 11939.940300298444, 12110.818337724764, 11637.301761894314, 11915.940420297842, 12039.398030098635, 12066.51733930668, 12231.143819932875, 8603.82792344162, 8697.956510217662, 8714.564271786512, 8918.375713700238, 8925.062868398725, 11023.61417350389, 11633.53465861356, 11713.41432928333, 11740.88259117432, 11958.58144964922], "unit": "score", "name": "jquery.html", "value": 8700.677982362753}, {"lowerIsBetter": false, "replicates": [1413.7737961926093, 1585.7779910812485, 1590.4592438570883, 1852.5090850924507, 1957.7650681918162, 7917.089534703511, 8044.0, 8047.758567242992, 8053.476524025934, 8074.878876816852, 7993.680252789882, 8179.672813087484, 8202.0, 8203.138670439608, 8209.97375328084, 2394.7006624172022, 2416.0, 2425.9029638814513, 2425.9393515162087, 2426.7694569015916, 2399.3042017814814, 2427.2232885476656, 2434.573949558829, 2447.877606119696, 2450.9509809803794, 2347.5187586544803, 2360.5160942006846, 2364.43253619131, 2394.916177933773, 2398.5202959408102, 2364.1370899621515, 2390.127603424755, 2394.964075538868, 2405.6151015837468, 2406.8435551689086, 2390.2351247600773, 2432.793212576933, 2449.620308852113, 2449.8162637802056, 2462.6675398821108, 8309.667613295462, 8354.749357519284, 8360.83278334436, 8361.205685459872, 8380.20388063133, 5079.79680812767, 5231.738413079331, 5241.606879484016, 5241.633085684004, 5256.947430525723, 3164.398764234788, 3166.176794033545, 3209.5025271082786, 3262.9021129366156, 3264.755143364257, 989.4656885281939, 1002.3735165521549, 1011.5650270383732, 1036.9481525923673, 1045.9633912813015, 11583.826242606368, 11599.304041757521, 11601.361925094116, 11603.477843497063, 11609.303441793434, 4468.597826195593, 4545.977270113628, 4591.95408045922, 4623.69945953512, 4632.189366860786, 9801.656942006995, 9824.557894894748, 9844.0, 9850.359726617748, 9854.753631159278, 5155.819546315861, 5156.04613146569, 5169.508896654812, 5179.22311653255, 5181.248718935809, 4172.7704976226, 4613.331066995334, 4661.557152070548, 4750.287456881495, 4756.048790241965, 3801.2967600993907, 3838.7504812187117, 3868.729188956746, 3886.7862267575556, 3887.5529314129235, 1219.7255617485994, 1221.4625564751482, 1233.4881024374963, 1243.6579940516249, 1250.3998080921208, 1209.1415095282448, 1225.026104247108, 1228.846394200725, 1486.5540337898587, 1503.9022463540055, 7906.802329941683, 7988.360931125496, 8027.07688615805, 8053.516788992679, 8053.758387248392, 497.14242930944556, 525.9421463638996, 526.2133110999081, 527.7625068719092, 534.1571578055723, 6206.100115483229, 6216.471599913967, 6230.532710046765, 6275.780347687809, 6278.937210627927, 10472.424016679155, 10808.675739727822, 10824.512896919658, 10838.729031774112, 10842.96991785779, 10326.845097323547, 10578.62974795894, 10646.520906559223, 10665.786684266272, 10722.195835312383, 8198.180181981754, 8356.832863342821, 8415.915840841513, 8417.032041315204, 8418.284445822173, 7655.846883062419, 7697.730579429693, 7698.0762308523335, 7713.652885620273, 7727.884081738891, 9381.343305968516, 9424.764380890532, 9555.856662149934, 9611.759706007126, 9642.132208101304, 9020.774480637774, 9073.364864459425, 9081.59132839037, 9836.311458197857, 9865.556049977624, 7121.181064177686, 7150.392216661642, 7269.0550228472075, 7795.41534384912, 7910.960445197968, 7865.4494185406475, 7874.645640946285, 7947.8807817881625, 7948.8807667883875, 7955.5226686399, 6962.0, 7338.449616278694, 7398.630068496661, 7415.406767458482, 7480.588567628833, 7169.677364518713, 7191.7842464726145, 7263.527870688388, 7390.408767298711, 7434.256574342522, 7607.35337496319, 7612.429067819825, 7642.388608911385, 7653.617319134132, 7658.4639075264195, 6966.3730264276455, 7003.5797852129035, 7049.118860142482, 7049.541779784297, 7054.858902822018, 7030.2969703029285, 7077.610731409822, 7077.7168913242895, 7084.397826184832, 7093.538919970186], "unit": "score", "name": "mootools.html", "value": 4734.573357066295}, {"lowerIsBetter": false, "replicates": [347.52562751843726, 353.3322021379593, 359.6888691282042, 362.3712858191039, 369.23752451188295, 5945.643261404313, 5958.463738263556, 6001.66990815505, 6006.51947844172, 6014.338422773491, 5914.260717410324, 5914.674692891889, 5928.318243401999, 5930.229070220866, 5948.958932186861, 4436.134953684033, 4528.388667529891, 4544.795484203219, 4640.814367425316, 4661.184292748764, 4626.028534007863, 4638.304254361839, 4660.347551342815, 4697.600703940169, 4705.106029854317, 4635.165670179366, 4645.468219820189, 4653.302004699305, 4654.2785868190485, 4655.790489427967, 4402.8679139625865, 4534.274516077428, 4643.791029403685, 4651.558101980307, 4678.883027924295, 4142.130152667944, 4148.315527937887, 4149.232392007489, 4156.750594964312, 4161.83352665893, 5696.060150075233, 5700.543956483471, 5712.11462223356, 5712.742926568314, 5718.914216286759, 5446.428125046853, 5451.536619387357, 5463.590230732671, 5464.371597266286, 5467.20725494805, 6299.716512756937, 6307.369263073701, 6310.085037669558, 6321.620702757849, 6327.335629758901, 4331.631811296043, 4476.8880777980485, 4496.303073023687, 4509.0, 4640.09518143962, 6548.770793022269, 6576.243731970789, 6600.174978127734, 6611.23970743361, 6618.635975021371, 4603.217453032992, 4609.124266389375, 4613.792379342871, 4614.353990441341, 4617.984043510422, 4667.159911216014, 4670.95329046712, 4672.135654903854, 4673.112108699336, 4682.321063445781, 5343.251944727741, 5348.331458567679, 5353.661584603849, 5357.571394288448, 5362.65142765719, 6243.75024999004, 6357.459615932605, 6358.904616430757, 6374.4701271695385, 6378.744850206032, 1619.2146808797725, 1627.7558366245157, 1635.8282380349892, 1638.189096397291, 1639.639279358563, 1014.6702321745462, 1074.8334008228737, 1078.3637653784306, 1103.0568863621647, 1109.611635927419, 6035.698215089228, 6046.3349031606485, 6056.212692349966, 6065.150878876961, 6159.599626024294, 6494.707738151795, 6498.967505162444, 6507.707153178024, 6518.120053792677, 6520.902186467207, 6125.050617154348, 6132.141500189977, 6132.877342453126, 6133.539984501181, 6154.7230374633245, 3471.791692498408, 3507.6141624421803, 3509.842057107436, 3511.122219445139, 3514.6309637488207, 6652.600843949379, 6722.394984451423, 6873.931260687329, 6898.241193468714, 6907.067545881342, 6796.898046529306, 6802.863942721118, 6821.522493425413, 6880.759173429006, 6880.931190688029, 6833.350831670983, 6855.383015528626, 6874.65626718662, 6874.828129296708, 6884.311568843075, 6619.635920024445, 6619.867602648016, 6630.436412904764, 6631.469482441489, 6640.535162538769, 6277.591956522811, 6510.251321098134, 6512.544121911421, 6545.410913017851, 6551.082848401133, 6842.144731908512, 6876.862462750817, 6878.793636190922, 6883.621400823003, 6890.173179218526, 4574.88562785933, 4615.0539139477, 4619.86140415788, 4621.0, 4623.56076172763, 6618.602883826986, 6619.669016549057, 6624.138861947916, 6626.237982632059, 6633.170853643294, 6329.7151628175925, 6364.6181229126405, 6425.742970281136, 6432.485401167989, 6434.195725534309, 6396.200474940632, 6436.0, 6441.903371449525, 6444.645544495098, 6449.226462722601, 6300.369963003663, 6303.527235457267, 6306.747730090745, 6310.936890631035, 6317.9052314214405, 6381.8085457436355, 6456.031595260561, 6459.192600924885, 6464.967675161594, 6478.060681201294, 5990.7903223386975, 6108.908366374597, 6254.562180647311, 6263.342349053284, 6309.873802524015], "unit": "score", "name": "prototype.html", "value": 4841.216091409075}, {"lowerIsBetter": false, "replicates": [788.964496597653, 793.7737744742745, 912.5984566790612, 914.6844338703145, 918.7565295196772, 14834.999999999987, 14864.925675371622, 15088.396464141435, 15373.385064597403, 15406.30671619777, 14481.131132132079, 14565.927170364133, 14586.635334116625, 14630.634234144152, 14658.560243192695, 778.5756762564388, 936.6113063078814, 938.4697645830119, 965.1265604627823, 969.4764826993415, 938.080680932683, 940.4498368454463, 944.707140786355, 949.4398305000049, 950.2018304624114, 1008.0222184481041, 1008.0373243552426, 1008.425197637347, 1008.7024327823273, 1008.9798204035915, 816.7345612675874, 984.901509849013, 993.2749093162032, 998.8651532043153, 1000.9949950250275, 728.3626826526789, 733.6331834082958, 733.7431898835418, 733.9596322202277, 734.5042096584784, 14391.496297629532, 14423.78364324536, 14482.637934051732, 14495.275236238145, 14523.346449409803, 14452.710945781026, 14648.780268295985, 14822.184779837105, 14865.925670371687, 14907.329170187368, 11872.347020913847, 11876.881231187665, 11934.582289619822, 12040.21738586989, 12113.818292725617, 3946.8223929923224, 4003.199360127957, 4005.619466150711, 4012.3580227163807, 4012.779297138656, 51608.0, 52175.217371739454, 53636.0, 53801.73099134479, 54083.729581352236, 11241.49413276388, 11264.831027534594, 11410.543578256777, 11485.540578376938, 11502.654920352403, 21389.14443422277, 21645.675314869975, 21712.457188570414, 21802.345929622137, 21811.78188218129, 8475.957620211859, 8636.827263454696, 8702.173293537104, 8722.171393717586, 8942.239909607626, 4570.245909424908, 4690.15577196108, 4815.518448155157, 4837.927431088537, 4839.758012099381, 3530.91172720684, 3551.4140166872176, 3571.714262858965, 3582.3193593217725, 3583.050491619723, 551.5256879083985, 564.6978866306506, 586.3052283044606, 653.0791583866725, 671.9059331693567, 617.8887800195918, 653.5882394091692, 686.9107016087877, 770.9768706938801, 795.2604078207207, 9068.365214434927, 9222.077792220723, 9328.906710932804, 9461.621535138655, 9511.66709165176, 661.507177153024, 679.9762008329685, 734.7318228846433, 758.2152472191256, 772.3975299266468, 4178.832846686159, 4197.559256278108, 4221.7255878367805, 4427.056007754872, 4489.842855500042, 59136.70431647814, 62338.68830655818, 62648.0, 62787.0, 63371.683141584, 53763.462365376625, 55049.1742623861, 55157.724211379485, 56138.43861561332, 56286.718566406904, 48573.02853942901, 50366.748166258934, 50803.0, 50811.0, 51163.0, 9296.72109836706, 9302.116298951589, 9502.382345147544, 9511.904880951379, 9724.70825875225, 34831.47752783761, 37167.62832371642, 38192.61807381891, 38741.41887871628, 39350.0, 46560.0, 46870.53129468798, 50686.49313506818, 50693.0, 50765.0, 12097.81853272184, 12126.878731212575, 12197.75604487923, 12200.694982625506, 12407.813882791947, 13129.212247265195, 13496.730065398833, 13626.250556219504, 13691.520796772065, 13717.17696938187, 12202.206856554296, 12348.938255309025, 12480.313582753035, 12751.61745147647, 12935.805962910375, 12348.506059757508, 12708.872911271139, 12781.297028663514, 13030.283334416697, 13061.673458163243, 11972.58095966637, 12162.878371216175, 12169.452374642986, 12170.634880953585, 12443.626691198917, 10340.586376544854, 10470.581176752845, 10697.197710171924, 10823.296485728402, 10880.510377033212, 10398.58405663765, 10807.783844322912, 10851.945740271249, 10904.890951090387, 10911.345319280868], "unit": "score", "name": "yui.html", "value": 7037.226021085794}], "name": "dromaeo_css", "value": 7232.438510884931}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 114.0, 113.0, 111.0, 100.0, 111.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [164.0, 127.0, 158.0, 165.0, 127.0, 151.0, 157.0, 139.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 160.0, 160.0, 162.0, 162.0, 164.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [75.0, 79.0, 75.0, 164.0, 77.0, 76.0, 76.0, 75.0, 171.0, 74.0], "unit": "score", "name": "audio-fft", "value": 94.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 94.0, 93.0, 94.0, 144.0, 94.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 55.0, 54.0, 55.0, 57.0, 54.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [86.0, 79.0, 80.0, 79.0, 80.0, 78.0, 82.0, 79.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 112.0, 125.0, 113.0, 115.0, 111.0, 117.0, 114.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.1}, {"lowerIsBetter": true, "replicates": [146.0, 134.0, 142.0, 142.0, 145.0, 135.0, 142.0, 141.0, 141.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 65.0, 67.0, 65.0, 67.0, 65.0, 66.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1503.6999999999998}]} 09:41:52 INFO - Return code: 0 09:41:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:41:52 INFO - # TBPL SUCCESS # 09:41:52 INFO - Running post-action listener: _resource_record_post_action 09:41:52 INFO - Running post-run listener: _resource_record_post_run 09:41:53 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 449036288; Read time: 40; Write time: 296764 09:41:53 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237375488; Read time: 0; Write time: 179452 09:41:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 16384; Write bytes: 211660800; Read time: 40; Write time: 117312 09:41:53 INFO - Running post-run listener: _upload_blobber_files 09:41:53 INFO - Blob upload gear active. 09:41:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:54 INFO - (blobuploader) - INFO - Done attempting. 09:41:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:56 INFO - (blobuploader) - INFO - Done attempting. 09:41:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:56 INFO - Return code: 0 09:41:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95cf9e17b308e961b131ba768d5731341aea5118e3139bea70f27aa2f1404ddd28cc992985aa7408d3c130b237b4282b4a03e01ba245c2edb790efb211107852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a0bef0a35b1468c3c4b870a9b6cfdc6f6116a1b62c0dffa9e6fc5b5f329fe90ec25e8ac6b33640a54bc698b57062aa8e8684d91ed4866eee9a599096768848"} 09:41:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:56 INFO - Contents: 09:41:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95cf9e17b308e961b131ba768d5731341aea5118e3139bea70f27aa2f1404ddd28cc992985aa7408d3c130b237b4282b4a03e01ba245c2edb790efb211107852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a0bef0a35b1468c3c4b870a9b6cfdc6f6116a1b62c0dffa9e6fc5b5f329fe90ec25e8ac6b33640a54bc698b57062aa8e8684d91ed4866eee9a599096768848"} 09:41:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:56 INFO - Copying logs to upload dir... 09:41:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.855657 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-20 09:41:55.077993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:55.084676) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 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-Beta/sha512/95cf9e17b308e961b131ba768d5731341aea5118e3139bea70f27aa2f1404ddd28cc992985aa7408d3c130b237b4282b4a03e01ba245c2edb790efb211107852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a0bef0a35b1468c3c4b870a9b6cfdc6f6116a1b62c0dffa9e6fc5b5f329fe90ec25e8ac6b33640a54bc698b57062aa8e8684d91ed4866eee9a599096768848"} build_url:https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/CptSyBIDRTGRrcab7G3XJg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95cf9e17b308e961b131ba768d5731341aea5118e3139bea70f27aa2f1404ddd28cc992985aa7408d3c130b237b4282b4a03e01ba245c2edb790efb211107852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a0bef0a35b1468c3c4b870a9b6cfdc6f6116a1b62c0dffa9e6fc5b5f329fe90ec25e8ac6b33640a54bc698b57062aa8e8684d91ed4866eee9a599096768848"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:55.113863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:55.114157) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463761134.914976-571343337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 09:41:55.196875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 09:41:55.197194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 09:41:55.197452) ========= ========= Total master_lag: 0.18 =========