builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1462794987.42 results: success (0) buildid: 20160509023013 builduid: bce274f78f064e5db96e4027e5e84f2a revision: ab8ae2c23df566acee8cbeb64e5164fae8a10b0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.416433) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.416850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.417120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.434639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.434928) ========= 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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 04:56:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-05-09 04:56:27 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116497 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.647066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.647387) ========= 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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015257 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:27.682484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:56:27.682860) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab8ae2c23df566acee8cbeb64e5164fae8a10b0e --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 ab8ae2c23df566acee8cbeb64e5164fae8a10b0e --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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 04:56:28,156 truncating revision to first 12 chars 2016-05-09 04:56:28,156 Setting DEBUG logging. 2016-05-09 04:56:28,156 attempt 1/10 2016-05-09 04:56:28,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab8ae2c23df5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:56:29,399 unpacking tar archive at: fx-team-ab8ae2c23df5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.512985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:56:29.212536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:29.212912) ========= script_repo_revision: ab8ae2c23df566acee8cbeb64e5164fae8a10b0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:29.213313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:29.213729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:56:29.223483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-09 04:56:29.223781) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:29 INFO - MultiFileLogger online at 20160509 04:56:29 in /builds/slave/test 04:56:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:56:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:29 INFO - {'append_to_log': False, 04:56:29 INFO - 'base_work_dir': '/builds/slave/test', 04:56:29 INFO - 'blob_upload_branch': 'Fx-Team', 04:56:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:29 INFO - 'branch': 'Fx-Team', 04:56:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:29 INFO - 'config_files': ('talos/linux_config.py',), 04:56:29 INFO - 'default_actions': ('clobber', 04:56:29 INFO - 'read-buildbot-config', 04:56:29 INFO - 'download-and-extract', 04:56:29 INFO - 'populate-webroot', 04:56:29 INFO - 'create-virtualenv', 04:56:29 INFO - 'install', 04:56:29 INFO - 'run-tests'), 04:56:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:29 INFO - 'download_minidump_stackwalk': True, 04:56:29 INFO - 'download_symbols': 'ondemand', 04:56:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:29 INFO - 'installer_path': 'installer.exe', 04:56:29 INFO - 'log_level': 'info', 04:56:29 INFO - 'log_name': 'talos', 04:56:29 INFO - 'log_to_console': True, 04:56:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:29 INFO - 'opt_config_files': (), 04:56:29 INFO - 'pip_index': False, 04:56:29 INFO - 'sps_profile': False, 04:56:29 INFO - 'sps_profile_interval': 0, 04:56:29 INFO - 'suite': 'dromaeojs', 04:56:29 INFO - 'system_bits': '32', 04:56:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:29 INFO - 'title': 'talos-linux64-ix-055', 04:56:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:29 INFO - 'use_talos_json': True, 04:56:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:29 INFO - 'work_dir': 'build'} 04:56:29 INFO - ##### 04:56:29 INFO - ##### Running clobber step. 04:56:29 INFO - ##### 04:56:29 INFO - Running pre-action listener: _resource_record_pre_action 04:56:29 INFO - Running main action method: clobber 04:56:29 INFO - rmtree: /builds/slave/test/build 04:56:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:30 INFO - Running post-action listener: _resource_record_post_action 04:56:30 INFO - ##### 04:56:30 INFO - ##### Finished clobber step (success) 04:56:30 INFO - ##### 04:56:30 INFO - ##### 04:56:30 INFO - ##### Running read-buildbot-config step. 04:56:30 INFO - ##### 04:56:30 INFO - Running pre-action listener: _resource_record_pre_action 04:56:30 INFO - Running main action method: read_buildbot_config 04:56:30 INFO - Using buildbot properties: 04:56:30 INFO - { 04:56:30 INFO - "project": "", 04:56:30 INFO - "product": "firefox", 04:56:30 INFO - "script_repo_revision": "production", 04:56:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:56:30 INFO - "repository": "", 04:56:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:56:30 INFO - "buildid": "20160509023013", 04:56:30 INFO - "pgo_build": "True", 04:56:30 INFO - "basedir": "/builds/slave/test", 04:56:30 INFO - "buildnumber": 1135, 04:56:30 INFO - "slavename": "talos-linux64-ix-055", 04:56:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:56:30 INFO - "platform": "ubuntu64_hw", 04:56:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:56:30 INFO - "branch": "fx-team", 04:56:30 INFO - "repo_path": "integration/fx-team", 04:56:30 INFO - "revision": "ab8ae2c23df566acee8cbeb64e5164fae8a10b0e", 04:56:30 INFO - "stage_platform": "linux64-pgo", 04:56:30 INFO - "builduid": "bce274f78f064e5db96e4027e5e84f2a", 04:56:30 INFO - "slavebuilddir": "test" 04:56:30 INFO - } 04:56:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:56:30 INFO - Running post-action listener: _resource_record_post_action 04:56:30 INFO - ##### 04:56:30 INFO - ##### Finished read-buildbot-config step (success) 04:56:30 INFO - ##### 04:56:30 INFO - ##### 04:56:30 INFO - ##### Running download-and-extract step. 04:56:30 INFO - ##### 04:56:30 INFO - Running pre-action listener: _resource_record_pre_action 04:56:30 INFO - Running main action method: download_and_extract 04:56:30 INFO - mkdir: /builds/slave/test/build/tests 04:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:30 INFO - https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:31 INFO - Downloaded 1361 bytes. 04:56:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:56:31 INFO - Using the following test package requirements: 04:56:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:56:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:56:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'jsshell-linux-x86_64.zip'], 04:56:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:56:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:56:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:56:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:56:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:56:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:56:31 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')]} 04:56:31 INFO - https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:33 INFO - Downloaded 23896328 bytes. 04:56:33 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'] 04:56:33 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 04:56:34 INFO - Return code: 0 04:56:34 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 04:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:34 INFO - https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:35 INFO - Downloaded 23896328 bytes. 04:56:35 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'] 04:56:35 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 04:56:37 INFO - Return code: 0 04:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:37 INFO - https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:38 INFO - Downloaded 10840152 bytes. 04:56:38 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'] 04:56:38 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 04:56:38 INFO - Return code: 0 04:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:38 INFO - https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkkNyOESRJy6AYDznzQMaA/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 04:56:41 INFO - Downloaded 58446250 bytes. 04:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:56:41 INFO - mkdir: /builds/slave/test/properties 04:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:41 INFO - Contents: 04:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:56:41 INFO - Running post-action listener: _resource_record_post_action 04:56:41 INFO - Running post-action listener: set_extra_try_arguments 04:56:41 INFO - ##### 04:56:41 INFO - ##### Finished download-and-extract step (success) 04:56:41 INFO - ##### 04:56:41 INFO - ##### 04:56:41 INFO - ##### Running populate-webroot step. 04:56:41 INFO - ##### 04:56:41 INFO - Running pre-action listener: _resource_record_pre_action 04:56:41 INFO - Running main action method: populate_webroot 04:56:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:41 INFO - '--tppagecycles', 04:56:41 INFO - '7'], 04:56:41 INFO - 'tests': ['tsvgm']}}, 04:56:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['damp', 'tps']}, 04:56:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'tests': ['damp', 'tps']}, 04:56:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['dromaeo_dom']}, 04:56:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['a11yr', 04:56:41 INFO - 'ts_paint', 04:56:41 INFO - 'tpaint', 04:56:41 INFO - 'sessionrestore', 04:56:41 INFO - 'sessionrestore_no_auto_restore', 04:56:41 INFO - 'tabpaint']}, 04:56:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['tsvgx', 04:56:41 INFO - 'tsvgr_opacity', 04:56:41 INFO - 'tart', 04:56:41 INFO - 'tscrollx', 04:56:41 INFO - 'cart']}, 04:56:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:41 INFO - 'tsvgr_opacity', 04:56:41 INFO - 'tart', 04:56:41 INFO - 'tscrollx', 04:56:41 INFO - 'cart']}, 04:56:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'talos_options': ['--disable-e10s'], 04:56:41 INFO - 'tests': ['tp5o']}, 04:56:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'tests': ['tp5o']}, 04:56:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'talos_options': ['--disable-e10s', 04:56:41 INFO - '--xperf_path', 04:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:41 INFO - 'tests': ['tp5n']}, 04:56:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:41 INFO - 'talos_options': ['--xperf_path', 04:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:41 INFO - 'tests': ['tp5n']}}, 04:56:41 INFO - 'talos.zip': {'path': '', 04:56:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:41 INFO - Running post-action listener: _resource_record_post_action 04:56:41 INFO - ##### 04:56:41 INFO - ##### Finished populate-webroot step (success) 04:56:41 INFO - ##### 04:56:41 INFO - ##### 04:56:41 INFO - ##### Running create-virtualenv step. 04:56:41 INFO - ##### 04:56:41 INFO - Running pre-action listener: _resource_record_pre_action 04:56:41 INFO - Running main action method: create_virtualenv 04:56:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:56:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:42 INFO - Using real prefix '/usr' 04:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:42 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:44 INFO - Installing pip.................done. 04:56:44 INFO - Return code: 0 04:56:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:44 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')]} 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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')]} 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:44 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 04:56:44 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 04:56:44 INFO - Using env: {'DISPLAY': ':0', 04:56:44 INFO - 'HOME': '/home/cltbld', 04:56:44 INFO - 'LANG': 'en_US.UTF-8', 04:56:44 INFO - 'LANGUAGE': 'en_US:en', 04:56:44 INFO - 'LOGNAME': 'cltbld', 04:56:44 INFO - 'MAIL': '/var/mail/cltbld', 04:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:44 INFO - 'MOZ_NO_REMOTE': '1', 04:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:44 INFO - 'NO_EM_RESTART': '1', 04:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:44 INFO - 'PWD': '/builds/slave/test', 04:56:44 INFO - 'SHELL': '/bin/bash', 04:56:44 INFO - 'SHLVL': '1', 04:56:44 INFO - 'TERM': 'linux', 04:56:44 INFO - 'TMOUT': '86400', 04:56:44 INFO - 'USER': 'cltbld', 04:56:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:44 INFO - '_': '/tools/buildbot/bin/python'} 04:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:44 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 04:56:44 INFO - Cleaning up... 04:56:44 INFO - Return code: 0 04:56:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:56:44 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')]} 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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')]} 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:44 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 04:56:44 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 04:56:44 INFO - Using env: {'DISPLAY': ':0', 04:56:44 INFO - 'HOME': '/home/cltbld', 04:56:44 INFO - 'LANG': 'en_US.UTF-8', 04:56:44 INFO - 'LANGUAGE': 'en_US:en', 04:56:44 INFO - 'LOGNAME': 'cltbld', 04:56:44 INFO - 'MAIL': '/var/mail/cltbld', 04:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:44 INFO - 'MOZ_NO_REMOTE': '1', 04:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:44 INFO - 'NO_EM_RESTART': '1', 04:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:44 INFO - 'PWD': '/builds/slave/test', 04:56:44 INFO - 'SHELL': '/bin/bash', 04:56:44 INFO - 'SHLVL': '1', 04:56:44 INFO - 'TERM': 'linux', 04:56:44 INFO - 'TMOUT': '86400', 04:56:44 INFO - 'USER': 'cltbld', 04:56:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:44 INFO - '_': '/tools/buildbot/bin/python'} 04:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:44 INFO - Downloading/unpacking psutil>=0.7.1 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:46 INFO - Installing collected packages: psutil 04:56:46 INFO - Running setup.py install for psutil 04:56:46 INFO - building 'psutil._psutil_linux' extension 04:56:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:56:47 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 04:56:47 INFO - building 'psutil._psutil_posix' extension 04:56:47 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 04:56:47 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 04:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:47 INFO - Successfully installed psutil 04:56:47 INFO - Cleaning up... 04:56:47 INFO - Return code: 0 04:56:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:47 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:47 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 04:56:47 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 04:56:47 INFO - Using env: {'DISPLAY': ':0', 04:56:47 INFO - 'HOME': '/home/cltbld', 04:56:47 INFO - 'LANG': 'en_US.UTF-8', 04:56:47 INFO - 'LANGUAGE': 'en_US:en', 04:56:47 INFO - 'LOGNAME': 'cltbld', 04:56:47 INFO - 'MAIL': '/var/mail/cltbld', 04:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:47 INFO - 'MOZ_NO_REMOTE': '1', 04:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:47 INFO - 'NO_EM_RESTART': '1', 04:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:47 INFO - 'PWD': '/builds/slave/test', 04:56:47 INFO - 'SHELL': '/bin/bash', 04:56:47 INFO - 'SHLVL': '1', 04:56:47 INFO - 'TERM': 'linux', 04:56:47 INFO - 'TMOUT': '86400', 04:56:47 INFO - 'USER': 'cltbld', 04:56:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:47 INFO - '_': '/tools/buildbot/bin/python'} 04:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:56:47 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 04:56:47 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 04:56:47 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 04:56:47 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 04:56:47 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 04:56:47 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 04:56:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:49 INFO - Installing collected packages: mozsystemmonitor 04:56:49 INFO - Running setup.py install for mozsystemmonitor 04:56:49 INFO - Successfully installed mozsystemmonitor 04:56:49 INFO - Cleaning up... 04:56:49 INFO - Return code: 0 04:56:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:56:49 INFO - Using env: {'DISPLAY': ':0', 04:56:49 INFO - 'HOME': '/home/cltbld', 04:56:49 INFO - 'LANG': 'en_US.UTF-8', 04:56:49 INFO - 'LANGUAGE': 'en_US:en', 04:56:49 INFO - 'LOGNAME': 'cltbld', 04:56:49 INFO - 'MAIL': '/var/mail/cltbld', 04:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:49 INFO - 'MOZ_NO_REMOTE': '1', 04:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:49 INFO - 'NO_EM_RESTART': '1', 04:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:49 INFO - 'PWD': '/builds/slave/test', 04:56:49 INFO - 'SHELL': '/bin/bash', 04:56:49 INFO - 'SHLVL': '1', 04:56:49 INFO - 'TERM': 'linux', 04:56:49 INFO - 'TMOUT': '86400', 04:56:49 INFO - 'USER': 'cltbld', 04:56:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:49 INFO - '_': '/tools/buildbot/bin/python'} 04:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:52 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 04:56:52 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 04:56:52 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 04:56:52 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 04:56:52 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 04:56:52 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 04:56:52 INFO - Downloading docopt-0.6.1.tar.gz 04:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:52 INFO - Running setup.py install for blobuploader 04:56:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:52 INFO - Running setup.py install for requests 04:56:53 INFO - Running setup.py install for docopt 04:56:53 INFO - Successfully installed blobuploader requests docopt 04:56:53 INFO - Cleaning up... 04:56:53 INFO - Return code: 0 04:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:53 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:53 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 04:56:53 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 04:56:53 INFO - Using env: {'DISPLAY': ':0', 04:56:53 INFO - 'HOME': '/home/cltbld', 04:56:53 INFO - 'LANG': 'en_US.UTF-8', 04:56:53 INFO - 'LANGUAGE': 'en_US:en', 04:56:53 INFO - 'LOGNAME': 'cltbld', 04:56:53 INFO - 'MAIL': '/var/mail/cltbld', 04:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:53 INFO - 'MOZ_NO_REMOTE': '1', 04:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:53 INFO - 'NO_EM_RESTART': '1', 04:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:53 INFO - 'PWD': '/builds/slave/test', 04:56:53 INFO - 'SHELL': '/bin/bash', 04:56:53 INFO - 'SHLVL': '1', 04:56:53 INFO - 'TERM': 'linux', 04:56:53 INFO - 'TMOUT': '86400', 04:56:53 INFO - 'USER': 'cltbld', 04:56:53 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:53 INFO - '_': '/tools/buildbot/bin/python'} 04:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:53 INFO - Running setup.py (path:/tmp/pip-4jJvdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:53 INFO - Running setup.py (path:/tmp/pip-rHVb3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:53 INFO - Running setup.py (path:/tmp/pip-ZxRJnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:53 INFO - Running setup.py (path:/tmp/pip-97kKfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:53 INFO - Running setup.py (path:/tmp/pip-MutZsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:53 INFO - Running setup.py (path:/tmp/pip-hMaVBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:53 INFO - Running setup.py (path:/tmp/pip-BBbc4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:53 INFO - Running setup.py (path:/tmp/pip-arOv3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:53 INFO - Running setup.py (path:/tmp/pip-Yz4Dv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:54 INFO - Running setup.py (path:/tmp/pip-7D0bJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:54 INFO - Running setup.py (path:/tmp/pip-fY67Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:54 INFO - Running setup.py (path:/tmp/pip-RBi1Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:54 INFO - Running setup.py (path:/tmp/pip-qcdfzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:54 INFO - Running setup.py (path:/tmp/pip-2qwGoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:54 INFO - Running setup.py (path:/tmp/pip-qIfuCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:54 INFO - Running setup.py (path:/tmp/pip-81TDMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:54 INFO - Running setup.py (path:/tmp/pip-D8Z6mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:54 INFO - Running setup.py install for manifestparser 04:56:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:54 INFO - Running setup.py install for mozcrash 04:56:54 INFO - Running setup.py install for mozdebug 04:56:54 INFO - Running setup.py install for mozdevice 04:56:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozfile 04:56:55 INFO - Running setup.py install for mozhttpd 04:56:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozinfo 04:56:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozInstall 04:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozleak 04:56:55 INFO - Running setup.py install for mozlog 04:56:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for moznetwork 04:56:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozprocess 04:56:55 INFO - Running setup.py install for mozprofile 04:56:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:55 INFO - Running setup.py install for mozrunner 04:56:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:56 INFO - Running setup.py install for mozscreenshot 04:56:56 INFO - Running setup.py install for moztest 04:56:56 INFO - Running setup.py install for mozversion 04:56:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:56 INFO - Cleaning up... 04:56:56 INFO - Return code: 0 04:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:56 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')]} 04:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 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')]} 04:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:56:56 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 04:56:56 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 04:56:56 INFO - Using env: {'DISPLAY': ':0', 04:56:56 INFO - 'HOME': '/home/cltbld', 04:56:56 INFO - 'LANG': 'en_US.UTF-8', 04:56:56 INFO - 'LANGUAGE': 'en_US:en', 04:56:56 INFO - 'LOGNAME': 'cltbld', 04:56:56 INFO - 'MAIL': '/var/mail/cltbld', 04:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:56 INFO - 'MOZ_NO_REMOTE': '1', 04:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:56 INFO - 'NO_EM_RESTART': '1', 04:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:56 INFO - 'PWD': '/builds/slave/test', 04:56:56 INFO - 'SHELL': '/bin/bash', 04:56:56 INFO - 'SHLVL': '1', 04:56:56 INFO - 'TERM': 'linux', 04:56:56 INFO - 'TMOUT': '86400', 04:56:56 INFO - 'USER': 'cltbld', 04:56:56 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:56 INFO - '_': '/tools/buildbot/bin/python'} 04:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:56 INFO - Running setup.py (path:/tmp/pip-jkmONj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:56 INFO - Running setup.py (path:/tmp/pip-RnxQC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:56 INFO - Running setup.py (path:/tmp/pip-C8ajD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:56 INFO - Running setup.py (path:/tmp/pip-HRgvvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:56 INFO - Running setup.py (path:/tmp/pip-rUcIAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:57 INFO - Running setup.py (path:/tmp/pip-y3IOmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:57 INFO - Running setup.py (path:/tmp/pip-ApYKqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:57 INFO - Running setup.py (path:/tmp/pip-DdKJt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:57 INFO - Running setup.py (path:/tmp/pip-_IJHW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:57 INFO - Running setup.py (path:/tmp/pip-0NfqUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:57 INFO - Running setup.py (path:/tmp/pip-N8K87h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:57 INFO - Running setup.py (path:/tmp/pip-Y8RwN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:57 INFO - Running setup.py (path:/tmp/pip-ArtV8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:57 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)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:57 INFO - Running setup.py (path:/tmp/pip-M8cOPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:57 INFO - Running setup.py (path:/tmp/pip-k29MzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:57 INFO - Running setup.py (path:/tmp/pip-nnttEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:57 INFO - Running setup.py (path:/tmp/pip-RbZ8xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:59 INFO - Downloading blessings-1.6.tar.gz 04:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:59 INFO - Installing collected packages: blessings 04:56:59 INFO - Running setup.py install for blessings 04:56:59 INFO - Successfully installed blessings 04:56:59 INFO - Cleaning up... 04:57:00 INFO - Return code: 0 04:57:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:00 INFO - Reading from file tmpfile_stdout 04:57:00 INFO - Current package versions: 04:57:00 INFO - argparse == 1.2.1 04:57:00 INFO - blessings == 1.6 04:57:00 INFO - blobuploader == 1.2.4 04:57:00 INFO - docopt == 0.6.1 04:57:00 INFO - manifestparser == 1.1 04:57:00 INFO - mozInstall == 1.12 04:57:00 INFO - mozcrash == 0.17 04:57:00 INFO - mozdebug == 0.1 04:57:00 INFO - mozdevice == 0.48 04:57:00 INFO - mozfile == 1.2 04:57:00 INFO - mozhttpd == 0.7 04:57:00 INFO - mozinfo == 0.9 04:57:00 INFO - mozleak == 0.1 04:57:00 INFO - mozlog == 3.1 04:57:00 INFO - moznetwork == 0.27 04:57:00 INFO - mozprocess == 0.22 04:57:00 INFO - mozprofile == 0.28 04:57:00 INFO - mozrunner == 6.11 04:57:00 INFO - mozscreenshot == 0.1 04:57:00 INFO - mozsystemmonitor == 0.0 04:57:00 INFO - moztest == 0.7 04:57:00 INFO - mozversion == 1.4 04:57:00 INFO - psutil == 3.1.1 04:57:00 INFO - requests == 1.2.3 04:57:00 INFO - wsgiref == 0.1.2 04:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:00 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')]} 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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')]} 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:57:00 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 04:57:00 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 04:57:00 INFO - Using env: {'DISPLAY': ':0', 04:57:00 INFO - 'HOME': '/home/cltbld', 04:57:00 INFO - 'LANG': 'en_US.UTF-8', 04:57:00 INFO - 'LANGUAGE': 'en_US:en', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MAIL': '/var/mail/cltbld', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SHLVL': '1', 04:57:00 INFO - 'TERM': 'linux', 04:57:00 INFO - 'TMOUT': '86400', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - '_': '/tools/buildbot/bin/python'} 04:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 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)) 04:57:00 INFO - Cleaning up... 04:57:00 INFO - Return code: 0 04:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:00 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')]} 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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')]} 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:57:00 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 04:57:00 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 04:57:00 INFO - Using env: {'DISPLAY': ':0', 04:57:00 INFO - 'HOME': '/home/cltbld', 04:57:00 INFO - 'LANG': 'en_US.UTF-8', 04:57:00 INFO - 'LANGUAGE': 'en_US:en', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MAIL': '/var/mail/cltbld', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SHLVL': '1', 04:57:00 INFO - 'TERM': 'linux', 04:57:00 INFO - 'TMOUT': '86400', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - '_': '/tools/buildbot/bin/python'} 04:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:00 INFO - Downloading/unpacking jsonschema 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:02 INFO - Downloading/unpacking functools32 (from jsonschema) 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:02 INFO - warning: no files found matching '*.txt' 04:57:02 INFO - no previously-included directories found matching 'build' 04:57:02 INFO - no previously-included directories found matching 'dist' 04:57:02 INFO - no previously-included directories found matching '.git*' 04:57:02 INFO - Installing collected packages: jsonschema, functools32 04:57:02 INFO - Running setup.py install for functools32 04:57:02 INFO - warning: no files found matching '*.txt' 04:57:02 INFO - no previously-included directories found matching 'build' 04:57:02 INFO - no previously-included directories found matching 'dist' 04:57:02 INFO - no previously-included directories found matching '.git*' 04:57:02 INFO - Successfully installed jsonschema functools32 04:57:02 INFO - Cleaning up... 04:57:03 INFO - Return code: 0 04:57:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e01b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, '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': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', '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 04:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:57:03 INFO - Using env: {'DISPLAY': ':0', 04:57:03 INFO - 'HOME': '/home/cltbld', 04:57:03 INFO - 'LANG': 'en_US.UTF-8', 04:57:03 INFO - 'LANGUAGE': 'en_US:en', 04:57:03 INFO - 'LOGNAME': 'cltbld', 04:57:03 INFO - 'MAIL': '/var/mail/cltbld', 04:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:03 INFO - 'MOZ_NO_REMOTE': '1', 04:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:03 INFO - 'NO_EM_RESTART': '1', 04:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:03 INFO - 'PWD': '/builds/slave/test', 04:57:03 INFO - 'SHELL': '/bin/bash', 04:57:03 INFO - 'SHLVL': '1', 04:57:03 INFO - 'TERM': 'linux', 04:57:03 INFO - 'TMOUT': '86400', 04:57:03 INFO - 'USER': 'cltbld', 04:57:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:03 INFO - '_': '/tools/buildbot/bin/python'} 04:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:03 INFO - Downloading/unpacking flake8 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:05 INFO - no previously-included directories found matching 'docs/_build' 04:57:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:05 INFO - Running setup.py install for pep8 04:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:05 INFO - no previously-included directories found matching 'docs/_build' 04:57:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:57:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:06 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Running post-action listener: _resource_record_post_action 04:57:06 INFO - Running post-action listener: _start_resource_monitoring 04:57:06 INFO - Starting resource monitoring. 04:57:06 INFO - ##### 04:57:06 INFO - ##### Finished create-virtualenv step (success) 04:57:06 INFO - ##### 04:57:06 INFO - ##### 04:57:06 INFO - ##### Running install step. 04:57:06 INFO - ##### 04:57:06 INFO - Running pre-action listener: _resource_record_pre_action 04:57:06 INFO - Running main action method: install 04:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:06 INFO - Reading from file tmpfile_stdout 04:57:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:06 INFO - Reading from file tmpfile_stdout 04:57:06 INFO - Output received: 04:57:06 INFO - Usage: mozinstall [options] installer 04:57:06 INFO - Options: 04:57:06 INFO - -h, --help show this help message and exit 04:57:06 INFO - -d DEST, --destination=DEST 04:57:06 INFO - Directory to install application into. [default: 04:57:06 INFO - "/builds/slave/test"] 04:57:06 INFO - --app=APP Application being installed. [default: firefox] 04:57:06 INFO - mkdir: /builds/slave/test/build/application 04:57:06 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'] 04:57:06 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 04:57:22 INFO - Reading from file tmpfile_stdout 04:57:22 INFO - Output received: 04:57:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:22 INFO - Running post-action listener: _resource_record_post_action 04:57:22 INFO - ##### 04:57:22 INFO - ##### Finished install step (success) 04:57:22 INFO - ##### 04:57:22 INFO - ##### 04:57:22 INFO - ##### Running run-tests step. 04:57:22 INFO - ##### 04:57:22 INFO - Running pre-action listener: _resource_record_pre_action 04:57:22 INFO - Running main action method: run_tests 04:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:23 INFO - Python 2.7.3 04:57:23 INFO - Return code: 0 04:57:23 INFO - grabbing minidump binary from tooltool 04:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:23 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 0x22889c0>, '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 0x22898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2289d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:23 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 04:57:23 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 04:57:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:23 INFO - Return code: 0 04:57:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:57:24 INFO - Return code: 0 04:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 04:57:24 INFO - Using env: {'DISPLAY': ':0', 04:57:24 INFO - 'HOME': '/home/cltbld', 04:57:24 INFO - 'LANG': 'en_US.UTF-8', 04:57:24 INFO - 'LANGUAGE': 'en_US:en', 04:57:24 INFO - 'LOGNAME': 'cltbld', 04:57:24 INFO - 'MAIL': '/var/mail/cltbld', 04:57:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:24 INFO - 'MOZ_NO_REMOTE': '1', 04:57:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:24 INFO - 'NO_EM_RESTART': '1', 04:57:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:24 INFO - 'PWD': '/builds/slave/test', 04:57:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:24 INFO - 'SHELL': '/bin/bash', 04:57:24 INFO - 'SHLVL': '1', 04:57:24 INFO - 'TERM': 'linux', 04:57:24 INFO - 'TMOUT': '86400', 04:57:24 INFO - 'USER': 'cltbld', 04:57:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615', 04:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:24 INFO - '_': '/tools/buildbot/bin/python'} 04:57:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:57:24 INFO - mozversion application_buildid: 20160509023013 04:57:24 INFO - mozversion application_changeset: ab8ae2c23df566acee8cbeb64e5164fae8a10b0e 04:57:24 INFO - mozversion application_display_name: Nightly 04:57:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:24 INFO - mozversion application_name: Firefox 04:57:24 INFO - mozversion application_remotingname: firefox 04:57:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:57:24 INFO - mozversion application_vendor: Mozilla 04:57:24 INFO - mozversion application_version: 49.0a1 04:57:24 INFO - mozversion platform_buildid: 20160509023013 04:57:24 INFO - mozversion platform_changeset: ab8ae2c23df566acee8cbeb64e5164fae8a10b0e 04:57:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:57:24 INFO - mozversion platform_version: 49.0a1 04:57:24 INFO - using testdate: 1462795044 04:57:24 INFO - actual date: 1462795044 04:57:24 INFO - starting webserver on 'localhost:46481' 04:57:24 INFO - SUITE-START | Running 2 tests 04:57:24 INFO - TEST-START | dromaeo_css 04:57:24 INFO - operating with platform_type : linux_ 04:57:24 INFO - Initialising browser for dromaeo_css test... 04:57:24 INFO - TEST-INFO | started process 25099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpognsCv/profile http://localhost:46481/getInfo.html) 04:57:27 INFO - PROCESS | 25099 | __metrics Screen width/height:1600/1200 04:57:27 INFO - PROCESS | 25099 | colorDepth:24 04:57:27 INFO - PROCESS | 25099 | Browser inner width/height: 1024/697 04:57:27 INFO - PROCESS | 25099 | __metrics 04:57:28 ERROR - PROCESS | 25099 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:57:29 INFO - TEST-INFO | 25099: exit 0 04:57:29 INFO - Browser initialized. 04:57:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:29 INFO - TEST-INFO | started process 25181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpognsCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:41 INFO - PROCESS | 25181 | RSS: Main: 151683072 04:57:41 INFO - PROCESS | 25181 | 04:58:32 INFO - PROCESS | 25181 | 1462795112566 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] 05:00:40 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46481/tests/dromaeo/cssquery-ext.html) 05:00:41 INFO - PROCESS | 25181 | RSS: Main: 250068992 05:00:41 INFO - PROCESS | 25181 | 05:03:43 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-ext.html (next: http://localhost:46481/tests/dromaeo/cssquery-jquery.html) 05:03:44 INFO - PROCESS | 25181 | RSS: Main: 237096960 05:03:44 INFO - PROCESS | 25181 | 05:06:46 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46481/tests/dromaeo/cssquery-mootools.html) 05:06:46 INFO - PROCESS | 25181 | RSS: Main: 240816128 05:06:46 INFO - PROCESS | 25181 | 05:09:49 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46481/tests/dromaeo/cssquery-prototype.html) 05:09:49 INFO - PROCESS | 25181 | RSS: Main: 231739392 05:09:49 INFO - PROCESS | 25181 | 05:12:52 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46481/tests/dromaeo/cssquery-yui.html) 05:12:52 INFO - PROCESS | 25181 | RSS: Main: 227147776 05:12:52 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | Cycle 1(1): loaded http://localhost:46481/tests/dromaeo/cssquery-yui.html (next: http://localhost:46481/tests/dromaeo/cssquery-dojo.html) 05:15:55 INFO - PROCESS | 25181 | RSS: Main: 264491008 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | __start_tp_report 05:15:55 INFO - PROCESS | 25181 | _x_x_mozilla_page_load 05:15:55 INFO - PROCESS | 25181 | _x_x_mozilla_page_load_details 05:15:55 INFO - PROCESS | 25181 | |i|pagename|runs| 05:15:55 INFO - PROCESS | 25181 | |0;dojo.html;3164.794288371256;3165.5093460513613;3183.1246407238004;3208.7272581830543;3232.1273256220807;5382.4079351271375;5402.189671549269;5460.1536761801935;5466.781328746855;5489.368722596908;5361.919571206435;5366.302380690515;5412.296401467804;5441.5102640762325;5451.2640793492865;4809.374781278429;4846.103470857903;5060.316857224265;5076.44159142494;5102.795888164469;5011.173156429203;5035.295058691786;5079.161938280179;5093.668911520758;5096.439391666913;4864.416270047599;4895.657303988723;4902.926456103161;4946.802127914879;4959;4957.702537847741;4959.082569724576;4961.330220420233;4979.053979743837;5014.047331007097;4813.03739252151;4871.2206047032305;4929.137400954819;4950.628702847301;4998.550130488274;5352.652077614982;5387.973060134714;5410.296661434028;5486.039943009997;5511.862203444906;5885.4997325227405;5894.941050589482;5922.4077592240865;5937.970310148465;5940.198073260098;5599.188117722948;5830.562707796932;5860.941390586082;5904.321003084658;5907.616004959664;5366.597505187126;5404.297441332641;5415.48552887475;5441.29263195782;5491.560675145979;5954.851128721816;5957.970210148921;5995.040793473024;6007;6009.978303688384;5635.718214089279;5705.971470142623;5770.105633626795;5772.797952071657;5780.913286300709;5827.3298570664065;5871.1486834409625;5874.618149820248;5879.706014699248;5937.643741375531;5790.218320526759;5815.244018277597;5825.854353641193;5849.853753656193;5851.473367396869;5639;5723.914141287884;5737.426257374229;5862.296524417097;5872.647641141545;4388.166248412791;4393.6704747144095;4394.1870753910625;4430.889227769267;4432.734035957853;3918.1380096378753;3933.350997085506;3939.2318497893207;3957.742746721454;3964.960350396459;5404.621676482687;5447.5641948644015;5470.863228419322;5475.72621368938;5485.725713714299;5831.941680583224;5855.853603659943;5861.413858614104;5891.793787217427;5908.675022873697;5498.257735205776;5509.3664228614225;5516.393196748354;5517.972410137923;5518.310211223597;4939.90120197594;4958.504149585013;4988.625853060962;4992.051510213048;5014.448410674823;5989.55078369124;5993.430624090704;5996.190514280604;5998.760049598054;5998.820035398945;5823.47588717026;5830.883382332415;5830.979578573818;5831.1253312001845;5831.1836342912875;5872.941270587239;5973.133895585029;5985.341612422543;6011.27864656244;6042.395760424099;5713.400092990176;5742.5405967521665;5742.942570574241;5742.994975879288;5752.28096487939;5678.346990096192;5792.913106303325;5833.708314584339;5858.916100521417;5864.706764661664;5511.145772405283;5539.529140023144;5563.610547261653;5599.692016938944;5603.691796951207;5577.191307260344;5580.358258800127;5582.385937546947;5589.10574308125;5589.5248903842;5369;5490.835274941758;5492.945070549244;5495.148252020943;5539.639923404966;5604.2154098425435;5735.541156707537;5748.080307151003;5752.626079304831;5754.510866576388;5562.054450743464;5562.3047119110115;5564.721763911707;5566.4990150886615;5602.1036634138345 05:15:55 INFO - PROCESS | 25181 | |1;ext.html;588.2822955993686;627.7865525721254;631.8673078653483;640.5932233032023;643.3341491556239;31759.36481270373;42836.785816070915;44042;44132.33801492976;44205.336919946225;44564.331535027;45073.8731531711;45148.54851451484;45163.54836451635;45279;7800.141984381742;8829.205371516578;9004;9031.322650801183;9033.909660903406;7803.492772969767;8057.677692892306;10323.122534584569;10559.524821383056;10561.630342937999;10577.100946419563;10658.573657053708;10689.572417103345;10710;10717.624883129092;10615.628453004147;10674.946625266824;10680.25238233324;10685.946570267177;10686.251962362638;10475.109615682675;10544.472776361152;10548.208884333706;10552.261341706084;10553.314034587804;35740.28519429597;35799.4630080549;35822.64177358245;35925;36056.09859753501;3565.2512972275854;3611.1874828163714;3649.434337677664;3802.4866643003115;3892.4939757831303;30519.542206866914;33442.49836252458;33751;33912.32175356479;33996.830015849766;4343.261645520269;4378.1462614790125;4381.737095774264;4414.183376075404;4433.889152771207;279770;287694;287859.9999999979;288623;288821;61978.872429670264;63376;63572.68213658902;63806.68096659487;63990.68004659947;37671.81164094217;38285.042873928374;38286.042848929;40204.19591608152;40448.39327410091;16807.495775126765;16986.405475808286;17038.403655871985;17039.48881533556;17057.573560661083;12618.873811261954;12918.160319579198;13642.045056845926;13671.384787684578;13690.794638080437;18927.716084258747;19075.141618627196;20453.48866278355;21287.148514059572;21403.78596214049;7524.833650784137;7747.320022989148;7900.012498437695;7993.440459167802;8015.358771298399;1069.9197560183018;1120.3557954176217;1179.0862081886607;1227.5764861122898;1252.5365614722612;31066.74550450453;33147.50278745821;33420.49869251915;33585;34000.48999265013;1163.941802909851;1174.747429302704;1196.6290449960366;1199.56215981168;1302.2707283921034;17097.743533847002;17433.651326973388;17472.38846640387;17604;17639.206235719423;452551;454128;458064;458432;459222;57635.71182144062;58070.4192958065;58089.128663070085;58104;58119.709401452725;1303.5372442782866;1397.4619771388088;1420.7158568286177;1426.707524957402;1460.1677044084981;32552;33962;34383.31233375368;34508.30983380369;34566.30867382688;49130.263046053624;50040.49959500358;50049.49950500448;50055.749721252614;50160;322937;329812;330276;330433;330861;25899.223023309332;28539.42921141524;28803.56794648124;29439.85280073586;29848.403031939673;44460.33309500425;49192;49344.50655493399;49581;50334;39256.2148757029;41930.790346048074;42647.36028959506;43888.17230104622;44787.77606111948;41649.79175104105;42640.1471970565;43073;43098;43260.783696081315;41046;41582;42098.36852447277;42252.78873605612;42266;36854.8157259212;37447;37615.6238437623;38101.61898381091;38308.80845595754;28630.71369286364;28664;29246;29249.85375073111;29310 05:15:55 INFO - PROCESS | 25181 | |2;jquery.html;403.5843081625926;412.13657387772616;416.48356038512253;416.6396067401698;429.7142400303798;13321.866781332184;17807.465776026726;19521.99999999998;19536.925469099195;19624.80375196251;15123.168225747579;17277.30890764368;17935.103244837737;17957.820421795812;18755.43733687988;5547.1679248112705;5687.687177205252;5697.4587414195585;5739.885202295973;5758.913616295759;5537.695426751527;5660.320761508604;5670.858228544278;5678.261825962619;5694.658320500763;5558.277423934883;5591.944080559183;5598.720063996804;5604.85987850305;5654.660720356771;5513.531349835269;5544.140658197965;5608.383077861432;5631.63394379366;5655.179998900177;4933.703977761345;5065.873353166164;5080.847574572768;5086.872828179288;5098.082345177866;21749;21882.562348753094;22047.889760551254;22103.44741381478;22514.324570262917;2420.189236605739;2445.425325048612;2577.935551611206;2722;2803.747662710366;13346.13250138738;14102.92948535261;14185.858141418557;14437.566872993826;14475.276236188254;1946.902654867251;1957.4323446200585;1967.8130577595105;2016.485796121994;2108.061912448961;67621.66189169022;80481;80601.19398806054;80872;82963.58518207431;10291.382517049002;10446.843297350546;10677.359358438363;10812.189085818438;11201.551937922555;14152.43390264378;14165.575032748828;14182.787258191136;14245.287735613178;14272.14367137975;8084.434089613671;8348;8377;8481.872771908425;8498.277646400002;8117.1476994915865;8121.309688676411;8123.918760812435;8228.50628962264;8252.958735206406;4132.380142978577;4352.347147927836;4361.171377438277;4422.5356337584735;4520.886977825515;1906.7044608085769;1954.9804501955082;1966.557524556992;1980.79201683824;2041.3569725536408;951.7953639967441;1096.040964156363;1099.4722533183956;1109.9500522476508;1121.3720316622716;17350.826491735173;17753;18361.17374718141;18731.344402946102;19071.711394632734;1025.415513157508;1042.5517027678172;1048.99475502622;1067.354250678344;1096.8080585897435;10118.443485608215;10347.320570845564;10417.791644167075;10509.421981791074;10524.473776311153;457907;461907;462512;464062;464672;89746;90998.54500727454;91298;91319.54340228389;91787.54106229426;1040.9375437473775;1047.5757318286107;1059.7403636109048;1066.0831684750954;1076.5424694504804;15228.923855380652;15727.528174154793;16282.267297971857;16502.25739841686;16710;37366;39954.80022599868;41410.62358423784;41955;42048.579514204466;55755;56516.43483565276;56631.150532741216;57716.4228357711;58271.708641458215;8171.223733745284;8334.708285209988;8350.624221909908;8471.364647651573;8493.57532123379;9283.35016548862;12981.675458113623;13367.264800436069;13562.118462299919;13648.454061837416;11671.12466564994;11989.22070065443;12014.219075760047;12056.397180140782;12156.878431215928;6458.677066146768;9757.341251987038;11641.126915481203;11833.82249266279;11957.940210298893;11812.991791395656;11832.526698931946;11938.164328496921;11947.462364193458;11994.820077699016;8566.78583035429;8647.654093836176;8651.437656552303;8810.691625793066;9016.323775716979;8641;11667.416629168338;11710.297382157098;11871.109666775199;11973.401329933295 05:15:55 INFO - PROCESS | 25181 | |3;mootools.html;1427.8929080318978;1538.2155100898542;1565.7494800831867;1718.4157386488591;1849.6300739852034;8286.709965151222;8691.478511289319;8717.520536370497;8840.469571825695;8865.33509986752;8598.097199794025;8789.648414063446;8802.383833131684;8811.118888111201;8815.162559556848;2065.938021859339;2307.4692820651176;2389.462370966536;2392.377981724751;2423.2851308863837;2315.8147348212187;2324.662923876037;2327.3134425344565;2328.9184878529254;2328.941776455585;2252.234240358278;2331.8367714260007;2333.265021518225;2336.8130549555995;2337.0301324950124;2039.2862498125685;2322.5703244899664;2413.0468464956243;2417.3714834143075;2430.2952143878256;2305.988470057656;2327.5461285049423;2352.694149760537;2359.893804778789;2360.433495960957;8769.605367758466;8809.33929955256;8816;8837.93944726637;8844.513551754651;5266.526012658841;5361.356637203521;5404.486573775485;5410.729463526808;5412.756425960802;3368.6799754023327;3441.5698037745283;3497.807620580867;3516.5428494295834;3527.0829584308262;1074.5379486820664;1100.3837850803495;1103.696483467045;1113.1373185781003;1154.2324354304378;12292.385380730928;12463.878250957458;12464.688382790411;12478.251304921643;12490.188137771107;4514.164879497303;4554.521775213555;4653.302004699254;4659.720416774937;4661.347411362412;9733.805323893625;9734.707958761248;9760.609575616896;9769.169620582188;9777;4663.090697313991;5235.476452354734;5257.237700533477;5282.947170528246;5296.867578310573;4448.866534003985;4494.550544945545;4522.88692782683;4677.087967846305;4827.324174615556;3817.4846395736777;3831.3295173344554;3895.474110995036;3926.0577461409057;4068.6541643960004;1125.4468833010394;1133.4332833583208;1146.295028557448;1165.7668466306773;1182.2138278045004;1010.6967909627083;1025.0518270599666;1030.3663247102977;1036.9377837329785;1037.5175543372368;5778.595498315161;5781.855453613609;5849.912251316234;5919.526437884959;6020.488258497989;457.5698843087554;467.50678034673064;468;470.5647276269437;478.28496397885385;4200.684948628804;4232.343986682069;4247.193033323721;4247.490301163818;4271.295236286041;10507;10929.180311476672;11106.278091924;11139.665810025712;11158.218924675195;10877.0754485868;10939.671809845717;10963.56145754161;10988.011079002928;10988.505517251742;7768.92231077682;8103.675852965934;8184.468009579358;8287.212714792086;8298.875516867252;5981.790637327673;6007.12896629995;6102.023676211785;6120.8775824484155;6137.815865524041;9924.1068303853;10123.9369866163;10135.79728405413;10138.23963202748;10303.278770485995;9884.950575247365;10271.486425678835;10405.115565177044;10467.528961196613;10502.737431563966;7188.245234250328;7772.37820974332;7865.134835168242;7937;7995.1605081465605;8763.29893608497;8767.693130740394;8801.91198088011;8823.161799629024;8824.867626985471;7714.807129821575;7954.880676789737;7957.7612671619945;7970.880436793569;7979.521228726295;7224;7492.100947886289;7644.388448924184;7770.261825126604;7798.649060792164;7057.36483716468;7251.854962900607;7285.23505031964;7286.271372862671;7290.6719197635175;5081.92377114351;5228.477152284741;5349.771698592355;5365.436629153883;5435.701036442875;5345.919811202757;5388.353397592314;5519.39286678473;5533.972330138324;5611.158326251095 05:15:55 INFO - PROCESS | 25181 | |4;prototype.html;322.23736163187374;323.95464634951105;328.7994323462689;330.15645026956116;332.7903420844867;5308.575313974882;5334.959073328199;5360.517553420192;5364.758585863636;5374.301340825697;5229.241759944805;5241.10901146805;5241.266222728811;5252.264682944391;5255.605829562779;3909.7654140751647;4148.216267005187;4151.418801367803;4203.495580530341;4214.346776249687;4085.0595966915776;4129.545749967501;4141.834326626947;4159.6464300534335;4165.687573432005;4088.3458646616546;4099.754014759124;4115.300398932174;4128.958710412888;4170.124273902469;3870.9225815483815;3920.862769803043;4052.331365324718;4121.361189015693;4125.566815484391;3577.8747743829103;3592.2456284180093;3594.227241143167;3596.8741094061843;3616;5002.699838009731;5025.688183435624;5027.371578552681;5029.497050294941;5113.718745468997;4430.379746835446;4572.702774319659;4650.604698600623;4675.906481870344;4687.390639216914;5487.463510217106;5491.972540137273;5508.283923090013;5516.420775818521;5525.502704756551;3998.6001399860074;4010.3984402339593;4015.678745700337;4045.4538637283886;4048.655864251513;5433.402325744165;5701.486866182064;5725.942740572583;5759.539236861083;5789.478946894799;4026.4564283821896;4039.131586708813;4055.270051390719;4066.7356621819486;4075.184963007351;4096.795160241976;4098.221337945781;4108.856190033334;4123.690723195772;4139.4204811326435;4497.775111244425;4683.625309975194;4684.8360307389075;4776.498467660846;4789.976050119727;5503.807366742145;5506.834794956158;5519.034169020486;5538.390777014525;5564.1931919871395;1383.1839214863278;1402.57221547429;1405.8823235527575;1419.8641087130254;1424.586869807765;922.7646950027699;966.8888077870994;975.5658731864253;980.0150848397458;983.3460748602242;5153.716545589954;5192.324997750344;5210.088234558937;5232.686038837682;5232.712200828991;5450.236966824647;5456.781728730885;5483.917741233885;5484.725763711798;5536.252605898152;5025;5046.26829109777;5095.515925987025;5229.398619158846;5269.130593452038;2905.5060639691305;2926.839023853666;2980.5544311009144;2992.189725216256;2998.6401631803888;5603.719814009283;5709.486146246858;5781;5787.6399046224105;5809.88380232393;5416.295881535375;5646.0640466957775;5672.744726487318;5673.517750991212;5699.74351154199;5540.418256083053;5730.478589420642;5741.88516229673;5753.971230143822;5775.5090817281;5244.7902083916215;5449.209864569536;5486.670799752028;5505.311836020497;5511.393746687781;5440.700761458158;5452.7546260417585;5459.972700136633;5492.945070549244;5518.668879867221;5705.942940570541;5739.397363276963;5749.885002300014;5754.194412782297;5759.222504961776;3927.9803600981813;4021.6380525752825;4041.1715598302867;4050.4126901599693;4055.7160998729805;5438.308037521452;5447.536959358499;5493.862653433696;5523.585731070266;5531.446855314597;5310.2386758884395;5331.70675612845;5361.865953351042;5379.488948549882;5385.057614917296;5153.845384638467;5392;5407.702576358338;5458.590605704668;5469.945300547103;5175;5360.3299587551555;5365.195220716923;5371.650842695212;5375.919361209507;5282.283257941108;5314.654547454557;5364.865878353073;5377.096367961257;5401.513863752281;5042.067217564762;5310.336207974004;5313.263669210282;5314.256004159498;5329.413764485981 05:15:55 INFO - PROCESS | 25181 | |5;yui.html;766.2414209932167;819.7131004148547;820.3314298846443;832.7834762961628;833.0378412933064;14070.64823379416;14536.98241123119;14782.556523304318;14846.257687115642;14886.77669834952;13636.522721704743;14441.855581444182;14455;14485;14499.202543860083;699.4928676709396;807.8747794091926;831.5925196653626;840.2521755637488;853.9146085391474;841.6885752271637;843.0052538005151;844.1811442900377;845.0535400351584;845.4546817302836;879.5338470610554;881.3169793410094;883.1521739130443;887.9822403551925;888.8044630181382;680.5338343234899;861.3539845116163;877.3902138014083;883.1830556735059;883.8497455432528;645.2805122288661;645.7868903261913;646.3665607704476;646.4828137489989;646.6508085633799;14157.787633185511;14280.500182493563;14294.07088539252;14314.713705725828;14379.137251764927;13188.208707477486;13300.800487992688;13436.596902092855;13499.932500337534;13592.38834252461;10769.030787229187;10855.457227138611;11063.170262230366;11804.114691398094;11918.106142039382;4481.708688935241;4550.908981820378;4697.037107392976;4703.15343238217;4718.221493453576;54432;54597.181042284;55405.72297138529;55531;55860.441395586335;10304.742381440374;10333.276670632984;10402.427866467417;10465.790684186426;10594.735131621772;17396.913015434842;17543.210555524776;17610.735838962424;17611.823881761018;17625.647487050188;7620.428467864932;7679.692812287446;7685.346745526693;7788.92211077882;7944.563049032358;4379.5182529921685;4383.583559561836;4469.530699276529;4480.7535585542455;4629.259318509023;3219.597550306212;3297.5878015248095;3302.8348582570775;3306.8181250031;3312.983435082809;675.4967549175896;677.7864972533636;681.4412182010703;684.3225207045089;712.5620023091345;692.5117791956759;697.4176562570209;713.9714411423485;715.620721017851;736.6390468670313;9146.99383067862;9264.583093760797;9515.33392662507;9580.616775329048;9659.227261819038;657.9868402631921;686.3719696477667;688.8174633722068;728.6793810723265;736.340974827537;4302.634276086505;4430.490493593214;4449.9777501112285;4609.1703493371515;4674.135284972291;64173.35826641767;64189.67905160444;64557.35442645608;64558.93013373328;65211.34788652148;55699;56597.71701141468;56692;57405.71297143488;57589.424105759244;52702.47297526975;52805.2079218812;53119;53282.46717532775;53412.46587534153;8355.248027677539;8411.4112012161;8670.739877803677;8840.911590884009;8948.015629028698;31259.218519537193;31683.683163168072;32034.35931281408;32240.516392254605;32714.836425817717;38813.41779873361;40421.59578404296;41838.1632367357;42407;42800.57199427966;12181.086418518824;12208.389580520761;12429.75140497203;12637.810432843331;12981.026423018122;9975.850362244428;12531.624051278111;13369.331533423485;13513.662158446117;13952.511662091778;12199.51201951912;12581.685457863627;12758;13142.34288285601;13159.802602960772;12921.353932303535;13103.73792524125;13220.140690855063;13269.734605307647;13285.202887826761;12440.937795310965;12906;12951.287679177736;13165.53920612774;13356.398962046536;10407;10577.153827693919;10706.573896353404;10779.730506737395;11029.944850276019;10059.547320370748;10103.393796372242;10144.49277536135;10312.226583006455;10364.119049880845 05:15:55 INFO - PROCESS | 25181 | __end_tp_report 05:15:55 INFO - PROCESS | 25181 | __start_cc_report 05:15:55 INFO - PROCESS | 25181 | _x_x_mozilla_cycle_collect,840 05:15:55 INFO - PROCESS | 25181 | __end_cc_report 05:15:55 INFO - PROCESS | 25181 | __startTimestamp1462796155690__endTimestamp 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | ------- Summary: start ------- 05:15:55 INFO - PROCESS | 25181 | Number of tests: 6 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#0] dojo.html Cycles:165 Average:5396.68 Median:5562.05 stddev:610.37 (11.0%) stddev-sans-first:586.59 05:15:55 INFO - PROCESS | 25181 | Values: 3164.8 3165.5 3183.1 3208.7 3232.1 5382.4 5402.2 5460.2 5466.8 5489.4 5361.9 5366.3 5412.3 5441.5 5451.3 4809.4 4846.1 5060.3 5076.4 5102.8 5011.2 5035.3 5079.2 5093.7 5096.4 4864.4 4895.7 4902.9 4946.8 4959.0 4957.7 4959.1 4961.3 4979.1 5014.0 4813.0 4871.2 4929.1 4950.6 4998.6 5352.7 5388.0 5410.3 5486.0 5511.9 5885.5 5894.9 5922.4 5938.0 5940.2 5599.2 5830.6 5860.9 5904.3 5907.6 5366.6 5404.3 5415.5 5441.3 5491.6 5954.9 5958.0 5995.0 6007.0 6010.0 5635.7 5706.0 5770.1 5772.8 5780.9 5827.3 5871.1 5874.6 5879.7 5937.6 5790.2 5815.2 5825.9 5849.9 5851.5 5639.0 5723.9 5737.4 5862.3 5872.6 4388.2 4393.7 4394.2 4430.9 4432.7 3918.1 3933.4 3939.2 3957.7 3965.0 5404.6 5447.6 5470.9 5475.7 5485.7 5831.9 5855.9 5861.4 5891.8 5908.7 5498.3 5509.4 5516.4 5518.0 5518.3 4939.9 4958.5 4988.6 4992.1 5014.4 5989.6 5993.4 5996.2 5998.8 5998.8 5823.5 5830.9 5831.0 5831.1 5831.2 5872.9 5973.1 5985.3 6011.3 6042.4 5713.4 5742.5 5742.9 5743.0 5752.3 5678.3 5792.9 5833.7 5858.9 5864.7 5511.1 5539.5 5563.6 5599.7 5603.7 5577.2 5580.4 5582.4 5589.1 5589.5 5369.0 5490.8 5492.9 5495.1 5539.6 5604.2 5735.5 5748.1 5752.6 5754.5 5562.1 5562.3 5564.7 5566.5 5602.1 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#1] ext.html Cycles:180 Average:53162.16 Median:35769.87 stddev:95911.63 (268.1%) stddev-sans-first:96099.46 05:15:55 INFO - PROCESS | 25181 | Values: 588.3 627.8 631.9 640.6 643.3 31759.4 42836.8 44042.0 44132.3 44205.3 44564.3 45073.9 45148.5 45163.5 45279.0 7800.1 8829.2 9004.0 9031.3 9033.9 7803.5 8057.7 10323.1 10559.5 10561.6 10577.1 10658.6 10689.6 10710.0 10717.6 10615.6 10674.9 10680.3 10685.9 10686.3 10475.1 10544.5 10548.2 10552.3 10553.3 35740.3 35799.5 35822.6 35925.0 36056.1 3565.3 3611.2 3649.4 3802.5 3892.5 30519.5 33442.5 33751.0 33912.3 33996.8 4343.3 4378.1 4381.7 4414.2 4433.9 279770.0 287694.0 287860.0 288623.0 288821.0 61978.9 63376.0 63572.7 63806.7 63990.7 37671.8 38285.0 38286.0 40204.2 40448.4 16807.5 16986.4 17038.4 17039.5 17057.6 12618.9 12918.2 13642.0 13671.4 13690.8 18927.7 19075.1 20453.5 21287.1 21403.8 7524.8 7747.3 7900.0 7993.4 8015.4 1069.9 1120.4 1179.1 1227.6 1252.5 31066.7 33147.5 33420.5 33585.0 34000.5 1163.9 1174.7 1196.6 1199.6 1302.3 17097.7 17433.7 17472.4 17604.0 17639.2 452551.0 454128.0 458064.0 458432.0 459222.0 57635.7 58070.4 58089.1 58104.0 58119.7 1303.5 1397.5 1420.7 1426.7 1460.2 32552.0 33962.0 34383.3 34508.3 34566.3 49130.3 50040.5 50049.5 50055.7 50160.0 322937.0 329812.0 330276.0 330433.0 330861.0 25899.2 28539.4 28803.6 29439.9 29848.4 44460.3 49192.0 49344.5 49581.0 50334.0 39256.2 41930.8 42647.4 43888.2 44787.8 41649.8 42640.1 43073.0 43098.0 43260.8 41046.0 41582.0 42098.4 42252.8 42266.0 36854.8 37447.0 37615.6 38101.6 38308.8 28630.7 28664.0 29246.0 29249.9 29310.0 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#2] jquery.html Cycles:180 Average:27892.32 Median:2432.81 stddev:76316.26 (3137.0%) stddev-sans-first:76502.44 05:15:55 INFO - PROCESS | 25181 | Values: 403.6 412.1 416.5 416.6 429.7 13321.9 17807.5 19522.0 19536.9 19624.8 15123.2 17277.3 17935.1 17957.8 18755.4 5547.2 5687.7 5697.5 5739.9 5758.9 5537.7 5660.3 5670.9 5678.3 5694.7 5558.3 5591.9 5598.7 5604.9 5654.7 5513.5 5544.1 5608.4 5631.6 5655.2 4933.7 5065.9 5080.8 5086.9 5098.1 21749.0 21882.6 22047.9 22103.4 22514.3 2420.2 2445.4 2577.9 2722.0 2803.7 13346.1 14102.9 14185.9 14437.6 14475.3 1946.9 1957.4 1967.8 2016.5 2108.1 67621.7 80481.0 80601.2 80872.0 82963.6 10291.4 10446.8 10677.4 10812.2 11201.6 14152.4 14165.6 14182.8 14245.3 14272.1 8084.4 8348.0 8377.0 8481.9 8498.3 8117.1 8121.3 8123.9 8228.5 8253.0 4132.4 4352.3 4361.2 4422.5 4520.9 1906.7 1955.0 1966.6 1980.8 2041.4 951.8 1096.0 1099.5 1110.0 1121.4 17350.8 17753.0 18361.2 18731.3 19071.7 1025.4 1042.6 1049.0 1067.4 1096.8 10118.4 10347.3 10417.8 10509.4 10524.5 457907.0 461907.0 462512.0 464062.0 464672.0 89746.0 90998.5 91298.0 91319.5 91787.5 1040.9 1047.6 1059.7 1066.1 1076.5 15228.9 15727.5 16282.3 16502.3 16710.0 37366.0 39954.8 41410.6 41955.0 42048.6 55755.0 56516.4 56631.2 57716.4 58271.7 8171.2 8334.7 8350.6 8471.4 8493.6 9283.4 12981.7 13367.3 13562.1 13648.5 11671.1 11989.2 12014.2 12056.4 12156.9 6458.7 9757.3 11641.1 11833.8 11957.9 11813.0 11832.5 11938.2 11947.5 11994.8 8566.8 8647.7 8651.4 8810.7 9016.3 8641.0 11667.4 11710.3 11871.1 11973.4 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#3] mootools.html Cycles:180 Average:5812.98 Median:4660.53 stddev:3320.23 (71.2%) stddev-sans-first:3313.19 05:15:55 INFO - PROCESS | 25181 | Values: 1427.9 1538.2 1565.7 1718.4 1849.6 8286.7 8691.5 8717.5 8840.5 8865.3 8598.1 8789.6 8802.4 8811.1 8815.2 2065.9 2307.5 2389.5 2392.4 2423.3 2315.8 2324.7 2327.3 2328.9 2328.9 2252.2 2331.8 2333.3 2336.8 2337.0 2039.3 2322.6 2413.0 2417.4 2430.3 2306.0 2327.5 2352.7 2359.9 2360.4 8769.6 8809.3 8816.0 8837.9 8844.5 5266.5 5361.4 5404.5 5410.7 5412.8 3368.7 3441.6 3497.8 3516.5 3527.1 1074.5 1100.4 1103.7 1113.1 1154.2 12292.4 12463.9 12464.7 12478.3 12490.2 4514.2 4554.5 4653.3 4659.7 4661.3 9733.8 9734.7 9760.6 9769.2 9777.0 4663.1 5235.5 5257.2 5282.9 5296.9 4448.9 4494.6 4522.9 4677.1 4827.3 3817.5 3831.3 3895.5 3926.1 4068.7 1125.4 1133.4 1146.3 1165.8 1182.2 1010.7 1025.1 1030.4 1036.9 1037.5 5778.6 5781.9 5849.9 5919.5 6020.5 457.6 467.5 468.0 470.6 478.3 4200.7 4232.3 4247.2 4247.5 4271.3 10507.0 10929.2 11106.3 11139.7 11158.2 10877.1 10939.7 10963.6 10988.0 10988.5 7768.9 8103.7 8184.5 8287.2 8298.9 5981.8 6007.1 6102.0 6120.9 6137.8 9924.1 10123.9 10135.8 10138.2 10303.3 9885.0 10271.5 10405.1 10467.5 10502.7 7188.2 7772.4 7865.1 7937.0 7995.2 8763.3 8767.7 8801.9 8823.2 8824.9 7714.8 7954.9 7957.8 7970.9 7979.5 7224.0 7492.1 7644.4 7770.3 7798.6 7057.4 7251.9 7285.2 7286.3 7290.7 5081.9 5228.5 5349.8 5365.4 5435.7 5345.9 5388.4 5519.4 5534.0 5611.2 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#4] prototype.html Cycles:180 Average:4588.94 Median:5248.53 stddev:1326.49 (25.3%) stddev-sans-first:1290.97 05:15:55 INFO - PROCESS | 25181 | Values: 322.2 324.0 328.8 330.2 332.8 5308.6 5335.0 5360.5 5364.8 5374.3 5229.2 5241.1 5241.3 5252.3 5255.6 3909.8 4148.2 4151.4 4203.5 4214.3 4085.1 4129.5 4141.8 4159.6 4165.7 4088.3 4099.8 4115.3 4129.0 4170.1 3870.9 3920.9 4052.3 4121.4 4125.6 3577.9 3592.2 3594.2 3596.9 3616.0 5002.7 5025.7 5027.4 5029.5 5113.7 4430.4 4572.7 4650.6 4675.9 4687.4 5487.5 5492.0 5508.3 5516.4 5525.5 3998.6 4010.4 4015.7 4045.5 4048.7 5433.4 5701.5 5725.9 5759.5 5789.5 4026.5 4039.1 4055.3 4066.7 4075.2 4096.8 4098.2 4108.9 4123.7 4139.4 4497.8 4683.6 4684.8 4776.5 4790.0 5503.8 5506.8 5519.0 5538.4 5564.2 1383.2 1402.6 1405.9 1419.9 1424.6 922.8 966.9 975.6 980.0 983.3 5153.7 5192.3 5210.1 5232.7 5232.7 5450.2 5456.8 5483.9 5484.7 5536.3 5025.0 5046.3 5095.5 5229.4 5269.1 2905.5 2926.8 2980.6 2992.2 2998.6 5603.7 5709.5 5781.0 5787.6 5809.9 5416.3 5646.1 5672.7 5673.5 5699.7 5540.4 5730.5 5741.9 5754.0 5775.5 5244.8 5449.2 5486.7 5505.3 5511.4 5440.7 5452.8 5460.0 5492.9 5518.7 5705.9 5739.4 5749.9 5754.2 5759.2 3928.0 4021.6 4041.2 4050.4 4055.7 5438.3 5447.5 5493.9 5523.6 5531.4 5310.2 5331.7 5361.9 5379.5 5385.1 5153.8 5392.0 5407.7 5458.6 5469.9 5175.0 5360.3 5365.2 5371.7 5375.9 5282.3 5314.7 5364.9 5377.1 5401.5 5042.1 5310.3 5313.3 5314.3 5329.4 05:15:55 INFO - PROCESS | 25181 | 05:15:55 INFO - PROCESS | 25181 | [#5] yui.html Cycles:180 Average:14812.82 Median:4481.23 stddev:17344.35 (387.0%) stddev-sans-first:17360.93 05:15:55 INFO - PROCESS | 25181 | Values: 766.2 819.7 820.3 832.8 833.0 14070.6 14537.0 14782.6 14846.3 14886.8 13636.5 14441.9 14455.0 14485.0 14499.2 699.5 807.9 831.6 840.3 853.9 841.7 843.0 844.2 845.1 845.5 879.5 881.3 883.2 888.0 888.8 680.5 861.4 877.4 883.2 883.8 645.3 645.8 646.4 646.5 646.7 14157.8 14280.5 14294.1 14314.7 14379.1 13188.2 13300.8 13436.6 13499.9 13592.4 10769.0 10855.5 11063.2 11804.1 11918.1 4481.7 4550.9 4697.0 4703.2 4718.2 54432.0 54597.2 55405.7 55531.0 55860.4 10304.7 10333.3 10402.4 10465.8 10594.7 17396.9 17543.2 17610.7 17611.8 17625.6 7620.4 7679.7 7685.3 7788.9 7944.6 4379.5 4383.6 4469.5 4480.8 4629.3 3219.6 3297.6 3302.8 3306.8 3313.0 675.5 677.8 681.4 684.3 712.6 692.5 697.4 714.0 715.6 736.6 9147.0 9264.6 9515.3 9580.6 9659.2 658.0 686.4 688.8 728.7 736.3 4302.6 4430.5 4450.0 4609.2 4674.1 64173.4 64189.7 64557.4 64558.9 65211.3 55699.0 56597.7 56692.0 57405.7 57589.4 52702.5 52805.2 53119.0 53282.5 53412.5 8355.2 8411.4 8670.7 8840.9 8948.0 31259.2 31683.7 32034.4 32240.5 32714.8 38813.4 40421.6 41838.2 42407.0 42800.6 12181.1 12208.4 12429.8 12637.8 12981.0 9975.9 12531.6 13369.3 13513.7 13952.5 12199.5 12581.7 12758.0 13142.3 13159.8 12921.4 13103.7 13220.1 13269.7 13285.2 12440.9 12906.0 12951.3 13165.5 13356.4 10407.0 10577.2 10706.6 10779.7 11029.9 10059.5 10103.4 10144.5 10312.2 10364.1 05:15:55 INFO - PROCESS | 25181 | -------- Summary: end -------- 05:15:55 INFO - PROCESS | 25181 | 05:15:56 INFO - TEST-INFO | 25181: exit 0 05:15:56 INFO - TEST-OK | dromaeo_css | took 1112125ms 05:15:56 INFO - TEST-START | kraken 05:15:56 INFO - operating with platform_type : linux_ 05:15:56 INFO - Initialising browser for kraken test... 05:15:56 INFO - TEST-INFO | started process 25358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKNB82/profile http://localhost:46481/getInfo.html) 05:16:00 INFO - PROCESS | 25358 | __metrics Screen width/height:1600/1200 05:16:00 INFO - PROCESS | 25358 | colorDepth:24 05:16:00 INFO - PROCESS | 25358 | Browser inner width/height: 1024/697 05:16:00 INFO - PROCESS | 25358 | __metrics 05:16:01 ERROR - PROCESS | 25358 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:16:01 INFO - TEST-INFO | 25358: exit 0 05:16:01 INFO - Browser initialized. 05:16:01 INFO - Running cycle 1/1 for kraken test... 05:16:01 INFO - TEST-INFO | started process 25441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKNB82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:13 INFO - PROCESS | 25441 | RSS: Main: 152395776 05:16:13 INFO - PROCESS | 25441 | 05:16:16 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46481/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:17 INFO - PROCESS | 25441 | RSS: Main: 208175104 05:16:17 INFO - PROCESS | 25441 | 05:16:19 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46481/tests/kraken/driver.html?testName=audio-dft) 05:16:20 INFO - PROCESS | 25441 | RSS: Main: 197582848 05:16:20 INFO - PROCESS | 25441 | 05:16:23 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46481/tests/kraken/driver.html?testName=audio-fft) 05:16:24 INFO - PROCESS | 25441 | RSS: Main: 265306112 05:16:24 INFO - PROCESS | 25441 | 05:16:26 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46481/tests/kraken/driver.html?testName=audio-oscillator) 05:16:26 INFO - PROCESS | 25441 | RSS: Main: 174616576 05:16:26 INFO - PROCESS | 25441 | 05:16:29 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:29 INFO - PROCESS | 25441 | RSS: Main: 179027968 05:16:29 INFO - PROCESS | 25441 | 05:16:33 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46481/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:33 INFO - PROCESS | 25441 | RSS: Main: 214740992 05:16:33 INFO - PROCESS | 25441 | 05:16:37 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46481/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:37 INFO - PROCESS | 25441 | RSS: Main: 211877888 05:16:37 INFO - PROCESS | 25441 | 05:16:40 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46481/tests/kraken/driver.html?testName=json-parse-financial) 05:16:41 INFO - PROCESS | 25441 | RSS: Main: 213385216 05:16:41 INFO - PROCESS | 25441 | 05:16:43 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:43 INFO - PROCESS | 25441 | RSS: Main: 202326016 05:16:43 INFO - PROCESS | 25441 | 05:16:45 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:46 INFO - PROCESS | 25441 | RSS: Main: 206716928 05:16:46 INFO - PROCESS | 25441 | 05:16:48 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:48 INFO - PROCESS | 25441 | RSS: Main: 216645632 05:16:48 INFO - PROCESS | 25441 | 05:16:51 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:52 INFO - PROCESS | 25441 | RSS: Main: 221130752 05:16:52 INFO - PROCESS | 25441 | 05:16:55 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:55 INFO - PROCESS | 25441 | RSS: Main: 219168768 05:16:55 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | Cycle 1(1): loaded http://localhost:46481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46481/tests/kraken/driver.html?testName=ai-astar) 05:16:57 INFO - PROCESS | 25441 | RSS: Main: 264753152 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | __start_tp_report 05:16:57 INFO - PROCESS | 25441 | _x_x_mozilla_page_load 05:16:57 INFO - PROCESS | 25441 | _x_x_mozilla_page_load_details 05:16:57 INFO - PROCESS | 25441 | |i|pagename|runs| 05:16:57 INFO - PROCESS | 25441 | |0;ai-astar;110;105;110;110;109;109;111;109;109;110 05:16:57 INFO - PROCESS | 25441 | |1;audio-beat-detection;151;124;162;210;127;151;151;130;180;124 05:16:57 INFO - PROCESS | 25441 | |2;audio-dft;162;162;161;160;161;161;162;161;162;160 05:16:57 INFO - PROCESS | 25441 | |3;audio-fft;74;77;76;151;76;76;77;76;135;75 05:16:57 INFO - PROCESS | 25441 | |4;audio-oscillator;92;92;145;92;92;92;121;91;92;120 05:16:57 INFO - PROCESS | 25441 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;116;116 05:16:57 INFO - PROCESS | 25441 | |6;imaging-darkroom;146;147;146;146;145;146;145;145;146;146 05:16:57 INFO - PROCESS | 25441 | |7;imaging-desaturate;94;94;94;95;95;95;95;95;95;94 05:16:57 INFO - PROCESS | 25441 | |8;json-parse-financial;60;60;58;59;63;59;60;112;57;57 05:16:57 INFO - PROCESS | 25441 | |9;json-stringify-tinderbox;60;60;59;59;60;59;59;59;59;60 05:16:57 INFO - PROCESS | 25441 | |10;stanford-crypto-aes;79;79;79;78;91;82;81;80;82;79 05:16:57 INFO - PROCESS | 25441 | |11;stanford-crypto-ccm;127;129;124;126;132;125;135;123;244;127 05:16:57 INFO - PROCESS | 25441 | |12;stanford-crypto-pbkdf2;170;175;171;177;175;170;176;173;170;170 05:16:57 INFO - PROCESS | 25441 | |13;stanford-crypto-sha256-iterative;67;65;66;74;64;65;66;64;74;63 05:16:57 INFO - PROCESS | 25441 | __end_tp_report 05:16:57 INFO - PROCESS | 25441 | __start_cc_report 05:16:57 INFO - PROCESS | 25441 | _x_x_mozilla_cycle_collect,1855 05:16:57 INFO - PROCESS | 25441 | __end_cc_report 05:16:57 INFO - PROCESS | 25441 | __startTimestamp1462796217886__endTimestamp 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | ------- Summary: start ------- 05:16:57 INFO - PROCESS | 25441 | Number of tests: 14 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.62 (1.5%) stddev-sans-first:1.69 05:16:57 INFO - PROCESS | 25441 | Values: 110.0 105.0 110.0 110.0 109.0 109.0 111.0 109.0 109.0 110.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:151.00 stddev:27.72 (18.4%) stddev-sans-first:29.41 05:16:57 INFO - PROCESS | 25441 | Values: 151.0 124.0 162.0 210.0 127.0 151.0 151.0 130.0 180.0 124.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:16:57 INFO - PROCESS | 25441 | Values: 162.0 162.0 161.0 160.0 161.0 161.0 162.0 161.0 162.0 160.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:28.57 (37.6%) stddev-sans-first:29.76 05:16:57 INFO - PROCESS | 25441 | Values: 74.0 77.0 76.0 151.0 76.0 76.0 77.0 76.0 135.0 75.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:92.00 stddev:18.99 (20.6%) stddev-sans-first:19.73 05:16:57 INFO - PROCESS | 25441 | Values: 92.0 92.0 145.0 92.0 92.0 92.0 121.0 91.0 92.0 120.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:16:57 INFO - PROCESS | 25441 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:16:57 INFO - PROCESS | 25441 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:16:57 INFO - PROCESS | 25441 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:59.50 stddev:16.78 (28.2%) stddev-sans-first:17.72 05:16:57 INFO - PROCESS | 25441 | Values: 60.0 60.0 58.0 59.0 63.0 59.0 60.0 112.0 57.0 57.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 05:16:57 INFO - PROCESS | 25441 | Values: 60.0 60.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:3.77 (4.7%) stddev-sans-first:3.93 05:16:57 INFO - PROCESS | 25441 | Values: 79.0 79.0 79.0 78.0 91.0 82.0 81.0 80.0 82.0 79.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:128.00 stddev:37.00 (28.9%) stddev-sans-first:38.98 05:16:57 INFO - PROCESS | 25441 | Values: 127.0 129.0 124.0 126.0 132.0 125.0 135.0 123.0 244.0 127.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:174.00 stddev:2.83 (1.6%) stddev-sans-first:2.83 05:16:57 INFO - PROCESS | 25441 | Values: 170.0 175.0 171.0 177.0 175.0 170.0 176.0 173.0 170.0 170.0 05:16:57 INFO - PROCESS | 25441 | 05:16:57 INFO - PROCESS | 25441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:3.97 (6.0%) stddev-sans-first:4.21 05:16:57 INFO - PROCESS | 25441 | Values: 67.0 65.0 66.0 74.0 64.0 65.0 66.0 64.0 74.0 63.0 05:16:57 INFO - PROCESS | 25441 | -------- Summary: end -------- 05:16:57 INFO - PROCESS | 25441 | 05:16:58 INFO - TEST-INFO | 25441: exit 0 05:16:58 INFO - TEST-OK | kraken | took 62567ms 05:16:58 INFO - SUITE-END | took 1174s 05:16:59 INFO - Completed test suite (00:19:34) 05:16:59 INFO - javascript benchmark 05:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.794288371256, 3165.5093460513613, 3183.1246407238004, 3208.7272581830543, 3232.1273256220807, 5382.4079351271375, 5402.189671549269, 5460.1536761801935, 5466.781328746855, 5489.368722596908, 5361.919571206435, 5366.302380690515, 5412.296401467804, 5441.5102640762325, 5451.2640793492865, 4809.374781278429, 4846.103470857903, 5060.316857224265, 5076.44159142494, 5102.795888164469, 5011.173156429203, 5035.295058691786, 5079.161938280179, 5093.668911520758, 5096.439391666913, 4864.416270047599, 4895.657303988723, 4902.926456103161, 4946.802127914879, 4959.0, 4957.702537847741, 4959.082569724576, 4961.330220420233, 4979.053979743837, 5014.047331007097, 4813.03739252151, 4871.2206047032305, 4929.137400954819, 4950.628702847301, 4998.550130488274, 5352.652077614982, 5387.973060134714, 5410.296661434028, 5486.039943009997, 5511.862203444906, 5885.4997325227405, 5894.941050589482, 5922.4077592240865, 5937.970310148465, 5940.198073260098, 5599.188117722948, 5830.562707796932, 5860.941390586082, 5904.321003084658, 5907.616004959664, 5366.597505187126, 5404.297441332641, 5415.48552887475, 5441.29263195782, 5491.560675145979, 5954.851128721816, 5957.970210148921, 5995.040793473024, 6007.0, 6009.978303688384, 5635.718214089279, 5705.971470142623, 5770.105633626795, 5772.797952071657, 5780.913286300709, 5827.3298570664065, 5871.1486834409625, 5874.618149820248, 5879.706014699248, 5937.643741375531, 5790.218320526759, 5815.244018277597, 5825.854353641193, 5849.853753656193, 5851.473367396869, 5639.0, 5723.914141287884, 5737.426257374229, 5862.296524417097, 5872.647641141545, 4388.166248412791, 4393.6704747144095, 4394.1870753910625, 4430.889227769267, 4432.734035957853, 3918.1380096378753, 3933.350997085506, 3939.2318497893207, 3957.742746721454, 3964.960350396459, 5404.621676482687, 5447.5641948644015, 5470.863228419322, 5475.72621368938, 5485.725713714299, 5831.941680583224, 5855.853603659943, 5861.413858614104, 5891.793787217427, 5908.675022873697, 5498.257735205776, 5509.3664228614225, 5516.393196748354, 5517.972410137923, 5518.310211223597, 4939.90120197594, 4958.504149585013, 4988.625853060962, 4992.051510213048, 5014.448410674823, 5989.55078369124, 5993.430624090704, 5996.190514280604, 5998.760049598054, 5998.820035398945, 5823.47588717026, 5830.883382332415, 5830.979578573818, 5831.1253312001845, 5831.1836342912875, 5872.941270587239, 5973.133895585029, 5985.341612422543, 6011.27864656244, 6042.395760424099, 5713.400092990176, 5742.5405967521665, 5742.942570574241, 5742.994975879288, 5752.28096487939, 5678.346990096192, 5792.913106303325, 5833.708314584339, 5858.916100521417, 5864.706764661664, 5511.145772405283, 5539.529140023144, 5563.610547261653, 5599.692016938944, 5603.691796951207, 5577.191307260344, 5580.358258800127, 5582.385937546947, 5589.10574308125, 5589.5248903842, 5369.0, 5490.835274941758, 5492.945070549244, 5495.148252020943, 5539.639923404966, 5604.2154098425435, 5735.541156707537, 5748.080307151003, 5752.626079304831, 5754.510866576388, 5562.054450743464, 5562.3047119110115, 5564.721763911707, 5566.4990150886615, 5602.1036634138345], "value": 5355.884147302479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2822955993686, 627.7865525721254, 631.8673078653483, 640.5932233032023, 643.3341491556239, 31759.36481270373, 42836.785816070915, 44042.0, 44132.33801492976, 44205.336919946225, 44564.331535027, 45073.8731531711, 45148.54851451484, 45163.54836451635, 45279.0, 7800.141984381742, 8829.205371516578, 9004.0, 9031.322650801183, 9033.909660903406, 7803.492772969767, 8057.677692892306, 10323.122534584569, 10559.524821383056, 10561.630342937999, 10577.100946419563, 10658.573657053708, 10689.572417103345, 10710.0, 10717.624883129092, 10615.628453004147, 10674.946625266824, 10680.25238233324, 10685.946570267177, 10686.251962362638, 10475.109615682675, 10544.472776361152, 10548.208884333706, 10552.261341706084, 10553.314034587804, 35740.28519429597, 35799.4630080549, 35822.64177358245, 35925.0, 36056.09859753501, 3565.2512972275854, 3611.1874828163714, 3649.434337677664, 3802.4866643003115, 3892.4939757831303, 30519.542206866914, 33442.49836252458, 33751.0, 33912.32175356479, 33996.830015849766, 4343.261645520269, 4378.1462614790125, 4381.737095774264, 4414.183376075404, 4433.889152771207, 279770.0, 287694.0, 287859.9999999979, 288623.0, 288821.0, 61978.872429670264, 63376.0, 63572.68213658902, 63806.68096659487, 63990.68004659947, 37671.81164094217, 38285.042873928374, 38286.042848929, 40204.19591608152, 40448.39327410091, 16807.495775126765, 16986.405475808286, 17038.403655871985, 17039.48881533556, 17057.573560661083, 12618.873811261954, 12918.160319579198, 13642.045056845926, 13671.384787684578, 13690.794638080437, 18927.716084258747, 19075.141618627196, 20453.48866278355, 21287.148514059572, 21403.78596214049, 7524.833650784137, 7747.320022989148, 7900.012498437695, 7993.440459167802, 8015.358771298399, 1069.9197560183018, 1120.3557954176217, 1179.0862081886607, 1227.5764861122898, 1252.5365614722612, 31066.74550450453, 33147.50278745821, 33420.49869251915, 33585.0, 34000.48999265013, 1163.941802909851, 1174.747429302704, 1196.6290449960366, 1199.56215981168, 1302.2707283921034, 17097.743533847002, 17433.651326973388, 17472.38846640387, 17604.0, 17639.206235719423, 452551.0, 454128.0, 458064.0, 458432.0, 459222.0, 57635.71182144062, 58070.4192958065, 58089.128663070085, 58104.0, 58119.709401452725, 1303.5372442782866, 1397.4619771388088, 1420.7158568286177, 1426.707524957402, 1460.1677044084981, 32552.0, 33962.0, 34383.31233375368, 34508.30983380369, 34566.30867382688, 49130.263046053624, 50040.49959500358, 50049.49950500448, 50055.749721252614, 50160.0, 322937.0, 329812.0, 330276.0, 330433.0, 330861.0, 25899.223023309332, 28539.42921141524, 28803.56794648124, 29439.85280073586, 29848.403031939673, 44460.33309500425, 49192.0, 49344.50655493399, 49581.0, 50334.0, 39256.2148757029, 41930.790346048074, 42647.36028959506, 43888.17230104622, 44787.77606111948, 41649.79175104105, 42640.1471970565, 43073.0, 43098.0, 43260.783696081315, 41046.0, 41582.0, 42098.36852447277, 42252.78873605612, 42266.0, 36854.8157259212, 37447.0, 37615.6238437623, 38101.61898381091, 38308.80845595754, 28630.71369286364, 28664.0, 29246.0, 29249.85375073111, 29310.0], "value": 20265.804139583823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.5843081625926, 412.13657387772616, 416.48356038512253, 416.6396067401698, 429.7142400303798, 13321.866781332184, 17807.465776026726, 19521.99999999998, 19536.925469099195, 19624.80375196251, 15123.168225747579, 17277.30890764368, 17935.103244837737, 17957.820421795812, 18755.43733687988, 5547.1679248112705, 5687.687177205252, 5697.4587414195585, 5739.885202295973, 5758.913616295759, 5537.695426751527, 5660.320761508604, 5670.858228544278, 5678.261825962619, 5694.658320500763, 5558.277423934883, 5591.944080559183, 5598.720063996804, 5604.85987850305, 5654.660720356771, 5513.531349835269, 5544.140658197965, 5608.383077861432, 5631.63394379366, 5655.179998900177, 4933.703977761345, 5065.873353166164, 5080.847574572768, 5086.872828179288, 5098.082345177866, 21749.0, 21882.562348753094, 22047.889760551254, 22103.44741381478, 22514.324570262917, 2420.189236605739, 2445.425325048612, 2577.935551611206, 2722.0, 2803.747662710366, 13346.13250138738, 14102.92948535261, 14185.858141418557, 14437.566872993826, 14475.276236188254, 1946.902654867251, 1957.4323446200585, 1967.8130577595105, 2016.485796121994, 2108.061912448961, 67621.66189169022, 80481.0, 80601.19398806054, 80872.0, 82963.58518207431, 10291.382517049002, 10446.843297350546, 10677.359358438363, 10812.189085818438, 11201.551937922555, 14152.43390264378, 14165.575032748828, 14182.787258191136, 14245.287735613178, 14272.14367137975, 8084.434089613671, 8348.0, 8377.0, 8481.872771908425, 8498.277646400002, 8117.1476994915865, 8121.309688676411, 8123.918760812435, 8228.50628962264, 8252.958735206406, 4132.380142978577, 4352.347147927836, 4361.171377438277, 4422.5356337584735, 4520.886977825515, 1906.7044608085769, 1954.9804501955082, 1966.557524556992, 1980.79201683824, 2041.3569725536408, 951.7953639967441, 1096.040964156363, 1099.4722533183956, 1109.9500522476508, 1121.3720316622716, 17350.826491735173, 17753.0, 18361.17374718141, 18731.344402946102, 19071.711394632734, 1025.415513157508, 1042.5517027678172, 1048.99475502622, 1067.354250678344, 1096.8080585897435, 10118.443485608215, 10347.320570845564, 10417.791644167075, 10509.421981791074, 10524.473776311153, 457907.0, 461907.0, 462512.0, 464062.0, 464672.0, 89746.0, 90998.54500727454, 91298.0, 91319.54340228389, 91787.54106229426, 1040.9375437473775, 1047.5757318286107, 1059.7403636109048, 1066.0831684750954, 1076.5424694504804, 15228.923855380652, 15727.528174154793, 16282.267297971857, 16502.25739841686, 16710.0, 37366.0, 39954.80022599868, 41410.62358423784, 41955.0, 42048.579514204466, 55755.0, 56516.43483565276, 56631.150532741216, 57716.4228357711, 58271.708641458215, 8171.223733745284, 8334.708285209988, 8350.624221909908, 8471.364647651573, 8493.57532123379, 9283.35016548862, 12981.675458113623, 13367.264800436069, 13562.118462299919, 13648.454061837416, 11671.12466564994, 11989.22070065443, 12014.219075760047, 12056.397180140782, 12156.878431215928, 6458.677066146768, 9757.341251987038, 11641.126915481203, 11833.82249266279, 11957.940210298893, 11812.991791395656, 11832.526698931946, 11938.164328496921, 11947.462364193458, 11994.820077699016, 8566.78583035429, 8647.654093836176, 8651.437656552303, 8810.691625793066, 9016.323775716979, 8641.0, 11667.416629168338, 11710.297382157098, 11871.109666775199, 11973.401329933295], "value": 9146.93653895856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.8929080318978, 1538.2155100898542, 1565.7494800831867, 1718.4157386488591, 1849.6300739852034, 8286.709965151222, 8691.478511289319, 8717.520536370497, 8840.469571825695, 8865.33509986752, 8598.097199794025, 8789.648414063446, 8802.383833131684, 8811.118888111201, 8815.162559556848, 2065.938021859339, 2307.4692820651176, 2389.462370966536, 2392.377981724751, 2423.2851308863837, 2315.8147348212187, 2324.662923876037, 2327.3134425344565, 2328.9184878529254, 2328.941776455585, 2252.234240358278, 2331.8367714260007, 2333.265021518225, 2336.8130549555995, 2337.0301324950124, 2039.2862498125685, 2322.5703244899664, 2413.0468464956243, 2417.3714834143075, 2430.2952143878256, 2305.988470057656, 2327.5461285049423, 2352.694149760537, 2359.893804778789, 2360.433495960957, 8769.605367758466, 8809.33929955256, 8816.0, 8837.93944726637, 8844.513551754651, 5266.526012658841, 5361.356637203521, 5404.486573775485, 5410.729463526808, 5412.756425960802, 3368.6799754023327, 3441.5698037745283, 3497.807620580867, 3516.5428494295834, 3527.0829584308262, 1074.5379486820664, 1100.3837850803495, 1103.696483467045, 1113.1373185781003, 1154.2324354304378, 12292.385380730928, 12463.878250957458, 12464.688382790411, 12478.251304921643, 12490.188137771107, 4514.164879497303, 4554.521775213555, 4653.302004699254, 4659.720416774937, 4661.347411362412, 9733.805323893625, 9734.707958761248, 9760.609575616896, 9769.169620582188, 9777.0, 4663.090697313991, 5235.476452354734, 5257.237700533477, 5282.947170528246, 5296.867578310573, 4448.866534003985, 4494.550544945545, 4522.88692782683, 4677.087967846305, 4827.324174615556, 3817.4846395736777, 3831.3295173344554, 3895.474110995036, 3926.0577461409057, 4068.6541643960004, 1125.4468833010394, 1133.4332833583208, 1146.295028557448, 1165.7668466306773, 1182.2138278045004, 1010.6967909627083, 1025.0518270599666, 1030.3663247102977, 1036.9377837329785, 1037.5175543372368, 5778.595498315161, 5781.855453613609, 5849.912251316234, 5919.526437884959, 6020.488258497989, 457.5698843087554, 467.50678034673064, 468.0, 470.5647276269437, 478.28496397885385, 4200.684948628804, 4232.343986682069, 4247.193033323721, 4247.490301163818, 4271.295236286041, 10507.0, 10929.180311476672, 11106.278091924, 11139.665810025712, 11158.218924675195, 10877.0754485868, 10939.671809845717, 10963.56145754161, 10988.011079002928, 10988.505517251742, 7768.92231077682, 8103.675852965934, 8184.468009579358, 8287.212714792086, 8298.875516867252, 5981.790637327673, 6007.12896629995, 6102.023676211785, 6120.8775824484155, 6137.815865524041, 9924.1068303853, 10123.9369866163, 10135.79728405413, 10138.23963202748, 10303.278770485995, 9884.950575247365, 10271.486425678835, 10405.115565177044, 10467.528961196613, 10502.737431563966, 7188.245234250328, 7772.37820974332, 7865.134835168242, 7937.0, 7995.1605081465605, 8763.29893608497, 8767.693130740394, 8801.91198088011, 8823.161799629024, 8824.867626985471, 7714.807129821575, 7954.880676789737, 7957.7612671619945, 7970.880436793569, 7979.521228726295, 7224.0, 7492.100947886289, 7644.388448924184, 7770.261825126604, 7798.649060792164, 7057.36483716468, 7251.854962900607, 7285.23505031964, 7286.271372862671, 7290.6719197635175, 5081.92377114351, 5228.477152284741, 5349.771698592355, 5365.436629153883, 5435.701036442875, 5345.919811202757, 5388.353397592314, 5519.39286678473, 5533.972330138324, 5611.158326251095], "value": 4571.817781786437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.23736163187374, 323.95464634951105, 328.7994323462689, 330.15645026956116, 332.7903420844867, 5308.575313974882, 5334.959073328199, 5360.517553420192, 5364.758585863636, 5374.301340825697, 5229.241759944805, 5241.10901146805, 5241.266222728811, 5252.264682944391, 5255.605829562779, 3909.7654140751647, 4148.216267005187, 4151.418801367803, 4203.495580530341, 4214.346776249687, 4085.0595966915776, 4129.545749967501, 4141.834326626947, 4159.6464300534335, 4165.687573432005, 4088.3458646616546, 4099.754014759124, 4115.300398932174, 4128.958710412888, 4170.124273902469, 3870.9225815483815, 3920.862769803043, 4052.331365324718, 4121.361189015693, 4125.566815484391, 3577.8747743829103, 3592.2456284180093, 3594.227241143167, 3596.8741094061843, 3616.0, 5002.699838009731, 5025.688183435624, 5027.371578552681, 5029.497050294941, 5113.718745468997, 4430.379746835446, 4572.702774319659, 4650.604698600623, 4675.906481870344, 4687.390639216914, 5487.463510217106, 5491.972540137273, 5508.283923090013, 5516.420775818521, 5525.502704756551, 3998.6001399860074, 4010.3984402339593, 4015.678745700337, 4045.4538637283886, 4048.655864251513, 5433.402325744165, 5701.486866182064, 5725.942740572583, 5759.539236861083, 5789.478946894799, 4026.4564283821896, 4039.131586708813, 4055.270051390719, 4066.7356621819486, 4075.184963007351, 4096.795160241976, 4098.221337945781, 4108.856190033334, 4123.690723195772, 4139.4204811326435, 4497.775111244425, 4683.625309975194, 4684.8360307389075, 4776.498467660846, 4789.976050119727, 5503.807366742145, 5506.834794956158, 5519.034169020486, 5538.390777014525, 5564.1931919871395, 1383.1839214863278, 1402.57221547429, 1405.8823235527575, 1419.8641087130254, 1424.586869807765, 922.7646950027699, 966.8888077870994, 975.5658731864253, 980.0150848397458, 983.3460748602242, 5153.716545589954, 5192.324997750344, 5210.088234558937, 5232.686038837682, 5232.712200828991, 5450.236966824647, 5456.781728730885, 5483.917741233885, 5484.725763711798, 5536.252605898152, 5025.0, 5046.26829109777, 5095.515925987025, 5229.398619158846, 5269.130593452038, 2905.5060639691305, 2926.839023853666, 2980.5544311009144, 2992.189725216256, 2998.6401631803888, 5603.719814009283, 5709.486146246858, 5781.0, 5787.6399046224105, 5809.88380232393, 5416.295881535375, 5646.0640466957775, 5672.744726487318, 5673.517750991212, 5699.74351154199, 5540.418256083053, 5730.478589420642, 5741.88516229673, 5753.971230143822, 5775.5090817281, 5244.7902083916215, 5449.209864569536, 5486.670799752028, 5505.311836020497, 5511.393746687781, 5440.700761458158, 5452.7546260417585, 5459.972700136633, 5492.945070549244, 5518.668879867221, 5705.942940570541, 5739.397363276963, 5749.885002300014, 5754.194412782297, 5759.222504961776, 3927.9803600981813, 4021.6380525752825, 4041.1715598302867, 4050.4126901599693, 4055.7160998729805, 5438.308037521452, 5447.536959358499, 5493.862653433696, 5523.585731070266, 5531.446855314597, 5310.2386758884395, 5331.70675612845, 5361.865953351042, 5379.488948549882, 5385.057614917296, 5153.845384638467, 5392.0, 5407.702576358338, 5458.590605704668, 5469.945300547103, 5175.0, 5360.3299587551555, 5365.195220716923, 5371.650842695212, 5375.919361209507, 5282.283257941108, 5314.654547454557, 5364.865878353073, 5377.096367961257, 5401.513863752281, 5042.067217564762, 5310.336207974004, 5313.263669210282, 5314.256004159498, 5329.413764485981], "value": 4168.436353798743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2414209932167, 819.7131004148547, 820.3314298846443, 832.7834762961628, 833.0378412933064, 14070.64823379416, 14536.98241123119, 14782.556523304318, 14846.257687115642, 14886.77669834952, 13636.522721704743, 14441.855581444182, 14455.0, 14485.0, 14499.202543860083, 699.4928676709396, 807.8747794091926, 831.5925196653626, 840.2521755637488, 853.9146085391474, 841.6885752271637, 843.0052538005151, 844.1811442900377, 845.0535400351584, 845.4546817302836, 879.5338470610554, 881.3169793410094, 883.1521739130443, 887.9822403551925, 888.8044630181382, 680.5338343234899, 861.3539845116163, 877.3902138014083, 883.1830556735059, 883.8497455432528, 645.2805122288661, 645.7868903261913, 646.3665607704476, 646.4828137489989, 646.6508085633799, 14157.787633185511, 14280.500182493563, 14294.07088539252, 14314.713705725828, 14379.137251764927, 13188.208707477486, 13300.800487992688, 13436.596902092855, 13499.932500337534, 13592.38834252461, 10769.030787229187, 10855.457227138611, 11063.170262230366, 11804.114691398094, 11918.106142039382, 4481.708688935241, 4550.908981820378, 4697.037107392976, 4703.15343238217, 4718.221493453576, 54432.0, 54597.181042284, 55405.72297138529, 55531.0, 55860.441395586335, 10304.742381440374, 10333.276670632984, 10402.427866467417, 10465.790684186426, 10594.735131621772, 17396.913015434842, 17543.210555524776, 17610.735838962424, 17611.823881761018, 17625.647487050188, 7620.428467864932, 7679.692812287446, 7685.346745526693, 7788.92211077882, 7944.563049032358, 4379.5182529921685, 4383.583559561836, 4469.530699276529, 4480.7535585542455, 4629.259318509023, 3219.597550306212, 3297.5878015248095, 3302.8348582570775, 3306.8181250031, 3312.983435082809, 675.4967549175896, 677.7864972533636, 681.4412182010703, 684.3225207045089, 712.5620023091345, 692.5117791956759, 697.4176562570209, 713.9714411423485, 715.620721017851, 736.6390468670313, 9146.99383067862, 9264.583093760797, 9515.33392662507, 9580.616775329048, 9659.227261819038, 657.9868402631921, 686.3719696477667, 688.8174633722068, 728.6793810723265, 736.340974827537, 4302.634276086505, 4430.490493593214, 4449.9777501112285, 4609.1703493371515, 4674.135284972291, 64173.35826641767, 64189.67905160444, 64557.35442645608, 64558.93013373328, 65211.34788652148, 55699.0, 56597.71701141468, 56692.0, 57405.71297143488, 57589.424105759244, 52702.47297526975, 52805.2079218812, 53119.0, 53282.46717532775, 53412.46587534153, 8355.248027677539, 8411.4112012161, 8670.739877803677, 8840.911590884009, 8948.015629028698, 31259.218519537193, 31683.683163168072, 32034.35931281408, 32240.516392254605, 32714.836425817717, 38813.41779873361, 40421.59578404296, 41838.1632367357, 42407.0, 42800.57199427966, 12181.086418518824, 12208.389580520761, 12429.75140497203, 12637.810432843331, 12981.026423018122, 9975.850362244428, 12531.624051278111, 13369.331533423485, 13513.662158446117, 13952.511662091778, 12199.51201951912, 12581.685457863627, 12758.0, 13142.34288285601, 13159.802602960772, 12921.353932303535, 13103.73792524125, 13220.140690855063, 13269.734605307647, 13285.202887826761, 12440.937795310965, 12906.0, 12951.287679177736, 13165.53920612774, 13356.398962046536, 10407.0, 10577.153827693919, 10706.573896353404, 10779.730506737395, 11029.944850276019, 10059.547320370748, 10103.393796372242, 10144.49277536135, 10312.226583006455, 10364.119049880845], "value": 6765.201798842579, "unit": "score"}], "name": "dromaeo_css", "value": 7099.209170081645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 109.0, 109.0, 111.0, 109.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 162.0, 210.0, 127.0, 151.0, 151.0, 130.0, 180.0, 124.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 151.0, 76.0, 76.0, 77.0, 76.0, 135.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 145.0, 92.0, 92.0, 92.0, 121.0, 91.0, 92.0, 120.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.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, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 59.0, 63.0, 59.0, 60.0, 112.0, 57.0, 57.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 91.0, 82.0, 81.0, 80.0, 82.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 124.0, 126.0, 132.0, 125.0, 135.0, 123.0, 244.0, 127.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 171.0, 177.0, 175.0, 170.0, 176.0, 173.0, 170.0, 170.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 74.0, 64.0, 65.0, 66.0, 64.0, 74.0, 63.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1554.1000000000001, "alertThreshold": 2.0}]} 05:16:59 INFO - Return code: 0 05:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:59 ERROR - # TBPL SUCCESS # 05:16:59 INFO - Running post-action listener: _resource_record_post_action 05:16:59 INFO - ##### 05:16:59 INFO - ##### Finished run-tests step (success) 05:16:59 INFO - ##### 05:16:59 INFO - Running post-run listener: _resource_record_post_run 05:17:00 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545546240; Read time: 12; Write time: 473288 05:17:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254058496; Read time: 0; Write time: 278100 05:17:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291487744; Read time: 12; Write time: 195188 05:17:00 INFO - Running post-run listener: _upload_blobber_files 05:17:00 INFO - Blob upload gear active. 05:17:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:00 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 05:17:00 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:00 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:01 INFO - (blobuploader) - INFO - Done attempting. 05:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:02 INFO - (blobuploader) - INFO - Done attempting. 05:17:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:02 INFO - Return code: 0 05:17:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/330aed525b472236c202562dd7a33cf5e464d7b154fdd045b33357c10cb1177ed5d96fafa4efb5c11a7a4200d1ef11ab74c624a53c9efb4ffe0b6d397ccc2901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a235fd801cb64f55264060f8272d805878ceaaf6161a0d811c1f5e1e2d49791f91cdda3513e2d1b1c08064e1cb85c69dd4ad8b431e48d6feff82f9622d8092b"} 05:17:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:02 INFO - Contents: 05:17:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/330aed525b472236c202562dd7a33cf5e464d7b154fdd045b33357c10cb1177ed5d96fafa4efb5c11a7a4200d1ef11ab74c624a53c9efb4ffe0b6d397ccc2901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a235fd801cb64f55264060f8272d805878ceaaf6161a0d811c1f5e1e2d49791f91cdda3513e2d1b1c08064e1cb85c69dd4ad8b431e48d6feff82f9622d8092b"} 05:17:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:02 INFO - Copying logs to upload dir... 05:17:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.823639 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-09 05:17:02.056801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:17:02.060124) ========= 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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 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/sha512/330aed525b472236c202562dd7a33cf5e464d7b154fdd045b33357c10cb1177ed5d96fafa4efb5c11a7a4200d1ef11ab74c624a53c9efb4ffe0b6d397ccc2901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a235fd801cb64f55264060f8272d805878ceaaf6161a0d811c1f5e1e2d49791f91cdda3513e2d1b1c08064e1cb85c69dd4ad8b431e48d6feff82f9622d8092b"} build_url:https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/FkkNyOESRJy6AYDznzQMaA/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/sha512/330aed525b472236c202562dd7a33cf5e464d7b154fdd045b33357c10cb1177ed5d96fafa4efb5c11a7a4200d1ef11ab74c624a53c9efb4ffe0b6d397ccc2901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a235fd801cb64f55264060f8272d805878ceaaf6161a0d811c1f5e1e2d49791f91cdda3513e2d1b1c08064e1cb85c69dd4ad8b431e48d6feff82f9622d8092b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:17:02.084478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:17:02.084797) ========= 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=82e07478c745e68b1fe4678a000001bc-1462794937.219498-2101114615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:17:02.169232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:17:02.169530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:17:02.169820) ========= ========= Total master_lag: 0.23 =========