builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1466523748.45 results: success (0) buildid: 20160621055703 builduid: 531c93508aa048bdafaf402ae19702f3 revision: 195b5d64869c579957bda22c659b8219456910ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.446066) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.446540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.446838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.461493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.461895) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:42:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-06-21 08:42:28 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.630345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.630699) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014354 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.680471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:28.680832) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 195b5d64869c579957bda22c659b8219456910ec --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 195b5d64869c579957bda22c659b8219456910ec --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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:42:28,839 truncating revision to first 12 chars 2016-06-21 08:42:28,839 Setting DEBUG logging. 2016-06-21 08:42:28,839 attempt 1/10 2016-06-21 08:42:28,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/195b5d64869c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:42:29,149 unpacking tar archive at: mozilla-beta-195b5d64869c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654887 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:29.349392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:29.349762) ========= script_repo_revision: 195b5d64869c579957bda22c659b8219456910ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:29.350209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:29.350482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:42:29.359525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-21 08:42:29.359864) ========= /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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:29 INFO - MultiFileLogger online at 20160621 08:42:29 in /builds/slave/test 08:42:29 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 08:42:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:29 INFO - {'append_to_log': False, 08:42:29 INFO - 'base_work_dir': '/builds/slave/test', 08:42:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:42:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:29 INFO - 'branch': 'Mozilla-Beta', 08:42:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:29 INFO - 'config_files': ('talos/linux_config.py',), 08:42:29 INFO - 'default_actions': ('clobber', 08:42:29 INFO - 'read-buildbot-config', 08:42:29 INFO - 'download-and-extract', 08:42:29 INFO - 'populate-webroot', 08:42:29 INFO - 'create-virtualenv', 08:42:29 INFO - 'install', 08:42:29 INFO - 'run-tests'), 08:42:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:29 INFO - 'download_minidump_stackwalk': True, 08:42:29 INFO - 'download_symbols': 'ondemand', 08:42:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:29 INFO - 'installer_path': 'installer.exe', 08:42:29 INFO - 'log_level': 'info', 08:42:29 INFO - 'log_name': 'talos', 08:42:29 INFO - 'log_to_console': True, 08:42:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:29 INFO - 'opt_config_files': (), 08:42:29 INFO - 'pip_index': False, 08:42:29 INFO - 'sps_profile': False, 08:42:29 INFO - 'sps_profile_interval': 0, 08:42:29 INFO - 'suite': 'dromaeojs', 08:42:29 INFO - 'system_bits': '32', 08:42:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:29 INFO - 'title': 'talos-linux64-ix-036', 08:42:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:29 INFO - 'use_talos_json': True, 08:42:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:29 INFO - 'work_dir': 'build'} 08:42:29 INFO - ##### 08:42:29 INFO - ##### Running clobber step. 08:42:29 INFO - ##### 08:42:29 INFO - Running pre-action listener: _resource_record_pre_action 08:42:29 INFO - Running main action method: clobber 08:42:29 INFO - rmtree: /builds/slave/test/build 08:42:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:30 INFO - Running post-action listener: _resource_record_post_action 08:42:30 INFO - ##### 08:42:30 INFO - ##### Running read-buildbot-config step. 08:42:30 INFO - ##### 08:42:30 INFO - Running pre-action listener: _resource_record_pre_action 08:42:30 INFO - Running main action method: read_buildbot_config 08:42:30 INFO - Using buildbot properties: 08:42:30 INFO - { 08:42:30 INFO - "project": "", 08:42:30 INFO - "product": "firefox", 08:42:30 INFO - "script_repo_revision": "production", 08:42:30 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:42:30 INFO - "repository": "", 08:42:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:42:30 INFO - "buildid": "20160621055703", 08:42:30 INFO - "pgo_build": "True", 08:42:30 INFO - "basedir": "/builds/slave/test", 08:42:30 INFO - "buildnumber": 54, 08:42:30 INFO - "slavename": "talos-linux64-ix-036", 08:42:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:42:30 INFO - "platform": "ubuntu64_hw", 08:42:30 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:42:30 INFO - "branch": "mozilla-beta", 08:42:30 INFO - "repo_path": "releases/mozilla-beta", 08:42:30 INFO - "revision": "195b5d64869c579957bda22c659b8219456910ec", 08:42:30 INFO - "stage_platform": "linux64-pgo", 08:42:30 INFO - "builduid": "531c93508aa048bdafaf402ae19702f3", 08:42:30 INFO - "slavebuilddir": "test" 08:42:30 INFO - } 08:42:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:42:30 INFO - Running post-action listener: _resource_record_post_action 08:42:30 INFO - ##### 08:42:30 INFO - ##### Running download-and-extract step. 08:42:30 INFO - ##### 08:42:30 INFO - Running pre-action listener: _resource_record_pre_action 08:42:30 INFO - Running main action method: download_and_extract 08:42:30 INFO - mkdir: /builds/slave/test/build/tests 08:42: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')]} 08:42:30 INFO - https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:42:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:42:32 INFO - Downloaded 1327 bytes. 08:42:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:32 INFO - Using the following test package requirements: 08:42:32 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:32 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:42:32 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'jsshell-linux-x86_64.zip'], 08:42:32 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:32 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:32 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:42:32 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:42:32 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:32 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:32 INFO - https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:33 INFO - Downloaded 24185717 bytes. 08:42:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:34 INFO - Return code: 0 08:42:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:34 INFO - https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:35 INFO - Downloaded 24185717 bytes. 08:42:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:37 INFO - Return code: 0 08:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:37 INFO - https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:38 INFO - Downloaded 10840145 bytes. 08:42:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:42:38 INFO - Return code: 0 08:42:38 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')]} 08:42:38 INFO - https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:42:40 INFO - Downloaded 55979123 bytes. 08:42:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:40 INFO - mkdir: /builds/slave/test/properties 08:42:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:40 INFO - Contents: 08:42:40 INFO - build_url:https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:41 INFO - Running post-action listener: _resource_record_post_action 08:42:41 INFO - Running post-action listener: set_extra_try_arguments 08:42:41 INFO - ##### 08:42:41 INFO - ##### Running populate-webroot step. 08:42:41 INFO - ##### 08:42:41 INFO - Running pre-action listener: _resource_record_pre_action 08:42:41 INFO - Running main action method: populate_webroot 08:42:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:41 INFO - '--tppagecycles', 08:42:41 INFO - '7'], 08:42:41 INFO - 'tests': ['tsvgm']}}, 08:42:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['damp', 'tps']}, 08:42:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'tests': ['damp', 'tps']}, 08:42:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['dromaeo_dom']}, 08:42:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tsvgx', 08:42:41 INFO - 'tsvgr_opacity', 08:42:41 INFO - 'tart', 08:42:41 INFO - 'tscrollx', 08:42:41 INFO - 'cart']}, 08:42:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:41 INFO - 'tsvgr_opacity', 08:42:41 INFO - 'tart', 08:42:41 INFO - 'tscrollx', 08:42:41 INFO - 'cart']}, 08:42:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tp5o']}, 08:42:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'tests': ['tp5o']}, 08:42:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s', 08:42:41 INFO - '--xperf_path', 08:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:41 INFO - 'tests': ['tp5n']}, 08:42:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:41 INFO - 'talos_options': ['--xperf_path', 08:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:41 INFO - 'tests': ['tp5n']}}, 08:42:41 INFO - 'talos.zip': {'path': '', 08:42:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:41 INFO - Running post-action listener: _resource_record_post_action 08:42:41 INFO - ##### 08:42:41 INFO - ##### Running create-virtualenv step. 08:42:41 INFO - ##### 08:42:41 INFO - Running pre-action listener: _resource_record_pre_action 08:42:41 INFO - Running main action method: create_virtualenv 08:42:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:41 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 08:42:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:41 INFO - Using real prefix '/usr' 08:42:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:43 INFO - Installing pip.................done. 08:42:43 INFO - Return code: 0 08:42:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:43 INFO - Using env: {'DISPLAY': ':0', 08:42:43 INFO - 'HOME': '/home/cltbld', 08:42:43 INFO - 'LANG': 'en_US.UTF-8', 08:42:43 INFO - 'LANGUAGE': 'en_US:en', 08:42:43 INFO - 'LOGNAME': 'cltbld', 08:42:43 INFO - 'MAIL': '/var/mail/cltbld', 08:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:43 INFO - 'MOZ_NO_REMOTE': '1', 08:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:43 INFO - 'NO_EM_RESTART': '1', 08:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:43 INFO - 'PWD': '/builds/slave/test', 08:42:43 INFO - 'SHELL': '/bin/bash', 08:42:43 INFO - 'SHLVL': '1', 08:42:43 INFO - 'TERM': 'linux', 08:42:43 INFO - 'TMOUT': '86400', 08:42:43 INFO - 'USER': 'cltbld', 08:42:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:43 INFO - '_': '/tools/buildbot/bin/python'} 08:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:42:43 INFO - Cleaning up... 08:42:43 INFO - Return code: 0 08:42:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:42:43 INFO - Using env: {'DISPLAY': ':0', 08:42:43 INFO - 'HOME': '/home/cltbld', 08:42:43 INFO - 'LANG': 'en_US.UTF-8', 08:42:43 INFO - 'LANGUAGE': 'en_US:en', 08:42:43 INFO - 'LOGNAME': 'cltbld', 08:42:43 INFO - 'MAIL': '/var/mail/cltbld', 08:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:43 INFO - 'MOZ_NO_REMOTE': '1', 08:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:43 INFO - 'NO_EM_RESTART': '1', 08:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:43 INFO - 'PWD': '/builds/slave/test', 08:42:43 INFO - 'SHELL': '/bin/bash', 08:42:43 INFO - 'SHLVL': '1', 08:42:43 INFO - 'TERM': 'linux', 08:42:43 INFO - 'TMOUT': '86400', 08:42:43 INFO - 'USER': 'cltbld', 08:42:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:43 INFO - '_': '/tools/buildbot/bin/python'} 08:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:44 INFO - Downloading/unpacking psutil>=0.7.1 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:46 INFO - Installing collected packages: psutil 08:42:46 INFO - Running setup.py install for psutil 08:42:46 INFO - building 'psutil._psutil_linux' extension 08:42:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:42:46 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 08:42:46 INFO - building 'psutil._psutil_posix' extension 08:42:46 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 08:42:46 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 08:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:46 INFO - Successfully installed psutil 08:42:46 INFO - Cleaning up... 08:42:46 INFO - Return code: 0 08:42:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', '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 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:42: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 mozsystemmonitor==0.0.0 08:42:46 INFO - Using env: {'DISPLAY': ':0', 08:42:46 INFO - 'HOME': '/home/cltbld', 08:42:46 INFO - 'LANG': 'en_US.UTF-8', 08:42:46 INFO - 'LANGUAGE': 'en_US:en', 08:42:46 INFO - 'LOGNAME': 'cltbld', 08:42:46 INFO - 'MAIL': '/var/mail/cltbld', 08:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:46 INFO - 'MOZ_NO_REMOTE': '1', 08:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:46 INFO - 'NO_EM_RESTART': '1', 08:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:46 INFO - 'PWD': '/builds/slave/test', 08:42:46 INFO - 'SHELL': '/bin/bash', 08:42:46 INFO - 'SHLVL': '1', 08:42:46 INFO - 'TERM': 'linux', 08:42:46 INFO - 'TMOUT': '86400', 08:42:46 INFO - 'USER': 'cltbld', 08:42:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:46 INFO - '_': '/tools/buildbot/bin/python'} 08:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:48 INFO - Installing collected packages: mozsystemmonitor 08:42:48 INFO - Running setup.py install for mozsystemmonitor 08:42:48 INFO - Successfully installed mozsystemmonitor 08:42:48 INFO - Cleaning up... 08:42:49 INFO - Return code: 0 08:42:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', '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 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42: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 blobuploader==1.2.4 08:42:49 INFO - Using env: {'DISPLAY': ':0', 08:42:49 INFO - 'HOME': '/home/cltbld', 08:42:49 INFO - 'LANG': 'en_US.UTF-8', 08:42:49 INFO - 'LANGUAGE': 'en_US:en', 08:42:49 INFO - 'LOGNAME': 'cltbld', 08:42:49 INFO - 'MAIL': '/var/mail/cltbld', 08:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:49 INFO - 'MOZ_NO_REMOTE': '1', 08:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:49 INFO - 'NO_EM_RESTART': '1', 08:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:49 INFO - 'PWD': '/builds/slave/test', 08:42:49 INFO - 'SHELL': '/bin/bash', 08:42:49 INFO - 'SHLVL': '1', 08:42:49 INFO - 'TERM': 'linux', 08:42:49 INFO - 'TMOUT': '86400', 08:42:49 INFO - 'USER': 'cltbld', 08:42:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:49 INFO - '_': '/tools/buildbot/bin/python'} 08:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:51 INFO - Downloading docopt-0.6.1.tar.gz 08:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:51 INFO - Running setup.py install for blobuploader 08:42:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:52 INFO - Running setup.py install for requests 08:42:52 INFO - Running setup.py install for docopt 08:42:52 INFO - Successfully installed blobuploader requests docopt 08:42:52 INFO - Cleaning up... 08:42:52 INFO - Return code: 0 08:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:52 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 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:52 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 08:42:52 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 08:42:52 INFO - Using env: {'DISPLAY': ':0', 08:42:52 INFO - 'HOME': '/home/cltbld', 08:42:52 INFO - 'LANG': 'en_US.UTF-8', 08:42:52 INFO - 'LANGUAGE': 'en_US:en', 08:42:52 INFO - 'LOGNAME': 'cltbld', 08:42:52 INFO - 'MAIL': '/var/mail/cltbld', 08:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:52 INFO - 'MOZ_NO_REMOTE': '1', 08:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:52 INFO - 'NO_EM_RESTART': '1', 08:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:52 INFO - 'PWD': '/builds/slave/test', 08:42:52 INFO - 'SHELL': '/bin/bash', 08:42:52 INFO - 'SHLVL': '1', 08:42:52 INFO - 'TERM': 'linux', 08:42:52 INFO - 'TMOUT': '86400', 08:42:52 INFO - 'USER': 'cltbld', 08:42:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:52 INFO - '_': '/tools/buildbot/bin/python'} 08:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Running setup.py (path:/tmp/pip-wM4KW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Running setup.py (path:/tmp/pip-BCTdqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Running setup.py (path:/tmp/pip-vltXIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:53 INFO - Running setup.py (path:/tmp/pip-vjZ6ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:53 INFO - Running setup.py (path:/tmp/pip-yGZFQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:53 INFO - Running setup.py (path:/tmp/pip-mZ78Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 INFO - Running setup.py (path:/tmp/pip-9DWCw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 INFO - Running setup.py (path:/tmp/pip-S0qaJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Running setup.py (path:/tmp/pip-PBb172-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Running setup.py (path:/tmp/pip-939ixn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Running setup.py (path:/tmp/pip-Sh1ikX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Running setup.py (path:/tmp/pip-_b3y1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Running setup.py (path:/tmp/pip-vwg_x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Running setup.py (path:/tmp/pip-Xgn5XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Running setup.py (path:/tmp/pip-iuvZTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:53 INFO - Running setup.py (path:/tmp/pip-NRTdT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:53 INFO - Running setup.py (path:/tmp/pip-YJ69Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:54 INFO - Running setup.py install for manifestparser 08:42:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Running setup.py install for mozcrash 08:42:54 INFO - Running setup.py install for mozdebug 08:42:54 INFO - Running setup.py install for mozdevice 08:42:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Running setup.py install for mozfile 08:42:54 INFO - Running setup.py install for mozhttpd 08:42:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Running setup.py install for mozinfo 08:42:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Running setup.py install for mozInstall 08:42:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:54 INFO - Running setup.py install for mozleak 08:42:54 INFO - Running setup.py install for mozlog 08:42:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for moznetwork 08:42:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for mozprocess 08:42:55 INFO - Running setup.py install for mozprofile 08:42:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for mozrunner 08:42:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for mozscreenshot 08:42:55 INFO - Running setup.py install for moztest 08:42:55 INFO - Running setup.py install for mozversion 08:42:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:55 INFO - Cleaning up... 08:42:55 INFO - Return code: 0 08:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:55 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 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:55 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 08:42:55 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 08:42:55 INFO - Using env: {'DISPLAY': ':0', 08:42:55 INFO - 'HOME': '/home/cltbld', 08:42:55 INFO - 'LANG': 'en_US.UTF-8', 08:42:55 INFO - 'LANGUAGE': 'en_US:en', 08:42:55 INFO - 'LOGNAME': 'cltbld', 08:42:55 INFO - 'MAIL': '/var/mail/cltbld', 08:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:55 INFO - 'MOZ_NO_REMOTE': '1', 08:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:55 INFO - 'NO_EM_RESTART': '1', 08:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:55 INFO - 'PWD': '/builds/slave/test', 08:42:55 INFO - 'SHELL': '/bin/bash', 08:42:55 INFO - 'SHLVL': '1', 08:42:55 INFO - 'TERM': 'linux', 08:42:55 INFO - 'TMOUT': '86400', 08:42:55 INFO - 'USER': 'cltbld', 08:42:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:55 INFO - '_': '/tools/buildbot/bin/python'} 08:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:56 INFO - Running setup.py (path:/tmp/pip-8u1SAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:56 INFO - Running setup.py (path:/tmp/pip-drLmYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:56 INFO - Running setup.py (path:/tmp/pip-J3_YPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:56 INFO - Running setup.py (path:/tmp/pip-fJyNkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:56 INFO - Running setup.py (path:/tmp/pip-wHIcGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:56 INFO - Running setup.py (path:/tmp/pip-_5WbBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:56 INFO - Running setup.py (path:/tmp/pip-J5ia4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:56 INFO - Running setup.py (path:/tmp/pip-jkefyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:56 INFO - Running setup.py (path:/tmp/pip-gzoBGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:56 INFO - Running setup.py (path:/tmp/pip-OYRqqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:56 INFO - Running setup.py (path:/tmp/pip-c6wO4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:56 INFO - Running setup.py (path:/tmp/pip-bIagFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:56 INFO - Running setup.py (path:/tmp/pip-_lYTlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:56 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)) 08:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:56 INFO - Running setup.py (path:/tmp/pip-9n3AzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:57 INFO - Running setup.py (path:/tmp/pip-oyuapK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:57 INFO - Running setup.py (path:/tmp/pip-gkuj9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:57 INFO - Running setup.py (path:/tmp/pip-Q7SBBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:57 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)) 08:42:57 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)) 08:42:57 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)) 08:42:57 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)) 08:42:57 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)) 08:42:57 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)) 08:42:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:59 INFO - Downloading blessings-1.6.tar.gz 08:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:59 INFO - Installing collected packages: blessings 08:42:59 INFO - Running setup.py install for blessings 08:42:59 INFO - Successfully installed blessings 08:42:59 INFO - Cleaning up... 08:42:59 INFO - Return code: 0 08:42:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:59 INFO - Reading from file tmpfile_stdout 08:42:59 INFO - Current package versions: 08:42:59 INFO - argparse == 1.2.1 08:42:59 INFO - blessings == 1.6 08:42:59 INFO - blobuploader == 1.2.4 08:42:59 INFO - docopt == 0.6.1 08:42:59 INFO - manifestparser == 1.1 08:42:59 INFO - mozInstall == 1.12 08:42:59 INFO - mozcrash == 0.17 08:42:59 INFO - mozdebug == 0.1 08:42:59 INFO - mozdevice == 0.48 08:42:59 INFO - mozfile == 1.2 08:42:59 INFO - mozhttpd == 0.7 08:42:59 INFO - mozinfo == 0.9 08:42:59 INFO - mozleak == 0.1 08:42:59 INFO - mozlog == 3.1 08:42:59 INFO - moznetwork == 0.27 08:42:59 INFO - mozprocess == 0.22 08:42:59 INFO - mozprofile == 0.28 08:42:59 INFO - mozrunner == 6.11 08:42:59 INFO - mozscreenshot == 0.1 08:42:59 INFO - mozsystemmonitor == 0.0 08:42:59 INFO - moztest == 0.7 08:42:59 INFO - mozversion == 1.4 08:42:59 INFO - psutil == 3.1.1 08:42:59 INFO - requests == 1.2.3 08:42:59 INFO - wsgiref == 0.1.2 08:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 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 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:59 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 08:42:59 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 08:42:59 INFO - Using env: {'DISPLAY': ':0', 08:42:59 INFO - 'HOME': '/home/cltbld', 08:42:59 INFO - 'LANG': 'en_US.UTF-8', 08:42:59 INFO - 'LANGUAGE': 'en_US:en', 08:42:59 INFO - 'LOGNAME': 'cltbld', 08:42:59 INFO - 'MAIL': '/var/mail/cltbld', 08:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:59 INFO - 'MOZ_NO_REMOTE': '1', 08:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:59 INFO - 'NO_EM_RESTART': '1', 08:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:59 INFO - 'PWD': '/builds/slave/test', 08:42:59 INFO - 'SHELL': '/bin/bash', 08:42:59 INFO - 'SHLVL': '1', 08:42:59 INFO - 'TERM': 'linux', 08:42:59 INFO - 'TMOUT': '86400', 08:42:59 INFO - 'USER': 'cltbld', 08:42:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:59 INFO - '_': '/tools/buildbot/bin/python'} 08:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 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)) 08:42:59 INFO - Cleaning up... 08:42:59 INFO - Return code: 0 08:42:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:59 INFO - Using env: {'DISPLAY': ':0', 08:42:59 INFO - 'HOME': '/home/cltbld', 08:42:59 INFO - 'LANG': 'en_US.UTF-8', 08:42:59 INFO - 'LANGUAGE': 'en_US:en', 08:42:59 INFO - 'LOGNAME': 'cltbld', 08:42:59 INFO - 'MAIL': '/var/mail/cltbld', 08:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:59 INFO - 'MOZ_NO_REMOTE': '1', 08:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:59 INFO - 'NO_EM_RESTART': '1', 08:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:59 INFO - 'PWD': '/builds/slave/test', 08:42:59 INFO - 'SHELL': '/bin/bash', 08:42:59 INFO - 'SHLVL': '1', 08:42:59 INFO - 'TERM': 'linux', 08:42:59 INFO - 'TMOUT': '86400', 08:42:59 INFO - 'USER': 'cltbld', 08:42:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:59 INFO - '_': '/tools/buildbot/bin/python'} 08:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:00 INFO - Downloading/unpacking jsonschema 08:43:00 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 08:43:00 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 08:43:00 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 08:43:00 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 08:43:00 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 08:43:00 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 08:43:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:02 INFO - warning: no files found matching '*.txt' 08:43:02 INFO - no previously-included directories found matching 'build' 08:43:02 INFO - no previously-included directories found matching 'dist' 08:43:02 INFO - no previously-included directories found matching '.git*' 08:43:02 INFO - Installing collected packages: jsonschema, functools32 08:43:02 INFO - Running setup.py install for functools32 08:43:02 INFO - warning: no files found matching '*.txt' 08:43:02 INFO - no previously-included directories found matching 'build' 08:43:02 INFO - no previously-included directories found matching 'dist' 08:43:02 INFO - no previously-included directories found matching '.git*' 08:43:02 INFO - Successfully installed jsonschema functools32 08:43:02 INFO - Cleaning up... 08:43:02 INFO - Return code: 0 08:43:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade90d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', '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 08:43: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', 'flake8'] in /builds/slave/test/build 08:43: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 flake8 08:43:02 INFO - Using env: {'DISPLAY': ':0', 08:43:02 INFO - 'HOME': '/home/cltbld', 08:43:02 INFO - 'LANG': 'en_US.UTF-8', 08:43:02 INFO - 'LANGUAGE': 'en_US:en', 08:43:02 INFO - 'LOGNAME': 'cltbld', 08:43:02 INFO - 'MAIL': '/var/mail/cltbld', 08:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:02 INFO - 'MOZ_NO_REMOTE': '1', 08:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:02 INFO - 'NO_EM_RESTART': '1', 08:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:02 INFO - 'PWD': '/builds/slave/test', 08:43:02 INFO - 'SHELL': '/bin/bash', 08:43:02 INFO - 'SHLVL': '1', 08:43:02 INFO - 'TERM': 'linux', 08:43:02 INFO - 'TMOUT': '86400', 08:43:02 INFO - 'USER': 'cltbld', 08:43:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:02 INFO - '_': '/tools/buildbot/bin/python'} 08:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:02 INFO - Downloading/unpacking flake8 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:05 INFO - no previously-included directories found matching 'docs/_build' 08:43:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:05 INFO - Running setup.py install for pep8 08:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:05 INFO - no previously-included directories found matching 'docs/_build' 08:43:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:05 INFO - Cleaning up... 08:43:05 INFO - Return code: 0 08:43:05 INFO - Running post-action listener: _resource_record_post_action 08:43:05 INFO - Running post-action listener: _start_resource_monitoring 08:43:05 INFO - Starting resource monitoring. 08:43:05 INFO - ##### 08:43:05 INFO - ##### Running install step. 08:43:05 INFO - ##### 08:43:05 INFO - Running pre-action listener: _resource_record_pre_action 08:43:05 INFO - Running main action method: install 08:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:05 INFO - Reading from file tmpfile_stdout 08:43:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:05 INFO - Reading from file tmpfile_stdout 08:43:05 INFO - Output received: 08:43:05 INFO - Usage: mozinstall [options] installer 08:43:05 INFO - Options: 08:43:05 INFO - -h, --help show this help message and exit 08:43:05 INFO - -d DEST, --destination=DEST 08:43:05 INFO - Directory to install application into. [default: 08:43:05 INFO - "/builds/slave/test"] 08:43:05 INFO - --app=APP Application being installed. [default: firefox] 08:43:05 INFO - mkdir: /builds/slave/test/build/application 08:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:19 INFO - Reading from file tmpfile_stdout 08:43:19 INFO - Output received: 08:43:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:19 INFO - Running post-action listener: _resource_record_post_action 08:43:19 INFO - ##### 08:43:19 INFO - ##### Running run-tests step. 08:43:19 INFO - ##### 08:43:19 INFO - Running pre-action listener: _resource_record_pre_action 08:43:19 INFO - Running main action method: run_tests 08:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:19 INFO - Python 2.7.3 08:43:19 INFO - Return code: 0 08:43:19 INFO - grabbing minidump binary from tooltool 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2882410>, '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 0x2883310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28837a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:43:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:43:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:19 INFO - Return code: 0 08:43:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:20 INFO - Return code: 0 08:43:20 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/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:43:20 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/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 08:43:20 INFO - Using env: {'DISPLAY': ':0', 08:43:20 INFO - 'HOME': '/home/cltbld', 08:43:20 INFO - 'LANG': 'en_US.UTF-8', 08:43:20 INFO - 'LANGUAGE': 'en_US:en', 08:43:20 INFO - 'LOGNAME': 'cltbld', 08:43:20 INFO - 'MAIL': '/var/mail/cltbld', 08:43:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:20 INFO - 'MOZ_NO_REMOTE': '1', 08:43:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:20 INFO - 'NO_EM_RESTART': '1', 08:43:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:20 INFO - 'PWD': '/builds/slave/test', 08:43:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:20 INFO - 'SHELL': '/bin/bash', 08:43:20 INFO - 'SHLVL': '1', 08:43:20 INFO - 'TERM': 'linux', 08:43:20 INFO - 'TMOUT': '86400', 08:43:20 INFO - 'USER': 'cltbld', 08:43:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603', 08:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:20 INFO - '_': '/tools/buildbot/bin/python'} 08:43:20 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/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:43:20 INFO - mozversion application_buildid: 20160621055703 08:43:20 INFO - mozversion application_changeset: 195b5d64869c579957bda22c659b8219456910ec 08:43:20 INFO - mozversion application_display_name: Firefox 08:43:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:20 INFO - mozversion application_name: Firefox 08:43:20 INFO - mozversion application_remotingname: firefox 08:43:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:20 INFO - mozversion application_vendor: Mozilla 08:43:20 INFO - mozversion application_version: 48.0 08:43:20 INFO - mozversion platform_buildid: 20160621055703 08:43:20 INFO - mozversion platform_changeset: 195b5d64869c579957bda22c659b8219456910ec 08:43:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:20 INFO - mozversion platform_version: 48.0 08:43:20 INFO - using testdate: 1466523800 08:43:20 INFO - actual date: 1466523800 08:43:20 INFO - starting webserver on 'localhost:32853' 08:43:20 INFO - SUITE-START | Running 2 tests 08:43:20 INFO - TEST-START | dromaeo_css 08:43:20 INFO - operating with platform_type : linux_ 08:43:20 INFO - Initialising browser for dromaeo_css test... 08:43:20 INFO - TEST-INFO | started process 16691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9uxCF7/profile http://localhost:32853/getInfo.html) 08:43:24 INFO - PROCESS | 16691 | __metrics Screen width/height:1600/1200 08:43:24 INFO - PROCESS | 16691 | colorDepth:24 08:43:24 INFO - PROCESS | 16691 | Browser inner width/height: 1024/697 08:43:24 INFO - PROCESS | 16691 | __metrics 08:43:25 ERROR - PROCESS | 16691 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:26 INFO - TEST-INFO | 16691: exit 0 08:43:26 INFO - Browser initialized. 08:43:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:26 INFO - TEST-INFO | started process 16781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9uxCF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:38 INFO - PROCESS | 16781 | RSS: Main: 141000704 08:43:38 INFO - PROCESS | 16781 | 08:44:29 INFO - PROCESS | 16781 | 1466523869180 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] 08:46:36 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32853/tests/dromaeo/cssquery-ext.html) 08:46:37 INFO - PROCESS | 16781 | RSS: Main: 248827904 08:46:37 INFO - PROCESS | 16781 | 08:49:39 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-ext.html (next: http://localhost:32853/tests/dromaeo/cssquery-jquery.html) 08:49:40 INFO - PROCESS | 16781 | RSS: Main: 217882624 08:49:40 INFO - PROCESS | 16781 | 08:52:42 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32853/tests/dromaeo/cssquery-mootools.html) 08:52:42 INFO - PROCESS | 16781 | RSS: Main: 215752704 08:52:42 INFO - PROCESS | 16781 | 08:55:44 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32853/tests/dromaeo/cssquery-prototype.html) 08:55:45 INFO - PROCESS | 16781 | RSS: Main: 217690112 08:55:45 INFO - PROCESS | 16781 | 08:58:47 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32853/tests/dromaeo/cssquery-yui.html) 08:58:48 INFO - PROCESS | 16781 | RSS: Main: 210903040 08:58:48 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | Cycle 1(1): loaded http://localhost:32853/tests/dromaeo/cssquery-yui.html (next: http://localhost:32853/tests/dromaeo/cssquery-dojo.html) 09:01:50 INFO - PROCESS | 16781 | RSS: Main: 255369216 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | __start_tp_report 09:01:50 INFO - PROCESS | 16781 | _x_x_mozilla_page_load 09:01:50 INFO - PROCESS | 16781 | _x_x_mozilla_page_load_details 09:01:50 INFO - PROCESS | 16781 | |i|pagename|runs| 09:01:50 INFO - PROCESS | 16781 | |0;dojo.html;3283.8522266498007;3337.1323455901475;3343.2811945431727;3375.915602109945;3388.81361525116;5540.168974653799;5571.275734154559;5584.4136365681625;5601.29983752031;5607.551395888324;5577.581681373893;5595.21666966625;5621.4940655341015;5624.3813180550205;5659.51894089003;4971.279164521142;4990.550850423461;5002.44973052963;5138.023775482665;5181;5025.824096156635;5107.28498010277;5110.105731496992;5110.28456016158;5119.078565858144;5063.797448102072;5100.821471248507;5104.106781313274;5116.437191908887;5117.539421452068;5164.715940623264;5201.687898726089;5205.661631993946;5213.921791173117;5243.842684719464;4981.053599816023;5007.324011258506;5068.366454193226;5108.463611320833;5110.054639891632;5461.5357694596005;5471.261379713727;5506.311711036121;5508.91736623951;5512.310961129859;5909.8818023639715;5922.289325280994;5928.911066333965;5932.199153114318;5937.2578427696535;6006.039033754622;6032.909506357408;6060.756773962521;6106.542009349317;6126.356732543063;5599.944000559983;5643.6049476536655;5650.180723795068;5653.9151912721345;5659.830205093854;5945.256842894638;6135.1653618788805;6147.72335244915;6154.323024467305;6154.846128846814;5930.347661757203;5960.910586341209;5970.283565972111;5971.104334349882;5986.73059712314;5991.790287340009;6011.969940150271;6015.3383127855905;6018.759249630053;6019.367966363557;5848.795292164754;5878.118282257696;5956.04703247487;5965.612235204698;5968.343482216953;6008.729607167688;6020.789272375446;6022.337542870281;6037.034074548052;6069.908951365733;4405.03089320349;4409.911801763947;4411.845585404495;4417.469903611587;4437.1569401814195;3908.179282350738;3969.900752481211;4002.399640053957;4010.3583426651594;4045.170739998352;5666.9716651416475;5690.345610254791;5692.089265717465;5692.971535142297;5693.345265294462;5994.910076348859;6003.279606447167;6008.128821320884;6008.24896887889;6012.609180403259;5493.121100623881;5610.635308704921;5651.971740141273;5706.258186435737;5709.600327977002;5097.745112744348;5098.745062746848;5109.795608175706;5110.514501122388;5112.948870511322;6278.434940855345;6280.309165991737;6288.056791481223;6293.527985401021;6297.275813281532;5681.17622944679;5839.153322768175;5903.2325797646035;6003.279606447254;6007.189029480965;6258.937410625836;6279.309275979547;6283.49732021428;6293.811185664437;6294.402031806971;5868.794592189253;5873.177755114373;5889.911651325319;5896.086106653475;5926.7925622603;5839.941600583939;5991.820245392645;6074.696265186812;6093.390660933871;6107.206063211754;5743.827685169452;5752.9137062943255;5764.394738552559;5768.596198266249;5778.711064446677;5716.714164291852;5730.426957304403;5778;5787.479126878601;5792.160136780228;5702.600817942704;5705.914411283751;5738.081906894877;5780.421957804186;5804.1293805929445;5766.769329226784;5775.624584402;5808.332041815076;5811.709414529341;5814.883702326015;5613.971930140323;5698.629589076697;5703.543716502752;5705.743241554057;5745.023346031101 09:01:50 INFO - PROCESS | 16781 | |1;ext.html;662.9270780214175;694.402813580321;694.9895751563724;738.4904415952992;753.6081237756368;32835.17912052197;33464.33071338578;33465.996020119404;33502.49746253805;33514;36118.09704757382;40955.38566921491;41722.7913860431;41754;41801;8903;8975.551222438884;9042.23141033013;9047.095290470967;9066.274698024143;8839.46963182211;8943.821123577525;8946.41848279863;8964.8655270171;8966.910330896673;9001.144891235323;9050.954745226298;9052.683156089539;9053.366264361497;9288.860667089999;9174;9225.677101301455;9227.723168304894;9252.53737313135;9253.814923701488;9071.637134514678;9154.542272886396;9175.724728258163;9181.862272065857;9183.724488265363;43963.12073758507;44303.77848110739;44488.11023779506;44504;44506.33240501395;3754;3907.2966865964113;4048.3725022621543;4377.4528183977;4385.122975404932;30085.849570752005;30277.091687249416;30441.23896902573;30511;31667.524987125213;4070.104576993057;4114.938275925863;4148.108156746314;4196.3705444183315;4208.55810139934;285099;287702;289450;289786;290731.54634226905;64931;65083;65384.67307663431;65446.05492752838;65507;60249.09626355608;70315;71987.64006179935;72095.27904720885;72100;17484;17569.648607027786;17570.736438953427;17571;17585;15400.845991540165;15465.613359665873;15468.071915685096;15485.535433937;15488.612784680248;20009;20076.89961550183;20124.29564965219;20177.99110044492;20311;7331.670074846645;7575;7605.23947605235;7622.923770762332;7660.119086305146;1029.8146333659863;1069.641670040545;1128.4132251229478;1135.642272684102;1177.7997740384155;33996.830015849766;34293.65706342905;34536;34634;34677.900091403906;1168.3282112785182;1187.4181650991125;1194.8028575285155;1226.9509219631116;1285.471381058999;17957.551061223312;18010.819891801177;18147.818521814876;18180.090995450173;18300.359487418144;444621;446868;447249;449773;452197;62026;62512;62811;62879.37120628827;62894.37105628977;1367.1660287224786;1478.8077549918657;1494.521753039039;1501.7296886560523;1505.811773528309;30152.84923575368;31227.219319517193;33280.33439331152;34234.48648270228;34294.48558271678;48551;48610.756946216454;48910.755446223964;48915;48950.26574601312;310330;310805;310974;311567;438511;31232;31811.045668629977;31837.840810796726;31840;31879.521807173376;46545.301820473396;49925.50074499209;50994.74502627463;51704;52377;37680;37933.81033094817;38031.239375211786;40887.795561022;42208.15583688248;40242.59757402389;40715.5570665761;41432.58567414287;42650.36024459574;42705.78647106745;42790.57209427866;44040.55959440365;44118.558814411444;44121;44209.778951105036;35940;37699;38258.744281008694;38364.80817595894;38510.42234366431;28867;29314.853425732734;29372.265693357836;29644.258893527833;29716.851415743648 09:01:50 INFO - PROCESS | 16781 | |2;jquery.html;433.92406328892474;442.70117670572375;443.40595558965515;444.75093947389445;446.4218836606596;18956.241750329988;19035.428937131892;19656.705149422753;19968.800311996874;19995.100220490076;19333.806661933377;19387.127579258933;19662.508437289074;19668.803311966876;19701;5574.202235621428;5734.885302293952;5906;5910.0543912973935;5915.9704201478935;4143.854965076223;5752.626079304852;5773.480386765212;6098.603590766608;6398.488120950313;6371.585846919936;6374.553781235315;6386.936130638681;6388.904166437507;6390.3609639036185;5694.4590263925065;5941.435563621449;5952;5963.433473819959;6468.611883286994;3995.62041606047;5560.304961879765;5777.220075289866;5779.826605201851;5791.449812267828;14408.423663053465;14619.195944223064;14645.41418343265;15143.924280378527;22463.213787517358;2294.4608017115966;2352.3531028967172;2410.409449684821;2433.3916520869784;2877.3669792645583;10507.842382364272;13530.323483825769;13747.931260343634;13841.723165536632;14194.169171403293;1988.9701654475195;2081.0739221046642;2106.1154315187505;2109.219588752156;2145.184829764695;79809;84095.99999999939;85114;85180;86502.56748716279;11231.831522527169;11578.305301681927;11638.41807909601;11685.824712629317;11692.649220523397;16380.590485237726;16436.75344869828;16482.917585411997;16490.83509164893;16493.17534123289;8821.38250322484;8983.505907175168;9012.8648070279;9121.908780912107;9175.265978721687;8789.296856251485;8860.512671802984;8869.866951995726;8892.59983300753;8939.061398553189;5058.822941197041;5117.8464646060675;5149.691018538825;5237.895242095136;5239.790408383698;1870.6165236126562;2008.9095990680162;2024.4938765308673;2041.9285325013552;2056.85602007861;927.2998885841282;999.5152351109706;1068.385678235018;1107.0036966730008;1116.7040734205443;17825.910870445565;18020.729689054675;18209.544761381072;18541.629167416577;18745.531361716065;1047.3611097230682;1080.6163811846839;1113.716002419378;1116.7208197950513;1138.9088872890316;9625.844898612211;10787.514561844735;10835.78328433427;10840;10882.510287037103;509483;510373;511528;514303;516551;93294;96063;97378;97500;97507.51246243724;1090.4057288777635;1093.3931667924378;1109.4175557832202;1113.9498722557505;1118.0775859915602;17042.06268655236;17086.74369884428;17251.309947601956;17255.91372043132;17357.13214339303;39080.60919390884;39721.60278397179;40070;40410.595894040685;40930;56482;58819.70590147022;58875.4112458887;59204;59421.405785941584;8885.289176865706;9142.817143656957;9220.723378298662;9277.372043999145;9340.71977840666;10146.18830493544;12453.688657783629;13245.940324774188;13493.325333733077;14036.157830530201;12075.27548347102;12115.575954841539;12311.69220769488;12752.6811829705;12799.168054076456;12212.694682633006;12321.199122057038;12459.897858220727;12514.061445391813;12607.558735444216;7974.880376794236;12240;12274;12424.130310878152;12635.178713383968;9331.346805723535;9358.719238422858;9439.952800235955;9440.763980900532;9544.522773861418;9257.35198536096;12135.271883687006;12212.69468263265;12327.260364378166;12345.135840491079 09:01:50 INFO - PROCESS | 16781 | |3;mootools.html;1444.6171764482408;1560.2900680190514;1577.7396729539623;1793.9910300448496;1908.2557802457036;8459.069502354743;8730.126987301266;8732;8733.650653973842;8743.038265790758;8491.363147763912;8659.480431174134;8664.0902705216;8671.17623825737;8672.8699069514;2453.0923558283416;2475.393528585499;2479.603263477844;2480.702315722116;2482.0816297969777;2459.9139030133947;2513.40934880303;2515.371157210697;2526.7852232560163;2535.1380530619585;2301.9654705179437;2302.873341966191;2456.1894574790276;2458.3362492127117;2458.8524688518655;2276.715410573678;2311.872846993415;2317.849339792925;2323.756005619411;2324.31432727345;2429.2347910408166;2472.5796614575565;2487.7561219390304;2491.775740183374;2494;7651.579163146025;8130.959345203236;8916.242119419858;8983.191512763817;8985.6855010075;5267.86830329241;5458.563314934796;5460.044492213847;5462.426445223234;5464.863378415532;3455;3500.4049311617086;3545.2909418116224;3588.7129029677826;3605.5132557104716;1102.7298311913632;1111;1122.1527746551383;1122.9157813163963;1150.091427772059;12129.393530323538;12592.81110783339;12687.238765673997;12714.936425317814;12727.872721272854;4814.350062741555;4821.108095002436;4921.630877684188;5003.949960500421;5017.774200161001;10806.837897431546;10821.350718956888;10832.566697332019;10836.349819010884;10866.67399978002;5449.01917654818;5503.394626591072;5509.531689806331;5514.476124768141;5518.586106042063;4960.379952505937;5021.899562008739;5024.974875125674;5029.823956161516;5030.270610761419;3940.7832569208967;4003.7397569158493;4045.7167998239843;4050.3721923101966;4050.3924411338535;1269.7079671675567;1274.5793888017117;1278.5013844600612;1281.9551315703904;1297.9091463597458;978.6574698855344;986.3145114145743;1001.4041645221228;1015.279151802214;1054.7574057966558;6169.537284703575;6183.721732522047;6203.689815509297;6266.968665156736;6291.370862913672;487.7780609822522;491.81802732989024;500.13726322094095;505.2522267044721;505.8507740216645;4250.3836943643;4346.804393802223;4368.104538569585;4393.472783266028;4396.670249731283;10539.736506587244;10712.839307410395;10824;10844.240903136704;10857.239993200557;10386.948065259625;10596.364218146937;10635.840462393071;10653.680389588324;10873.401962892116;8284.420090593721;8351.66593336272;8370.8325833483;8452.197041281068;8462.534560599102;5590.916136257878;5642.153676948491;5817.447342502455;5821.79623713168;5869.911951320648;9209.263258939403;9373.343865929592;9396.483193424154;9492.667756628485;9582.28132890022;9351.812963740824;9638.855417168888;9649.035096490295;9660.565274562521;9775.364601300893;7749.690012399441;7874.1338452769005;7896.802579935547;7939;7941.722039728582;8504.787380315542;8542.701005464778;8623;8661.437006594551;8697.739067827975;7830.060392752906;7921.089074756477;7940.960295198487;7953.8409231813885;8065.314448271963;7845.254700803414;7848.450608457353;7868.449208555347;7886.68453261886;8017.719379821679;7122.145342558926;7151.749688760869;7224.530405523624;7226.4218862491925;7231.4937954342695;5316.8936621266585;5384.273123128328;5406.567474602101;5538.335399752055;5646.3788983212635;5400.648957817729;5532.391436942014;5545.306836645419;5547.7780888764;5654.7455364509515 09:01:50 INFO - PROCESS | 16781 | |4;prototype.html;355.4082452716228;356.0528992878941;357.9302036102961;368.1110119062464;370.5886466022715;6084.330723620398;6087.695615219238;6107.938920610793;6121.204243448351;6121.66330851803;5794.913076303858;5962.672053037081;6112.755489780415;6122.846928826782;6145.539084568664;4696.154692155411;4701.106789709944;4705.576498115169;4717.127331443677;4724.220503616899;4666.183417901853;4708.976455117737;4710.152172608929;4713.575778179963;4715.457722361921;4482.350059241425;4572;4575.611073058777;4668.603168730645;4670.136024835399;4575.633949284066;4693.225617773063;4700.989287303212;4717.2452407614965;4720.858374248778;4156.8129434175535;4158.293090174678;4172.290710579209;4173.436586060873;4173.895652608679;5841.123831425278;5854.882902341972;5862.648241105548;5877.706114694291;5881.3530511643685;5453.182022696587;5482.122860342366;5482.396936337;5490.533304669108;5498.422665620093;6152.354002829683;6354.87290254197;6427.871442571122;6430.324815894311;6436.163298771176;4360.847370342023;4393.033532622818;4402.471703395613;4407.559244075599;4408.316710909782;6684.131062961833;6743.291954344772;6763.053172555846;6764.898526522057;6765.830854228634;4578.198815207325;4580.725156490621;4586.793594288265;4588.839390621312;4593.311003349524;4643.187442197602;4644.071185762861;4644.442666879996;4653.581177694024;4653.976730116327;5368.0605893968395;5375.919361209585;5387.703676297841;5388.703621300866;5392.325959255093;6279.905801412982;6536.477081833537;6555.704993275219;6556.442702370352;6567.408933196035;1601.967960640804;1654.139847279408;1655.4454257823522;1657.2128239086337;1658.1377683604699;1025.6307729217476;1043.3062013760764;1055.3193190392153;1074.484247561175;1078.6979645699216;6127.479164271087;6210.099535567408;6214.1921550198185;6218.595791273553;6237.313895471494;6552.57408268461;6568.1789776277965;6571.934280657228;6578.473722102221;6588.11060506835;6186.876262474815;6193.81418557444;6196.225471816023;6196.659183744938;6208.4722798562625;3494.5282386877952;3531.7880927143938;3534.717222622184;3541.769784963969;3545.5745310562897;6836.93163068363;6910.48171387148;7097.21930587635;7131.286871312931;7142.857142857114;6897.068895699117;6918.204406493318;6921.134858142732;6927.861442771116;6943.062686537354;7104.360607545345;7105.147382314155;7115.857682846314;7121.465890058266;7128.002079708845;6742.86514269702;6745.392914637706;6750.628715420699;6768.390844823989;6823.863522729418;6480.287168411565;6627.37039981201;6661.533692641662;6690.330966903465;6698.5980841149685;7104.822379440556;7116.608586527584;7116.644167791486;7123.358897699232;7132.714691412285;4571.954280457153;4579.610733087591;4605.516420775904;4613.677042606985;4616.49218585962;6750.628715420699;6758.763443279461;6831.897521537082;6836.692348844214;6838.897416538656;6403.0715546246465;6540.313267106885;6548.116004339544;6575.671216439063;6576.901346479903;6514.869702606016;6534.477241820738;6535.085088087577;6535.771248006297;6542.967285163544;6428.389303016206;6437.388448097423;6440.871182576416;6441.227052753699;6449.516286278454;6579.440747536513;6589.7364105435245;6591.231682693185;6592.307807680125;6596.175478065242;5976.6712830792985;6258.155149054819;6418.775342862978;6435.584171482266;6437.742490300336 09:01:50 INFO - PROCESS | 16781 | |5;yui.html;767.4551068741193;787.6219414680953;824.47233770387;855.4995327733276;919.8850143732034;14949.551513454586;15912.124833134187;16109.758353624706;16125.113118778463;16161.111138887356;15531.767023494629;15583.92208038961;15674.294656740445;15686.686266274695;15703.371865125382;742.3986570877606;872.110447343709;888.4136469929848;889.2041622747637;889.2219308105408;883.4346018548102;913.5295322908707;915.354674954159;916.2395211974078;916.5142474488498;937.8311903857337;942.4722155592856;943.3208090175063;944.4239014201331;944.5749412764284;777.9572123533203;911.4121391702381;940.8071345374182;942.0579420579421;942.1755963531909;695.1935754524727;695.2282965907838;696.3419568507762;696.7004188199072;697.1912581405545;14624.780628290584;14634.634134146732;14710.55868323952;14717.043392179474;14726.926365368105;14389.856101439062;14598.708025839423;14743.70512589753;14857.47998820047;14954.551363459113;11587.420628968603;11920.463579138874;12614.36928153598;12817.743645127139;12860.678483037906;4063.5326937402283;4090.6522945549664;4101.46680931477;4180.7909604519655;4185.958140418617;53969.1904621431;54002;54097.459025410026;54226.20416570842;54528.18207726887;10692.89307106919;11018;11162.665120046411;11349.432528373549;11376.431178441211;18335.449936501926;18346.082695865152;18392.816071839112;18425.631487370178;18459.630807383775;8140.796480087926;8278.130796266305;8477.491350518989;8616.526091065052;8680.6527738891;4828.46886842447;4880.731559764247;4904.435989861212;4947.282644016597;5048.368953880765;3616.2405894762396;3618.9685939507112;3648.7445878788762;3677.154254521475;3678.2459595782802;645.6707079389452;658.868226354731;670.7283550162192;686.6806934775353;691.5332150798291;782.6321628834439;786.6499407763605;798.6326289906708;798.8601994651029;803.0844836885955;9258.398204116711;9549.665761698307;9571.952140239393;9681.273904457194;9737.610495580097;692.2938602625294;718.4791026505742;775.6819703921365;777.7588947426316;834.9749507514784;4453.665975051884;4456;4490.461144662596;4549.977250113729;4682.41469816273;65056.67471662706;65567;65678.67160664166;65699.34300657029;65865;58091.12863307054;60592.69703651453;61813;61920.380796191464;62486;53727;53915.19127213095;54558.727206363714;55027;55728.44271557314;9214.815703686023;9231.58457869411;9389.154976052188;9432.811343773223;9448.574814133519;40592.39111413272;40719;41430.1713965713;41572.58427415687;42176.57823421849;48812;52673.209901850736;52967;53655.731721341144;54351;11705.414729263674;11829.17195796286;12015.699607509881;12031.4585843639;12068.094892882893;12977.610671679864;12988.805167922299;13037.543685970946;13040.54358097462;13073.215607063607;10830.350178989285;13030.41363138642;13308.600741977756;13332.40004199794;13557.186568805902;12235.32705701195;12301.630951071482;12520.937395313329;12872.549460768829;12891.723307880193;11511.19421640477;11614.5354185835;11636.907730673316;12362.876371236172;12464.813027804772;10711.517981690999;10891.400972946563;11046.447677616248;11072.501737421675;11113.774608216198;10273;10445.738856528647;10591.205659575717;10774.353538787698;10849.240553161519 09:01:50 INFO - PROCESS | 16781 | __end_tp_report 09:01:50 INFO - PROCESS | 16781 | __start_cc_report 09:01:50 INFO - PROCESS | 16781 | _x_x_mozilla_cycle_collect,817 09:01:50 INFO - PROCESS | 16781 | __end_cc_report 09:01:50 INFO - PROCESS | 16781 | __startTimestamp1466524910625__endTimestamp 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | ------- Summary: start ------- 09:01:50 INFO - PROCESS | 16781 | Number of tests: 6 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#0] dojo.html Cycles:165 Average:5550.97 Median:5716.71 stddev:637.54 (11.2%) stddev-sans-first:614.19 09:01:50 INFO - PROCESS | 16781 | Values: 3283.9 3337.1 3343.3 3375.9 3388.8 5540.2 5571.3 5584.4 5601.3 5607.6 5577.6 5595.2 5621.5 5624.4 5659.5 4971.3 4990.6 5002.4 5138.0 5181.0 5025.8 5107.3 5110.1 5110.3 5119.1 5063.8 5100.8 5104.1 5116.4 5117.5 5164.7 5201.7 5205.7 5213.9 5243.8 4981.1 5007.3 5068.4 5108.5 5110.1 5461.5 5471.3 5506.3 5508.9 5512.3 5909.9 5922.3 5928.9 5932.2 5937.3 6006.0 6032.9 6060.8 6106.5 6126.4 5599.9 5643.6 5650.2 5653.9 5659.8 5945.3 6135.2 6147.7 6154.3 6154.8 5930.3 5960.9 5970.3 5971.1 5986.7 5991.8 6012.0 6015.3 6018.8 6019.4 5848.8 5878.1 5956.0 5965.6 5968.3 6008.7 6020.8 6022.3 6037.0 6069.9 4405.0 4409.9 4411.8 4417.5 4437.2 3908.2 3969.9 4002.4 4010.4 4045.2 5667.0 5690.3 5692.1 5693.0 5693.3 5994.9 6003.3 6008.1 6008.2 6012.6 5493.1 5610.6 5652.0 5706.3 5709.6 5097.7 5098.7 5109.8 5110.5 5112.9 6278.4 6280.3 6288.1 6293.5 6297.3 5681.2 5839.2 5903.2 6003.3 6007.2 6258.9 6279.3 6283.5 6293.8 6294.4 5868.8 5873.2 5889.9 5896.1 5926.8 5839.9 5991.8 6074.7 6093.4 6107.2 5743.8 5752.9 5764.4 5768.6 5778.7 5716.7 5730.4 5778.0 5787.5 5792.2 5702.6 5705.9 5738.1 5780.4 5804.1 5766.8 5775.6 5808.3 5811.7 5814.9 5614.0 5698.6 5703.5 5705.7 5745.0 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#1] ext.html Cycles:180 Average:54053.15 Median:22535.16 stddev:96132.87 (426.6%) stddev-sans-first:96318.97 09:01:50 INFO - PROCESS | 16781 | Values: 662.9 694.4 695.0 738.5 753.6 32835.2 33464.3 33466.0 33502.5 33514.0 36118.1 40955.4 41722.8 41754.0 41801.0 8903.0 8975.6 9042.2 9047.1 9066.3 8839.5 8943.8 8946.4 8964.9 8966.9 9001.1 9051.0 9052.7 9053.4 9288.9 9174.0 9225.7 9227.7 9252.5 9253.8 9071.6 9154.5 9175.7 9181.9 9183.7 43963.1 44303.8 44488.1 44504.0 44506.3 3754.0 3907.3 4048.4 4377.5 4385.1 30085.8 30277.1 30441.2 30511.0 31667.5 4070.1 4114.9 4148.1 4196.4 4208.6 285099.0 287702.0 289450.0 289786.0 290731.5 64931.0 65083.0 65384.7 65446.1 65507.0 60249.1 70315.0 71987.6 72095.3 72100.0 17484.0 17569.6 17570.7 17571.0 17585.0 15400.8 15465.6 15468.1 15485.5 15488.6 20009.0 20076.9 20124.3 20178.0 20311.0 7331.7 7575.0 7605.2 7622.9 7660.1 1029.8 1069.6 1128.4 1135.6 1177.8 33996.8 34293.7 34536.0 34634.0 34677.9 1168.3 1187.4 1194.8 1227.0 1285.5 17957.6 18010.8 18147.8 18180.1 18300.4 444621.0 446868.0 447249.0 449773.0 452197.0 62026.0 62512.0 62811.0 62879.4 62894.4 1367.2 1478.8 1494.5 1501.7 1505.8 30152.8 31227.2 33280.3 34234.5 34294.5 48551.0 48610.8 48910.8 48915.0 48950.3 310330.0 310805.0 310974.0 311567.0 438511.0 31232.0 31811.0 31837.8 31840.0 31879.5 46545.3 49925.5 50994.7 51704.0 52377.0 37680.0 37933.8 38031.2 40887.8 42208.2 40242.6 40715.6 41432.6 42650.4 42705.8 42790.6 44040.6 44118.6 44121.0 44209.8 35940.0 37699.0 38258.7 38364.8 38510.4 28867.0 29314.9 29372.3 29644.3 29716.9 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#2] jquery.html Cycles:180 Average:29886.15 Median:2323.41 stddev:84482.20 (3636.1%) stddev-sans-first:84690.25 09:01:50 INFO - PROCESS | 16781 | Values: 433.9 442.7 443.4 444.8 446.4 18956.2 19035.4 19656.7 19968.8 19995.1 19333.8 19387.1 19662.5 19668.8 19701.0 5574.2 5734.9 5906.0 5910.1 5916.0 4143.9 5752.6 5773.5 6098.6 6398.5 6371.6 6374.6 6386.9 6388.9 6390.4 5694.5 5941.4 5952.0 5963.4 6468.6 3995.6 5560.3 5777.2 5779.8 5791.4 14408.4 14619.2 14645.4 15143.9 22463.2 2294.5 2352.4 2410.4 2433.4 2877.4 10507.8 13530.3 13747.9 13841.7 14194.2 1989.0 2081.1 2106.1 2109.2 2145.2 79809.0 84096.0 85114.0 85180.0 86502.6 11231.8 11578.3 11638.4 11685.8 11692.6 16380.6 16436.8 16482.9 16490.8 16493.2 8821.4 8983.5 9012.9 9121.9 9175.3 8789.3 8860.5 8869.9 8892.6 8939.1 5058.8 5117.8 5149.7 5237.9 5239.8 1870.6 2008.9 2024.5 2041.9 2056.9 927.3 999.5 1068.4 1107.0 1116.7 17825.9 18020.7 18209.5 18541.6 18745.5 1047.4 1080.6 1113.7 1116.7 1138.9 9625.8 10787.5 10835.8 10840.0 10882.5 509483.0 510373.0 511528.0 514303.0 516551.0 93294.0 96063.0 97378.0 97500.0 97507.5 1090.4 1093.4 1109.4 1113.9 1118.1 17042.1 17086.7 17251.3 17255.9 17357.1 39080.6 39721.6 40070.0 40410.6 40930.0 56482.0 58819.7 58875.4 59204.0 59421.4 8885.3 9142.8 9220.7 9277.4 9340.7 10146.2 12453.7 13245.9 13493.3 14036.2 12075.3 12115.6 12311.7 12752.7 12799.2 12212.7 12321.2 12459.9 12514.1 12607.6 7974.9 12240.0 12274.0 12424.1 12635.2 9331.3 9358.7 9440.0 9440.8 9544.5 9257.4 12135.3 12212.7 12327.3 12345.1 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#3] mootools.html Cycles:180 Average:5861.45 Median:2767.76 stddev:3259.20 (117.8%) stddev-sans-first:3251.44 09:01:50 INFO - PROCESS | 16781 | Values: 1444.6 1560.3 1577.7 1794.0 1908.3 8459.1 8730.1 8732.0 8733.7 8743.0 8491.4 8659.5 8664.1 8671.2 8672.9 2453.1 2475.4 2479.6 2480.7 2482.1 2459.9 2513.4 2515.4 2526.8 2535.1 2302.0 2302.9 2456.2 2458.3 2458.9 2276.7 2311.9 2317.8 2323.8 2324.3 2429.2 2472.6 2487.8 2491.8 2494.0 7651.6 8131.0 8916.2 8983.2 8985.7 5267.9 5458.6 5460.0 5462.4 5464.9 3455.0 3500.4 3545.3 3588.7 3605.5 1102.7 1111.0 1122.2 1122.9 1150.1 12129.4 12592.8 12687.2 12714.9 12727.9 4814.4 4821.1 4921.6 5003.9 5017.8 10806.8 10821.4 10832.6 10836.3 10866.7 5449.0 5503.4 5509.5 5514.5 5518.6 4960.4 5021.9 5025.0 5029.8 5030.3 3940.8 4003.7 4045.7 4050.4 4050.4 1269.7 1274.6 1278.5 1282.0 1297.9 978.7 986.3 1001.4 1015.3 1054.8 6169.5 6183.7 6203.7 6267.0 6291.4 487.8 491.8 500.1 505.3 505.9 4250.4 4346.8 4368.1 4393.5 4396.7 10539.7 10712.8 10824.0 10844.2 10857.2 10386.9 10596.4 10635.8 10653.7 10873.4 8284.4 8351.7 8370.8 8452.2 8462.5 5590.9 5642.2 5817.4 5821.8 5869.9 9209.3 9373.3 9396.5 9492.7 9582.3 9351.8 9638.9 9649.0 9660.6 9775.4 7749.7 7874.1 7896.8 7939.0 7941.7 8504.8 8542.7 8623.0 8661.4 8697.7 7830.1 7921.1 7941.0 7953.8 8065.3 7845.3 7848.5 7868.4 7886.7 8017.7 7122.1 7151.7 7224.5 7226.4 7231.5 5316.9 5384.3 5406.6 5538.3 5646.4 5400.6 5532.4 5545.3 5547.8 5654.7 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#4] prototype.html Cycles:180 Average:5441.14 Median:6136.51 stddev:1656.35 (27.0%) stddev-sans-first:1616.42 09:01:50 INFO - PROCESS | 16781 | Values: 355.4 356.1 357.9 368.1 370.6 6084.3 6087.7 6107.9 6121.2 6121.7 5794.9 5962.7 6112.8 6122.8 6145.5 4696.2 4701.1 4705.6 4717.1 4724.2 4666.2 4709.0 4710.2 4713.6 4715.5 4482.4 4572.0 4575.6 4668.6 4670.1 4575.6 4693.2 4701.0 4717.2 4720.9 4156.8 4158.3 4172.3 4173.4 4173.9 5841.1 5854.9 5862.6 5877.7 5881.4 5453.2 5482.1 5482.4 5490.5 5498.4 6152.4 6354.9 6427.9 6430.3 6436.2 4360.8 4393.0 4402.5 4407.6 4408.3 6684.1 6743.3 6763.1 6764.9 6765.8 4578.2 4580.7 4586.8 4588.8 4593.3 4643.2 4644.1 4644.4 4653.6 4654.0 5368.1 5375.9 5387.7 5388.7 5392.3 6279.9 6536.5 6555.7 6556.4 6567.4 1602.0 1654.1 1655.4 1657.2 1658.1 1025.6 1043.3 1055.3 1074.5 1078.7 6127.5 6210.1 6214.2 6218.6 6237.3 6552.6 6568.2 6571.9 6578.5 6588.1 6186.9 6193.8 6196.2 6196.7 6208.5 3494.5 3531.8 3534.7 3541.8 3545.6 6836.9 6910.5 7097.2 7131.3 7142.9 6897.1 6918.2 6921.1 6927.9 6943.1 7104.4 7105.1 7115.9 7121.5 7128.0 6742.9 6745.4 6750.6 6768.4 6823.9 6480.3 6627.4 6661.5 6690.3 6698.6 7104.8 7116.6 7116.6 7123.4 7132.7 4572.0 4579.6 4605.5 4613.7 4616.5 6750.6 6758.8 6831.9 6836.7 6838.9 6403.1 6540.3 6548.1 6575.7 6576.9 6514.9 6534.5 6535.1 6535.8 6543.0 6428.4 6437.4 6440.9 6441.2 6449.5 6579.4 6589.7 6591.2 6592.3 6596.2 5976.7 6258.2 6418.8 6435.6 6437.7 09:01:50 INFO - PROCESS | 16781 | 09:01:50 INFO - PROCESS | 16781 | [#5] yui.html Cycles:180 Average:15766.04 Median:4854.60 stddev:18562.86 (382.4%) stddev-sans-first:18580.76 09:01:50 INFO - PROCESS | 16781 | Values: 767.5 787.6 824.5 855.5 919.9 14949.6 15912.1 16109.8 16125.1 16161.1 15531.8 15583.9 15674.3 15686.7 15703.4 742.4 872.1 888.4 889.2 889.2 883.4 913.5 915.4 916.2 916.5 937.8 942.5 943.3 944.4 944.6 778.0 911.4 940.8 942.1 942.2 695.2 695.2 696.3 696.7 697.2 14624.8 14634.6 14710.6 14717.0 14726.9 14389.9 14598.7 14743.7 14857.5 14954.6 11587.4 11920.5 12614.4 12817.7 12860.7 4063.5 4090.7 4101.5 4180.8 4186.0 53969.2 54002.0 54097.5 54226.2 54528.2 10692.9 11018.0 11162.7 11349.4 11376.4 18335.4 18346.1 18392.8 18425.6 18459.6 8140.8 8278.1 8477.5 8616.5 8680.7 4828.5 4880.7 4904.4 4947.3 5048.4 3616.2 3619.0 3648.7 3677.2 3678.2 645.7 658.9 670.7 686.7 691.5 782.6 786.6 798.6 798.9 803.1 9258.4 9549.7 9572.0 9681.3 9737.6 692.3 718.5 775.7 777.8 835.0 4453.7 4456.0 4490.5 4550.0 4682.4 65056.7 65567.0 65678.7 65699.3 65865.0 58091.1 60592.7 61813.0 61920.4 62486.0 53727.0 53915.2 54558.7 55027.0 55728.4 9214.8 9231.6 9389.2 9432.8 9448.6 40592.4 40719.0 41430.2 41572.6 42176.6 48812.0 52673.2 52967.0 53655.7 54351.0 11705.4 11829.2 12015.7 12031.5 12068.1 12977.6 12988.8 13037.5 13040.5 13073.2 10830.4 13030.4 13308.6 13332.4 13557.2 12235.3 12301.6 12520.9 12872.5 12891.7 11511.2 11614.5 11636.9 12362.9 12464.8 10711.5 10891.4 11046.4 11072.5 11113.8 10273.0 10445.7 10591.2 10774.4 10849.2 09:01:50 INFO - PROCESS | 16781 | -------- Summary: end -------- 09:01:50 INFO - PROCESS | 16781 | 09:01:51 INFO - TEST-INFO | 16781: exit 0 09:01:51 INFO - TEST-OK | dromaeo_css | took 1111039ms 09:01:51 INFO - TEST-START | kraken 09:01:51 INFO - operating with platform_type : linux_ 09:01:51 INFO - Initialising browser for kraken test... 09:01:51 INFO - TEST-INFO | started process 16978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkMYkey/profile http://localhost:32853/getInfo.html) 09:01:55 INFO - PROCESS | 16978 | __metrics Screen width/height:1600/1200 09:01:55 INFO - PROCESS | 16978 | colorDepth:24 09:01:55 INFO - PROCESS | 16978 | Browser inner width/height: 1024/697 09:01:55 INFO - PROCESS | 16978 | __metrics 09:01:56 ERROR - PROCESS | 16978 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:01:56 INFO - TEST-INFO | 16978: exit 0 09:01:56 INFO - Browser initialized. 09:01:56 INFO - Running cycle 1/1 for kraken test... 09:01:56 INFO - TEST-INFO | started process 17069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkMYkey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:08 INFO - PROCESS | 17069 | RSS: Main: 140562432 09:02:08 INFO - PROCESS | 17069 | 09:02:11 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32853/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:12 INFO - PROCESS | 17069 | RSS: Main: 197009408 09:02:12 INFO - PROCESS | 17069 | 09:02:14 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32853/tests/kraken/driver.html?testName=audio-dft) 09:02:15 INFO - PROCESS | 17069 | RSS: Main: 185221120 09:02:15 INFO - PROCESS | 17069 | 09:02:18 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32853/tests/kraken/driver.html?testName=audio-fft) 09:02:18 INFO - PROCESS | 17069 | RSS: Main: 274268160 09:02:18 INFO - PROCESS | 17069 | 09:02:20 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32853/tests/kraken/driver.html?testName=audio-oscillator) 09:02:21 INFO - PROCESS | 17069 | RSS: Main: 180072448 09:02:21 INFO - PROCESS | 17069 | 09:02:23 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:24 INFO - PROCESS | 17069 | RSS: Main: 178995200 09:02:24 INFO - PROCESS | 17069 | 09:02:27 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32853/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:27 INFO - PROCESS | 17069 | RSS: Main: 213417984 09:02:27 INFO - PROCESS | 17069 | 09:02:30 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32853/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:31 INFO - PROCESS | 17069 | RSS: Main: 212590592 09:02:31 INFO - PROCESS | 17069 | 09:02:34 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32853/tests/kraken/driver.html?testName=json-parse-financial) 09:02:34 INFO - PROCESS | 17069 | RSS: Main: 213479424 09:02:34 INFO - PROCESS | 17069 | 09:02:36 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:37 INFO - PROCESS | 17069 | RSS: Main: 191987712 09:02:37 INFO - PROCESS | 17069 | 09:02:38 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:39 INFO - PROCESS | 17069 | RSS: Main: 194322432 09:02:39 INFO - PROCESS | 17069 | 09:02:41 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:41 INFO - PROCESS | 17069 | RSS: Main: 208003072 09:02:41 INFO - PROCESS | 17069 | 09:02:44 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:44 INFO - PROCESS | 17069 | RSS: Main: 217522176 09:02:44 INFO - PROCESS | 17069 | 09:02:47 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:48 INFO - PROCESS | 17069 | RSS: Main: 214863872 09:02:48 INFO - PROCESS | 17069 | 09:02:49 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:32853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32853/tests/kraken/driver.html?testName=ai-astar) 09:02:50 INFO - PROCESS | 17069 | RSS: Main: 275202048 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | __start_tp_report 09:02:50 INFO - PROCESS | 17069 | _x_x_mozilla_page_load 09:02:50 INFO - PROCESS | 17069 | _x_x_mozilla_page_load_details 09:02:50 INFO - PROCESS | 17069 | |i|pagename|runs| 09:02:50 INFO - PROCESS | 17069 | |0;ai-astar;109;110;110;111;111;111;105;109;109;107 09:02:50 INFO - PROCESS | 17069 | |1;audio-beat-detection;162;126;150;176;137;150;153;136;186;128 09:02:50 INFO - PROCESS | 17069 | |2;audio-dft;161;160;161;161;161;161;161;161;160;161 09:02:50 INFO - PROCESS | 17069 | |3;audio-fft;75;78;77;166;77;75;73;76;167;76 09:02:50 INFO - PROCESS | 17069 | |4;audio-oscillator;93;93;163;92;93;92;154;92;92;156 09:02:50 INFO - PROCESS | 17069 | |5;imaging-gaussian-blur;116;117;117;117;116;117;116;118;116;116 09:02:50 INFO - PROCESS | 17069 | |6;imaging-darkroom;144;145;145;145;145;145;146;145;146;145 09:02:50 INFO - PROCESS | 17069 | |7;imaging-desaturate;95;96;95;94;95;95;95;95;95;94 09:02:50 INFO - PROCESS | 17069 | |8;json-parse-financial;54;54;53;52;52;53;54;75;53;52 09:02:50 INFO - PROCESS | 17069 | |9;json-stringify-tinderbox;57;58;57;58;58;57;57;57;58;58 09:02:50 INFO - PROCESS | 17069 | |10;stanford-crypto-aes;74;72;72;75;74;73;73;82;74;73 09:02:50 INFO - PROCESS | 17069 | |11;stanford-crypto-ccm;117;116;114;118;110;120;114;116;137;121 09:02:50 INFO - PROCESS | 17069 | |12;stanford-crypto-pbkdf2;163;162;163;162;164;162;162;161;164;163 09:02:50 INFO - PROCESS | 17069 | |13;stanford-crypto-sha256-iterative;68;69;67;66;69;65;65;67;66;66 09:02:50 INFO - PROCESS | 17069 | __end_tp_report 09:02:50 INFO - PROCESS | 17069 | __start_cc_report 09:02:50 INFO - PROCESS | 17069 | _x_x_mozilla_cycle_collect,1592 09:02:50 INFO - PROCESS | 17069 | __end_cc_report 09:02:50 INFO - PROCESS | 17069 | __startTimestamp1466524970155__endTimestamp 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | ------- Summary: start ------- 09:02:50 INFO - PROCESS | 17069 | Number of tests: 14 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.93 (1.8%) stddev-sans-first:2.05 09:02:50 INFO - PROCESS | 17069 | Values: 109.0 110.0 110.0 111.0 111.0 111.0 105.0 109.0 109.0 107.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:151.50 stddev:19.86 (13.1%) stddev-sans-first:20.61 09:02:50 INFO - PROCESS | 17069 | Values: 162.0 126.0 150.0 176.0 137.0 150.0 153.0 136.0 186.0 128.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:02:50 INFO - PROCESS | 17069 | Values: 161.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 160.0 161.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.24 (50.3%) stddev-sans-first:39.93 09:02:50 INFO - PROCESS | 17069 | Values: 75.0 78.0 77.0 166.0 77.0 75.0 73.0 76.0 167.0 76.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:92.00 stddev:31.59 (34.3%) stddev-sans-first:32.75 09:02:50 INFO - PROCESS | 17069 | Values: 93.0 93.0 163.0 92.0 93.0 92.0 154.0 92.0 92.0 156.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 09:02:50 INFO - PROCESS | 17069 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 116.0 118.0 116.0 116.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 09:02:50 INFO - PROCESS | 17069 | Values: 144.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:02:50 INFO - PROCESS | 17069 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:53.50 stddev:7.00 (13.1%) stddev-sans-first:7.42 09:02:50 INFO - PROCESS | 17069 | Values: 54.0 54.0 53.0 52.0 52.0 53.0 54.0 75.0 53.0 52.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 09:02:50 INFO - PROCESS | 17069 | Values: 57.0 58.0 57.0 58.0 58.0 57.0 57.0 57.0 58.0 58.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.90 (3.9%) stddev-sans-first:3.07 09:02:50 INFO - PROCESS | 17069 | Values: 74.0 72.0 72.0 75.0 74.0 73.0 73.0 82.0 74.0 73.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:117.50 stddev:7.29 (6.2%) stddev-sans-first:7.72 09:02:50 INFO - PROCESS | 17069 | Values: 117.0 116.0 114.0 118.0 110.0 120.0 114.0 116.0 137.0 121.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:02:50 INFO - PROCESS | 17069 | Values: 163.0 162.0 163.0 162.0 164.0 162.0 162.0 161.0 164.0 163.0 09:02:50 INFO - PROCESS | 17069 | 09:02:50 INFO - PROCESS | 17069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 09:02:50 INFO - PROCESS | 17069 | Values: 68.0 69.0 67.0 66.0 69.0 65.0 65.0 67.0 66.0 66.0 09:02:50 INFO - PROCESS | 17069 | -------- Summary: end -------- 09:02:50 INFO - PROCESS | 17069 | 09:02:51 INFO - TEST-INFO | 17069: exit 0 09:02:51 INFO - TEST-OK | kraken | took 59900ms 09:02:51 INFO - SUITE-END | took 1170s 09:02:51 INFO - Completed test suite (00:19:31) 09:02:51 INFO - javascript benchmark 09:02:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.8522266498007, 3337.1323455901475, 3343.2811945431727, 3375.915602109945, 3388.81361525116, 5540.168974653799, 5571.275734154559, 5584.4136365681625, 5601.29983752031, 5607.551395888324, 5577.581681373893, 5595.21666966625, 5621.4940655341015, 5624.3813180550205, 5659.51894089003, 4971.279164521142, 4990.550850423461, 5002.44973052963, 5138.023775482665, 5181.0, 5025.824096156635, 5107.28498010277, 5110.105731496992, 5110.28456016158, 5119.078565858144, 5063.797448102072, 5100.821471248507, 5104.106781313274, 5116.437191908887, 5117.539421452068, 5164.715940623264, 5201.687898726089, 5205.661631993946, 5213.921791173117, 5243.842684719464, 4981.053599816023, 5007.324011258506, 5068.366454193226, 5108.463611320833, 5110.054639891632, 5461.5357694596005, 5471.261379713727, 5506.311711036121, 5508.91736623951, 5512.310961129859, 5909.8818023639715, 5922.289325280994, 5928.911066333965, 5932.199153114318, 5937.2578427696535, 6006.039033754622, 6032.909506357408, 6060.756773962521, 6106.542009349317, 6126.356732543063, 5599.944000559983, 5643.6049476536655, 5650.180723795068, 5653.9151912721345, 5659.830205093854, 5945.256842894638, 6135.1653618788805, 6147.72335244915, 6154.323024467305, 6154.846128846814, 5930.347661757203, 5960.910586341209, 5970.283565972111, 5971.104334349882, 5986.73059712314, 5991.790287340009, 6011.969940150271, 6015.3383127855905, 6018.759249630053, 6019.367966363557, 5848.795292164754, 5878.118282257696, 5956.04703247487, 5965.612235204698, 5968.343482216953, 6008.729607167688, 6020.789272375446, 6022.337542870281, 6037.034074548052, 6069.908951365733, 4405.03089320349, 4409.911801763947, 4411.845585404495, 4417.469903611587, 4437.1569401814195, 3908.179282350738, 3969.900752481211, 4002.399640053957, 4010.3583426651594, 4045.170739998352, 5666.9716651416475, 5690.345610254791, 5692.089265717465, 5692.971535142297, 5693.345265294462, 5994.910076348859, 6003.279606447167, 6008.128821320884, 6008.24896887889, 6012.609180403259, 5493.121100623881, 5610.635308704921, 5651.971740141273, 5706.258186435737, 5709.600327977002, 5097.745112744348, 5098.745062746848, 5109.795608175706, 5110.514501122388, 5112.948870511322, 6278.434940855345, 6280.309165991737, 6288.056791481223, 6293.527985401021, 6297.275813281532, 5681.17622944679, 5839.153322768175, 5903.2325797646035, 6003.279606447254, 6007.189029480965, 6258.937410625836, 6279.309275979547, 6283.49732021428, 6293.811185664437, 6294.402031806971, 5868.794592189253, 5873.177755114373, 5889.911651325319, 5896.086106653475, 5926.7925622603, 5839.941600583939, 5991.820245392645, 6074.696265186812, 6093.390660933871, 6107.206063211754, 5743.827685169452, 5752.9137062943255, 5764.394738552559, 5768.596198266249, 5778.711064446677, 5716.714164291852, 5730.426957304403, 5778.0, 5787.479126878601, 5792.160136780228, 5702.600817942704, 5705.914411283751, 5738.081906894877, 5780.421957804186, 5804.1293805929445, 5766.769329226784, 5775.624584402, 5808.332041815076, 5811.709414529341, 5814.883702326015, 5613.971930140323, 5698.629589076697, 5703.543716502752, 5705.743241554057, 5745.023346031101], "value": 5508.065549689302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.9270780214175, 694.402813580321, 694.9895751563724, 738.4904415952992, 753.6081237756368, 32835.17912052197, 33464.33071338578, 33465.996020119404, 33502.49746253805, 33514.0, 36118.09704757382, 40955.38566921491, 41722.7913860431, 41754.0, 41801.0, 8903.0, 8975.551222438884, 9042.23141033013, 9047.095290470967, 9066.274698024143, 8839.46963182211, 8943.821123577525, 8946.41848279863, 8964.8655270171, 8966.910330896673, 9001.144891235323, 9050.954745226298, 9052.683156089539, 9053.366264361497, 9288.860667089999, 9174.0, 9225.677101301455, 9227.723168304894, 9252.53737313135, 9253.814923701488, 9071.637134514678, 9154.542272886396, 9175.724728258163, 9181.862272065857, 9183.724488265363, 43963.12073758507, 44303.77848110739, 44488.11023779506, 44504.0, 44506.33240501395, 3754.0, 3907.2966865964113, 4048.3725022621543, 4377.4528183977, 4385.122975404932, 30085.849570752005, 30277.091687249416, 30441.23896902573, 30511.0, 31667.524987125213, 4070.104576993057, 4114.938275925863, 4148.108156746314, 4196.3705444183315, 4208.55810139934, 285099.0, 287702.0, 289450.0, 289786.0, 290731.54634226905, 64931.0, 65083.0, 65384.67307663431, 65446.05492752838, 65507.0, 60249.09626355608, 70315.0, 71987.64006179935, 72095.27904720885, 72100.0, 17484.0, 17569.648607027786, 17570.736438953427, 17571.0, 17585.0, 15400.845991540165, 15465.613359665873, 15468.071915685096, 15485.535433937, 15488.612784680248, 20009.0, 20076.89961550183, 20124.29564965219, 20177.99110044492, 20311.0, 7331.670074846645, 7575.0, 7605.23947605235, 7622.923770762332, 7660.119086305146, 1029.8146333659863, 1069.641670040545, 1128.4132251229478, 1135.642272684102, 1177.7997740384155, 33996.830015849766, 34293.65706342905, 34536.0, 34634.0, 34677.900091403906, 1168.3282112785182, 1187.4181650991125, 1194.8028575285155, 1226.9509219631116, 1285.471381058999, 17957.551061223312, 18010.819891801177, 18147.818521814876, 18180.090995450173, 18300.359487418144, 444621.0, 446868.0, 447249.0, 449773.0, 452197.0, 62026.0, 62512.0, 62811.0, 62879.37120628827, 62894.37105628977, 1367.1660287224786, 1478.8077549918657, 1494.521753039039, 1501.7296886560523, 1505.811773528309, 30152.84923575368, 31227.219319517193, 33280.33439331152, 34234.48648270228, 34294.48558271678, 48551.0, 48610.756946216454, 48910.755446223964, 48915.0, 48950.26574601312, 310330.0, 310805.0, 310974.0, 311567.0, 438511.0, 31232.0, 31811.045668629977, 31837.840810796726, 31840.0, 31879.521807173376, 46545.301820473396, 49925.50074499209, 50994.74502627463, 51704.0, 52377.0, 37680.0, 37933.81033094817, 38031.239375211786, 40887.795561022, 42208.15583688248, 40242.59757402389, 40715.5570665761, 41432.58567414287, 42650.36024459574, 42705.78647106745, 42790.57209427866, 44040.55959440365, 44118.558814411444, 44121.0, 44209.778951105036, 35940.0, 37699.0, 38258.744281008694, 38364.80817595894, 38510.42234366431, 28867.0, 29314.853425732734, 29372.265693357836, 29644.258893527833, 29716.851415743648], "value": 20521.250293544843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.92406328892474, 442.70117670572375, 443.40595558965515, 444.75093947389445, 446.4218836606596, 18956.241750329988, 19035.428937131892, 19656.705149422753, 19968.800311996874, 19995.100220490076, 19333.806661933377, 19387.127579258933, 19662.508437289074, 19668.803311966876, 19701.0, 5574.202235621428, 5734.885302293952, 5906.0, 5910.0543912973935, 5915.9704201478935, 4143.854965076223, 5752.626079304852, 5773.480386765212, 6098.603590766608, 6398.488120950313, 6371.585846919936, 6374.553781235315, 6386.936130638681, 6388.904166437507, 6390.3609639036185, 5694.4590263925065, 5941.435563621449, 5952.0, 5963.433473819959, 6468.611883286994, 3995.62041606047, 5560.304961879765, 5777.220075289866, 5779.826605201851, 5791.449812267828, 14408.423663053465, 14619.195944223064, 14645.41418343265, 15143.924280378527, 22463.213787517358, 2294.4608017115966, 2352.3531028967172, 2410.409449684821, 2433.3916520869784, 2877.3669792645583, 10507.842382364272, 13530.323483825769, 13747.931260343634, 13841.723165536632, 14194.169171403293, 1988.9701654475195, 2081.0739221046642, 2106.1154315187505, 2109.219588752156, 2145.184829764695, 79809.0, 84095.99999999939, 85114.0, 85180.0, 86502.56748716279, 11231.831522527169, 11578.305301681927, 11638.41807909601, 11685.824712629317, 11692.649220523397, 16380.590485237726, 16436.75344869828, 16482.917585411997, 16490.83509164893, 16493.17534123289, 8821.38250322484, 8983.505907175168, 9012.8648070279, 9121.908780912107, 9175.265978721687, 8789.296856251485, 8860.512671802984, 8869.866951995726, 8892.59983300753, 8939.061398553189, 5058.822941197041, 5117.8464646060675, 5149.691018538825, 5237.895242095136, 5239.790408383698, 1870.6165236126562, 2008.9095990680162, 2024.4938765308673, 2041.9285325013552, 2056.85602007861, 927.2998885841282, 999.5152351109706, 1068.385678235018, 1107.0036966730008, 1116.7040734205443, 17825.910870445565, 18020.729689054675, 18209.544761381072, 18541.629167416577, 18745.531361716065, 1047.3611097230682, 1080.6163811846839, 1113.716002419378, 1116.7208197950513, 1138.9088872890316, 9625.844898612211, 10787.514561844735, 10835.78328433427, 10840.0, 10882.510287037103, 509483.0, 510373.0, 511528.0, 514303.0, 516551.0, 93294.0, 96063.0, 97378.0, 97500.0, 97507.51246243724, 1090.4057288777635, 1093.3931667924378, 1109.4175557832202, 1113.9498722557505, 1118.0775859915602, 17042.06268655236, 17086.74369884428, 17251.309947601956, 17255.91372043132, 17357.13214339303, 39080.60919390884, 39721.60278397179, 40070.0, 40410.595894040685, 40930.0, 56482.0, 58819.70590147022, 58875.4112458887, 59204.0, 59421.405785941584, 8885.289176865706, 9142.817143656957, 9220.723378298662, 9277.372043999145, 9340.71977840666, 10146.18830493544, 12453.688657783629, 13245.940324774188, 13493.325333733077, 14036.157830530201, 12075.27548347102, 12115.575954841539, 12311.69220769488, 12752.6811829705, 12799.168054076456, 12212.694682633006, 12321.199122057038, 12459.897858220727, 12514.061445391813, 12607.558735444216, 7974.880376794236, 12240.0, 12274.0, 12424.130310878152, 12635.178713383968, 9331.346805723535, 9358.719238422858, 9439.952800235955, 9440.763980900532, 9544.522773861418, 9257.35198536096, 12135.271883687006, 12212.69468263265, 12327.260364378166, 12345.135840491079], "value": 9542.493776260926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.6171764482408, 1560.2900680190514, 1577.7396729539623, 1793.9910300448496, 1908.2557802457036, 8459.069502354743, 8730.126987301266, 8732.0, 8733.650653973842, 8743.038265790758, 8491.363147763912, 8659.480431174134, 8664.0902705216, 8671.17623825737, 8672.8699069514, 2453.0923558283416, 2475.393528585499, 2479.603263477844, 2480.702315722116, 2482.0816297969777, 2459.9139030133947, 2513.40934880303, 2515.371157210697, 2526.7852232560163, 2535.1380530619585, 2301.9654705179437, 2302.873341966191, 2456.1894574790276, 2458.3362492127117, 2458.8524688518655, 2276.715410573678, 2311.872846993415, 2317.849339792925, 2323.756005619411, 2324.31432727345, 2429.2347910408166, 2472.5796614575565, 2487.7561219390304, 2491.775740183374, 2494.0, 7651.579163146025, 8130.959345203236, 8916.242119419858, 8983.191512763817, 8985.6855010075, 5267.86830329241, 5458.563314934796, 5460.044492213847, 5462.426445223234, 5464.863378415532, 3455.0, 3500.4049311617086, 3545.2909418116224, 3588.7129029677826, 3605.5132557104716, 1102.7298311913632, 1111.0, 1122.1527746551383, 1122.9157813163963, 1150.091427772059, 12129.393530323538, 12592.81110783339, 12687.238765673997, 12714.936425317814, 12727.872721272854, 4814.350062741555, 4821.108095002436, 4921.630877684188, 5003.949960500421, 5017.774200161001, 10806.837897431546, 10821.350718956888, 10832.566697332019, 10836.349819010884, 10866.67399978002, 5449.01917654818, 5503.394626591072, 5509.531689806331, 5514.476124768141, 5518.586106042063, 4960.379952505937, 5021.899562008739, 5024.974875125674, 5029.823956161516, 5030.270610761419, 3940.7832569208967, 4003.7397569158493, 4045.7167998239843, 4050.3721923101966, 4050.3924411338535, 1269.7079671675567, 1274.5793888017117, 1278.5013844600612, 1281.9551315703904, 1297.9091463597458, 978.6574698855344, 986.3145114145743, 1001.4041645221228, 1015.279151802214, 1054.7574057966558, 6169.537284703575, 6183.721732522047, 6203.689815509297, 6266.968665156736, 6291.370862913672, 487.7780609822522, 491.81802732989024, 500.13726322094095, 505.2522267044721, 505.8507740216645, 4250.3836943643, 4346.804393802223, 4368.104538569585, 4393.472783266028, 4396.670249731283, 10539.736506587244, 10712.839307410395, 10824.0, 10844.240903136704, 10857.239993200557, 10386.948065259625, 10596.364218146937, 10635.840462393071, 10653.680389588324, 10873.401962892116, 8284.420090593721, 8351.66593336272, 8370.8325833483, 8452.197041281068, 8462.534560599102, 5590.916136257878, 5642.153676948491, 5817.447342502455, 5821.79623713168, 5869.911951320648, 9209.263258939403, 9373.343865929592, 9396.483193424154, 9492.667756628485, 9582.28132890022, 9351.812963740824, 9638.855417168888, 9649.035096490295, 9660.565274562521, 9775.364601300893, 7749.690012399441, 7874.1338452769005, 7896.802579935547, 7939.0, 7941.722039728582, 8504.787380315542, 8542.701005464778, 8623.0, 8661.437006594551, 8697.739067827975, 7830.060392752906, 7921.089074756477, 7940.960295198487, 7953.8409231813885, 8065.314448271963, 7845.254700803414, 7848.450608457353, 7868.449208555347, 7886.68453261886, 8017.719379821679, 7122.145342558926, 7151.749688760869, 7224.530405523624, 7226.4218862491925, 7231.4937954342695, 5316.8936621266585, 5384.273123128328, 5406.567474602101, 5538.335399752055, 5646.3788983212635, 5400.648957817729, 5532.391436942014, 5545.306836645419, 5547.7780888764, 5654.7455364509515], "value": 4660.48206065292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.4082452716228, 356.0528992878941, 357.9302036102961, 368.1110119062464, 370.5886466022715, 6084.330723620398, 6087.695615219238, 6107.938920610793, 6121.204243448351, 6121.66330851803, 5794.913076303858, 5962.672053037081, 6112.755489780415, 6122.846928826782, 6145.539084568664, 4696.154692155411, 4701.106789709944, 4705.576498115169, 4717.127331443677, 4724.220503616899, 4666.183417901853, 4708.976455117737, 4710.152172608929, 4713.575778179963, 4715.457722361921, 4482.350059241425, 4572.0, 4575.611073058777, 4668.603168730645, 4670.136024835399, 4575.633949284066, 4693.225617773063, 4700.989287303212, 4717.2452407614965, 4720.858374248778, 4156.8129434175535, 4158.293090174678, 4172.290710579209, 4173.436586060873, 4173.895652608679, 5841.123831425278, 5854.882902341972, 5862.648241105548, 5877.706114694291, 5881.3530511643685, 5453.182022696587, 5482.122860342366, 5482.396936337, 5490.533304669108, 5498.422665620093, 6152.354002829683, 6354.87290254197, 6427.871442571122, 6430.324815894311, 6436.163298771176, 4360.847370342023, 4393.033532622818, 4402.471703395613, 4407.559244075599, 4408.316710909782, 6684.131062961833, 6743.291954344772, 6763.053172555846, 6764.898526522057, 6765.830854228634, 4578.198815207325, 4580.725156490621, 4586.793594288265, 4588.839390621312, 4593.311003349524, 4643.187442197602, 4644.071185762861, 4644.442666879996, 4653.581177694024, 4653.976730116327, 5368.0605893968395, 5375.919361209585, 5387.703676297841, 5388.703621300866, 5392.325959255093, 6279.905801412982, 6536.477081833537, 6555.704993275219, 6556.442702370352, 6567.408933196035, 1601.967960640804, 1654.139847279408, 1655.4454257823522, 1657.2128239086337, 1658.1377683604699, 1025.6307729217476, 1043.3062013760764, 1055.3193190392153, 1074.484247561175, 1078.6979645699216, 6127.479164271087, 6210.099535567408, 6214.1921550198185, 6218.595791273553, 6237.313895471494, 6552.57408268461, 6568.1789776277965, 6571.934280657228, 6578.473722102221, 6588.11060506835, 6186.876262474815, 6193.81418557444, 6196.225471816023, 6196.659183744938, 6208.4722798562625, 3494.5282386877952, 3531.7880927143938, 3534.717222622184, 3541.769784963969, 3545.5745310562897, 6836.93163068363, 6910.48171387148, 7097.21930587635, 7131.286871312931, 7142.857142857114, 6897.068895699117, 6918.204406493318, 6921.134858142732, 6927.861442771116, 6943.062686537354, 7104.360607545345, 7105.147382314155, 7115.857682846314, 7121.465890058266, 7128.002079708845, 6742.86514269702, 6745.392914637706, 6750.628715420699, 6768.390844823989, 6823.863522729418, 6480.287168411565, 6627.37039981201, 6661.533692641662, 6690.330966903465, 6698.5980841149685, 7104.822379440556, 7116.608586527584, 7116.644167791486, 7123.358897699232, 7132.714691412285, 4571.954280457153, 4579.610733087591, 4605.516420775904, 4613.677042606985, 4616.49218585962, 6750.628715420699, 6758.763443279461, 6831.897521537082, 6836.692348844214, 6838.897416538656, 6403.0715546246465, 6540.313267106885, 6548.116004339544, 6575.671216439063, 6576.901346479903, 6514.869702606016, 6534.477241820738, 6535.085088087577, 6535.771248006297, 6542.967285163544, 6428.389303016206, 6437.388448097423, 6440.871182576416, 6441.227052753699, 6449.516286278454, 6579.440747536513, 6589.7364105435245, 6591.231682693185, 6592.307807680125, 6596.175478065242, 5976.6712830792985, 6258.155149054819, 6418.775342862978, 6435.584171482266, 6437.742490300336], "value": 4905.152171729226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.4551068741193, 787.6219414680953, 824.47233770387, 855.4995327733276, 919.8850143732034, 14949.551513454586, 15912.124833134187, 16109.758353624706, 16125.113118778463, 16161.111138887356, 15531.767023494629, 15583.92208038961, 15674.294656740445, 15686.686266274695, 15703.371865125382, 742.3986570877606, 872.110447343709, 888.4136469929848, 889.2041622747637, 889.2219308105408, 883.4346018548102, 913.5295322908707, 915.354674954159, 916.2395211974078, 916.5142474488498, 937.8311903857337, 942.4722155592856, 943.3208090175063, 944.4239014201331, 944.5749412764284, 777.9572123533203, 911.4121391702381, 940.8071345374182, 942.0579420579421, 942.1755963531909, 695.1935754524727, 695.2282965907838, 696.3419568507762, 696.7004188199072, 697.1912581405545, 14624.780628290584, 14634.634134146732, 14710.55868323952, 14717.043392179474, 14726.926365368105, 14389.856101439062, 14598.708025839423, 14743.70512589753, 14857.47998820047, 14954.551363459113, 11587.420628968603, 11920.463579138874, 12614.36928153598, 12817.743645127139, 12860.678483037906, 4063.5326937402283, 4090.6522945549664, 4101.46680931477, 4180.7909604519655, 4185.958140418617, 53969.1904621431, 54002.0, 54097.459025410026, 54226.20416570842, 54528.18207726887, 10692.89307106919, 11018.0, 11162.665120046411, 11349.432528373549, 11376.431178441211, 18335.449936501926, 18346.082695865152, 18392.816071839112, 18425.631487370178, 18459.630807383775, 8140.796480087926, 8278.130796266305, 8477.491350518989, 8616.526091065052, 8680.6527738891, 4828.46886842447, 4880.731559764247, 4904.435989861212, 4947.282644016597, 5048.368953880765, 3616.2405894762396, 3618.9685939507112, 3648.7445878788762, 3677.154254521475, 3678.2459595782802, 645.6707079389452, 658.868226354731, 670.7283550162192, 686.6806934775353, 691.5332150798291, 782.6321628834439, 786.6499407763605, 798.6326289906708, 798.8601994651029, 803.0844836885955, 9258.398204116711, 9549.665761698307, 9571.952140239393, 9681.273904457194, 9737.610495580097, 692.2938602625294, 718.4791026505742, 775.6819703921365, 777.7588947426316, 834.9749507514784, 4453.665975051884, 4456.0, 4490.461144662596, 4549.977250113729, 4682.41469816273, 65056.67471662706, 65567.0, 65678.67160664166, 65699.34300657029, 65865.0, 58091.12863307054, 60592.69703651453, 61813.0, 61920.380796191464, 62486.0, 53727.0, 53915.19127213095, 54558.727206363714, 55027.0, 55728.44271557314, 9214.815703686023, 9231.58457869411, 9389.154976052188, 9432.811343773223, 9448.574814133519, 40592.39111413272, 40719.0, 41430.1713965713, 41572.58427415687, 42176.57823421849, 48812.0, 52673.209901850736, 52967.0, 53655.731721341144, 54351.0, 11705.414729263674, 11829.17195796286, 12015.699607509881, 12031.4585843639, 12068.094892882893, 12977.610671679864, 12988.805167922299, 13037.543685970946, 13040.54358097462, 13073.215607063607, 10830.350178989285, 13030.41363138642, 13308.600741977756, 13332.40004199794, 13557.186568805902, 12235.32705701195, 12301.630951071482, 12520.937395313329, 12872.549460768829, 12891.723307880193, 11511.19421640477, 11614.5354185835, 11636.907730673316, 12362.876371236172, 12464.813027804772, 10711.517981690999, 10891.400972946563, 11046.447677616248, 11072.501737421675, 11113.774608216198, 10273.0, 10445.738856528647, 10591.205659575717, 10774.353538787698, 10849.240553161519], "value": 7113.943182349023, "unit": "score"}], "name": "dromaeo_css", "value": 7481.977919709806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 111.0, 111.0, 111.0, 105.0, 109.0, 109.0, 107.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 150.0, 176.0, 137.0, 150.0, 153.0, 136.0, 186.0, 128.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 77.0, 166.0, 77.0, 75.0, 73.0, 76.0, 167.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 163.0, 92.0, 93.0, 92.0, 154.0, 92.0, 92.0, 156.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 52.0, 52.0, 53.0, 54.0, 75.0, 53.0, 52.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 75.0, 74.0, 73.0, 73.0, 82.0, 74.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 118.0, 110.0, 120.0, 114.0, 116.0, 137.0, 121.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 164.0, 162.0, 162.0, 161.0, 164.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 66.0, 69.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1517.6, "alertThreshold": 2.0}]} 09:02:51 INFO - Return code: 0 09:02:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:02:51 ERROR - # TBPL SUCCESS # 09:02:51 INFO - Running post-action listener: _resource_record_post_action 09:02:51 INFO - Running post-run listener: _resource_record_post_run 09:02:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 464723968; Read time: 20; Write time: 356092 09:02:52 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242159616; Read time: 0; Write time: 227596 09:02:52 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221966336; Read time: 20; Write time: 128496 09:02:52 INFO - Running post-run listener: _upload_blobber_files 09:02:52 INFO - Blob upload gear active. 09:02:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:52 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:02:52 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:02:52 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:02:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:53 INFO - (blobuploader) - INFO - Done attempting. 09:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:54 INFO - (blobuploader) - INFO - Done attempting. 09:02:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:54 INFO - Return code: 0 09:02:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00f6f2dfde0608c35ca407a138de3aba5d0bf9f59b4dadf9037e8e6d64be21db69929b693eede69bf0ebad8ec718f8e27ebb380173aab1dbfb1ce9a6066b3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2668551f433e42e8bf8a74d837205ba5a8732a2a6d79e12152b254d859353264654d833f17882bb69f3d404f05042f06a48c832e1a357bce605bc9be5c52c1c0"} 09:02:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:54 INFO - Contents: 09:02:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00f6f2dfde0608c35ca407a138de3aba5d0bf9f59b4dadf9037e8e6d64be21db69929b693eede69bf0ebad8ec718f8e27ebb380173aab1dbfb1ce9a6066b3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2668551f433e42e8bf8a74d837205ba5a8732a2a6d79e12152b254d859353264654d833f17882bb69f3d404f05042f06a48c832e1a357bce605bc9be5c52c1c0"} 09:02:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:54 INFO - Copying logs to upload dir... 09:02:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.018293 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-21 09:02:54.403655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:02:54.406957) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 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/e00f6f2dfde0608c35ca407a138de3aba5d0bf9f59b4dadf9037e8e6d64be21db69929b693eede69bf0ebad8ec718f8e27ebb380173aab1dbfb1ce9a6066b3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2668551f433e42e8bf8a74d837205ba5a8732a2a6d79e12152b254d859353264654d833f17882bb69f3d404f05042f06a48c832e1a357bce605bc9be5c52c1c0"} build_url:https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/PgcJ47srRQSnOokRb6-vGw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00f6f2dfde0608c35ca407a138de3aba5d0bf9f59b4dadf9037e8e6d64be21db69929b693eede69bf0ebad8ec718f8e27ebb380173aab1dbfb1ce9a6066b3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2668551f433e42e8bf8a74d837205ba5a8732a2a6d79e12152b254d859353264654d833f17882bb69f3d404f05042f06a48c832e1a357bce605bc9be5c52c1c0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:02:54.432515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:02:54.432849) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466523747.884004-1401307603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:02:54.518652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:02:54.519005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:02:54.519327) ========= ========= Total master_lag: 0.18 =========