builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1461887561.0 results: success (0) buildid: 20160428161042 builduid: 835df724bdae4035a563f9d7616ad8c3 revision: 98aa054d9e2757e43158b0c962be9cbab784e9e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.996849) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.997541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.998039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.039068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.039359) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 16:52:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-28 16:52:41 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.192226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.192610) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019867 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.243610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.244011) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98aa054d9e2757e43158b0c962be9cbab784e9e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98aa054d9e2757e43158b0c962be9cbab784e9e2 --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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 16:52:41,781 truncating revision to first 12 chars 2016-04-28 16:52:41,782 Setting DEBUG logging. 2016-04-28 16:52:41,782 attempt 1/10 2016-04-28 16:52:41,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98aa054d9e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 16:52:42,110 unpacking tar archive at: fx-team-98aa054d9e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598747 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.951120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.951424) ========= script_repo_revision: 98aa054d9e2757e43158b0c962be9cbab784e9e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.951816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.952077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.973854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-28 16:52:41.974130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:42 INFO - MultiFileLogger online at 20160428 16:52:42 in /builds/slave/test 16:52:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:52:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:42 INFO - {'append_to_log': False, 16:52:42 INFO - 'base_work_dir': '/builds/slave/test', 16:52:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:52:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:42 INFO - 'branch': 'Fx-Team-Non-PGO', 16:52:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:42 INFO - 'config_files': ('talos/linux_config.py',), 16:52:42 INFO - 'default_actions': ('clobber', 16:52:42 INFO - 'read-buildbot-config', 16:52:42 INFO - 'download-and-extract', 16:52:42 INFO - 'populate-webroot', 16:52:42 INFO - 'create-virtualenv', 16:52:42 INFO - 'install', 16:52:42 INFO - 'run-tests'), 16:52:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:42 INFO - 'download_minidump_stackwalk': True, 16:52:42 INFO - 'download_symbols': 'ondemand', 16:52:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:42 INFO - 'installer_path': 'installer.exe', 16:52:42 INFO - 'log_level': 'info', 16:52:42 INFO - 'log_name': 'talos', 16:52:42 INFO - 'log_to_console': True, 16:52:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:42 INFO - 'opt_config_files': (), 16:52:42 INFO - 'pip_index': False, 16:52:42 INFO - 'sps_profile': False, 16:52:42 INFO - 'sps_profile_interval': 0, 16:52:42 INFO - 'suite': 'dromaeojs-e10s', 16:52:42 INFO - 'system_bits': '32', 16:52:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:42 INFO - 'title': 'talos-linux64-ix-024', 16:52:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:42 INFO - 'use_talos_json': True, 16:52:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:42 INFO - 'work_dir': 'build'} 16:52:42 INFO - ##### 16:52:42 INFO - ##### Running clobber step. 16:52:42 INFO - ##### 16:52:42 INFO - Running pre-action listener: _resource_record_pre_action 16:52:42 INFO - Running main action method: clobber 16:52:42 INFO - rmtree: /builds/slave/test/build 16:52:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:43 INFO - Running post-action listener: _resource_record_post_action 16:52:43 INFO - ##### 16:52:43 INFO - ##### Running read-buildbot-config step. 16:52:43 INFO - ##### 16:52:43 INFO - Running pre-action listener: _resource_record_pre_action 16:52:43 INFO - Running main action method: read_buildbot_config 16:52:43 INFO - Using buildbot properties: 16:52:43 INFO - { 16:52:43 INFO - "project": "", 16:52:43 INFO - "product": "firefox", 16:52:43 INFO - "script_repo_revision": "production", 16:52:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:52:43 INFO - "repository": "", 16:52:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:52:43 INFO - "buildid": "20160428161042", 16:52:43 INFO - "pgo_build": "False", 16:52:43 INFO - "basedir": "/builds/slave/test", 16:52:43 INFO - "buildnumber": 1454, 16:52:43 INFO - "slavename": "talos-linux64-ix-024", 16:52:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:52:43 INFO - "platform": "ubuntu64_hw", 16:52:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:52:43 INFO - "branch": "fx-team", 16:52:43 INFO - "repo_path": "integration/fx-team", 16:52:43 INFO - "revision": "98aa054d9e2757e43158b0c962be9cbab784e9e2", 16:52:43 INFO - "stage_platform": "linux64", 16:52:43 INFO - "builduid": "835df724bdae4035a563f9d7616ad8c3", 16:52:43 INFO - "slavebuilddir": "test" 16:52:43 INFO - } 16:52:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:52:43 INFO - Running post-action listener: _resource_record_post_action 16:52:43 INFO - ##### 16:52:43 INFO - ##### Running download-and-extract step. 16:52:43 INFO - ##### 16:52:43 INFO - Running pre-action listener: _resource_record_pre_action 16:52:43 INFO - Running main action method: download_and_extract 16:52:43 INFO - mkdir: /builds/slave/test/build/tests 16:52: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')]} 16:52:43 INFO - https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:52:49 INFO - Downloaded 1361 bytes. 16:52:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:52:49 INFO - Using the following test package requirements: 16:52:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:52:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'jsshell-linux-x86_64.zip'], 16:52:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:52:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:52:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52: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')]} 16:52:49 INFO - https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:52 INFO - Downloaded 22301146 bytes. 16:52:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:53 INFO - Return code: 0 16:52:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:53 INFO - https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:55 INFO - Downloaded 22301146 bytes. 16:52:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:57 INFO - Return code: 0 16:52:57 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')]} 16:52:57 INFO - https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:52:58 INFO - Downloaded 10840145 bytes. 16:52:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:52:58 INFO - Return code: 0 16:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:58 INFO - https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:52:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:52:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:52:59 INFO - Downloaded 54848454 bytes. 16:52:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:52:59 INFO - mkdir: /builds/slave/test/properties 16:52:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:59 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:59 INFO - Contents: 16:52:59 INFO - build_url:https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:53:00 INFO - Running post-action listener: _resource_record_post_action 16:53:00 INFO - Running post-action listener: set_extra_try_arguments 16:53:00 INFO - ##### 16:53:00 INFO - ##### Running populate-webroot step. 16:53:00 INFO - ##### 16:53:00 INFO - Running pre-action listener: _resource_record_pre_action 16:53:00 INFO - Running main action method: populate_webroot 16:53:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:00 INFO - '--tppagecycles', 16:53:00 INFO - '7'], 16:53:00 INFO - 'tests': ['tsvgm']}}, 16:53:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['damp', 'tps']}, 16:53:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'tests': ['damp', 'tps']}, 16:53:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['dromaeo_dom']}, 16:53:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['a11yr', 16:53:00 INFO - 'ts_paint', 16:53:00 INFO - 'tpaint', 16:53:00 INFO - 'sessionrestore', 16:53:00 INFO - 'sessionrestore_no_auto_restore', 16:53:00 INFO - 'tabpaint']}, 16:53:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['tsvgx', 16:53:00 INFO - 'tsvgr_opacity', 16:53:00 INFO - 'tart', 16:53:00 INFO - 'tscrollx', 16:53:00 INFO - 'cart']}, 16:53:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:00 INFO - 'tsvgr_opacity', 16:53:00 INFO - 'tart', 16:53:00 INFO - 'tscrollx', 16:53:00 INFO - 'cart']}, 16:53:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'talos_options': ['--disable-e10s'], 16:53:00 INFO - 'tests': ['tp5o']}, 16:53:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'tests': ['tp5o']}, 16:53:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'talos_options': ['--disable-e10s', 16:53:00 INFO - '--xperf_path', 16:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:00 INFO - 'tests': ['tp5n']}, 16:53:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:00 INFO - 'talos_options': ['--xperf_path', 16:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:00 INFO - 'tests': ['tp5n']}}, 16:53:00 INFO - 'talos.zip': {'path': '', 16:53:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:00 INFO - Running post-action listener: _resource_record_post_action 16:53:00 INFO - ##### 16:53:00 INFO - ##### Running create-virtualenv step. 16:53:00 INFO - ##### 16:53:00 INFO - Running pre-action listener: _resource_record_pre_action 16:53:00 INFO - Running main action method: create_virtualenv 16:53:00 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:00 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 16:53:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:00 INFO - Using real prefix '/usr' 16:53:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:03 INFO - Installing pip.................done. 16:53:03 INFO - Return code: 0 16:53:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:53:03 INFO - Using env: {'DISPLAY': ':0', 16:53:03 INFO - 'HOME': '/home/cltbld', 16:53:03 INFO - 'LANG': 'en_US.UTF-8', 16:53:03 INFO - 'LANGUAGE': 'en_US:en', 16:53:03 INFO - 'LOGNAME': 'cltbld', 16:53:03 INFO - 'MAIL': '/var/mail/cltbld', 16:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:03 INFO - 'MOZ_NO_REMOTE': '1', 16:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:03 INFO - 'NO_EM_RESTART': '1', 16:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:03 INFO - 'PWD': '/builds/slave/test', 16:53:03 INFO - 'SHELL': '/bin/bash', 16:53:03 INFO - 'SHLVL': '1', 16:53:03 INFO - 'TERM': 'linux', 16:53:03 INFO - 'TMOUT': '86400', 16:53:03 INFO - 'USER': 'cltbld', 16:53:03 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:03 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 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 16:53:03 INFO - Cleaning up... 16:53:03 INFO - Return code: 0 16:53:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:53:03 INFO - Using env: {'DISPLAY': ':0', 16:53:03 INFO - 'HOME': '/home/cltbld', 16:53:03 INFO - 'LANG': 'en_US.UTF-8', 16:53:03 INFO - 'LANGUAGE': 'en_US:en', 16:53:03 INFO - 'LOGNAME': 'cltbld', 16:53:03 INFO - 'MAIL': '/var/mail/cltbld', 16:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:03 INFO - 'MOZ_NO_REMOTE': '1', 16:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:03 INFO - 'NO_EM_RESTART': '1', 16:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:03 INFO - 'PWD': '/builds/slave/test', 16:53:03 INFO - 'SHELL': '/bin/bash', 16:53:03 INFO - 'SHLVL': '1', 16:53:03 INFO - 'TERM': 'linux', 16:53:03 INFO - 'TMOUT': '86400', 16:53:03 INFO - 'USER': 'cltbld', 16:53:03 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:03 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 INFO - Downloading/unpacking psutil>=0.7.1 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:05 INFO - Installing collected packages: psutil 16:53:05 INFO - Running setup.py install for psutil 16:53:05 INFO - building 'psutil._psutil_linux' extension 16:53:05 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 16:53:06 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 16:53:06 INFO - building 'psutil._psutil_posix' extension 16:53:06 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 16:53:06 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 16:53:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:06 INFO - Successfully installed psutil 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:53:06 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')]} 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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')]} 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:06 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:53:08 INFO - Installing collected packages: mozsystemmonitor 16:53:08 INFO - Running setup.py install for mozsystemmonitor 16:53:08 INFO - Successfully installed mozsystemmonitor 16:53:08 INFO - Cleaning up... 16:53:08 INFO - Return code: 0 16:53:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:53:08 INFO - Using env: {'DISPLAY': ':0', 16:53:08 INFO - 'HOME': '/home/cltbld', 16:53:08 INFO - 'LANG': 'en_US.UTF-8', 16:53:08 INFO - 'LANGUAGE': 'en_US:en', 16:53:08 INFO - 'LOGNAME': 'cltbld', 16:53:08 INFO - 'MAIL': '/var/mail/cltbld', 16:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:08 INFO - 'MOZ_NO_REMOTE': '1', 16:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:08 INFO - 'NO_EM_RESTART': '1', 16:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:08 INFO - 'PWD': '/builds/slave/test', 16:53:08 INFO - 'SHELL': '/bin/bash', 16:53:08 INFO - 'SHLVL': '1', 16:53:08 INFO - 'TERM': 'linux', 16:53:08 INFO - 'TMOUT': '86400', 16:53:08 INFO - 'USER': 'cltbld', 16:53:08 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:08 INFO - '_': '/tools/buildbot/bin/python'} 16:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:11 INFO - Downloading docopt-0.6.1.tar.gz 16:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:11 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:11 INFO - Running setup.py install for blobuploader 16:53:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:11 INFO - Running setup.py install for requests 16:53:11 INFO - Running setup.py install for docopt 16:53:11 INFO - Successfully installed blobuploader requests docopt 16:53:11 INFO - Cleaning up... 16:53:12 INFO - Return code: 0 16:53:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:12 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')]} 16:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:12 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')]} 16:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:12 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:12 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 16:53:12 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 16:53:12 INFO - Using env: {'DISPLAY': ':0', 16:53:12 INFO - 'HOME': '/home/cltbld', 16:53:12 INFO - 'LANG': 'en_US.UTF-8', 16:53:12 INFO - 'LANGUAGE': 'en_US:en', 16:53:12 INFO - 'LOGNAME': 'cltbld', 16:53:12 INFO - 'MAIL': '/var/mail/cltbld', 16:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:12 INFO - 'MOZ_NO_REMOTE': '1', 16:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:12 INFO - 'NO_EM_RESTART': '1', 16:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:12 INFO - 'PWD': '/builds/slave/test', 16:53:12 INFO - 'SHELL': '/bin/bash', 16:53:12 INFO - 'SHLVL': '1', 16:53:12 INFO - 'TERM': 'linux', 16:53:12 INFO - 'TMOUT': '86400', 16:53:12 INFO - 'USER': 'cltbld', 16:53:12 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:12 INFO - '_': '/tools/buildbot/bin/python'} 16:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:12 INFO - Running setup.py (path:/tmp/pip-IOgu4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:12 INFO - Running setup.py (path:/tmp/pip-gVXZd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:12 INFO - Running setup.py (path:/tmp/pip-AowM6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:12 INFO - Running setup.py (path:/tmp/pip-plsotH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:12 INFO - Running setup.py (path:/tmp/pip-OqsgE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:12 INFO - Running setup.py (path:/tmp/pip-G9Adb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:12 INFO - Running setup.py (path:/tmp/pip-uFmVp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:12 INFO - Running setup.py (path:/tmp/pip-haE9qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:12 INFO - Running setup.py (path:/tmp/pip-hL7Vfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:12 INFO - Running setup.py (path:/tmp/pip-IVwcrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:12 INFO - Running setup.py (path:/tmp/pip-73KA_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:13 INFO - Running setup.py (path:/tmp/pip-76Ahon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:13 INFO - Running setup.py (path:/tmp/pip-4KyqZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:13 INFO - Running setup.py (path:/tmp/pip-NaOvo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:13 INFO - Running setup.py (path:/tmp/pip-NbxwSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:13 INFO - Running setup.py (path:/tmp/pip-UqN5If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:13 INFO - Running setup.py (path:/tmp/pip-VUfkSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:13 INFO - Running setup.py install for manifestparser 16:53:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:13 INFO - Running setup.py install for mozcrash 16:53:13 INFO - Running setup.py install for mozdebug 16:53:13 INFO - Running setup.py install for mozdevice 16:53:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:13 INFO - Running setup.py install for mozfile 16:53:13 INFO - Running setup.py install for mozhttpd 16:53:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozinfo 16:53:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozInstall 16:53:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozleak 16:53:14 INFO - Running setup.py install for mozlog 16:53:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for moznetwork 16:53:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozprocess 16:53:14 INFO - Running setup.py install for mozprofile 16:53:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozrunner 16:53:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:14 INFO - Running setup.py install for mozscreenshot 16:53:15 INFO - Running setup.py install for moztest 16:53:15 INFO - Running setup.py install for mozversion 16:53:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:15 INFO - Cleaning up... 16:53:15 INFO - Return code: 0 16:53:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:15 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')]} 16:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:15 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')]} 16:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:15 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:15 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 16:53:15 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 16:53:15 INFO - Using env: {'DISPLAY': ':0', 16:53:15 INFO - 'HOME': '/home/cltbld', 16:53:15 INFO - 'LANG': 'en_US.UTF-8', 16:53:15 INFO - 'LANGUAGE': 'en_US:en', 16:53:15 INFO - 'LOGNAME': 'cltbld', 16:53:15 INFO - 'MAIL': '/var/mail/cltbld', 16:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:15 INFO - 'MOZ_NO_REMOTE': '1', 16:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:15 INFO - 'NO_EM_RESTART': '1', 16:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:15 INFO - 'PWD': '/builds/slave/test', 16:53:15 INFO - 'SHELL': '/bin/bash', 16:53:15 INFO - 'SHLVL': '1', 16:53:15 INFO - 'TERM': 'linux', 16:53:15 INFO - 'TMOUT': '86400', 16:53:15 INFO - 'USER': 'cltbld', 16:53:15 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:15 INFO - '_': '/tools/buildbot/bin/python'} 16:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:15 INFO - Running setup.py (path:/tmp/pip-rpFYTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:15 INFO - Running setup.py (path:/tmp/pip-BckDw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:15 INFO - Running setup.py (path:/tmp/pip-GHrYiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:15 INFO - Running setup.py (path:/tmp/pip-DmBR7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:15 INFO - Running setup.py (path:/tmp/pip-7NK8ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:15 INFO - Running setup.py (path:/tmp/pip-1Nmvel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:15 INFO - Running setup.py (path:/tmp/pip-8A17Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:15 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)) 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:15 INFO - Running setup.py (path:/tmp/pip-E6g_hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:16 INFO - Running setup.py (path:/tmp/pip-gtcpxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:16 INFO - Running setup.py (path:/tmp/pip-jU2ucQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:16 INFO - Running setup.py (path:/tmp/pip-SkPouN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:16 INFO - Running setup.py (path:/tmp/pip-jluubG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:16 INFO - Running setup.py (path:/tmp/pip-izVISn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:16 INFO - Running setup.py (path:/tmp/pip-JW1_Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:16 INFO - Running setup.py (path:/tmp/pip-z3tNU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:16 INFO - Running setup.py (path:/tmp/pip-7yvMEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:16 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)) 16:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:16 INFO - Running setup.py (path:/tmp/pip-gp5adi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:16 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)) 16:53:16 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)) 16:53:16 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)) 16:53:16 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)) 16:53:16 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)) 16:53:16 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)) 16:53:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:18 INFO - Downloading blessings-1.6.tar.gz 16:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:18 INFO - Installing collected packages: blessings 16:53:18 INFO - Running setup.py install for blessings 16:53:18 INFO - Successfully installed blessings 16:53:18 INFO - Cleaning up... 16:53:18 INFO - Return code: 0 16:53:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:19 INFO - Reading from file tmpfile_stdout 16:53:19 INFO - Current package versions: 16:53:19 INFO - argparse == 1.2.1 16:53:19 INFO - blessings == 1.6 16:53:19 INFO - blobuploader == 1.2.4 16:53:19 INFO - docopt == 0.6.1 16:53:19 INFO - manifestparser == 1.1 16:53:19 INFO - mozInstall == 1.12 16:53:19 INFO - mozcrash == 0.17 16:53:19 INFO - mozdebug == 0.1 16:53:19 INFO - mozdevice == 0.48 16:53:19 INFO - mozfile == 1.2 16:53:19 INFO - mozhttpd == 0.7 16:53:19 INFO - mozinfo == 0.9 16:53:19 INFO - mozleak == 0.1 16:53:19 INFO - mozlog == 3.1 16:53:19 INFO - moznetwork == 0.27 16:53:19 INFO - mozprocess == 0.22 16:53:19 INFO - mozprofile == 0.28 16:53:19 INFO - mozrunner == 6.11 16:53:19 INFO - mozscreenshot == 0.1 16:53:19 INFO - mozsystemmonitor == 0.0 16:53:19 INFO - moztest == 0.7 16:53:19 INFO - mozversion == 1.4 16:53:19 INFO - psutil == 3.1.1 16:53:19 INFO - requests == 1.2.3 16:53:19 INFO - wsgiref == 0.1.2 16:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:19 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:19 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 16:53:19 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 16:53:19 INFO - Using env: {'DISPLAY': ':0', 16:53:19 INFO - 'HOME': '/home/cltbld', 16:53:19 INFO - 'LANG': 'en_US.UTF-8', 16:53:19 INFO - 'LANGUAGE': 'en_US:en', 16:53:19 INFO - 'LOGNAME': 'cltbld', 16:53:19 INFO - 'MAIL': '/var/mail/cltbld', 16:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:19 INFO - 'MOZ_NO_REMOTE': '1', 16:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:19 INFO - 'NO_EM_RESTART': '1', 16:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:19 INFO - 'PWD': '/builds/slave/test', 16:53:19 INFO - 'SHELL': '/bin/bash', 16:53:19 INFO - 'SHLVL': '1', 16:53:19 INFO - 'TERM': 'linux', 16:53:19 INFO - 'TMOUT': '86400', 16:53:19 INFO - 'USER': 'cltbld', 16:53:19 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:19 INFO - '_': '/tools/buildbot/bin/python'} 16:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 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)) 16:53:19 INFO - Cleaning up... 16:53:19 INFO - Return code: 0 16:53:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:19 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:19 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 16:53:19 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 16:53:19 INFO - Using env: {'DISPLAY': ':0', 16:53:19 INFO - 'HOME': '/home/cltbld', 16:53:19 INFO - 'LANG': 'en_US.UTF-8', 16:53:19 INFO - 'LANGUAGE': 'en_US:en', 16:53:19 INFO - 'LOGNAME': 'cltbld', 16:53:19 INFO - 'MAIL': '/var/mail/cltbld', 16:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:19 INFO - 'MOZ_NO_REMOTE': '1', 16:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:19 INFO - 'NO_EM_RESTART': '1', 16:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:19 INFO - 'PWD': '/builds/slave/test', 16:53:19 INFO - 'SHELL': '/bin/bash', 16:53:19 INFO - 'SHLVL': '1', 16:53:19 INFO - 'TERM': 'linux', 16:53:19 INFO - 'TMOUT': '86400', 16:53:19 INFO - 'USER': 'cltbld', 16:53:19 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:19 INFO - '_': '/tools/buildbot/bin/python'} 16:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:19 INFO - Downloading/unpacking jsonschema 16:53:19 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 16:53:19 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 16:53:19 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 16:53:19 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 16:53:19 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 16:53:19 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 16:53:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:21 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:21 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:21 INFO - warning: no files found matching '*.txt' 16:53:21 INFO - no previously-included directories found matching 'build' 16:53:21 INFO - no previously-included directories found matching 'dist' 16:53:21 INFO - no previously-included directories found matching '.git*' 16:53:21 INFO - Installing collected packages: jsonschema, functools32 16:53:21 INFO - Running setup.py install for functools32 16:53:21 INFO - warning: no files found matching '*.txt' 16:53:21 INFO - no previously-included directories found matching 'build' 16:53:21 INFO - no previously-included directories found matching 'dist' 16:53:21 INFO - no previously-included directories found matching '.git*' 16:53:21 INFO - Successfully installed jsonschema functools32 16:53:21 INFO - Cleaning up... 16:53:21 INFO - Return code: 0 16:53:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53:21 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')]} 16:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:21 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')]} 16:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:21 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 0x7fcedc39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', '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 16:53:21 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 16:53:21 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 16:53:21 INFO - Using env: {'DISPLAY': ':0', 16:53:21 INFO - 'HOME': '/home/cltbld', 16:53:21 INFO - 'LANG': 'en_US.UTF-8', 16:53:21 INFO - 'LANGUAGE': 'en_US:en', 16:53:21 INFO - 'LOGNAME': 'cltbld', 16:53:21 INFO - 'MAIL': '/var/mail/cltbld', 16:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:21 INFO - 'MOZ_NO_REMOTE': '1', 16:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:21 INFO - 'NO_EM_RESTART': '1', 16:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:21 INFO - 'PWD': '/builds/slave/test', 16:53:21 INFO - 'SHELL': '/bin/bash', 16:53:21 INFO - 'SHLVL': '1', 16:53:21 INFO - 'TERM': 'linux', 16:53:21 INFO - 'TMOUT': '86400', 16:53:21 INFO - 'USER': 'cltbld', 16:53:21 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:21 INFO - '_': '/tools/buildbot/bin/python'} 16:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:22 INFO - Downloading/unpacking flake8 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:22 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 16:53:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:23 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 16:53:23 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 16:53:23 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 16:53:23 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 16:53:23 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 16:53:23 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 16:53:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:24 INFO - no previously-included directories found matching 'docs/_build' 16:53:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:24 INFO - Running setup.py install for pep8 16:53:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:24 INFO - no previously-included directories found matching 'docs/_build' 16:53:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:24 INFO - Cleaning up... 16:53:24 INFO - Return code: 0 16:53:24 INFO - Running post-action listener: _resource_record_post_action 16:53:24 INFO - Running post-action listener: _start_resource_monitoring 16:53:24 INFO - Starting resource monitoring. 16:53:24 INFO - ##### 16:53:24 INFO - ##### Running install step. 16:53:24 INFO - ##### 16:53:24 INFO - Running pre-action listener: _resource_record_pre_action 16:53:24 INFO - Running main action method: install 16:53:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:25 INFO - Reading from file tmpfile_stdout 16:53:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:25 INFO - Reading from file tmpfile_stdout 16:53:25 INFO - Output received: 16:53:25 INFO - Usage: mozinstall [options] installer 16:53:25 INFO - Options: 16:53:25 INFO - -h, --help show this help message and exit 16:53:25 INFO - -d DEST, --destination=DEST 16:53:25 INFO - Directory to install application into. [default: 16:53:25 INFO - "/builds/slave/test"] 16:53:25 INFO - --app=APP Application being installed. [default: firefox] 16:53:25 INFO - mkdir: /builds/slave/test/build/application 16:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:53:41 INFO - Reading from file tmpfile_stdout 16:53:41 INFO - Output received: 16:53:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - ##### 16:53:41 INFO - ##### Running run-tests step. 16:53:41 INFO - ##### 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: run_tests 16:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:41 INFO - Python 2.7.3 16:53:41 INFO - Return code: 0 16:53:41 INFO - grabbing minidump binary from tooltool 16:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:41 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 0x188d410>, '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 0x188e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:41 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 16:53:41 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 16:53:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:41 INFO - Return code: 0 16:53:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:42 INFO - Return code: 0 16:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:53:42 INFO - Using env: {'DISPLAY': ':0', 16:53:42 INFO - 'HOME': '/home/cltbld', 16:53:42 INFO - 'LANG': 'en_US.UTF-8', 16:53:42 INFO - 'LANGUAGE': 'en_US:en', 16:53:42 INFO - 'LOGNAME': 'cltbld', 16:53:42 INFO - 'MAIL': '/var/mail/cltbld', 16:53:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:42 INFO - 'MOZ_NO_REMOTE': '1', 16:53:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:42 INFO - 'NO_EM_RESTART': '1', 16:53:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:42 INFO - 'PWD': '/builds/slave/test', 16:53:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:42 INFO - 'SHELL': '/bin/bash', 16:53:42 INFO - 'SHLVL': '1', 16:53:42 INFO - 'TERM': 'linux', 16:53:42 INFO - 'TMOUT': '86400', 16:53:42 INFO - 'USER': 'cltbld', 16:53:42 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022', 16:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:42 INFO - '_': '/tools/buildbot/bin/python'} 16:53:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:53:42 INFO - mozversion application_buildid: 20160428161042 16:53:42 INFO - mozversion application_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 16:53:42 INFO - mozversion application_display_name: Nightly 16:53:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:42 INFO - mozversion application_name: Firefox 16:53:42 INFO - mozversion application_remotingname: firefox 16:53:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:53:42 INFO - mozversion application_vendor: Mozilla 16:53:42 INFO - mozversion application_version: 49.0a1 16:53:42 INFO - mozversion platform_buildid: 20160428161042 16:53:42 INFO - mozversion platform_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 16:53:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:53:42 INFO - mozversion platform_version: 49.0a1 16:53:42 INFO - using testdate: 1461887622 16:53:42 INFO - actual date: 1461887622 16:53:42 INFO - starting webserver on 'localhost:37007' 16:53:42 INFO - SUITE-START | Running 2 tests 16:53:42 INFO - TEST-START | dromaeo_css 16:53:42 INFO - operating with platform_type : linux_ 16:53:42 INFO - Initialising browser for dromaeo_css test... 16:53:42 INFO - TEST-INFO | started process 16478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrTgX_/profile http://localhost:37007/getInfo.html) 16:53:46 INFO - PROCESS | 16478 | 16:53:46 INFO - PROCESS | 16478 | (process:16548): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:53:46 INFO - PROCESS | 16478 | __metrics Screen width/height:1600/1200 16:53:46 INFO - PROCESS | 16478 | colorDepth:24 16:53:46 INFO - PROCESS | 16478 | Browser inner width/height: 1024/697 16:53:46 INFO - PROCESS | 16478 | __metrics 16:53:47 ERROR - PROCESS | 16478 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:53:48 INFO - TEST-INFO | 16478: exit 0 16:53:48 INFO - Browser initialized. 16:53:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:48 INFO - TEST-INFO | started process 16599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrTgX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:50 INFO - PROCESS | 16599 | 16:53:50 INFO - PROCESS | 16599 | (process:16661): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:00 INFO - PROCESS | 16599 | RSS: Main: 165953536 16:54:00 INFO - PROCESS | 16599 | 16:54:49 INFO - PROCESS | 16599 | 1461887689793 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] 16:57:03 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37007/tests/dromaeo/cssquery-ext.html) 16:57:04 INFO - PROCESS | 16599 | RSS: Main: 167546880 16:57:04 INFO - PROCESS | 16599 | 17:00:06 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-ext.html (next: http://localhost:37007/tests/dromaeo/cssquery-jquery.html) 17:00:06 INFO - PROCESS | 16599 | RSS: Main: 166797312 17:00:06 INFO - PROCESS | 16599 | 17:03:08 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37007/tests/dromaeo/cssquery-mootools.html) 17:03:09 INFO - PROCESS | 16599 | RSS: Main: 167919616 17:03:09 INFO - PROCESS | 16599 | 17:06:11 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37007/tests/dromaeo/cssquery-prototype.html) 17:06:11 INFO - PROCESS | 16599 | RSS: Main: 165724160 17:06:11 INFO - PROCESS | 16599 | 17:09:14 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37007/tests/dromaeo/cssquery-yui.html) 17:09:15 INFO - PROCESS | 16599 | RSS: Main: 166854656 17:09:15 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-yui.html (next: http://localhost:37007/tests/dromaeo/cssquery-dojo.html) 17:12:17 INFO - PROCESS | 16599 | RSS: Main: 168943616 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | __start_tp_report 17:12:17 INFO - PROCESS | 16599 | _x_x_mozilla_page_load 17:12:17 INFO - PROCESS | 16599 | _x_x_mozilla_page_load_details 17:12:17 INFO - PROCESS | 16599 | |i|pagename|runs| 17:12:17 INFO - PROCESS | 16599 | |0;dojo.html;2609.960850587241;2649.4568613434244;2690.1794952539494;2694.9730502694965;2707.0390011545887;4696.929546056807;4716.033213191296;4719.244920812671;4728.007118505114;4730.3614012108355;4628.190066738316;4666;4706.929396059062;4708.835190768324;4767.046590681869;4334.84828031019;4429.247028005231;4430.113977204556;4432.578905004019;4436.001899572587;548.6686971834292;4275.636570891478;4317.98527346075;4331.30699088146;4372.519022907478;4337.674674399401;4366.279563871957;4376.168527979706;4409.9118017639785;4420.778961051935;4346.130773845212;4376.102898905717;4379.802908869076;4385.868423947287;4416.205083085043;4338.3275592282935;4371.14762621289;4394.1651086293505;4399.900024993752;4438.334249862514;4681.344611754357;4695.5069717679835;4699.342092107074;4704.600108990706;4705.882352941204;4961.057399094197;5057.443681195103;5097.057044446789;5110.8466745997675;5120.564751996085;5162.948370516285;5188.584913206934;5208.739563021872;5217.217417387385;5262.815801446969;4775.570198682135;4822.324874517571;4823.131836269435;4826.203676393356;4861.538153875412;5077.746112694351;5230.293910322134;5300.787968481295;5305.257263983045;5314.202869569595;4976.726280054631;4995.675281106716;4995.750212489361;5001.599872010231;5044.1677123274985;5078.3905931287745;5078.466760990117;5091.770870310845;5092.414372347153;5139.203423469368;4848.490908454632;5004.149294619923;5032.84901452957;5079.619028572798;5097.821576244888;4981.103401387712;5006.224035274538;5016.749162541858;5028.698278103326;5066.59467242627;4281.143771245764;4286.699931004862;4291.463567054118;4299.505556861001;4309.806058727365;3601.2617413430185;3656.780593164419;3728.2729867676085;3760.3043436963703;3834.213986132836;4351.129774045204;4358.585934336233;4394.36281739146;4403.4495688039;4461.196984542748;5088.974555127201;5111.616628752859;5112.3865136183895;5143.305653736697;5178.741062946838;4292.82828686849;4402.097569998143;4412.382266482695;4416.072624748775;4454.10917816438;4557.088582283556;4574.611158051536;4587.105514424655;4632.791524381411;4641.651876109306;4754.1204877098535;4802.543758342952;4807.399075115611;4820.108279968217;4854.9514504855915;4961.7271050092595;5045.268436076822;5117.437081920912;5141.614378921521;5145.897082058263;4716.882077948078;4740.170470167775;4785.712857228577;4790.640701947298;4796.208625576741;5018.623603229846;5024;5029.044481548494;5038.974805125951;5073.543381095719;4881.8535443936735;5042.09242336383;5121.61587880903;5134.101532231919;5173.301604283373;4923.753812309442;4931.950680493293;4956.10790057793;4959.82640607577;4994.400671919393;4939.876503087452;4941.65408421407;4957.355543779286;4959.553640172402;4979.203327467588;4673.252279635242;4843.636727245541;4881.755912204447;4889;4914.36113305268;5008.649394542347;5017.996400719798;5024.196128619404;5038.370203724535;5074.289599456005;4921.8523444296725;4930.4822993586595;4935.654504184673;4935.654504184817;4936.481669424658 17:12:17 INFO - PROCESS | 16599 | |1;ext.html;578.6325683191172;592.7214209321618;601.7382438639191;621.4872729997753;639.9616023038615;33980.49029264563;34934.82532587337;34957.650423495754;35046.8247658762;35147.82426087866;38591.228175436474;38889.805550972276;39087.21825563494;39261;39333.21333573327;7646.197149299327;7740.574268415235;7816.53100813953;7824.491408058487;7868.606569671522;7707.6916923323;7898.170692077335;7912.4856884302335;7927.722529711461;7952;7891.921080789176;7969.960150199241;7983.680652773882;7987;8000.919990800105;7813.101493328283;7860.253275938748;7893.763187104396;7911.683532658687;7934.563599002053;7701.653425595861;7761.22387761225;7778.6888524458955;7801.21987801221;7806.375489960789;38296.617033829585;38540.42189367162;38578.80710596429;38681.80659096715;38907.8054609728;3019.1999120233154;3517.7889326640484;3742.850285988557;3743.850245990157;3797.1836055247977;28666.426671466455;29034.709652903624;29279.707202928123;29644.851775740983;29805.850970745225;3314.320564284316;3327.6505966873374;3335.31626016666;3344.0803778960735;3370.803349829478;250844;253991;254236;254746.72626636934;255113;31358.843205783825;32126;52903;53410;53717.1942420864;32579.18552036218;32616;32702.836485817417;32710.83644581762;32747.1813204667;12230.75538489243;12372.381380930918;12432.37838108091;12462.75074498505;12501.24992500453;10487.056164945192;10522.105621022145;10534.262601617813;10578.89421105779;10598.629047983284;8174.591270436455;8249.505029698237;8303.95848020756;8330.166983301622;8394.580270986426;3226.419244536006;3235.385276797448;3257.4950882613234;3276.6395696473846;3293.818839963825;926.342296969146;931.0363773494536;956.2827879090682;978.6721448314894;1076.042322333124;28552.857235713687;28869;29042.854785725936;29324.413511729646;29615.703842961295;981.3866333541537;996.6810620601483;1001.1840350114634;1054.3515737821185;1056.2817284246632;15239.23803809805;15461.304241309168;15653.452129175652;15759;15784.526464206092;388603;391668;392428;394527;395786;50781.492185078416;51248.48751512512;51452;51568.22647660288;51603.74198128985;1179.5281887244998;1182.3456340515597;1237.696764292754;1237.7833879071127;1240.4418011894684;27061.323466913484;27871.16386508408;27881.442371152058;28330.716692833634;28435;44878.3268250983;44957.325640116076;44976.550234497234;45342.31986520139;45387.319190211514;261691;261758;262244;262413;262797;26293;26293.21120366392;26620.866895665396;26848.32879178036;26916.730832692207;42973.785131074146;43326.35010474782;43527;43888.561114388445;44691.55308446874;37403;37690.43464347982;37705.43441848429;37843.43234851534;38174.80912595419;36253.27493450169;37404.25191496209;37457;37562.624373757004;37894.8105259483;35592.46611300781;36423;36447.45328820123;36725.81637091797;37074.44388334231;31862.681373185973;33633.495497568045;33717.49423758597;33992.66007339994;34016;25093.749062509873;25572.360690982874;25725.871370643777;25808.741912580634;25939.351516212246 17:12:17 INFO - PROCESS | 16599 | |2;jquery.html;378.4763848569815;380.2793705927267;388.6599225677532;389.82263070303014;394.44974260906054;15693.764593531107;16840.65274778018;16897.324107035718;17149.314027438886;17196.05421701806;17087.48737537873;17331.22009509572;17498.037607931557;17798.911005444956;17891.463256102306;5126.436092029883;5306.071437498442;5333.546648534879;5345.946540534604;5349.786008559653;3690.280395322913;5698.487136157745;6228.906566401485;6229.345918678541;6244.562880598337;6095.481884039862;6130.080487926824;6161.045038019114;6166.6300021998595;6194.845128871769;6207.162033125515;6252.3747625237565;6269.749210031593;6278.058291256302;6283.560150789446;5298.09932311508;5357.892842143175;5466.590005749545;5482.725863706839;5502.944970550283;20048.599028019504;20176.39470815878;20812.687809682866;21679.132834686592;21701.891490542603;1928.5757133430623;2026.5946810637931;2094.172801743303;2235.0277629231337;2362.161432691387;13167.144135631153;13519.526816561372;13804.378802953892;13857.307134643328;14015.369308381147;1752.071402156859;1758.648270345936;1797.91010449477;1839.2459091772444;1872.4850666066804;69581;70278.29721702769;70326.64836675784;70623.64688176577;71224;9829.36109152917;10149.39103653783;10160.237982151368;10161;10510.211734119972;14165.85834141666;14418.495352662607;14440.927795361165;14444.061136026125;14458;7197.532160409557;7215.747448839265;7317.890231646529;7406.259374062551;7497.325240728361;6808.114945057111;6947.270536593584;7041.119860017498;7091.680874360666;7174;6261.123442718023;6272.717727702265;6368.076628888785;6383.71273292703;6604.636744979072;1706.7781188445672;1796.3353559183186;1835.7483113405328;1877.8309952104375;1888.8016758240462;848.2747251100344;907.3920473282916;925.421611492817;958.4393130018877;1007.0483393193508;16129;16969.406070787463;17382.565435864206;18071.367502137364;18477;888.9244414224863;915.8809354783969;921.1249313152532;923.0999775219242;949.9050094990583;10129;10345;10345.74135646615;10397.272190946713;10431.895681043092;380132;380216;380539;393047.52143589343;396799;49290.50709492931;76115;80697.59651201824;81592.59203703943;81819;966.6858271061792;992.4095163377779;1018.383877753963;1019.7246743379246;1021.3004092196869;15793.551224827415;15953.282102305191;15965.760513592073;16025.358985640443;16147.67704645877;37350.8132459336;37411.812940935124;37678.434823478216;37826.810865945496;38014.42978355272;51764;51937.7403112982;53161;53877.46122538725;54652.180217297566;7729.768106956801;7766.029246344207;7774.222577742181;7976.84046319082;8036.316913062456;10382.948085259526;11159.49782259784;11587.88412115868;11628.53485860556;11722.355270460206;9472.147506724428;9731.929487756483;9960.750981225527;9970.950145249228;10080.798384032132;9533.713988580354;9602.231821454407;9842.671239382591;10041.899581004096;10089.747756305858;9724.513774311115;9853.113219809964;9916.603335866484;10115.533247679192;10160.491975401348;7613.276738709814;7699.3840492761565;7754.30864327074;7939.444238903452;7941.086775020946;8686.78283042929;9342.299327550596;9494.715158545254;9531.809363812823;9566.13904748576 17:12:17 INFO - PROCESS | 16599 | |3;mootools.html;1456.235476374903;1459.613202501337;1550;1623.0748473370184;1695.3896597224996;7018.263082376341;7529;7674.386049116071;8026.799330016745;8034.116247212802;7601.657925393357;7643.082830060401;7683.154852966183;7719.536827790323;7725.188855170197;2197.7033100531385;2242.7645097264717;2244.147224054857;2246.0117548278786;2247.1011595361824;2196.088623221361;2200.625893598084;2256.6727824465443;2271.8750468724215;2285.1544928376525;2192.6820611011394;2209.9558008839813;2213.756486786452;2224.1881713174657;2240.7423146338215;2109.3144727963395;2122.3208573256566;2124.3095993802076;2126.2133010786033;2132.8613640113344;2183.0831050958477;2186.0162926683056;2211.347652442533;2213.7896899794655;2214.7895949884737;7522.210167932398;7612.086549614081;7622.085349758009;7652.2347765223585;7655;4513.187626227278;4664;4672.602828759559;4720.409948756405;4721.527847215285;2793.25978615667;2796.545796185972;2890.248535380795;2892.190186747714;2948.970510294891;896.8161526887038;911.0378016390788;930.516131611565;934.9111834375791;948.4214629076258;10777.353358798497;10799.136069114453;10815.35107893529;10818.729531761768;10844.783104337868;4356.956430435718;4362.585554372329;4425.491068527096;4442.111577684476;4453.955460445419;9230.769230769285;9239.815203696024;9281.443113413217;9308.162265396148;9330.95334523323;4682.836100736458;4707.03505781314;4736.265878788793;4736.407949006374;4757.191277482767;3773.64150405711;4117.97941010299;4180.26845302077;4224.5353011168745;4240.851570195028;3695.1870588470492;3762.3039737648623;3774.339490589191;3815.3323168445413;3881.3013657541915;1214.8724383939737;1218.7196944702769;1223.1376879300071;1243.925364478116;1250.156144602408;775.2673723331397;885.181207383168;908.6923598102911;919.2554031234588;925.4262357338358;5162.380514338229;5259.368875734936;5279.630425870152;5289.47105289468;5290.788368465218;845.4504572028108;873.1835733589114;877.3376101043672;879.6804792810784;883.0418995389946;3596.4245720684567;3615.891523254307;3693.4829123922673;3708;3712.3132220539287;9280.118388753057;9728.367656102331;9741.512924353754;9807.558659860324;9824.95087524572;9690.56392462341;9725.0761177688;9892.703218903445;9921.65274215399;9958.402495850272;6927.168739751262;7079.752208672672;7101.609411482418;7274.745383911538;7277.3086556777025;5143.305653736697;5270;5368.946310536845;5379.085555455504;5518.613697041329;9088.363814532919;9156.542172891463;9166.633334666538;9288.489133097744;9332.766680833034;8895.021547629885;9416.576254068721;9434.528273586431;9449.291303152153;9476.384035037701;5736.110902810071;6469.935300646934;6606.075149479173;6627.900581491378;6883.724651013903;7036;7072.575645461289;7147.3210045045635;7158.821029474305;7162.104736907887;6367.442506498388;6507.544471886922;6539.673016349258;6553.180852393451;6655.633940133145;6301.086342480223;6404.167458230587;6412.487001039813;6579.342065793382;6698.062271282122;5957.880842383215;5982.252218472691;6029.758809647565;6053.788117415869;6064.332923378337;4299.957000429956;4412.139632771578;4417;4479.17135329965;4523.954760452353;4508.233600287894;4542.545745425431;4568.520305368022;4650.069986002881;4665.2069148245555 17:12:17 INFO - PROCESS | 16599 | |4;prototype.html;295.21472882133526;300.8119925046845;301.22584956661376;316.77667244592567;319.1399179212023;4965.1807451770455;4992.800287988485;5000.59995200384;5005.149124648809;5018.096742586333;4908.975455122728;4917.262410638406;4933.629977751665;4958.702477851331;4960.544530457429;3729.1050147964565;3818.522684664417;3944.5463771666195;3945.6646185074305;3953.861614843481;3904;3928.5285765708154;3948.644621984021;3964.7224694271413;3979.9801000994953;3929.5088113985753;3934.154156856275;3939.6454319111276;3955.8022098895085;3961.8811435656976;3843.7885916274595;3924.136689928211;3939.0940083780606;3950.3876899080688;3952.486176796998;3477.2523907360037;3492.755507114503;3494.633063528344;3495.6329585393423;3495.7028652564563;4737.336772851803;4783.851875549843;4797.976010119962;4812.951870481285;4822.397200349957;4359.38968544404;4472.686911916167;4495.078508905666;4495.707778994355;4495.9325610115875;5168.586513078944;5180.870478238036;5181.689098654093;5185.914380943333;5216.713080780555;3775.452559378902;3777.622237776228;3795.8481660733537;3820.6943444524372;3821.254855303217;5316.521513063843;5442.183672449125;5462.3445186577865;5486.354093771893;5505.137328589151;3893.922121557553;3897.5517815451017;3901.5708272090046;3907.9609203908167;3917.490726205575;3939.7439166454087;3946.2896678598127;3960.8019599019935;3961.286968345668;3975.7813320267082;4465.665075119379;4472.642188624902;4491.910161796811;4501.594856462869;4513.300438432048;5074.188129899198;5151.6908985461;5164.535191832753;5176.19768935808;5235.345581802275;1442.4879167895456;1450.4415799916897;1453.6147920800997;1455.8180227471566;1458.1105525629357;925;945.3949472337572;959.0770505137156;979.5591983607405;988.7083310423442;4470.105978804252;4571.177188106173;4587.742702681067;4595.517470665599;4626.398568186114;5318.149096144598;5324.92012619811;5406.972965135149;5434.076207044812;5441.755121019484;4450.888727781767;4590.862274131781;4596.6092882105395;4610.400647915817;4622.768861556909;3065.892693755708;3096.241420851906;3099.6900309969274;3103.379324135182;3117.5479555464785;5386.730663466811;5423.457654234624;5434.538064264502;5435.1847222916085;5461.399246082928;5766;5907.675077870673;5926.288845338587;5937.52499800015;5990.251218597676;5406.648567843156;5418.2685337479725;5428.185772134132;5451.645643033111;5452.991196628557;5609.635210150739;5620.634658747168;5703.657780533182;5805.912911306249;5831.533477321719;5560.860978475571;5627.240322556402;5664.631798933056;5682.772689092555;5714.342850572071;5365.114756065205;5393;5408.8377348679605;5410.2696136022705;5424.7558859850615;3581.9462708059923;4103.753774773523;4128.772917489567;4149.668026557929;4154.792260387029;5274.156135018378;5284.656497327662;5311.734413279243;5330.920036199538;5333.97309022569;5089.821856235162;5098.776293689562;5115.335006449138;5161.225816127611;5163.148080566664;4915.65590408668;5125.1799712045895;5145.45972672864;5146;5152.3044389007;5035.823746168867;5049.2173713074535;5078.542931136216;5097.8725531862;5118.513741194581;4982;5075.1625981712605;5103.489651035015;5227.843164705065;5263.5525980292105;5143.974280128576;5158.3235448478645;5184.248283998874;5184.533391994739;5188.429272779916 17:12:17 INFO - PROCESS | 16599 | |5;yui.html;691.4226620771656;740.3300013487792;741.7960060983232;745.6085555083582;747.7644541969275;11354.148438867087;11838.05295576354;11880.821787673181;11890.227135236226;11897.7620447591;11615.245009074426;11664.650060498177;11665.941670291659;11687.7078073048;11693.824592631096;768.0552919908502;799.8880156778026;803.2931020701803;805.4804651000102;805.4925396999911;798.0423491809822;802.4623502253504;806.0528878567688;808.3856269235365;808.8180159464102;827.764087235138;831.6673330667721;832.0847068224934;833.7665453672951;834.9248567628912;820.9096999330069;823.5347028928636;826.1243082332746;829.369679043925;831.5717405536154;604.066716922356;605.446016894541;607.0893659510734;611.7461253579759;612.610992020066;12188.451519681636;12231.69420764479;12245.204061736047;12308.8153677694;12410.937945310307;11282.605108821152;11320.886791132065;11321.264117832314;11669.066474682006;11839.230450020721;9773.21814254858;9852.753681157958;9873.851892221623;9973;10034.799304013879;3111.6577176510564;3120.5319202119636;3133.4673105572106;3190.4097741917585;3224.629167645727;48126.759366203296;48662.75668621669;48677.51322486765;48710.02579948417;49045.26432103521;8572.314214862796;9028.46316750067;9066.501342426098;9156.359054866096;9199.264058875275;16496.17519124039;16510.33958641641;16535.25591348392;16564.337426502803;16600.418985335455;6383.1382763326355;6442;6457.321981192001;6498.577592456475;6766.661666916634;3723.4600982857332;3740.6446387593137;3769.3215221260434;3836.0985168485386;3862.3820188769664;2760.254731222599;2810.297425643589;2824.8728807203725;2829.6462942132234;2830.9433811323656;489.3149590573226;489.6352217597841;491.8204855227816;507.05687421396175;507.37339385858434;565.5955991466121;570.9971450142723;577.6822747488865;602.8312072619674;603.1013789453682;7496.587687677121;7589.899464577606;7707.113681926538;7826.491278067021;7877.7636670899965;561.7612514681244;587.521170246248;603.9124326972565;609.8536351275751;622.0886401421939;3592.3354179476883;3593.443016332473;3604.945925811115;3637.5998640149564;3718.5165928429133;50751.746241268556;50979.49020509747;51673.48326516762;51928;52474.47525524772;44772.55227447684;44998.32502512465;45183.322250166275;46367.6089717309;46577.30134047992;43544.34683479751;43553.346699798894;44023;44220;44382.33426498605;7138.428925686037;7155.534890232118;7178.28217178278;7276.818079548054;7361.2638736125955;29028.854855725585;29419.705802942553;29764;30499.08502744921;30511.389772204875;35475.290494190485;37218.8139059303;37587.81206093952;38174.80912595419;39110.804445977585;10512.57949682004;10528.947355263175;10557.102646275152;10602.416867072077;10724.088452481627;11375.943120284346;11379.886201137882;11618.5352585899;11661.76676466483;11690;10635.308704934154;10965.56137754481;10995.890041099807;11310.886891131313;11599.188056835941;10963.397013164353;11244.718882027688;11287.887121128684;11455.140864435034;11457.942710286396;10556.841647375142;10642.220069066669;10697.732556686145;10779.89220107789;10829.458527073457;7988.12130665638;8054.5569993650915;8174.509529428254;8196.42625016243;8362.038365587792;8983.46099234048;9188.724338269863;9425.104615061558;9506.762330941781;9557.553742630704 17:12:17 INFO - PROCESS | 16599 | __end_tp_report 17:12:17 INFO - PROCESS | 16599 | __start_cc_report 17:12:17 INFO - PROCESS | 16599 | _x_x_mozilla_cycle_collect,377 17:12:17 INFO - PROCESS | 16599 | __end_cc_report 17:12:17 INFO - PROCESS | 16599 | __startTimestamp1461888737931__endTimestamp 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | ------- Summary: start ------- 17:12:17 INFO - PROCESS | 16599 | Number of tests: 6 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#0] dojo.html Cycles:165 Average:4678.57 Median:4826.20 stddev:592.46 (12.3%) stddev-sans-first:571.62 17:12:17 INFO - PROCESS | 16599 | Values: 2610.0 2649.5 2690.2 2695.0 2707.0 4696.9 4716.0 4719.2 4728.0 4730.4 4628.2 4666.0 4706.9 4708.8 4767.0 4334.8 4429.2 4430.1 4432.6 4436.0 548.7 4275.6 4318.0 4331.3 4372.5 4337.7 4366.3 4376.2 4409.9 4420.8 4346.1 4376.1 4379.8 4385.9 4416.2 4338.3 4371.1 4394.2 4399.9 4438.3 4681.3 4695.5 4699.3 4704.6 4705.9 4961.1 5057.4 5097.1 5110.8 5120.6 5162.9 5188.6 5208.7 5217.2 5262.8 4775.6 4822.3 4823.1 4826.2 4861.5 5077.7 5230.3 5300.8 5305.3 5314.2 4976.7 4995.7 4995.8 5001.6 5044.2 5078.4 5078.5 5091.8 5092.4 5139.2 4848.5 5004.1 5032.8 5079.6 5097.8 4981.1 5006.2 5016.7 5028.7 5066.6 4281.1 4286.7 4291.5 4299.5 4309.8 3601.3 3656.8 3728.3 3760.3 3834.2 4351.1 4358.6 4394.4 4403.4 4461.2 5089.0 5111.6 5112.4 5143.3 5178.7 4292.8 4402.1 4412.4 4416.1 4454.1 4557.1 4574.6 4587.1 4632.8 4641.7 4754.1 4802.5 4807.4 4820.1 4855.0 4961.7 5045.3 5117.4 5141.6 5145.9 4716.9 4740.2 4785.7 4790.6 4796.2 5018.6 5024.0 5029.0 5039.0 5073.5 4881.9 5042.1 5121.6 5134.1 5173.3 4923.8 4932.0 4956.1 4959.8 4994.4 4939.9 4941.7 4957.4 4959.6 4979.2 4673.3 4843.6 4881.8 4889.0 4914.4 5008.6 5018.0 5024.2 5038.4 5074.3 4921.9 4930.5 4935.7 4935.7 4936.5 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#1] ext.html Cycles:180 Average:45057.18 Median:36435.23 stddev:81574.21 (223.9%) stddev-sans-first:81734.68 17:12:17 INFO - PROCESS | 16599 | Values: 578.6 592.7 601.7 621.5 640.0 33980.5 34934.8 34957.7 35046.8 35147.8 38591.2 38889.8 39087.2 39261.0 39333.2 7646.2 7740.6 7816.5 7824.5 7868.6 7707.7 7898.2 7912.5 7927.7 7952.0 7891.9 7970.0 7983.7 7987.0 8000.9 7813.1 7860.3 7893.8 7911.7 7934.6 7701.7 7761.2 7778.7 7801.2 7806.4 38296.6 38540.4 38578.8 38681.8 38907.8 3019.2 3517.8 3742.9 3743.9 3797.2 28666.4 29034.7 29279.7 29644.9 29805.9 3314.3 3327.7 3335.3 3344.1 3370.8 250844.0 253991.0 254236.0 254746.7 255113.0 31358.8 32126.0 52903.0 53410.0 53717.2 32579.2 32616.0 32702.8 32710.8 32747.2 12230.8 12372.4 12432.4 12462.8 12501.2 10487.1 10522.1 10534.3 10578.9 10598.6 8174.6 8249.5 8304.0 8330.2 8394.6 3226.4 3235.4 3257.5 3276.6 3293.8 926.3 931.0 956.3 978.7 1076.0 28552.9 28869.0 29042.9 29324.4 29615.7 981.4 996.7 1001.2 1054.4 1056.3 15239.2 15461.3 15653.5 15759.0 15784.5 388603.0 391668.0 392428.0 394527.0 395786.0 50781.5 51248.5 51452.0 51568.2 51603.7 1179.5 1182.3 1237.7 1237.8 1240.4 27061.3 27871.2 27881.4 28330.7 28435.0 44878.3 44957.3 44976.6 45342.3 45387.3 261691.0 261758.0 262244.0 262413.0 262797.0 26293.0 26293.2 26620.9 26848.3 26916.7 42973.8 43326.4 43527.0 43888.6 44691.6 37403.0 37690.4 37705.4 37843.4 38174.8 36253.3 37404.3 37457.0 37562.6 37894.8 35592.5 36423.0 36447.5 36725.8 37074.4 31862.7 33633.5 33717.5 33992.7 34016.0 25093.7 25572.4 25725.9 25808.7 25939.4 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#2] jquery.html Cycles:180 Average:24517.28 Median:28445.22 stddev:63746.20 (224.1%) stddev-sans-first:63899.26 17:12:17 INFO - PROCESS | 16599 | Values: 378.5 380.3 388.7 389.8 394.4 15693.8 16840.7 16897.3 17149.3 17196.1 17087.5 17331.2 17498.0 17798.9 17891.5 5126.4 5306.1 5333.5 5345.9 5349.8 3690.3 5698.5 6228.9 6229.3 6244.6 6095.5 6130.1 6161.0 6166.6 6194.8 6207.2 6252.4 6269.7 6278.1 6283.6 5298.1 5357.9 5466.6 5482.7 5502.9 20048.6 20176.4 20812.7 21679.1 21701.9 1928.6 2026.6 2094.2 2235.0 2362.2 13167.1 13519.5 13804.4 13857.3 14015.4 1752.1 1758.6 1797.9 1839.2 1872.5 69581.0 70278.3 70326.6 70623.6 71224.0 9829.4 10149.4 10160.2 10161.0 10510.2 14165.9 14418.5 14440.9 14444.1 14458.0 7197.5 7215.7 7317.9 7406.3 7497.3 6808.1 6947.3 7041.1 7091.7 7174.0 6261.1 6272.7 6368.1 6383.7 6604.6 1706.8 1796.3 1835.7 1877.8 1888.8 848.3 907.4 925.4 958.4 1007.0 16129.0 16969.4 17382.6 18071.4 18477.0 888.9 915.9 921.1 923.1 949.9 10129.0 10345.0 10345.7 10397.3 10431.9 380132.0 380216.0 380539.0 393047.5 396799.0 49290.5 76115.0 80697.6 81592.6 81819.0 966.7 992.4 1018.4 1019.7 1021.3 15793.6 15953.3 15965.8 16025.4 16147.7 37350.8 37411.8 37678.4 37826.8 38014.4 51764.0 51937.7 53161.0 53877.5 54652.2 7729.8 7766.0 7774.2 7976.8 8036.3 10382.9 11159.5 11587.9 11628.5 11722.4 9472.1 9731.9 9960.8 9971.0 10080.8 9533.7 9602.2 9842.7 10041.9 10089.7 9724.5 9853.1 9916.6 10115.5 10160.5 7613.3 7699.4 7754.3 7939.4 7941.1 8686.8 9342.3 9494.7 9531.8 9566.1 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#3] mootools.html Cycles:180 Average:5142.36 Median:5290.13 stddev:2880.32 (54.4%) stddev-sans-first:2875.09 17:12:17 INFO - PROCESS | 16599 | Values: 1456.2 1459.6 1550.0 1623.1 1695.4 7018.3 7529.0 7674.4 8026.8 8034.1 7601.7 7643.1 7683.2 7719.5 7725.2 2197.7 2242.8 2244.1 2246.0 2247.1 2196.1 2200.6 2256.7 2271.9 2285.2 2192.7 2210.0 2213.8 2224.2 2240.7 2109.3 2122.3 2124.3 2126.2 2132.9 2183.1 2186.0 2211.3 2213.8 2214.8 7522.2 7612.1 7622.1 7652.2 7655.0 4513.2 4664.0 4672.6 4720.4 4721.5 2793.3 2796.5 2890.2 2892.2 2949.0 896.8 911.0 930.5 934.9 948.4 10777.4 10799.1 10815.4 10818.7 10844.8 4357.0 4362.6 4425.5 4442.1 4454.0 9230.8 9239.8 9281.4 9308.2 9331.0 4682.8 4707.0 4736.3 4736.4 4757.2 3773.6 4118.0 4180.3 4224.5 4240.9 3695.2 3762.3 3774.3 3815.3 3881.3 1214.9 1218.7 1223.1 1243.9 1250.2 775.3 885.2 908.7 919.3 925.4 5162.4 5259.4 5279.6 5289.5 5290.8 845.5 873.2 877.3 879.7 883.0 3596.4 3615.9 3693.5 3708.0 3712.3 9280.1 9728.4 9741.5 9807.6 9825.0 9690.6 9725.1 9892.7 9921.7 9958.4 6927.2 7079.8 7101.6 7274.7 7277.3 5143.3 5270.0 5368.9 5379.1 5518.6 9088.4 9156.5 9166.6 9288.5 9332.8 8895.0 9416.6 9434.5 9449.3 9476.4 5736.1 6469.9 6606.1 6627.9 6883.7 7036.0 7072.6 7147.3 7158.8 7162.1 6367.4 6507.5 6539.7 6553.2 6655.6 6301.1 6404.2 6412.5 6579.3 6698.1 5957.9 5982.3 6029.8 6053.8 6064.3 4300.0 4412.1 4417.0 4479.2 4524.0 4508.2 4542.5 4568.5 4650.1 4665.2 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#4] prototype.html Cycles:180 Average:4419.76 Median:4962.86 stddev:1272.83 (25.6%) stddev-sans-first:1238.18 17:12:17 INFO - PROCESS | 16599 | Values: 295.2 300.8 301.2 316.8 319.1 4965.2 4992.8 5000.6 5005.1 5018.1 4909.0 4917.3 4933.6 4958.7 4960.5 3729.1 3818.5 3944.5 3945.7 3953.9 3904.0 3928.5 3948.6 3964.7 3980.0 3929.5 3934.2 3939.6 3955.8 3961.9 3843.8 3924.1 3939.1 3950.4 3952.5 3477.3 3492.8 3494.6 3495.6 3495.7 4737.3 4783.9 4798.0 4813.0 4822.4 4359.4 4472.7 4495.1 4495.7 4495.9 5168.6 5180.9 5181.7 5185.9 5216.7 3775.5 3777.6 3795.8 3820.7 3821.3 5316.5 5442.2 5462.3 5486.4 5505.1 3893.9 3897.6 3901.6 3908.0 3917.5 3939.7 3946.3 3960.8 3961.3 3975.8 4465.7 4472.6 4491.9 4501.6 4513.3 5074.2 5151.7 5164.5 5176.2 5235.3 1442.5 1450.4 1453.6 1455.8 1458.1 925.0 945.4 959.1 979.6 988.7 4470.1 4571.2 4587.7 4595.5 4626.4 5318.1 5324.9 5407.0 5434.1 5441.8 4450.9 4590.9 4596.6 4610.4 4622.8 3065.9 3096.2 3099.7 3103.4 3117.5 5386.7 5423.5 5434.5 5435.2 5461.4 5766.0 5907.7 5926.3 5937.5 5990.3 5406.6 5418.3 5428.2 5451.6 5453.0 5609.6 5620.6 5703.7 5805.9 5831.5 5560.9 5627.2 5664.6 5682.8 5714.3 5365.1 5393.0 5408.8 5410.3 5424.8 3581.9 4103.8 4128.8 4149.7 4154.8 5274.2 5284.7 5311.7 5330.9 5334.0 5089.8 5098.8 5115.3 5161.2 5163.1 4915.7 5125.2 5145.5 5146.0 5152.3 5035.8 5049.2 5078.5 5097.9 5118.5 4982.0 5075.2 5103.5 5227.8 5263.6 5144.0 5158.3 5184.2 5184.5 5188.4 17:12:17 INFO - PROCESS | 16599 | 17:12:17 INFO - PROCESS | 16599 | [#5] yui.html Cycles:180 Average:12598.13 Median:47352.03 stddev:14569.19 (30.8%) stddev-sans-first:14582.62 17:12:17 INFO - PROCESS | 16599 | Values: 691.4 740.3 741.8 745.6 747.8 11354.1 11838.1 11880.8 11890.2 11897.8 11615.2 11664.7 11665.9 11687.7 11693.8 768.1 799.9 803.3 805.5 805.5 798.0 802.5 806.1 808.4 808.8 827.8 831.7 832.1 833.8 834.9 820.9 823.5 826.1 829.4 831.6 604.1 605.4 607.1 611.7 612.6 12188.5 12231.7 12245.2 12308.8 12410.9 11282.6 11320.9 11321.3 11669.1 11839.2 9773.2 9852.8 9873.9 9973.0 10034.8 3111.7 3120.5 3133.5 3190.4 3224.6 48126.8 48662.8 48677.5 48710.0 49045.3 8572.3 9028.5 9066.5 9156.4 9199.3 16496.2 16510.3 16535.3 16564.3 16600.4 6383.1 6442.0 6457.3 6498.6 6766.7 3723.5 3740.6 3769.3 3836.1 3862.4 2760.3 2810.3 2824.9 2829.6 2830.9 489.3 489.6 491.8 507.1 507.4 565.6 571.0 577.7 602.8 603.1 7496.6 7589.9 7707.1 7826.5 7877.8 561.8 587.5 603.9 609.9 622.1 3592.3 3593.4 3604.9 3637.6 3718.5 50751.7 50979.5 51673.5 51928.0 52474.5 44772.6 44998.3 45183.3 46367.6 46577.3 43544.3 43553.3 44023.0 44220.0 44382.3 7138.4 7155.5 7178.3 7276.8 7361.3 29028.9 29419.7 29764.0 30499.1 30511.4 35475.3 37218.8 37587.8 38174.8 39110.8 10512.6 10528.9 10557.1 10602.4 10724.1 11375.9 11379.9 11618.5 11661.8 11690.0 10635.3 10965.6 10995.9 11310.9 11599.2 10963.4 11244.7 11287.9 11455.1 11457.9 10556.8 10642.2 10697.7 10779.9 10829.5 7988.1 8054.6 8174.5 8196.4 8362.0 8983.5 9188.7 9425.1 9506.8 9557.6 17:12:17 INFO - PROCESS | 16599 | -------- Summary: end -------- 17:12:17 INFO - PROCESS | 16599 | 17:12:18 INFO - TEST-INFO | 16599: exit 0 17:12:18 INFO - TEST-OK | dromaeo_css | took 1116497ms 17:12:18 INFO - TEST-START | kraken 17:12:18 INFO - operating with platform_type : linux_ 17:12:18 INFO - Initialising browser for kraken test... 17:12:18 INFO - TEST-INFO | started process 16836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphykScs/profile http://localhost:37007/getInfo.html) 17:12:22 INFO - PROCESS | 16836 | 17:12:22 INFO - PROCESS | 16836 | (process:16903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:23 INFO - PROCESS | 16836 | __metrics Screen width/height:1600/1200 17:12:23 INFO - PROCESS | 16836 | colorDepth:24 17:12:23 INFO - PROCESS | 16836 | Browser inner width/height: 1024/697 17:12:23 INFO - PROCESS | 16836 | __metrics 17:12:23 ERROR - PROCESS | 16836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:12:24 INFO - TEST-INFO | 16836: exit 0 17:12:24 INFO - Browser initialized. 17:12:24 INFO - Running cycle 1/1 for kraken test... 17:12:24 INFO - TEST-INFO | started process 16954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphykScs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:26 INFO - PROCESS | 16954 | 17:12:26 INFO - PROCESS | 16954 | (process:17014): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:36 INFO - PROCESS | 16954 | RSS: Main: 165789696 17:12:36 INFO - PROCESS | 16954 | 17:12:39 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:40 INFO - PROCESS | 16954 | RSS: Main: 170545152 17:12:40 INFO - PROCESS | 16954 | 17:12:42 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-dft) 17:12:43 INFO - PROCESS | 16954 | RSS: Main: 173932544 17:12:43 INFO - PROCESS | 16954 | 17:12:46 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-fft) 17:12:47 INFO - PROCESS | 16954 | RSS: Main: 164548608 17:12:47 INFO - PROCESS | 16954 | 17:12:49 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-oscillator) 17:12:49 INFO - PROCESS | 16954 | RSS: Main: 164859904 17:12:49 INFO - PROCESS | 16954 | 17:12:52 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:52 INFO - PROCESS | 16954 | RSS: Main: 166322176 17:12:52 INFO - PROCESS | 16954 | 17:12:56 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:56 INFO - PROCESS | 16954 | RSS: Main: 166596608 17:12:56 INFO - PROCESS | 16954 | 17:13:00 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:00 INFO - PROCESS | 16954 | RSS: Main: 166051840 17:13:00 INFO - PROCESS | 16954 | 17:13:03 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37007/tests/kraken/driver.html?testName=json-parse-financial) 17:13:04 INFO - PROCESS | 16954 | RSS: Main: 166789120 17:13:04 INFO - PROCESS | 16954 | 17:13:06 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:06 INFO - PROCESS | 16954 | RSS: Main: 166952960 17:13:06 INFO - PROCESS | 16954 | 17:13:08 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:09 INFO - PROCESS | 16954 | RSS: Main: 166547456 17:13:09 INFO - PROCESS | 16954 | 17:13:11 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:12 INFO - PROCESS | 16954 | RSS: Main: 166957056 17:13:12 INFO - PROCESS | 16954 | 17:13:14 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:15 INFO - PROCESS | 16954 | RSS: Main: 167546880 17:13:15 INFO - PROCESS | 16954 | 17:13:18 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:19 INFO - PROCESS | 16954 | RSS: Main: 167698432 17:13:19 INFO - PROCESS | 16954 | 17:13:20 INFO - PROCESS | 16954 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37007/tests/kraken/driver.html?testName=ai-astar) 17:13:21 INFO - PROCESS | 16954 | RSS: Main: 168771584 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | __start_tp_report 17:13:21 INFO - PROCESS | 16954 | _x_x_mozilla_page_load 17:13:21 INFO - PROCESS | 16954 | _x_x_mozilla_page_load_details 17:13:21 INFO - PROCESS | 16954 | |i|pagename|runs| 17:13:21 INFO - PROCESS | 16954 | |0;ai-astar;115;108;113;115;114;128;115;115;113;112 17:13:21 INFO - PROCESS | 16954 | |1;audio-beat-detection;154;136;160;190;136;158;154;132;206;134 17:13:21 INFO - PROCESS | 16954 | |2;audio-dft;162;162;167;173;169;166;163;165;168;163 17:13:21 INFO - PROCESS | 16954 | |3;audio-fft;77;74;78;159;75;77;73;74;159;79 17:13:21 INFO - PROCESS | 16954 | |4;audio-oscillator;95;95;154;94;95;94;147;95;94;143 17:13:21 INFO - PROCESS | 16954 | |5;imaging-gaussian-blur;117;118;118;117;117;118;117;117;119;118 17:13:21 INFO - PROCESS | 16954 | |6;imaging-darkroom;148;148;147;147;147;151;148;147;148;148 17:13:21 INFO - PROCESS | 16954 | |7;imaging-desaturate;95;97;97;95;97;96;95;97;96;97 17:13:21 INFO - PROCESS | 16954 | |8;json-parse-financial;65;66;66;66;66;65;66;66;66;64 17:13:21 INFO - PROCESS | 16954 | |9;json-stringify-tinderbox;65;65;65;67;65;65;66;66;66;65 17:13:21 INFO - PROCESS | 16954 | |10;stanford-crypto-aes;78;78;77;79;80;81;80;81;108;85 17:13:21 INFO - PROCESS | 16954 | |11;stanford-crypto-ccm;141;142;131;135;140;141;132;132;133;153 17:13:21 INFO - PROCESS | 16954 | |12;stanford-crypto-pbkdf2;183;175;179;178;179;173;177;174;179;173 17:13:21 INFO - PROCESS | 16954 | |13;stanford-crypto-sha256-iterative;73;76;73;73;75;76;71;72;73;73 17:13:21 INFO - PROCESS | 16954 | __end_tp_report 17:13:21 INFO - PROCESS | 16954 | __start_cc_report 17:13:21 INFO - PROCESS | 16954 | _x_x_mozilla_cycle_collect,943 17:13:21 INFO - PROCESS | 16954 | __end_cc_report 17:13:21 INFO - PROCESS | 16954 | __startTimestamp1461888801091__endTimestamp 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | ------- Summary: start ------- 17:13:21 INFO - PROCESS | 16954 | Number of tests: 14 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:5.12 (4.4%) stddev-sans-first:5.43 17:13:21 INFO - PROCESS | 16954 | Values: 115.0 108.0 113.0 115.0 114.0 128.0 115.0 115.0 113.0 112.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:156.00 stddev:24.82 (15.9%) stddev-sans-first:26.31 17:13:21 INFO - PROCESS | 16954 | Values: 154.0 136.0 160.0 190.0 136.0 158.0 154.0 132.0 206.0 134.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.50 stddev:3.55 (2.1%) stddev-sans-first:3.49 17:13:21 INFO - PROCESS | 16954 | Values: 162.0 162.0 167.0 173.0 169.0 166.0 163.0 165.0 168.0 163.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:35.10 (46.2%) stddev-sans-first:36.78 17:13:21 INFO - PROCESS | 16954 | Values: 77.0 74.0 78.0 159.0 75.0 77.0 73.0 74.0 159.0 79.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.50 stddev:25.95 (27.5%) stddev-sans-first:26.90 17:13:21 INFO - PROCESS | 16954 | Values: 95.0 95.0 154.0 94.0 95.0 94.0 147.0 95.0 94.0 143.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 17:13:21 INFO - PROCESS | 16954 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 118.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 17:13:21 INFO - PROCESS | 16954 | Values: 148.0 148.0 147.0 147.0 147.0 151.0 148.0 147.0 148.0 148.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.87 17:13:21 INFO - PROCESS | 16954 | Values: 95.0 97.0 97.0 95.0 97.0 96.0 95.0 97.0 96.0 97.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 17:13:21 INFO - PROCESS | 16954 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 64.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 17:13:21 INFO - PROCESS | 16954 | Values: 65.0 65.0 65.0 67.0 65.0 65.0 66.0 66.0 66.0 65.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:80.00 stddev:9.17 (11.5%) stddev-sans-first:9.56 17:13:21 INFO - PROCESS | 16954 | Values: 78.0 78.0 77.0 79.0 80.0 81.0 80.0 81.0 108.0 85.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:140.50 stddev:6.82 (4.9%) stddev-sans-first:7.14 17:13:21 INFO - PROCESS | 16954 | Values: 141.0 142.0 131.0 135.0 140.0 141.0 132.0 132.0 133.0 153.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.50 stddev:3.23 (1.8%) stddev-sans-first:2.60 17:13:21 INFO - PROCESS | 16954 | Values: 183.0 175.0 179.0 178.0 179.0 173.0 177.0 174.0 179.0 173.0 17:13:21 INFO - PROCESS | 16954 | 17:13:21 INFO - PROCESS | 16954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 17:13:21 INFO - PROCESS | 16954 | Values: 73.0 76.0 73.0 73.0 75.0 76.0 71.0 72.0 73.0 73.0 17:13:21 INFO - PROCESS | 16954 | -------- Summary: end -------- 17:13:21 INFO - PROCESS | 16954 | 17:13:22 INFO - TEST-INFO | 16954: exit 0 17:13:22 INFO - TEST-OK | kraken | took 63393ms 17:13:22 INFO - SUITE-END | took 1179s 17:13:22 INFO - Completed test suite (00:19:40) 17:13:22 INFO - javascript benchmark 17:13:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.960850587241, 2649.4568613434244, 2690.1794952539494, 2694.9730502694965, 2707.0390011545887, 4696.929546056807, 4716.033213191296, 4719.244920812671, 4728.007118505114, 4730.3614012108355, 4628.190066738316, 4666.0, 4706.929396059062, 4708.835190768324, 4767.046590681869, 4334.84828031019, 4429.247028005231, 4430.113977204556, 4432.578905004019, 4436.001899572587, 548.6686971834292, 4275.636570891478, 4317.98527346075, 4331.30699088146, 4372.519022907478, 4337.674674399401, 4366.279563871957, 4376.168527979706, 4409.9118017639785, 4420.778961051935, 4346.130773845212, 4376.102898905717, 4379.802908869076, 4385.868423947287, 4416.205083085043, 4338.3275592282935, 4371.14762621289, 4394.1651086293505, 4399.900024993752, 4438.334249862514, 4681.344611754357, 4695.5069717679835, 4699.342092107074, 4704.600108990706, 4705.882352941204, 4961.057399094197, 5057.443681195103, 5097.057044446789, 5110.8466745997675, 5120.564751996085, 5162.948370516285, 5188.584913206934, 5208.739563021872, 5217.217417387385, 5262.815801446969, 4775.570198682135, 4822.324874517571, 4823.131836269435, 4826.203676393356, 4861.538153875412, 5077.746112694351, 5230.293910322134, 5300.787968481295, 5305.257263983045, 5314.202869569595, 4976.726280054631, 4995.675281106716, 4995.750212489361, 5001.599872010231, 5044.1677123274985, 5078.3905931287745, 5078.466760990117, 5091.770870310845, 5092.414372347153, 5139.203423469368, 4848.490908454632, 5004.149294619923, 5032.84901452957, 5079.619028572798, 5097.821576244888, 4981.103401387712, 5006.224035274538, 5016.749162541858, 5028.698278103326, 5066.59467242627, 4281.143771245764, 4286.699931004862, 4291.463567054118, 4299.505556861001, 4309.806058727365, 3601.2617413430185, 3656.780593164419, 3728.2729867676085, 3760.3043436963703, 3834.213986132836, 4351.129774045204, 4358.585934336233, 4394.36281739146, 4403.4495688039, 4461.196984542748, 5088.974555127201, 5111.616628752859, 5112.3865136183895, 5143.305653736697, 5178.741062946838, 4292.82828686849, 4402.097569998143, 4412.382266482695, 4416.072624748775, 4454.10917816438, 4557.088582283556, 4574.611158051536, 4587.105514424655, 4632.791524381411, 4641.651876109306, 4754.1204877098535, 4802.543758342952, 4807.399075115611, 4820.108279968217, 4854.9514504855915, 4961.7271050092595, 5045.268436076822, 5117.437081920912, 5141.614378921521, 5145.897082058263, 4716.882077948078, 4740.170470167775, 4785.712857228577, 4790.640701947298, 4796.208625576741, 5018.623603229846, 5024.0, 5029.044481548494, 5038.974805125951, 5073.543381095719, 4881.8535443936735, 5042.09242336383, 5121.61587880903, 5134.101532231919, 5173.301604283373, 4923.753812309442, 4931.950680493293, 4956.10790057793, 4959.82640607577, 4994.400671919393, 4939.876503087452, 4941.65408421407, 4957.355543779286, 4959.553640172402, 4979.203327467588, 4673.252279635242, 4843.636727245541, 4881.755912204447, 4889.0, 4914.36113305268, 5008.649394542347, 5017.996400719798, 5024.196128619404, 5038.370203724535, 5074.289599456005, 4921.8523444296725, 4930.4822993586595, 4935.654504184673, 4935.654504184817, 4936.481669424658], "value": 4642.517158956489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.6325683191172, 592.7214209321618, 601.7382438639191, 621.4872729997753, 639.9616023038615, 33980.49029264563, 34934.82532587337, 34957.650423495754, 35046.8247658762, 35147.82426087866, 38591.228175436474, 38889.805550972276, 39087.21825563494, 39261.0, 39333.21333573327, 7646.197149299327, 7740.574268415235, 7816.53100813953, 7824.491408058487, 7868.606569671522, 7707.6916923323, 7898.170692077335, 7912.4856884302335, 7927.722529711461, 7952.0, 7891.921080789176, 7969.960150199241, 7983.680652773882, 7987.0, 8000.919990800105, 7813.101493328283, 7860.253275938748, 7893.763187104396, 7911.683532658687, 7934.563599002053, 7701.653425595861, 7761.22387761225, 7778.6888524458955, 7801.21987801221, 7806.375489960789, 38296.617033829585, 38540.42189367162, 38578.80710596429, 38681.80659096715, 38907.8054609728, 3019.1999120233154, 3517.7889326640484, 3742.850285988557, 3743.850245990157, 3797.1836055247977, 28666.426671466455, 29034.709652903624, 29279.707202928123, 29644.851775740983, 29805.850970745225, 3314.320564284316, 3327.6505966873374, 3335.31626016666, 3344.0803778960735, 3370.803349829478, 250844.0, 253991.0, 254236.0, 254746.72626636934, 255113.0, 31358.843205783825, 32126.0, 52903.0, 53410.0, 53717.1942420864, 32579.18552036218, 32616.0, 32702.836485817417, 32710.83644581762, 32747.1813204667, 12230.75538489243, 12372.381380930918, 12432.37838108091, 12462.75074498505, 12501.24992500453, 10487.056164945192, 10522.105621022145, 10534.262601617813, 10578.89421105779, 10598.629047983284, 8174.591270436455, 8249.505029698237, 8303.95848020756, 8330.166983301622, 8394.580270986426, 3226.419244536006, 3235.385276797448, 3257.4950882613234, 3276.6395696473846, 3293.818839963825, 926.342296969146, 931.0363773494536, 956.2827879090682, 978.6721448314894, 1076.042322333124, 28552.857235713687, 28869.0, 29042.854785725936, 29324.413511729646, 29615.703842961295, 981.3866333541537, 996.6810620601483, 1001.1840350114634, 1054.3515737821185, 1056.2817284246632, 15239.23803809805, 15461.304241309168, 15653.452129175652, 15759.0, 15784.526464206092, 388603.0, 391668.0, 392428.0, 394527.0, 395786.0, 50781.492185078416, 51248.48751512512, 51452.0, 51568.22647660288, 51603.74198128985, 1179.5281887244998, 1182.3456340515597, 1237.696764292754, 1237.7833879071127, 1240.4418011894684, 27061.323466913484, 27871.16386508408, 27881.442371152058, 28330.716692833634, 28435.0, 44878.3268250983, 44957.325640116076, 44976.550234497234, 45342.31986520139, 45387.319190211514, 261691.0, 261758.0, 262244.0, 262413.0, 262797.0, 26293.0, 26293.21120366392, 26620.866895665396, 26848.32879178036, 26916.730832692207, 42973.785131074146, 43326.35010474782, 43527.0, 43888.561114388445, 44691.55308446874, 37403.0, 37690.43464347982, 37705.43441848429, 37843.43234851534, 38174.80912595419, 36253.27493450169, 37404.25191496209, 37457.0, 37562.624373757004, 37894.8105259483, 35592.46611300781, 36423.0, 36447.45328820123, 36725.81637091797, 37074.44388334231, 31862.681373185973, 33633.495497568045, 33717.49423758597, 33992.66007339994, 34016.0, 25093.749062509873, 25572.360690982874, 25725.871370643777, 25808.741912580634, 25939.351516212246], "value": 16583.95556973584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4763848569815, 380.2793705927267, 388.6599225677532, 389.82263070303014, 394.44974260906054, 15693.764593531107, 16840.65274778018, 16897.324107035718, 17149.314027438886, 17196.05421701806, 17087.48737537873, 17331.22009509572, 17498.037607931557, 17798.911005444956, 17891.463256102306, 5126.436092029883, 5306.071437498442, 5333.546648534879, 5345.946540534604, 5349.786008559653, 3690.280395322913, 5698.487136157745, 6228.906566401485, 6229.345918678541, 6244.562880598337, 6095.481884039862, 6130.080487926824, 6161.045038019114, 6166.6300021998595, 6194.845128871769, 6207.162033125515, 6252.3747625237565, 6269.749210031593, 6278.058291256302, 6283.560150789446, 5298.09932311508, 5357.892842143175, 5466.590005749545, 5482.725863706839, 5502.944970550283, 20048.599028019504, 20176.39470815878, 20812.687809682866, 21679.132834686592, 21701.891490542603, 1928.5757133430623, 2026.5946810637931, 2094.172801743303, 2235.0277629231337, 2362.161432691387, 13167.144135631153, 13519.526816561372, 13804.378802953892, 13857.307134643328, 14015.369308381147, 1752.071402156859, 1758.648270345936, 1797.91010449477, 1839.2459091772444, 1872.4850666066804, 69581.0, 70278.29721702769, 70326.64836675784, 70623.64688176577, 71224.0, 9829.36109152917, 10149.39103653783, 10160.237982151368, 10161.0, 10510.211734119972, 14165.85834141666, 14418.495352662607, 14440.927795361165, 14444.061136026125, 14458.0, 7197.532160409557, 7215.747448839265, 7317.890231646529, 7406.259374062551, 7497.325240728361, 6808.114945057111, 6947.270536593584, 7041.119860017498, 7091.680874360666, 7174.0, 6261.123442718023, 6272.717727702265, 6368.076628888785, 6383.71273292703, 6604.636744979072, 1706.7781188445672, 1796.3353559183186, 1835.7483113405328, 1877.8309952104375, 1888.8016758240462, 848.2747251100344, 907.3920473282916, 925.421611492817, 958.4393130018877, 1007.0483393193508, 16129.0, 16969.406070787463, 17382.565435864206, 18071.367502137364, 18477.0, 888.9244414224863, 915.8809354783969, 921.1249313152532, 923.0999775219242, 949.9050094990583, 10129.0, 10345.0, 10345.74135646615, 10397.272190946713, 10431.895681043092, 380132.0, 380216.0, 380539.0, 393047.52143589343, 396799.0, 49290.50709492931, 76115.0, 80697.59651201824, 81592.59203703943, 81819.0, 966.6858271061792, 992.4095163377779, 1018.383877753963, 1019.7246743379246, 1021.3004092196869, 15793.551224827415, 15953.282102305191, 15965.760513592073, 16025.358985640443, 16147.67704645877, 37350.8132459336, 37411.812940935124, 37678.434823478216, 37826.810865945496, 38014.42978355272, 51764.0, 51937.7403112982, 53161.0, 53877.46122538725, 54652.180217297566, 7729.768106956801, 7766.029246344207, 7774.222577742181, 7976.84046319082, 8036.316913062456, 10382.948085259526, 11159.49782259784, 11587.88412115868, 11628.53485860556, 11722.355270460206, 9472.147506724428, 9731.929487756483, 9960.750981225527, 9970.950145249228, 10080.798384032132, 9533.713988580354, 9602.231821454407, 9842.671239382591, 10041.899581004096, 10089.747756305858, 9724.513774311115, 9853.113219809964, 9916.603335866484, 10115.533247679192, 10160.491975401348, 7613.276738709814, 7699.3840492761565, 7754.30864327074, 7939.444238903452, 7941.086775020946, 8686.78283042929, 9342.299327550596, 9494.715158545254, 9531.809363812823, 9566.13904748576], "value": 8587.374697557889, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.235476374903, 1459.613202501337, 1550.0, 1623.0748473370184, 1695.3896597224996, 7018.263082376341, 7529.0, 7674.386049116071, 8026.799330016745, 8034.116247212802, 7601.657925393357, 7643.082830060401, 7683.154852966183, 7719.536827790323, 7725.188855170197, 2197.7033100531385, 2242.7645097264717, 2244.147224054857, 2246.0117548278786, 2247.1011595361824, 2196.088623221361, 2200.625893598084, 2256.6727824465443, 2271.8750468724215, 2285.1544928376525, 2192.6820611011394, 2209.9558008839813, 2213.756486786452, 2224.1881713174657, 2240.7423146338215, 2109.3144727963395, 2122.3208573256566, 2124.3095993802076, 2126.2133010786033, 2132.8613640113344, 2183.0831050958477, 2186.0162926683056, 2211.347652442533, 2213.7896899794655, 2214.7895949884737, 7522.210167932398, 7612.086549614081, 7622.085349758009, 7652.2347765223585, 7655.0, 4513.187626227278, 4664.0, 4672.602828759559, 4720.409948756405, 4721.527847215285, 2793.25978615667, 2796.545796185972, 2890.248535380795, 2892.190186747714, 2948.970510294891, 896.8161526887038, 911.0378016390788, 930.516131611565, 934.9111834375791, 948.4214629076258, 10777.353358798497, 10799.136069114453, 10815.35107893529, 10818.729531761768, 10844.783104337868, 4356.956430435718, 4362.585554372329, 4425.491068527096, 4442.111577684476, 4453.955460445419, 9230.769230769285, 9239.815203696024, 9281.443113413217, 9308.162265396148, 9330.95334523323, 4682.836100736458, 4707.03505781314, 4736.265878788793, 4736.407949006374, 4757.191277482767, 3773.64150405711, 4117.97941010299, 4180.26845302077, 4224.5353011168745, 4240.851570195028, 3695.1870588470492, 3762.3039737648623, 3774.339490589191, 3815.3323168445413, 3881.3013657541915, 1214.8724383939737, 1218.7196944702769, 1223.1376879300071, 1243.925364478116, 1250.156144602408, 775.2673723331397, 885.181207383168, 908.6923598102911, 919.2554031234588, 925.4262357338358, 5162.380514338229, 5259.368875734936, 5279.630425870152, 5289.47105289468, 5290.788368465218, 845.4504572028108, 873.1835733589114, 877.3376101043672, 879.6804792810784, 883.0418995389946, 3596.4245720684567, 3615.891523254307, 3693.4829123922673, 3708.0, 3712.3132220539287, 9280.118388753057, 9728.367656102331, 9741.512924353754, 9807.558659860324, 9824.95087524572, 9690.56392462341, 9725.0761177688, 9892.703218903445, 9921.65274215399, 9958.402495850272, 6927.168739751262, 7079.752208672672, 7101.609411482418, 7274.745383911538, 7277.3086556777025, 5143.305653736697, 5270.0, 5368.946310536845, 5379.085555455504, 5518.613697041329, 9088.363814532919, 9156.542172891463, 9166.633334666538, 9288.489133097744, 9332.766680833034, 8895.021547629885, 9416.576254068721, 9434.528273586431, 9449.291303152153, 9476.384035037701, 5736.110902810071, 6469.935300646934, 6606.075149479173, 6627.900581491378, 6883.724651013903, 7036.0, 7072.575645461289, 7147.3210045045635, 7158.821029474305, 7162.104736907887, 6367.442506498388, 6507.544471886922, 6539.673016349258, 6553.180852393451, 6655.633940133145, 6301.086342480223, 6404.167458230587, 6412.487001039813, 6579.342065793382, 6698.062271282122, 5957.880842383215, 5982.252218472691, 6029.758809647565, 6053.788117415869, 6064.332923378337, 4299.957000429956, 4412.139632771578, 4417.0, 4479.17135329965, 4523.954760452353, 4508.233600287894, 4542.545745425431, 4568.520305368022, 4650.069986002881, 4665.2069148245555], "value": 4161.304014490178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.21472882133526, 300.8119925046845, 301.22584956661376, 316.77667244592567, 319.1399179212023, 4965.1807451770455, 4992.800287988485, 5000.59995200384, 5005.149124648809, 5018.096742586333, 4908.975455122728, 4917.262410638406, 4933.629977751665, 4958.702477851331, 4960.544530457429, 3729.1050147964565, 3818.522684664417, 3944.5463771666195, 3945.6646185074305, 3953.861614843481, 3904.0, 3928.5285765708154, 3948.644621984021, 3964.7224694271413, 3979.9801000994953, 3929.5088113985753, 3934.154156856275, 3939.6454319111276, 3955.8022098895085, 3961.8811435656976, 3843.7885916274595, 3924.136689928211, 3939.0940083780606, 3950.3876899080688, 3952.486176796998, 3477.2523907360037, 3492.755507114503, 3494.633063528344, 3495.6329585393423, 3495.7028652564563, 4737.336772851803, 4783.851875549843, 4797.976010119962, 4812.951870481285, 4822.397200349957, 4359.38968544404, 4472.686911916167, 4495.078508905666, 4495.707778994355, 4495.9325610115875, 5168.586513078944, 5180.870478238036, 5181.689098654093, 5185.914380943333, 5216.713080780555, 3775.452559378902, 3777.622237776228, 3795.8481660733537, 3820.6943444524372, 3821.254855303217, 5316.521513063843, 5442.183672449125, 5462.3445186577865, 5486.354093771893, 5505.137328589151, 3893.922121557553, 3897.5517815451017, 3901.5708272090046, 3907.9609203908167, 3917.490726205575, 3939.7439166454087, 3946.2896678598127, 3960.8019599019935, 3961.286968345668, 3975.7813320267082, 4465.665075119379, 4472.642188624902, 4491.910161796811, 4501.594856462869, 4513.300438432048, 5074.188129899198, 5151.6908985461, 5164.535191832753, 5176.19768935808, 5235.345581802275, 1442.4879167895456, 1450.4415799916897, 1453.6147920800997, 1455.8180227471566, 1458.1105525629357, 925.0, 945.3949472337572, 959.0770505137156, 979.5591983607405, 988.7083310423442, 4470.105978804252, 4571.177188106173, 4587.742702681067, 4595.517470665599, 4626.398568186114, 5318.149096144598, 5324.92012619811, 5406.972965135149, 5434.076207044812, 5441.755121019484, 4450.888727781767, 4590.862274131781, 4596.6092882105395, 4610.400647915817, 4622.768861556909, 3065.892693755708, 3096.241420851906, 3099.6900309969274, 3103.379324135182, 3117.5479555464785, 5386.730663466811, 5423.457654234624, 5434.538064264502, 5435.1847222916085, 5461.399246082928, 5766.0, 5907.675077870673, 5926.288845338587, 5937.52499800015, 5990.251218597676, 5406.648567843156, 5418.2685337479725, 5428.185772134132, 5451.645643033111, 5452.991196628557, 5609.635210150739, 5620.634658747168, 5703.657780533182, 5805.912911306249, 5831.533477321719, 5560.860978475571, 5627.240322556402, 5664.631798933056, 5682.772689092555, 5714.342850572071, 5365.114756065205, 5393.0, 5408.8377348679605, 5410.2696136022705, 5424.7558859850615, 3581.9462708059923, 4103.753774773523, 4128.772917489567, 4149.668026557929, 4154.792260387029, 5274.156135018378, 5284.656497327662, 5311.734413279243, 5330.920036199538, 5333.97309022569, 5089.821856235162, 5098.776293689562, 5115.335006449138, 5161.225816127611, 5163.148080566664, 4915.65590408668, 5125.1799712045895, 5145.45972672864, 5146.0, 5152.3044389007, 5035.823746168867, 5049.2173713074535, 5078.542931136216, 5097.8725531862, 5118.513741194581, 4982.0, 5075.1625981712605, 5103.489651035015, 5227.843164705065, 5263.5525980292105, 5143.974280128576, 5158.3235448478645, 5184.248283998874, 5184.533391994739, 5188.429272779916], "value": 4020.929382726913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4226620771656, 740.3300013487792, 741.7960060983232, 745.6085555083582, 747.7644541969275, 11354.148438867087, 11838.05295576354, 11880.821787673181, 11890.227135236226, 11897.7620447591, 11615.245009074426, 11664.650060498177, 11665.941670291659, 11687.7078073048, 11693.824592631096, 768.0552919908502, 799.8880156778026, 803.2931020701803, 805.4804651000102, 805.4925396999911, 798.0423491809822, 802.4623502253504, 806.0528878567688, 808.3856269235365, 808.8180159464102, 827.764087235138, 831.6673330667721, 832.0847068224934, 833.7665453672951, 834.9248567628912, 820.9096999330069, 823.5347028928636, 826.1243082332746, 829.369679043925, 831.5717405536154, 604.066716922356, 605.446016894541, 607.0893659510734, 611.7461253579759, 612.610992020066, 12188.451519681636, 12231.69420764479, 12245.204061736047, 12308.8153677694, 12410.937945310307, 11282.605108821152, 11320.886791132065, 11321.264117832314, 11669.066474682006, 11839.230450020721, 9773.21814254858, 9852.753681157958, 9873.851892221623, 9973.0, 10034.799304013879, 3111.6577176510564, 3120.5319202119636, 3133.4673105572106, 3190.4097741917585, 3224.629167645727, 48126.759366203296, 48662.75668621669, 48677.51322486765, 48710.02579948417, 49045.26432103521, 8572.314214862796, 9028.46316750067, 9066.501342426098, 9156.359054866096, 9199.264058875275, 16496.17519124039, 16510.33958641641, 16535.25591348392, 16564.337426502803, 16600.418985335455, 6383.1382763326355, 6442.0, 6457.321981192001, 6498.577592456475, 6766.661666916634, 3723.4600982857332, 3740.6446387593137, 3769.3215221260434, 3836.0985168485386, 3862.3820188769664, 2760.254731222599, 2810.297425643589, 2824.8728807203725, 2829.6462942132234, 2830.9433811323656, 489.3149590573226, 489.6352217597841, 491.8204855227816, 507.05687421396175, 507.37339385858434, 565.5955991466121, 570.9971450142723, 577.6822747488865, 602.8312072619674, 603.1013789453682, 7496.587687677121, 7589.899464577606, 7707.113681926538, 7826.491278067021, 7877.7636670899965, 561.7612514681244, 587.521170246248, 603.9124326972565, 609.8536351275751, 622.0886401421939, 3592.3354179476883, 3593.443016332473, 3604.945925811115, 3637.5998640149564, 3718.5165928429133, 50751.746241268556, 50979.49020509747, 51673.48326516762, 51928.0, 52474.47525524772, 44772.55227447684, 44998.32502512465, 45183.322250166275, 46367.6089717309, 46577.30134047992, 43544.34683479751, 43553.346699798894, 44023.0, 44220.0, 44382.33426498605, 7138.428925686037, 7155.534890232118, 7178.28217178278, 7276.818079548054, 7361.2638736125955, 29028.854855725585, 29419.705802942553, 29764.0, 30499.08502744921, 30511.389772204875, 35475.290494190485, 37218.8139059303, 37587.81206093952, 38174.80912595419, 39110.804445977585, 10512.57949682004, 10528.947355263175, 10557.102646275152, 10602.416867072077, 10724.088452481627, 11375.943120284346, 11379.886201137882, 11618.5352585899, 11661.76676466483, 11690.0, 10635.308704934154, 10965.56137754481, 10995.890041099807, 11310.886891131313, 11599.188056835941, 10963.397013164353, 11244.718882027688, 11287.887121128684, 11455.140864435034, 11457.942710286396, 10556.841647375142, 10642.220069066669, 10697.732556686145, 10779.89220107789, 10829.458527073457, 7988.12130665638, 8054.5569993650915, 8174.509529428254, 8196.42625016243, 8362.038365587792, 8983.46099234048, 9188.724338269863, 9425.104615061558, 9506.762330941781, 9557.553742630704], "value": 5799.877271985099, "unit": "score"}], "name": "dromaeo_css", "value": 6327.328929047262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 115.0, 114.0, 128.0, 115.0, 115.0, 113.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 136.0, 160.0, 190.0, 136.0, 158.0, 154.0, 132.0, 206.0, 134.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 173.0, 169.0, 166.0, 163.0, 165.0, 168.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 78.0, 159.0, 75.0, 77.0, 73.0, 74.0, 159.0, 79.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 154.0, 94.0, 95.0, 94.0, 147.0, 95.0, 94.0, 143.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 151.0, 148.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 95.0, 97.0, 96.0, 95.0, 97.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 79.0, 80.0, 81.0, 80.0, 81.0, 108.0, 85.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 131.0, 135.0, 140.0, 141.0, 132.0, 132.0, 133.0, 153.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 175.0, 179.0, 178.0, 179.0, 173.0, 177.0, 174.0, 179.0, 173.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 73.0, 75.0, 76.0, 71.0, 72.0, 73.0, 73.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1603.7, "alertThreshold": 2.0}]} 17:13:22 INFO - Return code: 0 17:13:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:22 ERROR - # TBPL SUCCESS # 17:13:22 INFO - Running post-action listener: _resource_record_post_action 17:13:22 INFO - Running post-run listener: _resource_record_post_run 17:13:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518819840; Read time: 16; Write time: 376876 17:13:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234565632; Read time: 0; Write time: 198784 17:13:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283967488; Read time: 16; Write time: 178068 17:13:23 INFO - Running post-run listener: _upload_blobber_files 17:13:23 INFO - Blob upload gear active. 17:13:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:23 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 17:13:23 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:13:23 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:13:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:13:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:13:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:24 INFO - (blobuploader) - INFO - Done attempting. 17:13:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:13:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:13:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:25 INFO - (blobuploader) - INFO - Done attempting. 17:13:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:25 INFO - Return code: 0 17:13:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed2aa6b46fa90495e798398c889afc7d92078f01632035a6f870a72fe6039afbded1fae17667bcf65173bdbec6b4f24fd7df968f7271ec6203a65bfc14ea3e06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a2b644156b707ed7a9f81c7ee08a738705e507f963df2c06cc9fa03d0c719c4b4e8867af2eaffc4e481cab4dbe36865701bc2ec44e059e81533faa9a5f57f0"} 17:13:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:25 INFO - Contents: 17:13:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed2aa6b46fa90495e798398c889afc7d92078f01632035a6f870a72fe6039afbded1fae17667bcf65173bdbec6b4f24fd7df968f7271ec6203a65bfc14ea3e06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a2b644156b707ed7a9f81c7ee08a738705e507f963df2c06cc9fa03d0c719c4b4e8867af2eaffc4e481cab4dbe36865701bc2ec44e059e81533faa9a5f57f0"} 17:13:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:25 INFO - Copying logs to upload dir... 17:13:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.927924 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-28 17:13:24.929114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:24.933215) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed2aa6b46fa90495e798398c889afc7d92078f01632035a6f870a72fe6039afbded1fae17667bcf65173bdbec6b4f24fd7df968f7271ec6203a65bfc14ea3e06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a2b644156b707ed7a9f81c7ee08a738705e507f963df2c06cc9fa03d0c719c4b4e8867af2eaffc4e481cab4dbe36865701bc2ec44e059e81533faa9a5f57f0"} build_url:https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/HvoyHNJ6TWSFjAhG6rRcxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed2aa6b46fa90495e798398c889afc7d92078f01632035a6f870a72fe6039afbded1fae17667bcf65173bdbec6b4f24fd7df968f7271ec6203a65bfc14ea3e06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a2b644156b707ed7a9f81c7ee08a738705e507f963df2c06cc9fa03d0c719c4b4e8867af2eaffc4e481cab4dbe36865701bc2ec44e059e81533faa9a5f57f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:24.959479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:24.960006) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461887252.683974-989716022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:25.045312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 17:13:25.045873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 17:13:25.046392) ========= ========= Total master_lag: 0.28 =========