builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1461887560.95 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.951409) ========= 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.951925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.952199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.983302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:40.983582) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 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% 221M=0s 2016-04-28 16:52:41 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.352552 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.350075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.350396) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020336 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.402625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.402998) ========= 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=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 16:52:41,496 truncating revision to first 12 chars 2016-04-28 16:52:41,496 Setting DEBUG logging. 2016-04-28 16:52:41,496 attempt 1/10 2016-04-28 16:52:41,496 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:41,756 unpacking tar archive at: fx-team-98aa054d9e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.961293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.961573) ========= script_repo_revision: 98aa054d9e2757e43158b0c962be9cbab784e9e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.961946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.962284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:52:41.979009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 16:52:41.979279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 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 --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', 16:52:42 INFO - 'system_bits': '32', 16:52:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:42 INFO - 'title': 'talos-linux64-ix-052', 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:42 INFO - Running post-action listener: _resource_record_post_action 16:52:42 INFO - ##### 16:52:42 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 16:52:42 INFO - Using buildbot properties: 16:52:42 INFO - { 16:52:42 INFO - "project": "", 16:52:42 INFO - "product": "firefox", 16:52:42 INFO - "script_repo_revision": "production", 16:52:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:52:42 INFO - "repository": "", 16:52:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:52:42 INFO - "buildid": "20160428161042", 16:52:42 INFO - "pgo_build": "False", 16:52:42 INFO - "basedir": "/builds/slave/test", 16:52:42 INFO - "buildnumber": 2909, 16:52:42 INFO - "slavename": "talos-linux64-ix-052", 16:52:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:52:42 INFO - "platform": "ubuntu64_hw", 16:52:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:52:42 INFO - "branch": "fx-team", 16:52:42 INFO - "repo_path": "integration/fx-team", 16:52:42 INFO - "revision": "98aa054d9e2757e43158b0c962be9cbab784e9e2", 16:52:42 INFO - "stage_platform": "linux64", 16:52:42 INFO - "builduid": "835df724bdae4035a563f9d7616ad8c3", 16:52:42 INFO - "slavebuilddir": "test" 16:52:42 INFO - } 16:52:42 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:42 INFO - Running post-action listener: _resource_record_post_action 16:52:42 INFO - ##### 16:52:42 INFO - ##### Running download-and-extract 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: download_and_extract 16:52:42 INFO - mkdir: /builds/slave/test/build/tests 16:52:42 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:42 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:42 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:42 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:42 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:42 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:47 INFO - Downloaded 1361 bytes. 16:52:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:52:47 INFO - Using the following test package requirements: 16:52:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:52:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'jsshell-linux-x86_64.zip'], 16:52:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:52:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:52:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:47 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:47 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:47 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:47 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:47 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:47 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:57 INFO - Downloaded 22301146 bytes. 16:52:57 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:57 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:58 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:59 INFO - Downloaded 10840145 bytes. 16:52:59 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:59 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:59 INFO - Return code: 0 16:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:59 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:59 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:59 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:59 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:59 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:53:02 INFO - Downloaded 54848454 bytes. 16:53:02 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:53:02 INFO - mkdir: /builds/slave/test/properties 16:53:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:02 INFO - Contents: 16:53:02 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:02 INFO - Running post-action listener: _resource_record_post_action 16:53:02 INFO - Running post-action listener: set_extra_try_arguments 16:53:02 INFO - ##### 16:53:02 INFO - ##### Running populate-webroot step. 16:53:02 INFO - ##### 16:53:02 INFO - Running pre-action listener: _resource_record_pre_action 16:53:02 INFO - Running main action method: populate_webroot 16:53:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:02 INFO - '--tppagecycles', 16:53:02 INFO - '7'], 16:53:02 INFO - 'tests': ['tsvgm']}}, 16:53:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['damp', 'tps']}, 16:53:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'tests': ['damp', 'tps']}, 16:53:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['dromaeo_dom']}, 16:53:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['a11yr', 16:53:02 INFO - 'ts_paint', 16:53:02 INFO - 'tpaint', 16:53:02 INFO - 'sessionrestore', 16:53:02 INFO - 'sessionrestore_no_auto_restore', 16:53:02 INFO - 'tabpaint']}, 16:53:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['tsvgx', 16:53:02 INFO - 'tsvgr_opacity', 16:53:02 INFO - 'tart', 16:53:02 INFO - 'tscrollx', 16:53:02 INFO - 'cart']}, 16:53:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:02 INFO - 'tsvgr_opacity', 16:53:02 INFO - 'tart', 16:53:02 INFO - 'tscrollx', 16:53:02 INFO - 'cart']}, 16:53:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'talos_options': ['--disable-e10s'], 16:53:02 INFO - 'tests': ['tp5o']}, 16:53:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'tests': ['tp5o']}, 16:53:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'talos_options': ['--disable-e10s', 16:53:02 INFO - '--xperf_path', 16:53:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:02 INFO - 'tests': ['tp5n']}, 16:53:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:02 INFO - 'talos_options': ['--xperf_path', 16:53:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:02 INFO - 'tests': ['tp5n']}}, 16:53:02 INFO - 'talos.zip': {'path': '', 16:53:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:02 INFO - Running post-action listener: _resource_record_post_action 16:53:02 INFO - ##### 16:53:02 INFO - ##### Running create-virtualenv step. 16:53:02 INFO - ##### 16:53:02 INFO - Running pre-action listener: _resource_record_pre_action 16:53:02 INFO - Running main action method: create_virtualenv 16:53:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:02 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:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:03 INFO - Using real prefix '/usr' 16:53:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:05 INFO - Installing pip.................done. 16:53:05 INFO - Return code: 0 16:53:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:05 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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 16:53:05 INFO - 'HOME': '/home/cltbld', 16:53:05 INFO - 'LANG': 'en_US.UTF-8', 16:53:05 INFO - 'LANGUAGE': 'en_US:en', 16:53:05 INFO - 'LOGNAME': 'cltbld', 16:53:05 INFO - 'MAIL': '/var/mail/cltbld', 16:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:05 INFO - 'MOZ_NO_REMOTE': '1', 16:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:05 INFO - 'NO_EM_RESTART': '1', 16:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:05 INFO - 'PWD': '/builds/slave/test', 16:53:05 INFO - 'SHELL': '/bin/bash', 16:53:05 INFO - 'SHLVL': '1', 16:53:05 INFO - 'TERM': 'linux', 16:53:05 INFO - 'TMOUT': '86400', 16:53:05 INFO - 'USER': 'cltbld', 16:53:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:05 INFO - '_': '/tools/buildbot/bin/python'} 16:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:05 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:05 INFO - Cleaning up... 16:53:05 INFO - Return code: 0 16:53:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:53:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:05 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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 16:53:05 INFO - 'HOME': '/home/cltbld', 16:53:05 INFO - 'LANG': 'en_US.UTF-8', 16:53:05 INFO - 'LANGUAGE': 'en_US:en', 16:53:05 INFO - 'LOGNAME': 'cltbld', 16:53:05 INFO - 'MAIL': '/var/mail/cltbld', 16:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:05 INFO - 'MOZ_NO_REMOTE': '1', 16:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:05 INFO - 'NO_EM_RESTART': '1', 16:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:05 INFO - 'PWD': '/builds/slave/test', 16:53:05 INFO - 'SHELL': '/bin/bash', 16:53:05 INFO - 'SHLVL': '1', 16:53:05 INFO - 'TERM': 'linux', 16:53:05 INFO - 'TMOUT': '86400', 16:53:05 INFO - 'USER': 'cltbld', 16:53:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:05 INFO - '_': '/tools/buildbot/bin/python'} 16:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:05 INFO - Downloading/unpacking psutil>=0.7.1 16:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:07 INFO - Installing collected packages: psutil 16:53:07 INFO - Running setup.py install for psutil 16:53:07 INFO - building 'psutil._psutil_linux' extension 16:53:07 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:08 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:08 INFO - building 'psutil._psutil_posix' extension 16:53:08 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:08 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:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:08 INFO - Successfully installed psutil 16:53:08 INFO - Cleaning up... 16:53:08 INFO - Return code: 0 16:53:08 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 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 mozsystemmonitor==0.0.0 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 mozsystemmonitor-0.0.tar.gz 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:10 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:10 INFO - Installing collected packages: mozsystemmonitor 16:53:10 INFO - Running setup.py install for mozsystemmonitor 16:53:10 INFO - Successfully installed mozsystemmonitor 16:53:10 INFO - Cleaning up... 16:53:10 INFO - Return code: 0 16:53:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 16:53:10 INFO - 'HOME': '/home/cltbld', 16:53:10 INFO - 'LANG': 'en_US.UTF-8', 16:53:10 INFO - 'LANGUAGE': 'en_US:en', 16:53:10 INFO - 'LOGNAME': 'cltbld', 16:53:10 INFO - 'MAIL': '/var/mail/cltbld', 16:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:10 INFO - 'MOZ_NO_REMOTE': '1', 16:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:10 INFO - 'NO_EM_RESTART': '1', 16:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:10 INFO - 'PWD': '/builds/slave/test', 16:53:10 INFO - 'SHELL': '/bin/bash', 16:53:10 INFO - 'SHLVL': '1', 16:53:10 INFO - 'TERM': 'linux', 16:53:10 INFO - 'TMOUT': '86400', 16:53:10 INFO - 'USER': 'cltbld', 16:53:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:10 INFO - '_': '/tools/buildbot/bin/python'} 16:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:10 INFO - Downloading/unpacking 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:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:12 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:12 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:12 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:12 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:12 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:12 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - Downloading docopt-0.6.1.tar.gz 16:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:13 INFO - Running setup.py install for blobuploader 16:53:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:13 INFO - Running setup.py install for requests 16:53:13 INFO - Running setup.py install for docopt 16:53:14 INFO - Successfully installed blobuploader requests docopt 16:53:14 INFO - Cleaning up... 16:53:14 INFO - Return code: 0 16:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:14 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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 16:53:14 INFO - 'HOME': '/home/cltbld', 16:53:14 INFO - 'LANG': 'en_US.UTF-8', 16:53:14 INFO - 'LANGUAGE': 'en_US:en', 16:53:14 INFO - 'LOGNAME': 'cltbld', 16:53:14 INFO - 'MAIL': '/var/mail/cltbld', 16:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:14 INFO - 'MOZ_NO_REMOTE': '1', 16:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:14 INFO - 'NO_EM_RESTART': '1', 16:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:14 INFO - 'PWD': '/builds/slave/test', 16:53:14 INFO - 'SHELL': '/bin/bash', 16:53:14 INFO - 'SHLVL': '1', 16:53:14 INFO - 'TERM': 'linux', 16:53:14 INFO - 'TMOUT': '86400', 16:53:14 INFO - 'USER': 'cltbld', 16:53:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:14 INFO - '_': '/tools/buildbot/bin/python'} 16:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:14 INFO - Running setup.py (path:/tmp/pip-sHcIly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:14 INFO - Running setup.py (path:/tmp/pip-aOC584-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:14 INFO - Running setup.py (path:/tmp/pip-9B_sPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:14 INFO - Running setup.py (path:/tmp/pip-AbaWlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:14 INFO - Running setup.py (path:/tmp/pip-dsqPhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:14 INFO - Running setup.py (path:/tmp/pip-oyvCry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:14 INFO - Running setup.py (path:/tmp/pip-uNfxDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:14 INFO - Running setup.py (path:/tmp/pip-BBJ13e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:14 INFO - Running setup.py (path:/tmp/pip-Zv2WYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:14 INFO - Running setup.py (path:/tmp/pip-oJMVFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:15 INFO - Running setup.py (path:/tmp/pip-aJWWSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:15 INFO - Running setup.py (path:/tmp/pip-Hb9Opv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:15 INFO - Running setup.py (path:/tmp/pip-P5zVNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:15 INFO - Running setup.py (path:/tmp/pip-33Gx8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:15 INFO - Running setup.py (path:/tmp/pip-jlZrgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:15 INFO - Running setup.py (path:/tmp/pip-SHNRpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:15 INFO - Running setup.py (path:/tmp/pip-DukKDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:15 INFO - Running setup.py install for manifestparser 16:53:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:15 INFO - Running setup.py install for mozcrash 16:53:15 INFO - Running setup.py install for mozdebug 16:53:15 INFO - Running setup.py install for mozdevice 16:53:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:15 INFO - Running setup.py install for mozfile 16:53:16 INFO - Running setup.py install for mozhttpd 16:53:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for mozinfo 16:53:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for mozInstall 16:53:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for mozleak 16:53:16 INFO - Running setup.py install for mozlog 16:53:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for moznetwork 16:53:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for mozprocess 16:53:16 INFO - Running setup.py install for mozprofile 16:53:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:16 INFO - Running setup.py install for mozrunner 16:53:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:17 INFO - Running setup.py install for mozscreenshot 16:53:17 INFO - Running setup.py install for moztest 16:53:17 INFO - Running setup.py install for mozversion 16:53:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:17 INFO - Cleaning up... 16:53:17 INFO - Return code: 0 16:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:17 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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 16:53:17 INFO - 'HOME': '/home/cltbld', 16:53:17 INFO - 'LANG': 'en_US.UTF-8', 16:53:17 INFO - 'LANGUAGE': 'en_US:en', 16:53:17 INFO - 'LOGNAME': 'cltbld', 16:53:17 INFO - 'MAIL': '/var/mail/cltbld', 16:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:17 INFO - 'MOZ_NO_REMOTE': '1', 16:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:17 INFO - 'NO_EM_RESTART': '1', 16:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:17 INFO - 'PWD': '/builds/slave/test', 16:53:17 INFO - 'SHELL': '/bin/bash', 16:53:17 INFO - 'SHLVL': '1', 16:53:17 INFO - 'TERM': 'linux', 16:53:17 INFO - 'TMOUT': '86400', 16:53:17 INFO - 'USER': 'cltbld', 16:53:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:17 INFO - '_': '/tools/buildbot/bin/python'} 16:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:17 INFO - Running setup.py (path:/tmp/pip-WubtuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:17 INFO - Running setup.py (path:/tmp/pip-ZWl8ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:17 INFO - Running setup.py (path:/tmp/pip-DRfJxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:17 INFO - Running setup.py (path:/tmp/pip-BeAYOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:17 INFO - Running setup.py (path:/tmp/pip-sywSB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:17 INFO - Running setup.py (path:/tmp/pip-BMHaqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:17 INFO - Running setup.py (path:/tmp/pip-EQpkFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:18 INFO - Running setup.py (path:/tmp/pip-SigVng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:18 INFO - Running setup.py (path:/tmp/pip-ZvdDlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:18 INFO - Running setup.py (path:/tmp/pip-pr1oh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:18 INFO - Running setup.py (path:/tmp/pip-oYhjIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:18 INFO - Running setup.py (path:/tmp/pip-y97rNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:18 INFO - Running setup.py (path:/tmp/pip-BgaeQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:18 INFO - Running setup.py (path:/tmp/pip-oHxJMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:18 INFO - Running setup.py (path:/tmp/pip-tK6hdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:18 INFO - Running setup.py (path:/tmp/pip-ZDHBss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:18 INFO - Running setup.py (path:/tmp/pip-7zW7Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:18 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:18 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 - 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:18 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:18 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:18 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:20 INFO - Downloading blessings-1.6.tar.gz 16:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:20 INFO - Installing collected packages: blessings 16:53:20 INFO - Running setup.py install for blessings 16:53:20 INFO - Successfully installed blessings 16:53:20 INFO - Cleaning up... 16:53:20 INFO - Return code: 0 16:53:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:21 INFO - Reading from file tmpfile_stdout 16:53:21 INFO - Current package versions: 16:53:21 INFO - argparse == 1.2.1 16:53:21 INFO - blessings == 1.6 16:53:21 INFO - blobuploader == 1.2.4 16:53:21 INFO - docopt == 0.6.1 16:53:21 INFO - manifestparser == 1.1 16:53:21 INFO - mozInstall == 1.12 16:53:21 INFO - mozcrash == 0.17 16:53:21 INFO - mozdebug == 0.1 16:53:21 INFO - mozdevice == 0.48 16:53:21 INFO - mozfile == 1.2 16:53:21 INFO - mozhttpd == 0.7 16:53:21 INFO - mozinfo == 0.9 16:53:21 INFO - mozleak == 0.1 16:53:21 INFO - mozlog == 3.1 16:53:21 INFO - moznetwork == 0.27 16:53:21 INFO - mozprocess == 0.22 16:53:21 INFO - mozprofile == 0.28 16:53:21 INFO - mozrunner == 6.11 16:53:21 INFO - mozscreenshot == 0.1 16:53:21 INFO - mozsystemmonitor == 0.0 16:53:21 INFO - moztest == 0.7 16:53:21 INFO - mozversion == 1.4 16:53:21 INFO - psutil == 3.1.1 16:53:21 INFO - requests == 1.2.3 16:53:21 INFO - wsgiref == 0.1.2 16:53:21 INFO - Installing None 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', '-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 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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', '-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:21 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: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': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:21 INFO - '_': '/tools/buildbot/bin/python'} 16:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Cleaning up... 16:53:21 INFO - Return code: 0 16:53:21 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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', 'jsonschema'] 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 jsonschema 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': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:21 INFO - '_': '/tools/buildbot/bin/python'} 16:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:21 INFO - Downloading/unpacking 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:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:23 INFO - Downloading/unpacking functools32 (from jsonschema) 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:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:23 INFO - warning: no files found matching '*.txt' 16:53:23 INFO - no previously-included directories found matching 'build' 16:53:23 INFO - no previously-included directories found matching 'dist' 16:53:23 INFO - no previously-included directories found matching '.git*' 16:53:23 INFO - Installing collected packages: jsonschema, functools32 16:53:23 INFO - Running setup.py install for functools32 16:53:24 INFO - warning: no files found matching '*.txt' 16:53:24 INFO - no previously-included directories found matching 'build' 16:53:24 INFO - no previously-included directories found matching 'dist' 16:53:24 INFO - no previously-included directories found matching '.git*' 16:53:24 INFO - Successfully installed jsonschema functools32 16:53:24 INFO - Cleaning up... 16:53:24 INFO - Return code: 0 16:53:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b8076cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', '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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:53:24 INFO - Using env: {'DISPLAY': ':0', 16:53:24 INFO - 'HOME': '/home/cltbld', 16:53:24 INFO - 'LANG': 'en_US.UTF-8', 16:53:24 INFO - 'LANGUAGE': 'en_US:en', 16:53:24 INFO - 'LOGNAME': 'cltbld', 16:53:24 INFO - 'MAIL': '/var/mail/cltbld', 16:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:24 INFO - 'MOZ_NO_REMOTE': '1', 16:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:24 INFO - 'NO_EM_RESTART': '1', 16:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:24 INFO - 'PWD': '/builds/slave/test', 16:53:24 INFO - 'SHELL': '/bin/bash', 16:53:24 INFO - 'SHLVL': '1', 16:53:24 INFO - 'TERM': 'linux', 16:53:24 INFO - 'TMOUT': '86400', 16:53:24 INFO - 'USER': 'cltbld', 16:53:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:24 INFO - '_': '/tools/buildbot/bin/python'} 16:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:24 INFO - Downloading/unpacking 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:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:26 INFO - no previously-included directories found matching 'docs/_build' 16:53:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:27 INFO - Running setup.py install for pep8 16:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:27 INFO - no previously-included directories found matching 'docs/_build' 16:53:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:27 INFO - Cleaning up... 16:53:27 INFO - Return code: 0 16:53:27 INFO - Running post-action listener: _resource_record_post_action 16:53:27 INFO - Running post-action listener: _start_resource_monitoring 16:53:27 INFO - Starting resource monitoring. 16:53:27 INFO - ##### 16:53:27 INFO - ##### Running install step. 16:53:27 INFO - ##### 16:53:27 INFO - Running pre-action listener: _resource_record_pre_action 16:53:27 INFO - Running main action method: install 16:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:27 INFO - Reading from file tmpfile_stdout 16:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:27 INFO - Reading from file tmpfile_stdout 16:53:27 INFO - Output received: 16:53:27 INFO - Usage: mozinstall [options] installer 16:53:27 INFO - Options: 16:53:27 INFO - -h, --help show this help message and exit 16:53:27 INFO - -d DEST, --destination=DEST 16:53:27 INFO - Directory to install application into. [default: 16:53:27 INFO - "/builds/slave/test"] 16:53:27 INFO - --app=APP Application being installed. [default: firefox] 16:53:27 INFO - mkdir: /builds/slave/test/build/application 16:53:27 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:27 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:43 INFO - Reading from file tmpfile_stdout 16:53:43 INFO - Output received: 16:53:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:43 INFO - Running post-action listener: _resource_record_post_action 16:53:43 INFO - ##### 16:53:43 INFO - ##### Running run-tests step. 16:53:43 INFO - ##### 16:53:43 INFO - Running pre-action listener: _resource_record_pre_action 16:53:43 INFO - Running main action method: run_tests 16:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:43 INFO - Python 2.7.3 16:53:43 INFO - Return code: 0 16:53:43 INFO - grabbing minidump binary from tooltool 16:53: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:53:43 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 0x2754410>, '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 0x2755310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27557a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:43 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:43 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:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:43 INFO - Return code: 0 16:53:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:44 INFO - Return code: 0 16:53:44 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', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:53:44 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 --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-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:53:44 INFO - Using env: {'DISPLAY': ':0', 16:53:44 INFO - 'HOME': '/home/cltbld', 16:53:44 INFO - 'LANG': 'en_US.UTF-8', 16:53:44 INFO - 'LANGUAGE': 'en_US:en', 16:53:44 INFO - 'LOGNAME': 'cltbld', 16:53:44 INFO - 'MAIL': '/var/mail/cltbld', 16:53:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:44 INFO - 'MOZ_NO_REMOTE': '1', 16:53:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:44 INFO - 'NO_EM_RESTART': '1', 16:53:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:44 INFO - 'PWD': '/builds/slave/test', 16:53:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:44 INFO - 'SHELL': '/bin/bash', 16:53:44 INFO - 'SHLVL': '1', 16:53:44 INFO - 'TERM': 'linux', 16:53:44 INFO - 'TMOUT': '86400', 16:53:44 INFO - 'USER': 'cltbld', 16:53:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271', 16:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:44 INFO - '_': '/tools/buildbot/bin/python'} 16:53:44 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', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:53:44 INFO - mozversion application_buildid: 20160428161042 16:53:44 INFO - mozversion application_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 16:53:44 INFO - mozversion application_display_name: Nightly 16:53:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:44 INFO - mozversion application_name: Firefox 16:53:44 INFO - mozversion application_remotingname: firefox 16:53:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:53:44 INFO - mozversion application_vendor: Mozilla 16:53:44 INFO - mozversion application_version: 49.0a1 16:53:44 INFO - mozversion platform_buildid: 20160428161042 16:53:44 INFO - mozversion platform_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 16:53:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:53:44 INFO - mozversion platform_version: 49.0a1 16:53:44 INFO - using testdate: 1461887624 16:53:44 INFO - actual date: 1461887624 16:53:44 INFO - starting webserver on 'localhost:57808' 16:53:44 INFO - SUITE-START | Running 2 tests 16:53:44 INFO - TEST-START | dromaeo_css 16:53:44 INFO - operating with platform_type : linux_ 16:53:44 INFO - Initialising browser for dromaeo_css test... 16:53:44 INFO - TEST-INFO | started process 10002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5aaBL/profile http://localhost:57808/getInfo.html) 16:53:48 INFO - PROCESS | 10002 | __metrics Screen width/height:1600/1200 16:53:48 INFO - PROCESS | 10002 | colorDepth:24 16:53:48 INFO - PROCESS | 10002 | Browser inner width/height: 1024/697 16:53:48 INFO - PROCESS | 10002 | __metrics 16:53:49 ERROR - PROCESS | 10002 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:53:50 INFO - TEST-INFO | 10002: exit 0 16:53:50 INFO - Browser initialized. 16:53:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:50 INFO - TEST-INFO | started process 10081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5aaBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:02 INFO - PROCESS | 10081 | RSS: Main: 156418048 16:54:02 INFO - PROCESS | 10081 | 16:54:53 INFO - PROCESS | 10081 | 1461887693766 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:06 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57808/tests/dromaeo/cssquery-ext.html) 16:57:07 INFO - PROCESS | 10081 | RSS: Main: 264110080 16:57:07 INFO - PROCESS | 10081 | 17:00:10 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-ext.html (next: http://localhost:57808/tests/dromaeo/cssquery-jquery.html) 17:00:11 INFO - PROCESS | 10081 | RSS: Main: 229232640 17:00:11 INFO - PROCESS | 10081 | 17:03:13 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57808/tests/dromaeo/cssquery-mootools.html) 17:03:13 INFO - PROCESS | 10081 | RSS: Main: 239431680 17:03:13 INFO - PROCESS | 10081 | 17:06:15 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57808/tests/dromaeo/cssquery-prototype.html) 17:06:16 INFO - PROCESS | 10081 | RSS: Main: 232919040 17:06:16 INFO - PROCESS | 10081 | 17:09:19 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57808/tests/dromaeo/cssquery-yui.html) 17:09:20 INFO - PROCESS | 10081 | RSS: Main: 215797760 17:09:20 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-yui.html (next: http://localhost:57808/tests/dromaeo/cssquery-dojo.html) 17:12:22 INFO - PROCESS | 10081 | RSS: Main: 268853248 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | __start_tp_report 17:12:22 INFO - PROCESS | 10081 | _x_x_mozilla_page_load 17:12:22 INFO - PROCESS | 10081 | _x_x_mozilla_page_load_details 17:12:22 INFO - PROCESS | 10081 | |i|pagename|runs| 17:12:22 INFO - PROCESS | 10081 | |0;dojo.html;2589.5079934812384;2676.408727983174;2680.8793604287807;2687.892484300628;2713.7828973682103;4587.81648734051;4645.488996210423;4647.814087436503;4659.557342052503;4677.204875171225;4606.631469482441;4652.534746525345;4713.457952335482;4716.693414928027;4727.314539391795;4273.829046838123;4293.656507479394;4296.990207301282;4354.673399495035;4459.17505261526;4378.16814805186;4378.693491455583;4424.0045989652235;4428.889277768066;4450.310201918708;4246;4257.425247591566;4292.806823692941;4334.674899382559;4352.8476503322545;4284.228838809013;4316.158349121891;4324.978375108136;4333.631641310492;4351.760653164075;4245.341971994346;4246.2356775780345;4267.445232119804;4287.399764033038;4301.419308393358;4406.250937340627;4489.1919454498175;4498.482674492442;4550.226461501553;4590.655700822452;4999.700017998932;5000.1999680051385;5006.499350065001;5009.2486127080865;5046.016026874761;4978.576820970222;4990.201567749143;4993.825216117455;5025.3718285214345;5051.722155281458;4564.246899261651;4582.656300777455;4636.095961287584;4662.953370466286;4664.346991421204;5072.442031376546;5073;5087.338645976073;5095.261187127846;5127.9230811537855;4887.437944636341;4891.217405215149;4891.5353041461;4892.217245240744;4941.431735350408;4871.732054737024;4923.261510773341;4964.35463389757;4988.152014157602;5014.473480284591;4880.487548807395;4899.485554016848;4905.23968784839;4909.5090490950615;4955.776990035457;4883.853484395474;4883.877903052452;4884.218525036048;4886.682365646222;4932.457429682732;4081.816318265626;4200.5169405518145;4202.075543380452;4211.136716973013;4258.829646814154;3645.1616128290643;3656.1590834107774;3696.131409118855;3711.6659500645073;3742.5321834770652;4250.234957707642;4253.5108462527205;4257.5529569395385;4297.484301883794;4297.957020429818;4884.609231261491;4958.553730164303;4971.1797553404;4986.750662466935;5059.392872855207;4243.575642435793;4283.571642835692;4301.849435269751;4327.307630779061;4343.522212556616;4488.102379524043;4512.75179865104;4515.07440974606;4523.615492683093;4557.931631025537;4601.654875884389;4687.835925742583;4753.619710423089;4756.619470442287;4769.284607308931;4943.134951383421;4963.553280204799;4963.553280204799;4967.354243948408;5012;4661.953380466288;4667.253239481666;4673.322368256516;4681.789319480564;4723.409573803275;4761.142994261067;4834.709917404967;4873.415190177201;4909.607231421549;4917.434495033117;4962.602991760723;4971.850844474671;4972.105021096093;4979.029089327546;5035.018171456531;4714.104320179155;4858.489858564941;4870.05034018363;4871.415430148263;4914.361133052823;4764.2615394613895;4788.904221915612;4796.616270698266;4818.373611430492;4844.0554091951735;4671.556202160789;4702.341672165831;4706.458757242961;4706.882327941828;4745.47799742035;4713.646476514206;4796.712197268175;4803.327534145153;4804.183288840975;4858.125537403302;4759.50025247344;4775.355327030807;4778.689385189951;4802.927956080732;4817.927731083966 17:12:22 INFO - PROCESS | 10081 | |1;ext.html;566.3656704490968;593.3917734322321;594.898867192577;598.5361344957655;615.6675395286544;27137.185884423474;27675.723242767566;27740.722592774066;27743.861280693593;33282.16794580137;35055.64944350556;35786.64213357866;35815.4627680585;35817.641823581755;35880.10299742508;7464.477486575942;7626.771196864103;7632.885506717404;7635.274648908345;7639.847203055935;7107.147142342926;7614;9444.8583271251;9761.755956101118;9771.75570610737;9824.263180261472;9952.800943981116;9956.452395118265;9964.402135871871;9966.2525310602;9799.363041402321;9880.40717556949;9925.602975880956;9933.403995760205;9936.95031524845;9725.124738773473;9850.753731156707;9860.50697465131;9883.752906177331;9885.555150018266;37113.25773484542;37622.4356634648;37670.81164594187;37695;37711.43432848509;2957.4972254716536;3010.9548356774667;3031.818090914552;3255.8209298488573;3335.116194208537;26670.73329266702;28051;28500.572491412437;28741.85629071862;29693.10920672383;3368.511565822942;3384.238546327081;3391.796492210475;3402.9659703403145;3445.0698311456017;182783;183393;183775.08112459487;183834;183863;51924.74037629863;52517.7374113127;52662.21006684903;52900;52961.2055819163;56163;56291.87416251652;56364.43635563674;56408.15387769187;56477.43522564722;13414.932925335312;13562.79655805144;13576.253306068262;13591.796123058162;13599.728005439836;9215.447073175497;10280.742981425525;10812.459377031117;10881.891181088246;10907.945460272647;15749.370025198863;15828.76256856148;15859.682806344039;15876.364945402285;16071.517854464384;6081.361457046946;6136.23297087864;6269.717862696099;6320.115183874169;6332.715027823759;869.5782545465444;909.3816204980677;917.4266083697689;971.9465429401309;976.2677991506371;27760.444791104066;28422.431551368856;28920.42159156805;28978.420431591672;29018.41963160725;955.3742298794162;986.9901300987042;1003.9397636141708;1015.3958394755109;1080.0765345629532;13016.284104374161;13473.797893031613;13548.119372240773;13705.314734263247;13755.931220343835;362453;365757;368840;369998;370766;46597.30104048442;47419;47506.28740568894;47548.28677569839;47565.5243447568;1078.9028987391016;1157.1957489544855;1211.5032836536977;1215.428748488209;1284.3642397013539;25179.49641007206;27315.726842731317;27650.308742281602;27802.582961255193;27802.582961256;38780.80609597047;38964.805175975074;39149.21701565896;39207;39261.607383925795;236263;236930;237161;237291;237613;20669.793302066788;22831.31506054821;23594;23776.52446951017;24650.87674561616;35502.644973549934;35785.1053723659;35792.64207357893;36399;36820.63179368172;31108;31646.683533164374;31700.841495793295;34117.658823411446;34579;32916.50625240671;33241.83379083089;33321.333573328884;33460.66539334576;33640.327193456484;32562.348753025282;32956.34087318288;33264.1683957903;33323.333533329685;33543;29096.27259318534;31446.528302075945;31540.211494712818;31632.367352653277;31644.208894777814;24379.51240975135;24385.51228975375;24594.385140371633;24960.50078998446;24967.375815604028 17:12:22 INFO - PROCESS | 10081 | |2;jquery.html;378.249175386857;381.5192857000179;382.43017903324045;398.4501388084443;401.1255463090462;15985.440509582168;17347.132643367844;18068.90965545174;18080.095995200238;18110.728339074925;16580.917095414537;16925;17127.31490740372;17318.307267709308;17335.566610834736;5092.134337162673;5198.8700282493055;5198.896022079556;5219.616801547593;5241.973790131044;3727.9813600931957;3910.804459777;5678.375378708339;5985;5992.460678538931;5869.9706501467645;5919.852003699899;5920.615160014585;5947.078202878561;5948.167256584082;5712.314522257335;5827.4755272025295;5855.560832937546;5861.618994765348;5865.589408741411;3402.642722514125;4995.475475075101;5236.973815130938;5240.449752775941;5247.763850626731;11551.595694150665;12138.332391718452;12158.392080396034;19427;19557.804421955883;1817.3094224194854;1931.1599454237312;1941.3108346536917;2093.7801530839197;2290.8510946788406;9094.226990705798;9424.434533927986;9748.025197480267;11871.584494542736;12119.454624541828;1721.5382003734655;1790.3912669692368;1808.8733788634802;1827.2964908510187;1832.2579355360967;67625.3237467629;69635.65182174108;71117;72344.63827680881;72617.99999999948;9802.9019709802;9954.502274886227;10019.398836069859;10082.19342452602;10169.186465082776;14195.290235488184;14284.928575357057;14289.857101429061;14312.06971546867;14324.785128223086;7185;7246.058012458347;7248.4563657725885;7401.703931842666;7426.368758655467;6777.322267773183;6785.423239024738;6820.693068811816;6903.1716194057035;6905.067815844897;4403.546829546242;4429.557044295545;4431.556844315543;4438.822447102144;4466.932996005063;1686.9493915182563;1809.6199798042296;1833.8532917366845;1840.558156247825;1849.1246112295241;877.0396415924553;880.7754022724164;904.8733177355175;937.7983733497331;979.6130528441369;16272.674546509004;17203.741943870853;17281;17567.472975810746;17594.472165835046;852.9061803201643;861.3109512390188;883.4169448164181;887.9334049946151;921.6589861751195;9372.67195648149;9682.612695492102;9716;9737;9800.26498012652;407278;411661;422290;424870;426419;44718.55281447144;83247.58376208201;83818;84406.15593844106;85863.14136858676;924.5007695844304;936.5036530638772;945.6075728572703;960.011188475871;963.017721923634;15287.694246114794;15358.539243822703;15508.147051912254;15574.454894078654;15762.211889405713;34636.82681586576;35405.82297088498;35579.466308004885;35995.46006809847;36081.78991550534;48414.27378589394;49457.50542494529;49891.25163122629;54572.181417279564;55054.44945550493;7493.325600695964;7923.524588524707;8053.919460805317;8055.718049868226;8173.550454724809;10752.83870741955;11085.50115244832;11300.547978081113;11782.882171178522;11793.52825886955;9838.9016109838;9970.50147492637;9976.800463990825;9997.450140242356;10031.448270345201;9947.900520994697;10140.442275674908;10189.388636681526;10248.128909042814;10271.281010329205;9896;10180.13468855126;10285.640002599874;10359.482025898826;10381.418410648314;7714.614269286625;7735.226477352445;7852.332551733167;7897.881531776913;8061.87907181381;7706.460547761603;9476.763080923032;9809.117179453884;9912.553935072794;9932.652357167464 17:12:22 INFO - PROCESS | 10081 | |3;mootools.html;1292.5023865811672;1450.5648305508346;1480.4596322342343;1614.3703955457374;1805.377144885014;6867.656617169147;7751.6511756971;7963.92036079639;8001.239882211188;8004.759857204279;7664.731734389297;7820.335271501915;7847.568383738892;7849.45053846231;7869.252421020008;1913.2538310059088;1953.5116220944765;1964.008175871183;2234.754177040524;2267.9886600566974;2210.126999835064;2295.3572999560065;2295.747467778543;2301.0450662974845;2302.1482051640833;2227.6435770276757;2253.1550668499312;2258.503129311557;2260.8643481391086;2267.319804058784;1887.9339223127263;2199.373178644095;2238.8880555972137;2245.8427910046303;2249.8425110242288;2209.624363858148;2235.0947866114248;2237.116339046084;2238.8656680599215;2239.8656080635214;7780.688772449095;7843.529388236724;7852.097008843999;7857;7860.68557257709;4449.377087207794;4632.050429661911;4634.791434385461;4636.605888499482;4644.651651126179;2825.2795537138104;3003;3046.8933587324336;3054.083774867553;3066.923326916845;941.9199368053723;957.3681370295641;972.2853702528636;973.1193270090579;983.1986930651497;10911.83632245517;10929.945350273198;10930.234883558154;10930.726731831688;10948.4525773711;4184.456020717348;4234.491860976641;4252.723572967747;4362.236608593484;4364.8908777280185;9214.262858971266;9255.67605133817;9265.768355791159;9265.861012084824;9280.767980800534;4706;4762.9523704763205;4768.570828625371;4771.33201351811;4774.140654682191;3684.9263014739554;3935.822887970048;4154.813033413504;4274.935875961863;4346.869593912188;3560.3413368526903;3578.1054736315923;3593.065802891267;3669.3945498992366;3698.0569954661387;1186.7389174381622;1211.7455334379704;1220.993895030519;1227.9623717958311;1235.2897084176634;697.285282585354;849.7450764770545;890.7550423633423;901.1439132823843;902.3457992955186;5227.921581176285;5483.122700367922;5504.174373843955;5515.531179849678;5556.638818476786;395.7210166832376;404.1270854953287;406.3660689324663;409.1571362992186;409.633378126581;3292.9176770580925;3658.1951970566965;3680.411134218512;3683.244934788362;3732.458793474931;9563;9965.501724913725;9972.750681232883;9986.900130998742;9987.40075595452;9090.409123406956;9481.952590237004;9726.416415015121;9885.851712224323;9893.703188904345;7058.6823592938445;7203.603801790951;7205.423566114699;7209.134903811576;7236.674349654279;5229.816956406507;5426.728663566885;5476.288082549243;5534.4742249486235;5583.246261754611;8800.955995219983;8828.470291782514;8927.285817134743;9065.77335566616;9147.039560846015;8992.775180620536;9148.268138548767;9159.587818548049;9221.585028673591;9223.58493867764;6294.874102517832;6899.344562266577;7003.7548685795755;7149.0706208192605;7154.67803948834;7613.162552119373;7656.846863062596;7718;7722.884156737766;7738.806529836799;6923.307669233238;7100.467464940047;7121.608311542915;7182.748603798842;7284.927150728637;6686.632235226914;6704.229013663491;6943.826404339932;7009.228984811564;7137.928620713934;6146.200993870768;6220.413794482378;6234.688265586793;6257.217847769029;6293.559450838397;4605.539446055502;4631.606313463393;4634.073185362873;4680.344751734828;4693.436787585511;4484.461864576272;4500.347449619852;4562.612177964777;4627.30590411441;4665.113628410591 17:12:22 INFO - PROCESS | 10081 | |4;prototype.html;303.76761777240415;310.52954773518127;318.60174781523096;319.2625036166456;319.9504076868085;4556.225441674915;4673.761453214892;4739.857804265873;4761.976175122348;4794.137055330039;4563.931541026879;4710.85867423977;4718.41019872516;4721.945953510225;4730.597899178574;3768.755030922988;3790.9431358529646;3792.4500947362617;3800.600936901627;3822.4075268333313;3585.4980302757635;3637.308911306843;3805.448210009547;3811.256804923027;3811.4092315690973;3766.133789228479;3770.0386401467586;3777.6411240932207;3800.548646123249;3803.0682482791754;3750.324941510527;3755.36158852997;3786.2616789726017;3787.6591106800242;3790.564085130218;3373.9831300843584;3382.0046172757943;3384.6446123157207;3386.6613338666184;3394.7778799632115;4417.845375411845;4491.8096704373365;4519.548045195487;4531.252343363374;4550.158220729176;4289.185054839601;4295.183915056161;4303.978480107611;4307.978460107679;4317.870463886088;4913.14020046494;4920.114379411704;4939.753012349368;4944.208926571767;4951.777170027357;3523.119220194951;3659.8170091495317;3666.4866918631415;3671.5777685566236;3674.1365779041903;5125.103106956268;5167.767450464738;5179.533841954205;5181.020912975055;5181.818636347747;3749.2314075614436;3754.5682246541996;3777.905552361213;3794.734368594172;3806.809659517013;3813.7139714521522;3816.2939856126704;3836.712246581518;3844.519435070616;3845.4616353710503;4009.3585026395635;4241.406203131564;4244.469441319835;4248.957510424918;4252.766097864585;4971.552560269593;4989.401271847401;4991.700497970133;4992.475790041994;5014.84955451337;1268.758935802213;1315.9144655597356;1333.306680526121;1367.4871923028863;1370.5545697648304;917.5779141594941;918.7151982885327;924.357571487823;936.4334577580602;936.6908920056366;4650.697704649187;4658.208104622222;4660.440747110369;4661.319741148853;4670.042641258534;5488.25908502355;5489.423610520837;5490;5490.588205884575;5503.3395992481155;4228.76741779199;4603.194440972883;4633.698809577367;4655.789494731394;4669.7431641260055;2949.3069128754723;2949.6902825203474;2958.2012856528618;2975.1818249980997;2976.4493568689863;5206.193040078794;5208.7916483341;5234.7906083756225;5252.789888404497;5254.2118682197215;5493.2034854945805;5683.261176047087;5695.743691533891;5709.800156994485;5726.0838265877255;5217.1652535594885;5236.92144617831;5237;5245.6852588844795;5254.4220135785035;5571.303587051619;5572.4706152915405;5576;5603.663780173202;5608.691521966331;5340.225667278145;5393.166323450046;5424.972875135599;5476.890462190813;5485.094959331665;5188.818391356435;5194.844154675366;5212.081234508687;5246.790128394821;5265.447128051653;3856.672182864488;3862.111714305669;3873.9225215496094;3894.727369084137;3897.5517815450453;4890.364252647133;5359.062164121341;5535.446455354432;5547.694876781816;5551.195076713773;4873.171560834738;5021.543752311789;5078.314427552381;5086.54221120101;5093.796248150033;5037.395512538519;5052.797888084436;5053.469385714594;5056.696598204119;5070.3155074064525;4845.830395936126;4971.428285747041;4982.003599280086;4985.252212168204;4994.625403094709;5041.697498150123;5042.520960508746;5069.797208111634;5087.262346959744;5095.579599690266;4962.181240095344;4969.726665033458;4971.9502804972935;4978.47725988766;4985.407588054264 17:12:22 INFO - PROCESS | 10081 | |5;yui.html;699.1295836683329;721.9458540609455;724.518195400059;725.4015437264259;733.8458923626039;10819.567217311307;13124.606261812149;13620.727585448285;13627.182369057864;13647.795283070736;12676.746465070693;12758.489660413572;12759.872401275985;12814.743705125915;12821.743565128716;635.993640063598;790.9723159689427;799.4244144216184;800.8678568036296;801.0107517216234;781.620913856779;810.8175660476375;815.0545367373848;815.388458656008;815.4984684419069;831.222806675757;833.9708110216144;837.4807619276057;838.0237023867187;838.1116017021976;663.0750103605492;818.8812622169752;821.3593397150232;829.4525613095358;830.6220669595319;619.6684773646123;620.8944479438507;622.1787240842091;623.2801114712469;623.7847942459844;12312.26126432417;12402.75194496105;12409.62771116868;12440.688982775413;12462.065345099154;11292.378919159442;11674.474648640831;11845.111616628701;11872;12074.215176013531;9588.520573971344;9681.66114186;9755.36590121647;9853.310268281222;9910.752231194207;3180.77734558581;3244.9351012979846;3274.1650879025933;3279.360524697685;3282.9986854009517;49320.50679493195;49473.50526494725;49656;49770.25344619834;50006.499935000546;9400.576974036185;9415.858762118574;9427.207043017932;9458.85811712825;9476.526173691287;16784.32862685479;16900.661986760195;16950.321987120376;16973.91513042427;17096.230669619898;6416.262129855033;6450.516211284173;6532;6541.934580654132;6567.9671601641685;3680.9263814723554;3779.3197224499854;3853.421986702017;3881.340172170738;3917.05990562263;2784.972150278512;2856.8428736419282;2857.914262572126;2858.6140870982567;2859.814112082708;491.78607305822084;503.0517474560407;506.2482213912337;509.2590281140931;510.80589376037614;577.5610535992591;606.9241344831896;613.3743581546797;618.1932577985772;634.7238951056213;8215.465994710325;8307.471235692683;8311.584420778936;8524.232819046316;8531.74404767858;473.9763011849463;537.5757515646176;544.8365490352878;597.7758340622266;611.8531552427474;3872.4772155759174;3875.6899448044087;3942.3889297158985;3958.6437220650278;4005.8798236052967;54455.45544544504;55268;56643.43356566464;56708.43291567032;57029.14456283159;49943.50056499461;50323.24515132276;50524.74737626289;50876.49123508792;51238.48761512412;45137.54862451399;45562.316565251545;45734;46073.76963115163;46591.76704116526;7441.181470038183;7451.627418628938;7572.280633339824;7587.696492140473;7665.540067595962;30657.386852263277;31172.53241201429;32024.67975320217;32217.51673724849;32558;40121.39817902792;40236.798816005736;40330.79834600808;40487.392689109096;40516.797416012734;8504.872426913726;9184.58669359867;9272.814543708953;9399.765005874908;9513.66702165421;9738.464384458639;9778.9022109778;9855.605775768889;9887.357321774061;9944.944246075329;9235.861462077939;9427.858582121136;9430.858537121812;9469.337146399686;9497.667581634609;9863.210943124677;9881.407115573089;10035.949820250851;10055.798884022131;10140.290179687647;8900.777480563038;9606.039396060338;9735.41587504752;9748.9025109748;9812.313138080266;7784.844303113793;8076.313513351431;8092.215235214453;8187.672493100209;8623.439476434012;8159.428839981382;8198;8254.752357429286;8561.44350617208;8691.435056721293 17:12:22 INFO - PROCESS | 10081 | __end_tp_report 17:12:22 INFO - PROCESS | 10081 | __start_cc_report 17:12:22 INFO - PROCESS | 10081 | _x_x_mozilla_cycle_collect,1066 17:12:22 INFO - PROCESS | 10081 | __end_cc_report 17:12:22 INFO - PROCESS | 10081 | __startTimestamp1461888742965__endTimestamp 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | ------- Summary: start ------- 17:12:22 INFO - PROCESS | 10081 | Number of tests: 6 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#0] dojo.html Cycles:165 Average:4594.55 Median:4713.46 stddev:463.55 (9.8%) stddev-sans-first:437.47 17:12:22 INFO - PROCESS | 10081 | Values: 2589.5 2676.4 2680.9 2687.9 2713.8 4587.8 4645.5 4647.8 4659.6 4677.2 4606.6 4652.5 4713.5 4716.7 4727.3 4273.8 4293.7 4297.0 4354.7 4459.2 4378.2 4378.7 4424.0 4428.9 4450.3 4246.0 4257.4 4292.8 4334.7 4352.8 4284.2 4316.2 4325.0 4333.6 4351.8 4245.3 4246.2 4267.4 4287.4 4301.4 4406.3 4489.2 4498.5 4550.2 4590.7 4999.7 5000.2 5006.5 5009.2 5046.0 4978.6 4990.2 4993.8 5025.4 5051.7 4564.2 4582.7 4636.1 4663.0 4664.3 5072.4 5073.0 5087.3 5095.3 5127.9 4887.4 4891.2 4891.5 4892.2 4941.4 4871.7 4923.3 4964.4 4988.2 5014.5 4880.5 4899.5 4905.2 4909.5 4955.8 4883.9 4883.9 4884.2 4886.7 4932.5 4081.8 4200.5 4202.1 4211.1 4258.8 3645.2 3656.2 3696.1 3711.7 3742.5 4250.2 4253.5 4257.6 4297.5 4298.0 4884.6 4958.6 4971.2 4986.8 5059.4 4243.6 4283.6 4301.8 4327.3 4343.5 4488.1 4512.8 4515.1 4523.6 4557.9 4601.7 4687.8 4753.6 4756.6 4769.3 4943.1 4963.6 4963.6 4967.4 5012.0 4662.0 4667.3 4673.3 4681.8 4723.4 4761.1 4834.7 4873.4 4909.6 4917.4 4962.6 4971.9 4972.1 4979.0 5035.0 4714.1 4858.5 4870.1 4871.4 4914.4 4764.3 4788.9 4796.6 4818.4 4844.1 4671.6 4702.3 4706.5 4706.9 4745.5 4713.6 4796.7 4803.3 4804.2 4858.1 4759.5 4775.4 4778.7 4802.9 4817.9 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#1] ext.html Cycles:180 Average:41647.77 Median:3376.38 stddev:72086.23 (2135.0%) stddev-sans-first:72222.46 17:12:22 INFO - PROCESS | 10081 | Values: 566.4 593.4 594.9 598.5 615.7 27137.2 27675.7 27740.7 27743.9 33282.2 35055.6 35786.6 35815.5 35817.6 35880.1 7464.5 7626.8 7632.9 7635.3 7639.8 7107.1 7614.0 9444.9 9761.8 9771.8 9824.3 9952.8 9956.5 9964.4 9966.3 9799.4 9880.4 9925.6 9933.4 9937.0 9725.1 9850.8 9860.5 9883.8 9885.6 37113.3 37622.4 37670.8 37695.0 37711.4 2957.5 3011.0 3031.8 3255.8 3335.1 26670.7 28051.0 28500.6 28741.9 29693.1 3368.5 3384.2 3391.8 3403.0 3445.1 182783.0 183393.0 183775.1 183834.0 183863.0 51924.7 52517.7 52662.2 52900.0 52961.2 56163.0 56291.9 56364.4 56408.2 56477.4 13414.9 13562.8 13576.3 13591.8 13599.7 9215.4 10280.7 10812.5 10881.9 10907.9 15749.4 15828.8 15859.7 15876.4 16071.5 6081.4 6136.2 6269.7 6320.1 6332.7 869.6 909.4 917.4 971.9 976.3 27760.4 28422.4 28920.4 28978.4 29018.4 955.4 987.0 1003.9 1015.4 1080.1 13016.3 13473.8 13548.1 13705.3 13755.9 362453.0 365757.0 368840.0 369998.0 370766.0 46597.3 47419.0 47506.3 47548.3 47565.5 1078.9 1157.2 1211.5 1215.4 1284.4 25179.5 27315.7 27650.3 27802.6 27802.6 38780.8 38964.8 39149.2 39207.0 39261.6 236263.0 236930.0 237161.0 237291.0 237613.0 20669.8 22831.3 23594.0 23776.5 24650.9 35502.6 35785.1 35792.6 36399.0 36820.6 31108.0 31646.7 31700.8 34117.7 34579.0 32916.5 33241.8 33321.3 33460.7 33640.3 32562.3 32956.3 33264.2 33323.3 33543.0 29096.3 31446.5 31540.2 31632.4 31644.2 24379.5 24385.5 24594.4 24960.5 24967.4 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#2] jquery.html Cycles:180 Average:25005.87 Median:27443.36 stddev:69013.48 (251.5%) stddev-sans-first:69182.31 17:12:22 INFO - PROCESS | 10081 | Values: 378.2 381.5 382.4 398.5 401.1 15985.4 17347.1 18068.9 18080.1 18110.7 16580.9 16925.0 17127.3 17318.3 17335.6 5092.1 5198.9 5198.9 5219.6 5242.0 3728.0 3910.8 5678.4 5985.0 5992.5 5870.0 5919.9 5920.6 5947.1 5948.2 5712.3 5827.5 5855.6 5861.6 5865.6 3402.6 4995.5 5237.0 5240.4 5247.8 11551.6 12138.3 12158.4 19427.0 19557.8 1817.3 1931.2 1941.3 2093.8 2290.9 9094.2 9424.4 9748.0 11871.6 12119.5 1721.5 1790.4 1808.9 1827.3 1832.3 67625.3 69635.7 71117.0 72344.6 72618.0 9802.9 9954.5 10019.4 10082.2 10169.2 14195.3 14284.9 14289.9 14312.1 14324.8 7185.0 7246.1 7248.5 7401.7 7426.4 6777.3 6785.4 6820.7 6903.2 6905.1 4403.5 4429.6 4431.6 4438.8 4466.9 1686.9 1809.6 1833.9 1840.6 1849.1 877.0 880.8 904.9 937.8 979.6 16272.7 17203.7 17281.0 17567.5 17594.5 852.9 861.3 883.4 887.9 921.7 9372.7 9682.6 9716.0 9737.0 9800.3 407278.0 411661.0 422290.0 424870.0 426419.0 44718.6 83247.6 83818.0 84406.2 85863.1 924.5 936.5 945.6 960.0 963.0 15287.7 15358.5 15508.1 15574.5 15762.2 34636.8 35405.8 35579.5 35995.5 36081.8 48414.3 49457.5 49891.3 54572.2 55054.4 7493.3 7923.5 8053.9 8055.7 8173.6 10752.8 11085.5 11300.5 11782.9 11793.5 9838.9 9970.5 9976.8 9997.5 10031.4 9947.9 10140.4 10189.4 10248.1 10271.3 9896.0 10180.1 10285.6 10359.5 10381.4 7714.6 7735.2 7852.3 7897.9 8061.9 7706.5 9476.8 9809.1 9912.6 9932.7 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#3] mootools.html Cycles:180 Average:5200.55 Median:5228.87 stddev:2940.87 (56.2%) stddev-sans-first:2934.45 17:12:22 INFO - PROCESS | 10081 | Values: 1292.5 1450.6 1480.5 1614.4 1805.4 6867.7 7751.7 7963.9 8001.2 8004.8 7664.7 7820.3 7847.6 7849.5 7869.3 1913.3 1953.5 1964.0 2234.8 2268.0 2210.1 2295.4 2295.7 2301.0 2302.1 2227.6 2253.2 2258.5 2260.9 2267.3 1887.9 2199.4 2238.9 2245.8 2249.8 2209.6 2235.1 2237.1 2238.9 2239.9 7780.7 7843.5 7852.1 7857.0 7860.7 4449.4 4632.1 4634.8 4636.6 4644.7 2825.3 3003.0 3046.9 3054.1 3066.9 941.9 957.4 972.3 973.1 983.2 10911.8 10929.9 10930.2 10930.7 10948.5 4184.5 4234.5 4252.7 4362.2 4364.9 9214.3 9255.7 9265.8 9265.9 9280.8 4706.0 4763.0 4768.6 4771.3 4774.1 3684.9 3935.8 4154.8 4274.9 4346.9 3560.3 3578.1 3593.1 3669.4 3698.1 1186.7 1211.7 1221.0 1228.0 1235.3 697.3 849.7 890.8 901.1 902.3 5227.9 5483.1 5504.2 5515.5 5556.6 395.7 404.1 406.4 409.2 409.6 3292.9 3658.2 3680.4 3683.2 3732.5 9563.0 9965.5 9972.8 9986.9 9987.4 9090.4 9482.0 9726.4 9885.9 9893.7 7058.7 7203.6 7205.4 7209.1 7236.7 5229.8 5426.7 5476.3 5534.5 5583.2 8801.0 8828.5 8927.3 9065.8 9147.0 8992.8 9148.3 9159.6 9221.6 9223.6 6294.9 6899.3 7003.8 7149.1 7154.7 7613.2 7656.8 7718.0 7722.9 7738.8 6923.3 7100.5 7121.6 7182.7 7284.9 6686.6 6704.2 6943.8 7009.2 7137.9 6146.2 6220.4 6234.7 6257.2 6293.6 4605.5 4631.6 4634.1 4680.3 4693.4 4484.5 4500.3 4562.6 4627.3 4665.1 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#4] prototype.html Cycles:180 Average:4281.92 Median:4726.27 stddev:1248.49 (26.4%) stddev-sans-first:1215.77 17:12:22 INFO - PROCESS | 10081 | Values: 303.8 310.5 318.6 319.3 320.0 4556.2 4673.8 4739.9 4762.0 4794.1 4563.9 4710.9 4718.4 4721.9 4730.6 3768.8 3790.9 3792.5 3800.6 3822.4 3585.5 3637.3 3805.4 3811.3 3811.4 3766.1 3770.0 3777.6 3800.5 3803.1 3750.3 3755.4 3786.3 3787.7 3790.6 3374.0 3382.0 3384.6 3386.7 3394.8 4417.8 4491.8 4519.5 4531.3 4550.2 4289.2 4295.2 4304.0 4308.0 4317.9 4913.1 4920.1 4939.8 4944.2 4951.8 3523.1 3659.8 3666.5 3671.6 3674.1 5125.1 5167.8 5179.5 5181.0 5181.8 3749.2 3754.6 3777.9 3794.7 3806.8 3813.7 3816.3 3836.7 3844.5 3845.5 4009.4 4241.4 4244.5 4249.0 4252.8 4971.6 4989.4 4991.7 4992.5 5014.8 1268.8 1315.9 1333.3 1367.5 1370.6 917.6 918.7 924.4 936.4 936.7 4650.7 4658.2 4660.4 4661.3 4670.0 5488.3 5489.4 5490.0 5490.6 5503.3 4228.8 4603.2 4633.7 4655.8 4669.7 2949.3 2949.7 2958.2 2975.2 2976.4 5206.2 5208.8 5234.8 5252.8 5254.2 5493.2 5683.3 5695.7 5709.8 5726.1 5217.2 5236.9 5237.0 5245.7 5254.4 5571.3 5572.5 5576.0 5603.7 5608.7 5340.2 5393.2 5425.0 5476.9 5485.1 5188.8 5194.8 5212.1 5246.8 5265.4 3856.7 3862.1 3873.9 3894.7 3897.6 4890.4 5359.1 5535.4 5547.7 5551.2 4873.2 5021.5 5078.3 5086.5 5093.8 5037.4 5052.8 5053.5 5056.7 5070.3 4845.8 4971.4 4982.0 4985.3 4994.6 5041.7 5042.5 5069.8 5087.3 5095.6 4962.2 4969.7 4972.0 4978.5 4985.4 17:12:22 INFO - PROCESS | 10081 | 17:12:22 INFO - PROCESS | 10081 | [#5] yui.html Cycles:180 Average:12976.50 Median:615.78 stddev:15634.42 (2538.9%) stddev-sans-first:15651.10 17:12:22 INFO - PROCESS | 10081 | Values: 699.1 721.9 724.5 725.4 733.8 10819.6 13124.6 13620.7 13627.2 13647.8 12676.7 12758.5 12759.9 12814.7 12821.7 636.0 791.0 799.4 800.9 801.0 781.6 810.8 815.1 815.4 815.5 831.2 834.0 837.5 838.0 838.1 663.1 818.9 821.4 829.5 830.6 619.7 620.9 622.2 623.3 623.8 12312.3 12402.8 12409.6 12440.7 12462.1 11292.4 11674.5 11845.1 11872.0 12074.2 9588.5 9681.7 9755.4 9853.3 9910.8 3180.8 3244.9 3274.2 3279.4 3283.0 49320.5 49473.5 49656.0 49770.3 50006.5 9400.6 9415.9 9427.2 9458.9 9476.5 16784.3 16900.7 16950.3 16973.9 17096.2 6416.3 6450.5 6532.0 6541.9 6568.0 3680.9 3779.3 3853.4 3881.3 3917.1 2785.0 2856.8 2857.9 2858.6 2859.8 491.8 503.1 506.2 509.3 510.8 577.6 606.9 613.4 618.2 634.7 8215.5 8307.5 8311.6 8524.2 8531.7 474.0 537.6 544.8 597.8 611.9 3872.5 3875.7 3942.4 3958.6 4005.9 54455.5 55268.0 56643.4 56708.4 57029.1 49943.5 50323.2 50524.7 50876.5 51238.5 45137.5 45562.3 45734.0 46073.8 46591.8 7441.2 7451.6 7572.3 7587.7 7665.5 30657.4 31172.5 32024.7 32217.5 32558.0 40121.4 40236.8 40330.8 40487.4 40516.8 8504.9 9184.6 9272.8 9399.8 9513.7 9738.5 9778.9 9855.6 9887.4 9944.9 9235.9 9427.9 9430.9 9469.3 9497.7 9863.2 9881.4 10035.9 10055.8 10140.3 8900.8 9606.0 9735.4 9748.9 9812.3 7784.8 8076.3 8092.2 8187.7 8623.4 8159.4 8198.0 8254.8 8561.4 8691.4 17:12:22 INFO - PROCESS | 10081 | -------- Summary: end -------- 17:12:22 INFO - PROCESS | 10081 | 17:12:23 INFO - TEST-INFO | 10081: exit 0 17:12:23 INFO - TEST-OK | dromaeo_css | took 1119309ms 17:12:23 INFO - TEST-START | kraken 17:12:23 INFO - operating with platform_type : linux_ 17:12:23 INFO - Initialising browser for kraken test... 17:12:23 INFO - TEST-INFO | started process 10261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8GJRXV/profile http://localhost:57808/getInfo.html) 17:12:27 INFO - PROCESS | 10261 | __metrics Screen width/height:1600/1200 17:12:27 INFO - PROCESS | 10261 | colorDepth:24 17:12:27 INFO - PROCESS | 10261 | Browser inner width/height: 1024/697 17:12:27 INFO - PROCESS | 10261 | __metrics 17:12:28 ERROR - PROCESS | 10261 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:12:29 INFO - TEST-INFO | 10261: exit 0 17:12:29 INFO - Browser initialized. 17:12:29 INFO - Running cycle 1/1 for kraken test... 17:12:29 INFO - TEST-INFO | started process 10340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8GJRXV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:41 INFO - PROCESS | 10340 | RSS: Main: 155914240 17:12:41 INFO - PROCESS | 10340 | 17:12:44 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:45 INFO - PROCESS | 10340 | RSS: Main: 211161088 17:12:45 INFO - PROCESS | 10340 | 17:12:47 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-dft) 17:12:48 INFO - PROCESS | 10340 | RSS: Main: 195997696 17:12:48 INFO - PROCESS | 10340 | 17:12:51 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-fft) 17:12:52 INFO - PROCESS | 10340 | RSS: Main: 268132352 17:12:52 INFO - PROCESS | 10340 | 17:12:54 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-oscillator) 17:12:55 INFO - PROCESS | 10340 | RSS: Main: 175882240 17:12:55 INFO - PROCESS | 10340 | 17:12:57 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:57 INFO - PROCESS | 10340 | RSS: Main: 179892224 17:12:57 INFO - PROCESS | 10340 | 17:13:01 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:01 INFO - PROCESS | 10340 | RSS: Main: 215752704 17:13:01 INFO - PROCESS | 10340 | 17:13:05 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:05 INFO - PROCESS | 10340 | RSS: Main: 213434368 17:13:05 INFO - PROCESS | 10340 | 17:13:08 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57808/tests/kraken/driver.html?testName=json-parse-financial) 17:13:09 INFO - PROCESS | 10340 | RSS: Main: 214872064 17:13:09 INFO - PROCESS | 10340 | 17:13:10 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:11 INFO - PROCESS | 10340 | RSS: Main: 203812864 17:13:11 INFO - PROCESS | 10340 | 17:13:13 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:14 INFO - PROCESS | 10340 | RSS: Main: 206098432 17:13:14 INFO - PROCESS | 10340 | 17:13:16 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:16 INFO - PROCESS | 10340 | RSS: Main: 217923584 17:13:16 INFO - PROCESS | 10340 | 17:13:19 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:20 INFO - PROCESS | 10340 | RSS: Main: 224882688 17:13:20 INFO - PROCESS | 10340 | 17:13:23 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:23 INFO - PROCESS | 10340 | RSS: Main: 222879744 17:13:23 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57808/tests/kraken/driver.html?testName=ai-astar) 17:13:25 INFO - PROCESS | 10340 | RSS: Main: 286015488 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | __start_tp_report 17:13:25 INFO - PROCESS | 10340 | _x_x_mozilla_page_load 17:13:25 INFO - PROCESS | 10340 | _x_x_mozilla_page_load_details 17:13:25 INFO - PROCESS | 10340 | |i|pagename|runs| 17:13:25 INFO - PROCESS | 10340 | |0;ai-astar;112;113;109;113;113;115;102;112;112;112 17:13:25 INFO - PROCESS | 10340 | |1;audio-beat-detection;154;132;155;184;131;157;155;140;195;133 17:13:25 INFO - PROCESS | 10340 | |2;audio-dft;160;160;160;158;161;161;162;161;161;162 17:13:25 INFO - PROCESS | 10340 | |3;audio-fft;76;76;123;115;74;73;75;112;109;73 17:13:25 INFO - PROCESS | 10340 | |4;audio-oscillator;94;95;142;94;94;94;145;94;94;152 17:13:25 INFO - PROCESS | 10340 | |5;imaging-gaussian-blur;118;117;117;117;117;117;119;116;116;117 17:13:25 INFO - PROCESS | 10340 | |6;imaging-darkroom;145;146;146;146;146;147;145;145;146;146 17:13:25 INFO - PROCESS | 10340 | |7;imaging-desaturate;94;95;95;95;95;94;95;94;95;95 17:13:25 INFO - PROCESS | 10340 | |8;json-parse-financial;72;66;66;64;65;65;66;85;62;62 17:13:25 INFO - PROCESS | 10340 | |9;json-stringify-tinderbox;66;65;65;65;64;65;65;65;66;65 17:13:25 INFO - PROCESS | 10340 | |10;stanford-crypto-aes;79;78;79;78;79;79;79;79;79;78 17:13:25 INFO - PROCESS | 10340 | |11;stanford-crypto-ccm;137;130;129;132;132;133;137;141;168;138 17:13:25 INFO - PROCESS | 10340 | |12;stanford-crypto-pbkdf2;178;175;179;180;175;186;179;173;173;172 17:13:25 INFO - PROCESS | 10340 | |13;stanford-crypto-sha256-iterative;72;71;72;71;70;72;74;72;70;70 17:13:25 INFO - PROCESS | 10340 | __end_tp_report 17:13:25 INFO - PROCESS | 10340 | __start_cc_report 17:13:25 INFO - PROCESS | 10340 | _x_x_mozilla_cycle_collect,1907 17:13:25 INFO - PROCESS | 10340 | __end_cc_report 17:13:25 INFO - PROCESS | 10340 | __startTimestamp1461888805923__endTimestamp 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | ------- Summary: start ------- 17:13:25 INFO - PROCESS | 10340 | Number of tests: 14 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.59 (3.2%) stddev-sans-first:3.80 17:13:25 INFO - PROCESS | 10340 | Values: 112.0 113.0 109.0 113.0 113.0 115.0 102.0 112.0 112.0 112.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:155.00 stddev:21.71 (14.0%) stddev-sans-first:23.02 17:13:25 INFO - PROCESS | 10340 | Values: 154.0 132.0 155.0 184.0 131.0 157.0 155.0 140.0 195.0 133.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 17:13:25 INFO - PROCESS | 10340 | Values: 160.0 160.0 160.0 158.0 161.0 161.0 162.0 161.0 161.0 162.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#3] audio-fft Cycles:10 Average:90.60 Median:73.50 stddev:21.10 (28.7%) stddev-sans-first:21.71 17:13:25 INFO - PROCESS | 10340 | Values: 76.0 76.0 123.0 115.0 74.0 73.0 75.0 112.0 109.0 73.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.33 (26.9%) stddev-sans-first:26.21 17:13:25 INFO - PROCESS | 10340 | Values: 94.0 95.0 142.0 94.0 94.0 94.0 145.0 94.0 94.0 152.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 17:13:25 INFO - PROCESS | 10340 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 116.0 117.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:13:25 INFO - PROCESS | 10340 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 146.0 146.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:13:25 INFO - PROCESS | 10340 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:66.00 stddev:6.82 (10.3%) stddev-sans-first:7.01 17:13:25 INFO - PROCESS | 10340 | Values: 72.0 66.0 66.0 64.0 65.0 65.0 66.0 85.0 62.0 62.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 17:13:25 INFO - PROCESS | 10340 | Values: 66.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 17:13:25 INFO - PROCESS | 10340 | Values: 79.0 78.0 79.0 78.0 79.0 79.0 79.0 79.0 79.0 78.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:137.00 stddev:11.31 (8.3%) stddev-sans-first:12.00 17:13:25 INFO - PROCESS | 10340 | Values: 137.0 130.0 129.0 132.0 132.0 133.0 137.0 141.0 168.0 138.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.50 stddev:4.27 (2.4%) stddev-sans-first:4.51 17:13:25 INFO - PROCESS | 10340 | Values: 178.0 175.0 179.0 180.0 175.0 186.0 179.0 173.0 173.0 172.0 17:13:25 INFO - PROCESS | 10340 | 17:13:25 INFO - PROCESS | 10340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 17:13:25 INFO - PROCESS | 10340 | Values: 72.0 71.0 72.0 71.0 70.0 72.0 74.0 72.0 70.0 70.0 17:13:25 INFO - PROCESS | 10340 | -------- Summary: end -------- 17:13:25 INFO - PROCESS | 10340 | 17:13:26 INFO - TEST-INFO | 10340: exit 0 17:13:26 INFO - TEST-OK | kraken | took 63150ms 17:13:26 INFO - SUITE-END | took 1182s 17:13:27 INFO - Completed test suite (00:19:42) 17:13:27 INFO - javascript benchmark 17:13:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.5079934812384, 2676.408727983174, 2680.8793604287807, 2687.892484300628, 2713.7828973682103, 4587.81648734051, 4645.488996210423, 4647.814087436503, 4659.557342052503, 4677.204875171225, 4606.631469482441, 4652.534746525345, 4713.457952335482, 4716.693414928027, 4727.314539391795, 4273.829046838123, 4293.656507479394, 4296.990207301282, 4354.673399495035, 4459.17505261526, 4378.16814805186, 4378.693491455583, 4424.0045989652235, 4428.889277768066, 4450.310201918708, 4246.0, 4257.425247591566, 4292.806823692941, 4334.674899382559, 4352.8476503322545, 4284.228838809013, 4316.158349121891, 4324.978375108136, 4333.631641310492, 4351.760653164075, 4245.341971994346, 4246.2356775780345, 4267.445232119804, 4287.399764033038, 4301.419308393358, 4406.250937340627, 4489.1919454498175, 4498.482674492442, 4550.226461501553, 4590.655700822452, 4999.700017998932, 5000.1999680051385, 5006.499350065001, 5009.2486127080865, 5046.016026874761, 4978.576820970222, 4990.201567749143, 4993.825216117455, 5025.3718285214345, 5051.722155281458, 4564.246899261651, 4582.656300777455, 4636.095961287584, 4662.953370466286, 4664.346991421204, 5072.442031376546, 5073.0, 5087.338645976073, 5095.261187127846, 5127.9230811537855, 4887.437944636341, 4891.217405215149, 4891.5353041461, 4892.217245240744, 4941.431735350408, 4871.732054737024, 4923.261510773341, 4964.35463389757, 4988.152014157602, 5014.473480284591, 4880.487548807395, 4899.485554016848, 4905.23968784839, 4909.5090490950615, 4955.776990035457, 4883.853484395474, 4883.877903052452, 4884.218525036048, 4886.682365646222, 4932.457429682732, 4081.816318265626, 4200.5169405518145, 4202.075543380452, 4211.136716973013, 4258.829646814154, 3645.1616128290643, 3656.1590834107774, 3696.131409118855, 3711.6659500645073, 3742.5321834770652, 4250.234957707642, 4253.5108462527205, 4257.5529569395385, 4297.484301883794, 4297.957020429818, 4884.609231261491, 4958.553730164303, 4971.1797553404, 4986.750662466935, 5059.392872855207, 4243.575642435793, 4283.571642835692, 4301.849435269751, 4327.307630779061, 4343.522212556616, 4488.102379524043, 4512.75179865104, 4515.07440974606, 4523.615492683093, 4557.931631025537, 4601.654875884389, 4687.835925742583, 4753.619710423089, 4756.619470442287, 4769.284607308931, 4943.134951383421, 4963.553280204799, 4963.553280204799, 4967.354243948408, 5012.0, 4661.953380466288, 4667.253239481666, 4673.322368256516, 4681.789319480564, 4723.409573803275, 4761.142994261067, 4834.709917404967, 4873.415190177201, 4909.607231421549, 4917.434495033117, 4962.602991760723, 4971.850844474671, 4972.105021096093, 4979.029089327546, 5035.018171456531, 4714.104320179155, 4858.489858564941, 4870.05034018363, 4871.415430148263, 4914.361133052823, 4764.2615394613895, 4788.904221915612, 4796.616270698266, 4818.373611430492, 4844.0554091951735, 4671.556202160789, 4702.341672165831, 4706.458757242961, 4706.882327941828, 4745.47799742035, 4713.646476514206, 4796.712197268175, 4803.327534145153, 4804.183288840975, 4858.125537403302, 4759.50025247344, 4775.355327030807, 4778.689385189951, 4802.927956080732, 4817.927731083966], "value": 4566.284374107371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3656704490968, 593.3917734322321, 594.898867192577, 598.5361344957655, 615.6675395286544, 27137.185884423474, 27675.723242767566, 27740.722592774066, 27743.861280693593, 33282.16794580137, 35055.64944350556, 35786.64213357866, 35815.4627680585, 35817.641823581755, 35880.10299742508, 7464.477486575942, 7626.771196864103, 7632.885506717404, 7635.274648908345, 7639.847203055935, 7107.147142342926, 7614.0, 9444.8583271251, 9761.755956101118, 9771.75570610737, 9824.263180261472, 9952.800943981116, 9956.452395118265, 9964.402135871871, 9966.2525310602, 9799.363041402321, 9880.40717556949, 9925.602975880956, 9933.403995760205, 9936.95031524845, 9725.124738773473, 9850.753731156707, 9860.50697465131, 9883.752906177331, 9885.555150018266, 37113.25773484542, 37622.4356634648, 37670.81164594187, 37695.0, 37711.43432848509, 2957.4972254716536, 3010.9548356774667, 3031.818090914552, 3255.8209298488573, 3335.116194208537, 26670.73329266702, 28051.0, 28500.572491412437, 28741.85629071862, 29693.10920672383, 3368.511565822942, 3384.238546327081, 3391.796492210475, 3402.9659703403145, 3445.0698311456017, 182783.0, 183393.0, 183775.08112459487, 183834.0, 183863.0, 51924.74037629863, 52517.7374113127, 52662.21006684903, 52900.0, 52961.2055819163, 56163.0, 56291.87416251652, 56364.43635563674, 56408.15387769187, 56477.43522564722, 13414.932925335312, 13562.79655805144, 13576.253306068262, 13591.796123058162, 13599.728005439836, 9215.447073175497, 10280.742981425525, 10812.459377031117, 10881.891181088246, 10907.945460272647, 15749.370025198863, 15828.76256856148, 15859.682806344039, 15876.364945402285, 16071.517854464384, 6081.361457046946, 6136.23297087864, 6269.717862696099, 6320.115183874169, 6332.715027823759, 869.5782545465444, 909.3816204980677, 917.4266083697689, 971.9465429401309, 976.2677991506371, 27760.444791104066, 28422.431551368856, 28920.42159156805, 28978.420431591672, 29018.41963160725, 955.3742298794162, 986.9901300987042, 1003.9397636141708, 1015.3958394755109, 1080.0765345629532, 13016.284104374161, 13473.797893031613, 13548.119372240773, 13705.314734263247, 13755.931220343835, 362453.0, 365757.0, 368840.0, 369998.0, 370766.0, 46597.30104048442, 47419.0, 47506.28740568894, 47548.28677569839, 47565.5243447568, 1078.9028987391016, 1157.1957489544855, 1211.5032836536977, 1215.428748488209, 1284.3642397013539, 25179.49641007206, 27315.726842731317, 27650.308742281602, 27802.582961255193, 27802.582961256, 38780.80609597047, 38964.805175975074, 39149.21701565896, 39207.0, 39261.607383925795, 236263.0, 236930.0, 237161.0, 237291.0, 237613.0, 20669.793302066788, 22831.31506054821, 23594.0, 23776.52446951017, 24650.87674561616, 35502.644973549934, 35785.1053723659, 35792.64207357893, 36399.0, 36820.63179368172, 31108.0, 31646.683533164374, 31700.841495793295, 34117.658823411446, 34579.0, 32916.50625240671, 33241.83379083089, 33321.333573328884, 33460.66539334576, 33640.327193456484, 32562.348753025282, 32956.34087318288, 33264.1683957903, 33323.333533329685, 33543.0, 29096.27259318534, 31446.528302075945, 31540.211494712818, 31632.367352653277, 31644.208894777814, 24379.51240975135, 24385.51228975375, 24594.385140371633, 24960.50078998446, 24967.375815604028], "value": 16855.7196843256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.249175386857, 381.5192857000179, 382.43017903324045, 398.4501388084443, 401.1255463090462, 15985.440509582168, 17347.132643367844, 18068.90965545174, 18080.095995200238, 18110.728339074925, 16580.917095414537, 16925.0, 17127.31490740372, 17318.307267709308, 17335.566610834736, 5092.134337162673, 5198.8700282493055, 5198.896022079556, 5219.616801547593, 5241.973790131044, 3727.9813600931957, 3910.804459777, 5678.375378708339, 5985.0, 5992.460678538931, 5869.9706501467645, 5919.852003699899, 5920.615160014585, 5947.078202878561, 5948.167256584082, 5712.314522257335, 5827.4755272025295, 5855.560832937546, 5861.618994765348, 5865.589408741411, 3402.642722514125, 4995.475475075101, 5236.973815130938, 5240.449752775941, 5247.763850626731, 11551.595694150665, 12138.332391718452, 12158.392080396034, 19427.0, 19557.804421955883, 1817.3094224194854, 1931.1599454237312, 1941.3108346536917, 2093.7801530839197, 2290.8510946788406, 9094.226990705798, 9424.434533927986, 9748.025197480267, 11871.584494542736, 12119.454624541828, 1721.5382003734655, 1790.3912669692368, 1808.8733788634802, 1827.2964908510187, 1832.2579355360967, 67625.3237467629, 69635.65182174108, 71117.0, 72344.63827680881, 72617.99999999948, 9802.9019709802, 9954.502274886227, 10019.398836069859, 10082.19342452602, 10169.186465082776, 14195.290235488184, 14284.928575357057, 14289.857101429061, 14312.06971546867, 14324.785128223086, 7185.0, 7246.058012458347, 7248.4563657725885, 7401.703931842666, 7426.368758655467, 6777.322267773183, 6785.423239024738, 6820.693068811816, 6903.1716194057035, 6905.067815844897, 4403.546829546242, 4429.557044295545, 4431.556844315543, 4438.822447102144, 4466.932996005063, 1686.9493915182563, 1809.6199798042296, 1833.8532917366845, 1840.558156247825, 1849.1246112295241, 877.0396415924553, 880.7754022724164, 904.8733177355175, 937.7983733497331, 979.6130528441369, 16272.674546509004, 17203.741943870853, 17281.0, 17567.472975810746, 17594.472165835046, 852.9061803201643, 861.3109512390188, 883.4169448164181, 887.9334049946151, 921.6589861751195, 9372.67195648149, 9682.612695492102, 9716.0, 9737.0, 9800.26498012652, 407278.0, 411661.0, 422290.0, 424870.0, 426419.0, 44718.55281447144, 83247.58376208201, 83818.0, 84406.15593844106, 85863.14136858676, 924.5007695844304, 936.5036530638772, 945.6075728572703, 960.011188475871, 963.017721923634, 15287.694246114794, 15358.539243822703, 15508.147051912254, 15574.454894078654, 15762.211889405713, 34636.82681586576, 35405.82297088498, 35579.466308004885, 35995.46006809847, 36081.78991550534, 48414.27378589394, 49457.50542494529, 49891.25163122629, 54572.181417279564, 55054.44945550493, 7493.325600695964, 7923.524588524707, 8053.919460805317, 8055.718049868226, 8173.550454724809, 10752.83870741955, 11085.50115244832, 11300.547978081113, 11782.882171178522, 11793.52825886955, 9838.9016109838, 9970.50147492637, 9976.800463990825, 9997.450140242356, 10031.448270345201, 9947.900520994697, 10140.442275674908, 10189.388636681526, 10248.128909042814, 10271.281010329205, 9896.0, 10180.13468855126, 10285.640002599874, 10359.482025898826, 10381.418410648314, 7714.614269286625, 7735.226477352445, 7852.332551733167, 7897.881531776913, 8061.87907181381, 7706.460547761603, 9476.763080923032, 9809.117179453884, 9912.553935072794, 9932.652357167464], "value": 8234.363358911378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.5023865811672, 1450.5648305508346, 1480.4596322342343, 1614.3703955457374, 1805.377144885014, 6867.656617169147, 7751.6511756971, 7963.92036079639, 8001.239882211188, 8004.759857204279, 7664.731734389297, 7820.335271501915, 7847.568383738892, 7849.45053846231, 7869.252421020008, 1913.2538310059088, 1953.5116220944765, 1964.008175871183, 2234.754177040524, 2267.9886600566974, 2210.126999835064, 2295.3572999560065, 2295.747467778543, 2301.0450662974845, 2302.1482051640833, 2227.6435770276757, 2253.1550668499312, 2258.503129311557, 2260.8643481391086, 2267.319804058784, 1887.9339223127263, 2199.373178644095, 2238.8880555972137, 2245.8427910046303, 2249.8425110242288, 2209.624363858148, 2235.0947866114248, 2237.116339046084, 2238.8656680599215, 2239.8656080635214, 7780.688772449095, 7843.529388236724, 7852.097008843999, 7857.0, 7860.68557257709, 4449.377087207794, 4632.050429661911, 4634.791434385461, 4636.605888499482, 4644.651651126179, 2825.2795537138104, 3003.0, 3046.8933587324336, 3054.083774867553, 3066.923326916845, 941.9199368053723, 957.3681370295641, 972.2853702528636, 973.1193270090579, 983.1986930651497, 10911.83632245517, 10929.945350273198, 10930.234883558154, 10930.726731831688, 10948.4525773711, 4184.456020717348, 4234.491860976641, 4252.723572967747, 4362.236608593484, 4364.8908777280185, 9214.262858971266, 9255.67605133817, 9265.768355791159, 9265.861012084824, 9280.767980800534, 4706.0, 4762.9523704763205, 4768.570828625371, 4771.33201351811, 4774.140654682191, 3684.9263014739554, 3935.822887970048, 4154.813033413504, 4274.935875961863, 4346.869593912188, 3560.3413368526903, 3578.1054736315923, 3593.065802891267, 3669.3945498992366, 3698.0569954661387, 1186.7389174381622, 1211.7455334379704, 1220.993895030519, 1227.9623717958311, 1235.2897084176634, 697.285282585354, 849.7450764770545, 890.7550423633423, 901.1439132823843, 902.3457992955186, 5227.921581176285, 5483.122700367922, 5504.174373843955, 5515.531179849678, 5556.638818476786, 395.7210166832376, 404.1270854953287, 406.3660689324663, 409.1571362992186, 409.633378126581, 3292.9176770580925, 3658.1951970566965, 3680.411134218512, 3683.244934788362, 3732.458793474931, 9563.0, 9965.501724913725, 9972.750681232883, 9986.900130998742, 9987.40075595452, 9090.409123406956, 9481.952590237004, 9726.416415015121, 9885.851712224323, 9893.703188904345, 7058.6823592938445, 7203.603801790951, 7205.423566114699, 7209.134903811576, 7236.674349654279, 5229.816956406507, 5426.728663566885, 5476.288082549243, 5534.4742249486235, 5583.246261754611, 8800.955995219983, 8828.470291782514, 8927.285817134743, 9065.77335566616, 9147.039560846015, 8992.775180620536, 9148.268138548767, 9159.587818548049, 9221.585028673591, 9223.58493867764, 6294.874102517832, 6899.344562266577, 7003.7548685795755, 7149.0706208192605, 7154.67803948834, 7613.162552119373, 7656.846863062596, 7718.0, 7722.884156737766, 7738.806529836799, 6923.307669233238, 7100.467464940047, 7121.608311542915, 7182.748603798842, 7284.927150728637, 6686.632235226914, 6704.229013663491, 6943.826404339932, 7009.228984811564, 7137.928620713934, 6146.200993870768, 6220.413794482378, 6234.688265586793, 6257.217847769029, 6293.559450838397, 4605.539446055502, 4631.606313463393, 4634.073185362873, 4680.344751734828, 4693.436787585511, 4484.461864576272, 4500.347449619852, 4562.612177964777, 4627.30590411441, 4665.113628410591], "value": 4114.675228811171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.76761777240415, 310.52954773518127, 318.60174781523096, 319.2625036166456, 319.9504076868085, 4556.225441674915, 4673.761453214892, 4739.857804265873, 4761.976175122348, 4794.137055330039, 4563.931541026879, 4710.85867423977, 4718.41019872516, 4721.945953510225, 4730.597899178574, 3768.755030922988, 3790.9431358529646, 3792.4500947362617, 3800.600936901627, 3822.4075268333313, 3585.4980302757635, 3637.308911306843, 3805.448210009547, 3811.256804923027, 3811.4092315690973, 3766.133789228479, 3770.0386401467586, 3777.6411240932207, 3800.548646123249, 3803.0682482791754, 3750.324941510527, 3755.36158852997, 3786.2616789726017, 3787.6591106800242, 3790.564085130218, 3373.9831300843584, 3382.0046172757943, 3384.6446123157207, 3386.6613338666184, 3394.7778799632115, 4417.845375411845, 4491.8096704373365, 4519.548045195487, 4531.252343363374, 4550.158220729176, 4289.185054839601, 4295.183915056161, 4303.978480107611, 4307.978460107679, 4317.870463886088, 4913.14020046494, 4920.114379411704, 4939.753012349368, 4944.208926571767, 4951.777170027357, 3523.119220194951, 3659.8170091495317, 3666.4866918631415, 3671.5777685566236, 3674.1365779041903, 5125.103106956268, 5167.767450464738, 5179.533841954205, 5181.020912975055, 5181.818636347747, 3749.2314075614436, 3754.5682246541996, 3777.905552361213, 3794.734368594172, 3806.809659517013, 3813.7139714521522, 3816.2939856126704, 3836.712246581518, 3844.519435070616, 3845.4616353710503, 4009.3585026395635, 4241.406203131564, 4244.469441319835, 4248.957510424918, 4252.766097864585, 4971.552560269593, 4989.401271847401, 4991.700497970133, 4992.475790041994, 5014.84955451337, 1268.758935802213, 1315.9144655597356, 1333.306680526121, 1367.4871923028863, 1370.5545697648304, 917.5779141594941, 918.7151982885327, 924.357571487823, 936.4334577580602, 936.6908920056366, 4650.697704649187, 4658.208104622222, 4660.440747110369, 4661.319741148853, 4670.042641258534, 5488.25908502355, 5489.423610520837, 5490.0, 5490.588205884575, 5503.3395992481155, 4228.76741779199, 4603.194440972883, 4633.698809577367, 4655.789494731394, 4669.7431641260055, 2949.3069128754723, 2949.6902825203474, 2958.2012856528618, 2975.1818249980997, 2976.4493568689863, 5206.193040078794, 5208.7916483341, 5234.7906083756225, 5252.789888404497, 5254.2118682197215, 5493.2034854945805, 5683.261176047087, 5695.743691533891, 5709.800156994485, 5726.0838265877255, 5217.1652535594885, 5236.92144617831, 5237.0, 5245.6852588844795, 5254.4220135785035, 5571.303587051619, 5572.4706152915405, 5576.0, 5603.663780173202, 5608.691521966331, 5340.225667278145, 5393.166323450046, 5424.972875135599, 5476.890462190813, 5485.094959331665, 5188.818391356435, 5194.844154675366, 5212.081234508687, 5246.790128394821, 5265.447128051653, 3856.672182864488, 3862.111714305669, 3873.9225215496094, 3894.727369084137, 3897.5517815450453, 4890.364252647133, 5359.062164121341, 5535.446455354432, 5547.694876781816, 5551.195076713773, 4873.171560834738, 5021.543752311789, 5078.314427552381, 5086.54221120101, 5093.796248150033, 5037.395512538519, 5052.797888084436, 5053.469385714594, 5056.696598204119, 5070.3155074064525, 4845.830395936126, 4971.428285747041, 4982.003599280086, 4985.252212168204, 4994.625403094709, 5041.697498150123, 5042.520960508746, 5069.797208111634, 5087.262346959744, 5095.579599690266, 4962.181240095344, 4969.726665033458, 4971.9502804972935, 4978.47725988766, 4985.407588054264], "value": 3894.122196795675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.1295836683329, 721.9458540609455, 724.518195400059, 725.4015437264259, 733.8458923626039, 10819.567217311307, 13124.606261812149, 13620.727585448285, 13627.182369057864, 13647.795283070736, 12676.746465070693, 12758.489660413572, 12759.872401275985, 12814.743705125915, 12821.743565128716, 635.993640063598, 790.9723159689427, 799.4244144216184, 800.8678568036296, 801.0107517216234, 781.620913856779, 810.8175660476375, 815.0545367373848, 815.388458656008, 815.4984684419069, 831.222806675757, 833.9708110216144, 837.4807619276057, 838.0237023867187, 838.1116017021976, 663.0750103605492, 818.8812622169752, 821.3593397150232, 829.4525613095358, 830.6220669595319, 619.6684773646123, 620.8944479438507, 622.1787240842091, 623.2801114712469, 623.7847942459844, 12312.26126432417, 12402.75194496105, 12409.62771116868, 12440.688982775413, 12462.065345099154, 11292.378919159442, 11674.474648640831, 11845.111616628701, 11872.0, 12074.215176013531, 9588.520573971344, 9681.66114186, 9755.36590121647, 9853.310268281222, 9910.752231194207, 3180.77734558581, 3244.9351012979846, 3274.1650879025933, 3279.360524697685, 3282.9986854009517, 49320.50679493195, 49473.50526494725, 49656.0, 49770.25344619834, 50006.499935000546, 9400.576974036185, 9415.858762118574, 9427.207043017932, 9458.85811712825, 9476.526173691287, 16784.32862685479, 16900.661986760195, 16950.321987120376, 16973.91513042427, 17096.230669619898, 6416.262129855033, 6450.516211284173, 6532.0, 6541.934580654132, 6567.9671601641685, 3680.9263814723554, 3779.3197224499854, 3853.421986702017, 3881.340172170738, 3917.05990562263, 2784.972150278512, 2856.8428736419282, 2857.914262572126, 2858.6140870982567, 2859.814112082708, 491.78607305822084, 503.0517474560407, 506.2482213912337, 509.2590281140931, 510.80589376037614, 577.5610535992591, 606.9241344831896, 613.3743581546797, 618.1932577985772, 634.7238951056213, 8215.465994710325, 8307.471235692683, 8311.584420778936, 8524.232819046316, 8531.74404767858, 473.9763011849463, 537.5757515646176, 544.8365490352878, 597.7758340622266, 611.8531552427474, 3872.4772155759174, 3875.6899448044087, 3942.3889297158985, 3958.6437220650278, 4005.8798236052967, 54455.45544544504, 55268.0, 56643.43356566464, 56708.43291567032, 57029.14456283159, 49943.50056499461, 50323.24515132276, 50524.74737626289, 50876.49123508792, 51238.48761512412, 45137.54862451399, 45562.316565251545, 45734.0, 46073.76963115163, 46591.76704116526, 7441.181470038183, 7451.627418628938, 7572.280633339824, 7587.696492140473, 7665.540067595962, 30657.386852263277, 31172.53241201429, 32024.67975320217, 32217.51673724849, 32558.0, 40121.39817902792, 40236.798816005736, 40330.79834600808, 40487.392689109096, 40516.797416012734, 8504.872426913726, 9184.58669359867, 9272.814543708953, 9399.765005874908, 9513.66702165421, 9738.464384458639, 9778.9022109778, 9855.605775768889, 9887.357321774061, 9944.944246075329, 9235.861462077939, 9427.858582121136, 9430.858537121812, 9469.337146399686, 9497.667581634609, 9863.210943124677, 9881.407115573089, 10035.949820250851, 10055.798884022131, 10140.290179687647, 8900.777480563038, 9606.039396060338, 9735.41587504752, 9748.9025109748, 9812.313138080266, 7784.844303113793, 8076.313513351431, 8092.215235214453, 8187.672493100209, 8623.439476434012, 8159.428839981382, 8198.0, 8254.752357429286, 8561.44350617208, 8691.435056721293], "value": 5803.262409878185, "unit": "score"}], "name": "dromaeo_css", "value": 6238.3189109104, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 109.0, 113.0, 113.0, 115.0, 102.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 155.0, 184.0, 131.0, 157.0, 155.0, 140.0, 195.0, 133.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 158.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 123.0, 115.0, 74.0, 73.0, 75.0, 112.0, 109.0, 73.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 142.0, 94.0, 94.0, 94.0, 145.0, 94.0, 94.0, 152.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 66.0, 64.0, 65.0, 65.0, 66.0, 85.0, 62.0, 62.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 129.0, 132.0, 132.0, 133.0, 137.0, 141.0, 168.0, 138.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 179.0, 180.0, 175.0, 186.0, 179.0, 173.0, 173.0, 172.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 71.0, 70.0, 72.0, 74.0, 72.0, 70.0, 70.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1580.7, "alertThreshold": 2.0}]} 17:13:27 INFO - Return code: 0 17:13:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:27 ERROR - # TBPL SUCCESS # 17:13:27 INFO - Running post-action listener: _resource_record_post_action 17:13:27 INFO - Running post-run listener: _resource_record_post_run 17:13:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 212992; Write bytes: 277995520; Read time: 28; Write time: 172716 17:13:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 434176; Read time: 0; Write time: 44 17:13:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 212992; Write bytes: 277561344; Read time: 28; Write time: 172672 17:13:28 INFO - Running post-run listener: _upload_blobber_files 17:13:28 INFO - Blob upload gear active. 17:13:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:28 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:28 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:28 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:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:29 INFO - (blobuploader) - INFO - Done attempting. 17:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:30 INFO - (blobuploader) - INFO - Done attempting. 17:13:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:30 INFO - Return code: 0 17:13:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d485dfc893787019ff9825908e667b454361c539cde073b83056000efa89e2d78165dee249d3d9584dea39be8a794703ac28f6661da901bd6fb9eb14e34cdb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/647ca5ef501c2a9758ed691495fce4b7008c23b797529f0f5bfc5763683310a3ee22622fdeda61bb869ad9a2940466273dafc5a3e65be58940c3526cf2a8b738"} 17:13:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:30 INFO - Contents: 17:13:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d485dfc893787019ff9825908e667b454361c539cde073b83056000efa89e2d78165dee249d3d9584dea39be8a794703ac28f6661da901bd6fb9eb14e34cdb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/647ca5ef501c2a9758ed691495fce4b7008c23b797529f0f5bfc5763683310a3ee22622fdeda61bb869ad9a2940466273dafc5a3e65be58940c3526cf2a8b738"} 17:13:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:30 INFO - Copying logs to upload dir... 17:13:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.391626 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 17:13:30.393929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:30.398652) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d485dfc893787019ff9825908e667b454361c539cde073b83056000efa89e2d78165dee249d3d9584dea39be8a794703ac28f6661da901bd6fb9eb14e34cdb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/647ca5ef501c2a9758ed691495fce4b7008c23b797529f0f5bfc5763683310a3ee22622fdeda61bb869ad9a2940466273dafc5a3e65be58940c3526cf2a8b738"} 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.011249 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d485dfc893787019ff9825908e667b454361c539cde073b83056000efa89e2d78165dee249d3d9584dea39be8a794703ac28f6661da901bd6fb9eb14e34cdb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/647ca5ef501c2a9758ed691495fce4b7008c23b797529f0f5bfc5763683310a3ee22622fdeda61bb869ad9a2940466273dafc5a3e65be58940c3526cf2a8b738"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:30.424488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:30.424828) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1461887070.727975-1134159271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 17:13:30.474433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 17:13:30.477402) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 17:13:30.477701) ========= ========= Total master_lag: 0.15 =========