builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1462817218.04 results: success (0) buildid: 20160509083056 builduid: 201edf6d429e4f51a4d8081ba1628787 revision: a0aa4227b6b36846a06ad580dd30628316cf18f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.042086) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.044612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.045149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.254531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.254797) ========= 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-1462816945.911270-1533457901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 11:06:58-- 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.5M=0s 2016-05-09 11:06:58 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.386229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.386534) ========= 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-1462816945.911270-1533457901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:58.438981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 11:06:58.439302) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a0aa4227b6b36846a06ad580dd30628316cf18f7 --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 a0aa4227b6b36846a06ad580dd30628316cf18f7 --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-1462816945.911270-1533457901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 11:06:58,625 truncating revision to first 12 chars 2016-05-09 11:06:58,625 Setting DEBUG logging. 2016-05-09 11:06:58,625 attempt 1/10 2016-05-09 11:06:58,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a0aa4227b6b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 11:06:59,769 unpacking tar archive at: fx-team-a0aa4227b6b3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 11:06:59.884242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:59.884537) ========= script_repo_revision: a0aa4227b6b36846a06ad580dd30628316cf18f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:59.884917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:59.885174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 11:06:59.893116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 11:06:59.893376) ========= /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-1462816945.911270-1533457901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:00 INFO - MultiFileLogger online at 20160509 11:07:00 in /builds/slave/test 11:07:00 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 11:07:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:00 INFO - {'append_to_log': False, 11:07:00 INFO - 'base_work_dir': '/builds/slave/test', 11:07:00 INFO - 'blob_upload_branch': 'Fx-Team', 11:07:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:00 INFO - 'branch': 'Fx-Team', 11:07:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:00 INFO - 'config_files': ('talos/linux_config.py',), 11:07:00 INFO - 'default_actions': ('clobber', 11:07:00 INFO - 'read-buildbot-config', 11:07:00 INFO - 'download-and-extract', 11:07:00 INFO - 'populate-webroot', 11:07:00 INFO - 'create-virtualenv', 11:07:00 INFO - 'install', 11:07:00 INFO - 'run-tests'), 11:07:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:00 INFO - 'download_minidump_stackwalk': True, 11:07:00 INFO - 'download_symbols': 'ondemand', 11:07:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:00 INFO - 'installer_path': 'installer.exe', 11:07:00 INFO - 'log_level': 'info', 11:07:00 INFO - 'log_name': 'talos', 11:07:00 INFO - 'log_to_console': True, 11:07:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:00 INFO - 'opt_config_files': (), 11:07:00 INFO - 'pip_index': False, 11:07:00 INFO - 'sps_profile': False, 11:07:00 INFO - 'sps_profile_interval': 0, 11:07:00 INFO - 'suite': 'dromaeojs', 11:07:00 INFO - 'system_bits': '32', 11:07:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:00 INFO - 'title': 'talos-linux64-ix-055', 11:07:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:00 INFO - 'use_talos_json': True, 11:07:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:00 INFO - 'work_dir': 'build'} 11:07:00 INFO - ##### 11:07:00 INFO - ##### Running clobber step. 11:07:00 INFO - ##### 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: clobber 11:07:00 INFO - rmtree: /builds/slave/test/build 11:07:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:00 INFO - Running post-action listener: _resource_record_post_action 11:07:00 INFO - ##### 11:07:00 INFO - ##### Finished clobber step (success) 11:07:00 INFO - ##### 11:07:00 INFO - ##### 11:07:00 INFO - ##### Running read-buildbot-config step. 11:07:00 INFO - ##### 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: read_buildbot_config 11:07:00 INFO - Using buildbot properties: 11:07:00 INFO - { 11:07:00 INFO - "project": "", 11:07:00 INFO - "product": "firefox", 11:07:00 INFO - "script_repo_revision": "production", 11:07:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:07:00 INFO - "repository": "", 11:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:07:00 INFO - "buildid": "20160509083056", 11:07:00 INFO - "pgo_build": "True", 11:07:00 INFO - "basedir": "/builds/slave/test", 11:07:00 INFO - "buildnumber": 1137, 11:07:00 INFO - "slavename": "talos-linux64-ix-055", 11:07:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:07:00 INFO - "platform": "ubuntu64_hw", 11:07:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:07:00 INFO - "branch": "fx-team", 11:07:00 INFO - "repo_path": "integration/fx-team", 11:07:00 INFO - "revision": "a0aa4227b6b36846a06ad580dd30628316cf18f7", 11:07:00 INFO - "stage_platform": "linux64-pgo", 11:07:00 INFO - "builduid": "201edf6d429e4f51a4d8081ba1628787", 11:07:00 INFO - "slavebuilddir": "test" 11:07:00 INFO - } 11:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:07:00 INFO - Running post-action listener: _resource_record_post_action 11:07:00 INFO - ##### 11:07:00 INFO - ##### Finished read-buildbot-config step (success) 11:07:00 INFO - ##### 11:07:00 INFO - ##### 11:07:00 INFO - ##### Running download-and-extract step. 11:07:00 INFO - ##### 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: download_and_extract 11:07:00 INFO - mkdir: /builds/slave/test/build/tests 11:07: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')]} 11:07:00 INFO - https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:03 INFO - Downloaded 1361 bytes. 11:07:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:07:03 INFO - Using the following test package requirements: 11:07:03 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:03 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:03 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:03 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'jsshell-linux-x86_64.zip'], 11:07:03 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:03 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:03 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:03 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:03 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:03 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07: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')]} 11:07:03 INFO - https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:09 INFO - Downloaded 23896842 bytes. 11:07:09 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'] 11:07:09 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 11:07:11 INFO - Return code: 0 11:07:11 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 11:07:11 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')]} 11:07:11 INFO - https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:12 INFO - Downloaded 23896842 bytes. 11:07:12 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'] 11:07:12 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 11:07:14 INFO - Return code: 0 11:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:14 INFO - https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:15 INFO - Downloaded 10840152 bytes. 11:07:15 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'] 11:07:15 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 11:07:15 INFO - Return code: 0 11:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:15 INFO - https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3fM_50ySJqGU55GtSL1og/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 11:07:16 INFO - Downloaded 58444137 bytes. 11:07:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - mkdir: /builds/slave/test/properties 11:07:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:16 INFO - Contents: 11:07:16 INFO - build_url:https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:17 INFO - Running post-action listener: _resource_record_post_action 11:07:17 INFO - Running post-action listener: set_extra_try_arguments 11:07:17 INFO - ##### 11:07:17 INFO - ##### Finished download-and-extract step (success) 11:07:17 INFO - ##### 11:07:17 INFO - ##### 11:07:17 INFO - ##### Running populate-webroot step. 11:07:17 INFO - ##### 11:07:17 INFO - Running pre-action listener: _resource_record_pre_action 11:07:17 INFO - Running main action method: populate_webroot 11:07:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:17 INFO - '--tppagecycles', 11:07:17 INFO - '7'], 11:07:17 INFO - 'tests': ['tsvgm']}}, 11:07:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['damp', 'tps']}, 11:07:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'tests': ['damp', 'tps']}, 11:07:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['dromaeo_dom']}, 11:07:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['a11yr', 11:07:17 INFO - 'ts_paint', 11:07:17 INFO - 'tpaint', 11:07:17 INFO - 'sessionrestore', 11:07:17 INFO - 'sessionrestore_no_auto_restore', 11:07:17 INFO - 'tabpaint']}, 11:07:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['tsvgx', 11:07:17 INFO - 'tsvgr_opacity', 11:07:17 INFO - 'tart', 11:07:17 INFO - 'tscrollx', 11:07:17 INFO - 'cart']}, 11:07:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:17 INFO - 'tsvgr_opacity', 11:07:17 INFO - 'tart', 11:07:17 INFO - 'tscrollx', 11:07:17 INFO - 'cart']}, 11:07:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'talos_options': ['--disable-e10s'], 11:07:17 INFO - 'tests': ['tp5o']}, 11:07:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'tests': ['tp5o']}, 11:07:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'talos_options': ['--disable-e10s', 11:07:17 INFO - '--xperf_path', 11:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:17 INFO - 'tests': ['tp5n']}, 11:07:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:17 INFO - 'talos_options': ['--xperf_path', 11:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:17 INFO - 'tests': ['tp5n']}}, 11:07:17 INFO - 'talos.zip': {'path': '', 11:07:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:17 INFO - Running post-action listener: _resource_record_post_action 11:07:17 INFO - ##### 11:07:17 INFO - ##### Finished populate-webroot step (success) 11:07:17 INFO - ##### 11:07:17 INFO - ##### 11:07:17 INFO - ##### Running create-virtualenv step. 11:07:17 INFO - ##### 11:07:17 INFO - Running pre-action listener: _resource_record_pre_action 11:07:17 INFO - Running main action method: create_virtualenv 11:07:17 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:17 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 11:07:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:17 INFO - Using real prefix '/usr' 11:07:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:19 INFO - Installing pip.................done. 11:07:19 INFO - Return code: 0 11:07:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:07:19 INFO - Using env: {'DISPLAY': ':0', 11:07:19 INFO - 'HOME': '/home/cltbld', 11:07:19 INFO - 'LANG': 'en_US.UTF-8', 11:07:19 INFO - 'LANGUAGE': 'en_US:en', 11:07:19 INFO - 'LOGNAME': 'cltbld', 11:07:19 INFO - 'MAIL': '/var/mail/cltbld', 11:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:19 INFO - 'MOZ_NO_REMOTE': '1', 11:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:19 INFO - 'NO_EM_RESTART': '1', 11:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:19 INFO - 'PWD': '/builds/slave/test', 11:07:19 INFO - 'SHELL': '/bin/bash', 11:07:19 INFO - 'SHLVL': '1', 11:07:19 INFO - 'TERM': 'linux', 11:07:19 INFO - 'TMOUT': '86400', 11:07:19 INFO - 'USER': 'cltbld', 11:07:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:19 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:20 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 11:07:20 INFO - Cleaning up... 11:07:20 INFO - Return code: 0 11:07:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:20 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 11:07:20 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 11:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:20 INFO - Downloading/unpacking psutil>=0.7.1 11:07:20 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 11:07:20 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 11:07:20 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 11:07:20 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 11:07:20 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 11:07:20 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 11:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:22 INFO - Installing collected packages: psutil 11:07:22 INFO - Running setup.py install for psutil 11:07:22 INFO - building 'psutil._psutil_linux' extension 11:07:22 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 11:07:22 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 11:07:22 INFO - building 'psutil._psutil_posix' extension 11:07:22 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 11:07:22 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 11:07:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:22 INFO - Successfully installed psutil 11:07:22 INFO - Cleaning up... 11:07:22 INFO - Return code: 0 11:07:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:07:22 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')]} 11:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 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')]} 11:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:22 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 11:07:22 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 11:07:22 INFO - Using env: {'DISPLAY': ':0', 11:07:22 INFO - 'HOME': '/home/cltbld', 11:07:22 INFO - 'LANG': 'en_US.UTF-8', 11:07:22 INFO - 'LANGUAGE': 'en_US:en', 11:07:22 INFO - 'LOGNAME': 'cltbld', 11:07:22 INFO - 'MAIL': '/var/mail/cltbld', 11:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:22 INFO - 'MOZ_NO_REMOTE': '1', 11:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:22 INFO - 'NO_EM_RESTART': '1', 11:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:22 INFO - 'PWD': '/builds/slave/test', 11:07:22 INFO - 'SHELL': '/bin/bash', 11:07:22 INFO - 'SHLVL': '1', 11:07:22 INFO - 'TERM': 'linux', 11:07:22 INFO - 'TMOUT': '86400', 11:07:22 INFO - 'USER': 'cltbld', 11:07:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:22 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:25 INFO - Installing collected packages: mozsystemmonitor 11:07:25 INFO - Running setup.py install for mozsystemmonitor 11:07:25 INFO - Successfully installed mozsystemmonitor 11:07:25 INFO - Cleaning up... 11:07:25 INFO - Return code: 0 11:07:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:25 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')]} 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 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')]} 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:25 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 11:07:25 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 11:07:25 INFO - Using env: {'DISPLAY': ':0', 11:07:25 INFO - 'HOME': '/home/cltbld', 11:07:25 INFO - 'LANG': 'en_US.UTF-8', 11:07:25 INFO - 'LANGUAGE': 'en_US:en', 11:07:25 INFO - 'LOGNAME': 'cltbld', 11:07:25 INFO - 'MAIL': '/var/mail/cltbld', 11:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:25 INFO - 'MOZ_NO_REMOTE': '1', 11:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:25 INFO - 'NO_EM_RESTART': '1', 11:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:25 INFO - 'PWD': '/builds/slave/test', 11:07:25 INFO - 'SHELL': '/bin/bash', 11:07:25 INFO - 'SHLVL': '1', 11:07:25 INFO - 'TERM': 'linux', 11:07:25 INFO - 'TMOUT': '86400', 11:07:25 INFO - 'USER': 'cltbld', 11:07:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:25 INFO - '_': '/tools/buildbot/bin/python'} 11:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 INFO - Downloading docopt-0.6.1.tar.gz 11:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:27 INFO - Running setup.py install for blobuploader 11:07:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:28 INFO - Running setup.py install for requests 11:07:28 INFO - Running setup.py install for docopt 11:07:28 INFO - Successfully installed blobuploader requests docopt 11:07:28 INFO - Cleaning up... 11:07:28 INFO - Return code: 0 11:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:28 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')]} 11:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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')]} 11:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:28 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 11:07:28 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 11:07:28 INFO - Using env: {'DISPLAY': ':0', 11:07:28 INFO - 'HOME': '/home/cltbld', 11:07:28 INFO - 'LANG': 'en_US.UTF-8', 11:07:28 INFO - 'LANGUAGE': 'en_US:en', 11:07:28 INFO - 'LOGNAME': 'cltbld', 11:07:28 INFO - 'MAIL': '/var/mail/cltbld', 11:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:28 INFO - 'MOZ_NO_REMOTE': '1', 11:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:28 INFO - 'NO_EM_RESTART': '1', 11:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:28 INFO - 'PWD': '/builds/slave/test', 11:07:28 INFO - 'SHELL': '/bin/bash', 11:07:28 INFO - 'SHLVL': '1', 11:07:28 INFO - 'TERM': 'linux', 11:07:28 INFO - 'TMOUT': '86400', 11:07:28 INFO - 'USER': 'cltbld', 11:07:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:28 INFO - '_': '/tools/buildbot/bin/python'} 11:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:28 INFO - Running setup.py (path:/tmp/pip-aqDfhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:28 INFO - Running setup.py (path:/tmp/pip-QH3CZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:28 INFO - Running setup.py (path:/tmp/pip-Qm4T11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:29 INFO - Running setup.py (path:/tmp/pip-u3LI2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:29 INFO - Running setup.py (path:/tmp/pip-v6p1fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:29 INFO - Running setup.py (path:/tmp/pip-p5iW7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:29 INFO - Running setup.py (path:/tmp/pip-5dftkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:29 INFO - Running setup.py (path:/tmp/pip-7HesFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:29 INFO - Running setup.py (path:/tmp/pip-3HTYyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:29 INFO - Running setup.py (path:/tmp/pip-J8BioK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:29 INFO - Running setup.py (path:/tmp/pip-U40X19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:29 INFO - Running setup.py (path:/tmp/pip-2igrwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:29 INFO - Running setup.py (path:/tmp/pip-3hA1Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:29 INFO - Running setup.py (path:/tmp/pip-9e1zx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:29 INFO - Running setup.py (path:/tmp/pip-MjCE36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:29 INFO - Running setup.py (path:/tmp/pip-PmGOEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:29 INFO - Running setup.py (path:/tmp/pip-1VvI5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:30 INFO - Running setup.py install for manifestparser 11:07:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Running setup.py install for mozcrash 11:07:30 INFO - Running setup.py install for mozdebug 11:07:30 INFO - Running setup.py install for mozdevice 11:07:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Running setup.py install for mozfile 11:07:30 INFO - Running setup.py install for mozhttpd 11:07:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Running setup.py install for mozinfo 11:07:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Running setup.py install for mozInstall 11:07:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:30 INFO - Running setup.py install for mozleak 11:07:30 INFO - Running setup.py install for mozlog 11:07:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Running setup.py install for moznetwork 11:07:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Running setup.py install for mozprocess 11:07:31 INFO - Running setup.py install for mozprofile 11:07:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Running setup.py install for mozrunner 11:07:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Running setup.py install for mozscreenshot 11:07:31 INFO - Running setup.py install for moztest 11:07:31 INFO - Running setup.py install for mozversion 11:07:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:31 INFO - Cleaning up... 11:07:31 INFO - Return code: 0 11:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:31 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:31 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 11:07:31 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 11:07:31 INFO - Using env: {'DISPLAY': ':0', 11:07:31 INFO - 'HOME': '/home/cltbld', 11:07:31 INFO - 'LANG': 'en_US.UTF-8', 11:07:31 INFO - 'LANGUAGE': 'en_US:en', 11:07:31 INFO - 'LOGNAME': 'cltbld', 11:07:31 INFO - 'MAIL': '/var/mail/cltbld', 11:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:31 INFO - 'MOZ_NO_REMOTE': '1', 11:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:31 INFO - 'NO_EM_RESTART': '1', 11:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:31 INFO - 'PWD': '/builds/slave/test', 11:07:31 INFO - 'SHELL': '/bin/bash', 11:07:31 INFO - 'SHLVL': '1', 11:07:31 INFO - 'TERM': 'linux', 11:07:31 INFO - 'TMOUT': '86400', 11:07:31 INFO - 'USER': 'cltbld', 11:07:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:31 INFO - '_': '/tools/buildbot/bin/python'} 11:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:32 INFO - Running setup.py (path:/tmp/pip-_gpQMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:32 INFO - Running setup.py (path:/tmp/pip-FZ2hVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 INFO - Running setup.py (path:/tmp/pip-pqMl_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 INFO - Running setup.py (path:/tmp/pip-vecI2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:32 INFO - Running setup.py (path:/tmp/pip-FrJAkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:32 INFO - Running setup.py (path:/tmp/pip-AWjb8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:32 INFO - Running setup.py (path:/tmp/pip-xSaF7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:32 INFO - Running setup.py (path:/tmp/pip-eAedAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:32 INFO - Running setup.py (path:/tmp/pip-CjW2HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:32 INFO - Running setup.py (path:/tmp/pip-X_Pcg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:32 INFO - Running setup.py (path:/tmp/pip-_klPc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:32 INFO - Running setup.py (path:/tmp/pip-xh4U2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:32 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)) 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:32 INFO - Running setup.py (path:/tmp/pip-vwDKCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:33 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)) 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:33 INFO - Running setup.py (path:/tmp/pip-1tHWFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:33 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)) 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:33 INFO - Running setup.py (path:/tmp/pip-lWeubR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:33 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)) 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:33 INFO - Running setup.py (path:/tmp/pip-KRfxIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:33 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)) 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:33 INFO - Running setup.py (path:/tmp/pip-xfQGuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:33 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)) 11:07:33 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)) 11:07:33 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)) 11:07:33 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)) 11:07:33 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)) 11:07:33 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)) 11:07:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:33 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 11:07:33 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 11:07:33 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 11:07:33 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 11:07:33 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 11:07:33 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 11:07:35 INFO - Downloading blessings-1.6.tar.gz 11:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:35 INFO - Installing collected packages: blessings 11:07:35 INFO - Running setup.py install for blessings 11:07:35 INFO - Successfully installed blessings 11:07:35 INFO - Cleaning up... 11:07:35 INFO - Return code: 0 11:07:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:35 INFO - Reading from file tmpfile_stdout 11:07:35 INFO - Current package versions: 11:07:35 INFO - argparse == 1.2.1 11:07:35 INFO - blessings == 1.6 11:07:35 INFO - blobuploader == 1.2.4 11:07:35 INFO - docopt == 0.6.1 11:07:35 INFO - manifestparser == 1.1 11:07:35 INFO - mozInstall == 1.12 11:07:35 INFO - mozcrash == 0.17 11:07:35 INFO - mozdebug == 0.1 11:07:35 INFO - mozdevice == 0.48 11:07:35 INFO - mozfile == 1.2 11:07:35 INFO - mozhttpd == 0.7 11:07:35 INFO - mozinfo == 0.9 11:07:35 INFO - mozleak == 0.1 11:07:35 INFO - mozlog == 3.1 11:07:35 INFO - moznetwork == 0.27 11:07:35 INFO - mozprocess == 0.22 11:07:35 INFO - mozprofile == 0.28 11:07:35 INFO - mozrunner == 6.11 11:07:35 INFO - mozscreenshot == 0.1 11:07:35 INFO - mozsystemmonitor == 0.0 11:07:35 INFO - moztest == 0.7 11:07:35 INFO - mozversion == 1.4 11:07:35 INFO - psutil == 3.1.1 11:07:35 INFO - requests == 1.2.3 11:07:35 INFO - wsgiref == 0.1.2 11:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:35 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')]} 11:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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')]} 11:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:35 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 11:07:35 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 11:07:35 INFO - Using env: {'DISPLAY': ':0', 11:07:35 INFO - 'HOME': '/home/cltbld', 11:07:35 INFO - 'LANG': 'en_US.UTF-8', 11:07:35 INFO - 'LANGUAGE': 'en_US:en', 11:07:35 INFO - 'LOGNAME': 'cltbld', 11:07:35 INFO - 'MAIL': '/var/mail/cltbld', 11:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:35 INFO - 'MOZ_NO_REMOTE': '1', 11:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:35 INFO - 'NO_EM_RESTART': '1', 11:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:35 INFO - 'PWD': '/builds/slave/test', 11:07:35 INFO - 'SHELL': '/bin/bash', 11:07:35 INFO - 'SHLVL': '1', 11:07:35 INFO - 'TERM': 'linux', 11:07:35 INFO - 'TMOUT': '86400', 11:07:35 INFO - 'USER': 'cltbld', 11:07:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:35 INFO - '_': '/tools/buildbot/bin/python'} 11:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 INFO - Cleaning up... 11:07:35 INFO - Return code: 0 11:07:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:35 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')]} 11:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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')]} 11:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:35 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 11:07:35 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 11:07:35 INFO - Using env: {'DISPLAY': ':0', 11:07:35 INFO - 'HOME': '/home/cltbld', 11:07:35 INFO - 'LANG': 'en_US.UTF-8', 11:07:35 INFO - 'LANGUAGE': 'en_US:en', 11:07:35 INFO - 'LOGNAME': 'cltbld', 11:07:35 INFO - 'MAIL': '/var/mail/cltbld', 11:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:35 INFO - 'MOZ_NO_REMOTE': '1', 11:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:35 INFO - 'NO_EM_RESTART': '1', 11:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:35 INFO - 'PWD': '/builds/slave/test', 11:07:35 INFO - 'SHELL': '/bin/bash', 11:07:35 INFO - 'SHLVL': '1', 11:07:35 INFO - 'TERM': 'linux', 11:07:35 INFO - 'TMOUT': '86400', 11:07:35 INFO - 'USER': 'cltbld', 11:07:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:35 INFO - '_': '/tools/buildbot/bin/python'} 11:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:36 INFO - Downloading/unpacking jsonschema 11:07:36 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 11:07:36 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 11:07:36 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 11:07:36 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 11:07:36 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 11:07:36 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 11:07:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:37 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:38 INFO - warning: no files found matching '*.txt' 11:07:38 INFO - no previously-included directories found matching 'build' 11:07:38 INFO - no previously-included directories found matching 'dist' 11:07:38 INFO - no previously-included directories found matching '.git*' 11:07:38 INFO - Installing collected packages: jsonschema, functools32 11:07:38 INFO - Running setup.py install for functools32 11:07:38 INFO - warning: no files found matching '*.txt' 11:07:38 INFO - no previously-included directories found matching 'build' 11:07:38 INFO - no previously-included directories found matching 'dist' 11:07:38 INFO - no previously-included directories found matching '.git*' 11:07:38 INFO - Successfully installed jsonschema functools32 11:07:38 INFO - Cleaning up... 11:07:38 INFO - Return code: 0 11:07:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 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 0x7f7f24ee0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, '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-1462816945.911270-1533457901', '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 11:07:38 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 11:07:38 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 11:07:38 INFO - Using env: {'DISPLAY': ':0', 11:07:38 INFO - 'HOME': '/home/cltbld', 11:07:38 INFO - 'LANG': 'en_US.UTF-8', 11:07:38 INFO - 'LANGUAGE': 'en_US:en', 11:07:38 INFO - 'LOGNAME': 'cltbld', 11:07:38 INFO - 'MAIL': '/var/mail/cltbld', 11:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:38 INFO - 'MOZ_NO_REMOTE': '1', 11:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:38 INFO - 'NO_EM_RESTART': '1', 11:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:38 INFO - 'PWD': '/builds/slave/test', 11:07:38 INFO - 'SHELL': '/bin/bash', 11:07:38 INFO - 'SHLVL': '1', 11:07:38 INFO - 'TERM': 'linux', 11:07:38 INFO - 'TMOUT': '86400', 11:07:38 INFO - 'USER': 'cltbld', 11:07:38 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:38 INFO - '_': '/tools/buildbot/bin/python'} 11:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:38 INFO - Downloading/unpacking flake8 11:07:38 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 11:07:38 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 11:07:38 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 11:07:38 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 11:07:38 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 11:07:38 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 11:07:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:41 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 11:07:41 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 11:07:41 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 11:07:41 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 11:07:41 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 11:07:41 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 11:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:41 INFO - no previously-included directories found matching 'docs/_build' 11:07:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:41 INFO - Running setup.py install for pep8 11:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:41 INFO - no previously-included directories found matching 'docs/_build' 11:07:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:41 INFO - Cleaning up... 11:07:41 INFO - Return code: 0 11:07:41 INFO - Running post-action listener: _resource_record_post_action 11:07:41 INFO - Running post-action listener: _start_resource_monitoring 11:07:41 INFO - Starting resource monitoring. 11:07:41 INFO - ##### 11:07:41 INFO - ##### Finished create-virtualenv step (success) 11:07:41 INFO - ##### 11:07:41 INFO - ##### 11:07:41 INFO - ##### Running install step. 11:07:41 INFO - ##### 11:07:41 INFO - Running pre-action listener: _resource_record_pre_action 11:07:41 INFO - Running main action method: install 11:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:41 INFO - Reading from file tmpfile_stdout 11:07:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:41 INFO - Reading from file tmpfile_stdout 11:07:41 INFO - Output received: 11:07:41 INFO - Usage: mozinstall [options] installer 11:07:41 INFO - Options: 11:07:41 INFO - -h, --help show this help message and exit 11:07:41 INFO - -d DEST, --destination=DEST 11:07:41 INFO - Directory to install application into. [default: 11:07:41 INFO - "/builds/slave/test"] 11:07:41 INFO - --app=APP Application being installed. [default: firefox] 11:07:41 INFO - mkdir: /builds/slave/test/build/application 11:07:41 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'] 11:07:41 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 11:07:58 INFO - Reading from file tmpfile_stdout 11:07:58 INFO - Output received: 11:07:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:58 INFO - Running post-action listener: _resource_record_post_action 11:07:58 INFO - ##### 11:07:58 INFO - ##### Finished install step (success) 11:07:58 INFO - ##### 11:07:58 INFO - ##### 11:07:58 INFO - ##### Running run-tests step. 11:07:58 INFO - ##### 11:07:58 INFO - Running pre-action listener: _resource_record_pre_action 11:07:58 INFO - Running main action method: run_tests 11:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:58 INFO - Python 2.7.3 11:07:58 INFO - Return code: 0 11:07:58 INFO - grabbing minidump binary from tooltool 11:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:58 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 0x26629c0>, '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 0x26638c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:58 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 11:07:58 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 11:07:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:58 INFO - Return code: 0 11:07:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:59 INFO - Return code: 0 11:07:59 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/R3fM_50ySJqGU55GtSL1og/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 11:07:59 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/R3fM_50ySJqGU55GtSL1og/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 11:07:59 INFO - Using env: {'DISPLAY': ':0', 11:07:59 INFO - 'HOME': '/home/cltbld', 11:07:59 INFO - 'LANG': 'en_US.UTF-8', 11:07:59 INFO - 'LANGUAGE': 'en_US:en', 11:07:59 INFO - 'LOGNAME': 'cltbld', 11:07:59 INFO - 'MAIL': '/var/mail/cltbld', 11:07:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:59 INFO - 'MOZ_NO_REMOTE': '1', 11:07:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:59 INFO - 'NO_EM_RESTART': '1', 11:07:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:59 INFO - 'PWD': '/builds/slave/test', 11:07:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:59 INFO - 'SHELL': '/bin/bash', 11:07:59 INFO - 'SHLVL': '1', 11:07:59 INFO - 'TERM': 'linux', 11:07:59 INFO - 'TMOUT': '86400', 11:07:59 INFO - 'USER': 'cltbld', 11:07:59 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462816945.911270-1533457901', 11:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:59 INFO - '_': '/tools/buildbot/bin/python'} 11:07:59 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/R3fM_50ySJqGU55GtSL1og/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 11:07:59 INFO - mozversion application_buildid: 20160509083056 11:07:59 INFO - mozversion application_changeset: a0aa4227b6b36846a06ad580dd30628316cf18f7 11:07:59 INFO - mozversion application_display_name: Nightly 11:07:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:59 INFO - mozversion application_name: Firefox 11:07:59 INFO - mozversion application_remotingname: firefox 11:07:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:07:59 INFO - mozversion application_vendor: Mozilla 11:07:59 INFO - mozversion application_version: 49.0a1 11:07:59 INFO - mozversion platform_buildid: 20160509083056 11:07:59 INFO - mozversion platform_changeset: a0aa4227b6b36846a06ad580dd30628316cf18f7 11:07:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:07:59 INFO - mozversion platform_version: 49.0a1 11:07:59 INFO - using testdate: 1462817279 11:07:59 INFO - actual date: 1462817279 11:07:59 INFO - starting webserver on 'localhost:54182' 11:07:59 INFO - SUITE-START | Running 2 tests 11:07:59 INFO - TEST-START | dromaeo_css 11:07:59 INFO - operating with platform_type : linux_ 11:07:59 INFO - Initialising browser for dromaeo_css test... 11:07:59 INFO - TEST-INFO | started process 7459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZdvAh1/profile http://localhost:54182/getInfo.html) 11:08:03 INFO - PROCESS | 7459 | __metrics Screen width/height:1600/1200 11:08:03 INFO - PROCESS | 7459 | colorDepth:24 11:08:03 INFO - PROCESS | 7459 | Browser inner width/height: 1024/697 11:08:03 INFO - PROCESS | 7459 | __metrics 11:08:04 ERROR - PROCESS | 7459 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:08:05 INFO - TEST-INFO | 7459: exit 0 11:08:05 INFO - Browser initialized. 11:08:05 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:05 INFO - TEST-INFO | started process 7540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZdvAh1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:17 INFO - PROCESS | 7540 | RSS: Main: 151851008 11:08:17 INFO - PROCESS | 7540 | 11:09:08 INFO - PROCESS | 7540 | 1462817348228 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] 11:11:16 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54182/tests/dromaeo/cssquery-ext.html) 11:11:17 INFO - PROCESS | 7540 | RSS: Main: 269246464 11:11:17 INFO - PROCESS | 7540 | 11:14:19 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-ext.html (next: http://localhost:54182/tests/dromaeo/cssquery-jquery.html) 11:14:20 INFO - PROCESS | 7540 | RSS: Main: 241025024 11:14:20 INFO - PROCESS | 7540 | 11:17:22 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54182/tests/dromaeo/cssquery-mootools.html) 11:17:22 INFO - PROCESS | 7540 | RSS: Main: 237686784 11:17:22 INFO - PROCESS | 7540 | 11:20:24 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54182/tests/dromaeo/cssquery-prototype.html) 11:20:25 INFO - PROCESS | 7540 | RSS: Main: 232058880 11:20:25 INFO - PROCESS | 7540 | 11:23:28 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54182/tests/dromaeo/cssquery-yui.html) 11:23:28 INFO - PROCESS | 7540 | RSS: Main: 226111488 11:23:28 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-yui.html (next: http://localhost:54182/tests/dromaeo/cssquery-dojo.html) 11:26:31 INFO - PROCESS | 7540 | RSS: Main: 257904640 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | __start_tp_report 11:26:31 INFO - PROCESS | 7540 | _x_x_mozilla_page_load 11:26:31 INFO - PROCESS | 7540 | _x_x_mozilla_page_load_details 11:26:31 INFO - PROCESS | 7540 | |i|pagename|runs| 11:26:31 INFO - PROCESS | 7540 | |0;dojo.html;3114.6106736657916;3118.313970926397;3161.2571045804234;3168.6356069052067;3181.2524056846637;5249.501297376743;5274.077036518613;5274.865903830676;5334.946650533493;5348.919766203505;5291.550218231455;5364.436734142917;5377.247185394038;5391.649542779716;5396;4830.492798256177;4863.489333619972;5033.446320904697;5065.037642847866;5081.237814327844;4813.90372192556;5010.223415370623;5018.673786203904;5047.798088076491;5078.5175408336145;4910.263460480938;4919.852404427873;4969;4998.175301075318;5003.399592048941;4990.950090499121;5004.574611158019;5017.899642007176;5024.9748751256375;5058.089543882136;4737.95262047382;4781.019890922353;4783.330333753277;4889.315495830587;4922.852314430573;5229.50319719626;5240.266362709223;5250.737463126867;5254.632175747699;5261.76322065508;5664;5676.943230567724;5736.282964629421;5795.478406943354;5796.043652797283;5891.086881533369;5895.115732640138;5896.764129434818;5897.469227769521;5898.41015898411;5469.371022332482;5470.753816078246;5509.641873278224;5522.392536820947;5526.115821468586;5682.261306030272;5886.8822623547285;5945.286565612154;5969.76120955157;5991.970040149771;5778.768849245983;5816.360200377955;5827.679477628772;5828.417158284137;5832.475077243069;5551.417101204396;5837.532997360201;5861.677607731615;5906.26171728534;5914.733836977346;5574.916376254359;5667.1782591524825;5689.857753556112;5725.141228815711;5729.541636669056;5721.599488035881;5725.685087320154;5741.511971482387;5742.54059675225;5743.282089738783;4271.252530807096;4283.079137985285;4367.67242456817;4371.825126994948;4420.734755914656;3846.249981253685;3894.9805250973563;3900.4344370066183;3913.4325522799036;3933.468981687493;5355.062863998784;5359;5402.783888644489;5405.5135037846785;5462.5083742462575;5603.047481928082;5649.322081350264;5716.714164291769;5776.480116789509;5782.132680097935;5356.4107948125675;5386.165144402624;5409.918851217235;5417.918731219035;5447.4824891635235;4939.086269040239;4941.45643979162;4953.975230123826;4955.677880937799;4995.925061124086;5785.1322301654245;5942.405759424023;5943.5839491236065;5982.4914882234625;6002.219711437572;5891.469767720926;5902.2327097477055;5930.199423077829;5950.702464876652;5951;6000.669963152069;6026.457618814327;6059.303180134165;6085.57400981927;6092.482139018233;5493.23094766741;5683.60214784961;5690.5163061140265;5690.829275121753;5692.459216374438;5805.245318108618;5876.942150412967;5885.205497257815;5893.116032595145;5935.940640593712;5661.150827375926;5709.486146246858;5727.885442291047;5728.226689396878;5732.254806875079;5459.181122831607;5477.178423236546;5514.91727624094;5710.4004079572705;5717.342505611908;5407.756650950795;5414.133738601805;5414.729263536886;5425.348958125051;5460.180972854104;5579.944200557942;5581.051221292309;5627.409122042291;5630.943690563042;5634.577406694432;5329.840104796862;5445.918311225256;5453.590980676545;5512.448755124456;5519.558435325084 11:26:31 INFO - PROCESS | 7540 | |1;ext.html;579.9333076696179;639.7920675780371;649.0102593544843;651.4365074210806;654.4960380507013;43175.78412107939;44463;44476.110477790426;44589.55410445895;47668.284975725306;44466.77766611162;45230.32154517685;45231.321530177076;45249.77375113128;45259.32111018337;7889.211078892123;8056.798580035487;8970.237529809974;9121.726348209531;10641.414722190277;10520.05319521243;10621.044106030457;10669.679909602724;10671.35971841692;10675.83986240207;10581;10667.199960002992;10687.358758474478;10690.572377104907;10706.78586428271;8309.00291964965;10633.255672102956;10878.891211087866;11180.496877640444;11191.32852028881;10651.360918344924;10735.355878647306;10741.78516429667;10751;10757.62348317813;41400.792996035125;41684.37473437901;41702;41807.790961045306;41815;3609.6390360963956;3966.900827479336;4200.348945913388;4266.552012038754;4351.151525452538;32545.186370340693;32582.51126233085;32598.837005815058;32846.34307313864;33860.32279354399;4337.197618440567;4345.41336919515;4359.106383191438;4411.757353345564;4459.152760975437;309050;310292;311881;312800;313454;35523.28953420969;37029.07427314285;59446.70276648589;60041.69979150076;60219.69890150609;37786.62213377831;37853.62146378556;38011.809940950116;38017.619823801964;38022.42966355507;14271;14292.571222863122;14315.14109153454;14395.928020359832;14405.06367086136;10841.728956776144;11892.405379730979;12088.09339299556;12102.81845772314;12103.092268079754;8521.10528394522;8653.264472519906;8670.002949660744;8739.30085593151;8750.781230469289;3300.35643049603;3325.717314028286;3334.9333013339597;3342.38165939302;3353.3293341331832;1053.1832588784287;1084.219362059316;1170.9578475157116;1202.4588934979295;1220.7558488302375;32294.83852580722;32357.51463728046;32522.837385813393;32523.674763252064;32930;1085.571199376242;1092.2190633696946;1119.7368618374676;1168.1414160591958;1188.4948896719034;16358.591035224215;16692.41576544815;16873.565746911405;16882.66234675324;16930.238139283763;436833;440455;441356;442115;443496;56016;57293.713531432906;57320;57447;57576;1293.3985696651102;1390.2284232250995;1416.9433222670978;1440.229477229677;1443.3793468808512;31623.525647115774;33466.163345916546;33642;33659.66340336565;34282.48576271308;49449.25826112683;49763.50236497589;50189.49810501994;50222.246666300765;50260.49739502558;352312;352939;355743;356028;356074;26129.477410451305;28262.71737282601;28907;28954;30160.84919575476;45384.31923521084;46672;47166.29250561313;47222.29166562573;49060.509394905595;39604.80197598993;40102.79948600355;41693.374599380426;41905.79047104745;42787.57212427836;39678.60321396749;39896.401553977295;41071.589284106776;41572.79213603913;41783.164336712485;41468.1706365877;42233.36649950314;42283;42465.5753442474;42491.57508424876;35223;36572.63427365692;36949.63050369569;37010.93403348211;37537.43693844649;28387.477023895743;28388.744251927397;28449.753830004916;28502.42995140044;28518.85924563077 11:26:31 INFO - PROCESS | 7540 | |2;jquery.html;412.1057305646746;413.97128136580574;415.858608073255;419.58670709351287;432.437830819934;18500.444986650404;18633.90683046583;19549.315773947914;20128.194872205113;20128.49678758032;12144.69638259044;12211.267323960568;12500.624981250554;12807.743845123092;12812.80780788289;5120.974395128019;5220.34745656792;5241.161414173733;5336.519713225809;5380.838574842761;5883.646981181143;5907.995640741063;5916.319623243339;5939.851503712399;5960.552958528127;5881.617694849842;5886.381929897363;5888.764449422018;5898.262717160355;6940.9652951735425;7333.9266607333775;7394.223606521318;7482.663280152352;7505.399568034544;7514.774556763278;6988.545744526589;7225.783226503213;7231.927680723231;7234.674439650228;7236.638168091627;23976;24895.377615559573;25081.122160724288;25597.616035759478;26271.737282627313;2591.3262551736498;2620.1091628846284;2657.3755167535614;2661.9733802661917;3317.402867483852;15334.463293784776;15670.764938525932;15859.286332115082;15871.28579213938;16751;1983.7917018712972;2066.390414827614;2118.8728676279475;2130.4673831542113;2142.368001439579;50609;51276.74361628205;67752;68935.65532172358;85394.99999999937;16947.830521694625;17743.29026838912;17762.289508419777;17889;18013.819861801476;26771;28393.57409638857;30272.394552108835;32432.83783581114;32721;9640.903590964;9689.224862011022;9743.853842192373;9819.607215711434;9830.459324737209;7616.466847320745;7689.307962283309;7782.416318776114;8088.150744171778;8198.38512111594;8822.33832462555;8970.282377409792;8977.820443591223;9204.318272690844;9239.584218710173;3242.189452636841;3292.851821668031;3339.9713517101864;3509.596396414394;3540.185757275841;976.9023097690316;998.6953979036318;1080.9567617295377;1094.5020015892908;1108.2630051015983;18755.531111722044;19429.708554371697;19559.413217603495;19647.803521964597;19658.8034119657;1047.9318844275251;1057.2757661002238;1062.134360496193;1089.6349722842779;1151.8272259161026;10280.177585793119;10917.181211409017;10923.071538919123;10928.289661171999;10951.123910087173;478085.5340126158;478456;479207;496822;516814;82342;84282.73575896367;84877.02930397406;85513;88489.55755221311;1049.3861091261697;1055.625253035177;1068.9679309620724;1082.3343643659093;1086.1745073743853;16672.416465424136;16999.49001529956;17001.234944427284;17117.400890968755;17512.474625761246;27268.181954541396;30349.69650303557;36672.63327366692;36746.448803267434;39426.80286598549;47606;49216.26175607297;52931;53233.46766532285;53638;7668.769936901902;8622.698205562776;8807.867881981903;8920.286377089687;8975.057618949917;11595.246308989888;13560.186388816703;13688.93155534216;13798.724025519634;14009;11857.5849845255;11946.104042196695;11974.341411222467;12040.638780836589;12187.268763874195;11664;11773.52905883755;11909.821352679543;11925.045996320447;11981.820272695742;12119;12354.814677780021;12358.134930554776;12362.258264504158;12533.93733031329;8159.224873636995;8174.427790054639;8249.628766705393;8280.917190828015;8446.831063378575;10875;12452.252864828139;12477.313747743598;12535.749285014432;12582.24506529611 11:26:31 INFO - PROCESS | 7540 | |3;mootools.html;1445.8192725909262;1485.019886874663;1546.9535913922582;1721.9483415497532;1890.281692956677;8244.34045276378;8557.700480483176;8557.871631925518;8729.65081396745;8738.95630521848;8422.241998220159;8583.87124193136;8622.525761083138;8641.611127499262;8691.130886911305;2070.2650559051544;2328.4877326988035;2344.050659482912;2373.2880135959144;2414.9758502415016;2427.2596857958315;2429.441228517442;2439.4755127647554;2443.0472115874823;2444.743301953296;2273.30664147435;2356.7761062699014;2360.4334959609655;2361.2798096580536;2364.798992085666;2033.054629597237;2293.7706229377177;2379.0483806477546;2391.234804862445;2396.484755777499;2306.3196357074703;2313.745487996319;2315.5368926214655;2316.745158032615;2356.375560476458;8816.559172041436;8863.734087977307;8866.645334186625;8874.334424918092;8881.289496840238;5320.068987927098;5433.728313584305;5460.290162278879;5467.972660136674;5485.01269771441;3465.549478567795;3560.092176494977;3560.3413368526644;3575.249197668493;3581.4627805829073;1221.9572314969023;1236.6351926181799;1253.7680529102145;1254.3978890132696;1262.2237324045739;12354.0734444917;12377.071719620975;12382.195157314745;12387.504499819996;12401;4775.976120119447;4870.464248932614;4885.633577481632;4919.065377578248;4945.802167913315;10337.586496540205;10385.480725963822;10387.948060259801;10396.844047339297;10406.063454289151;4868.342773725572;5385.865353366119;5408.323959505062;5422.647527910752;5430.239766432703;4790.640701947298;4927.162382395001;4930.309756634074;4939.827106051271;4975.577075948512;4042.272390969595;4073.429719839225;4113.794310284534;4129.525104613008;4160.895977600584;1288.1820044271956;1329.2755448280711;1334.8665133486768;1337.4449603414669;1348.8313960754906;954.0888451528912;961.8893827209961;1024.9282550221562;1027.4759872465097;1047.8533005379254;5886.941130588725;5987.1318658794235;5995.2805663319805;6060.181875446759;6069.514438844882;467.7848189832715;468.20405310971483;470.1983118782468;477.5439455320161;486.151665343977;4290.764007979591;4379.430674012422;4386.298192289219;4399.6920215584605;4406.317020861771;10536;11021.669349919515;11038.17213708975;11059.944700276446;11086.722831929266;10675.092617127475;10724.356538607708;10788.225625996241;10806.621768238074;11035.337879727242;8162.877556836652;8291.129431409736;8295.211954864279;8359.164083591591;8409.537475438787;6067.54493412987;6135.294441139147;6138;6235.314115447388;6242.65665388408;9956.751081222737;10033.749156271151;10116.494175291353;10148.23888208402;10184.796304074025;9855.162311203629;10161.644342447978;10230.130438912776;10418.218633602359;10484.895151048391;6803.183617965876;7407.407407407287;7613;7720.8455830884195;7786.805329866798;8546;8605.698800541952;8629.007664118706;8636.827263454821;8651.52416617092;7781.221877812173;7875.369970402239;7969.6015199238645;8055.194480551898;8099.959500202462;7546.735864244725;7713.2286771322415;7715.498492597963;7812.804679883048;7861.921380786119;7048.894266586108;7074.752383666547;7219.45854060958;7227.2772722729405;7229.602371869387;5432.565394768488;5445.50990410865;5557.5553955682635;5581.023320918742;5644.153376993484;5399.406065332889;5422.213779002102;5507.642003269774;5556.91664625039;5687.0616348302065 11:26:31 INFO - PROCESS | 7540 | |4;prototype.html;339.22994801799916;343.6529105603341;352.80771979271327;352.84827524164615;360.25607121294524;5329.321263801905;5431.185322201672;5431.646942948715;5478.534324582405;5488.451154884509;5349.331333583302;5384.946150538503;5386.326709161355;5388.407275199725;5428.4300148484435;3979.487794638048;4154.566674497309;4222.19778242133;4230.76730779807;4230.773075808012;3875.4380614810834;4185.225733239346;4185.727927684691;4191.538930717618;4221.810018549158;4130.442390277304;4153.522344930327;4163.2298024865495;4186.665066794649;4191.197784952469;4009.959900400988;4141.295979683461;4142.399352093959;4198.03445207604;4204.684648651348;3558.7508874378805;3648.945265821015;3686.502322186524;3696.611855755161;3703.148275896532;5180.844574662766;5183.289514460219;5199.272101905736;5200.245964335188;5224.555912747421;4650.465196502411;4767.570918617306;4795.520447955211;4809.855704328841;4814;5578.888422231573;5591.903036361365;5615.606907516475;5617.101263797814;5619.4942455178825;4012.558618551957;4028.254772867029;4031;4035.3543433050572;4043.130726893732;5503.624093976506;5720.542356611502;5822.592418530705;5902.468777809975;5914;4092.0792821615496;4120.175964806991;4126.195391898551;4132.380142978577;4141.254574176677;4200.85297014603;4212.346221880257;4212.93566152583;4213.641840443596;4214.093969796447;4618.168729628699;4788.545088216614;4805.423349198119;4822.8794280143275;4824.34871292371;5626.2685850839125;5683.044816695296;5703.857403564944;5705.486506214377;5737.942620573825;1391.6660001599544;1401.687216093454;1406.2757679794913;1413.837408698013;1414.3847426369562;908.4420219323891;952.4903028699589;959.2421986630624;967.8047611200162;974.3179774158118;5296.622878051734;5328.8401347959625;5367;5369.5167434931045;5404.54061404785;5565.276514053147;5583.776648934078;5638.859028524238;5648.915266271009;5693.174489699053;4983.975080124649;5243.528082472596;5264.184051472028;5293.338332708411;5324.307839980777;2961.6297962754657;2982.4482470742983;2988.462076826192;2995.5057415526194;3001.504751715986;5773.538116950634;5791.507721843606;5794.5364370851075;5823.864346452401;5830.125481177857;5629.915551266734;6081.695915204222;6085.17850090241;6095.146679464879;6099.359567245464;6054.545909056927;6093.177421048191;6096.237970253718;6110.633361998294;6114.357992410822;5537.335519737658;5839.2190381933915;5871.2073870027;5906.852328691817;5947.613405128653;5803.361630220588;5804.22970993834;5811.244538210006;5856.970715146397;5858.502027327725;5813.56398270123;5949.2266005419015;6038.909416358846;6100.176476175659;6104.786332478342;4088.8773336799945;4118.588141185857;4133.669306455537;4134.958650413578;4139.288765858368;5711.882853467828;5810.186573879576;5884.47039766423;5922.555808314308;5932.300803134477;5729.684867332337;5746.281714785652;5771.537077753314;5772.422757724194;5780.364159942487;5718.971405142947;5749.223854779551;5772.913406298825;5780.132980053026;5800.216970708901;5424.457554244544;5627.240322556566;5637.605367624391;5644.6613203207935;5653.915191272216;5612.943870561242;5621.791314867323;5622.8313150605545;5668.2064510967675;5718.885622287447;5374.946250537445;5573.972130139324;5580.38615752275;5618.775248989995;5619.522340601095 11:26:31 INFO - PROCESS | 7540 | |5;yui.html;844.7085755414382;885.1546772831946;887.3965703321743;888.8400087984164;895.9910400895993;14568.635784105403;14922;14977.251137443138;14981.47564835231;14987.775183372245;13144.211347319168;13417.865821341784;13420.328983550808;13488.393022313994;13507.324633768321;701.9052427922217;842.3976856547567;855.2431098477846;863.1713554987219;865.2861389353777;856.5331894117721;857.3355649371724;859.2610355094614;860.8407444622765;860.9440386374897;907.0702529906832;910.5811326789651;910.5902343945252;910.7586489580233;911.2709832134299;724.974625888094;886.1935638568904;899.941503802254;903.7333986474006;904.2449554621899;664.2925284571916;664.4418688301802;664.5514277862424;664.5547483186277;666.114068289179;14032.228227447486;14061.507847225297;14082.155070695688;14093.78859317111;14113.576592702235;13772.380242889094;14011.439542418291;14072.92963535186;14084.225367604779;14214.076085054437;11957.641270761891;12050.819237711441;12111.394430278538;12342.81485777714;12357.93821030889;4536.34223037661;4546.38623785788;4573.885652858672;4725.716457012591;4728.4562275338085;55219.72390138024;55325.170122448195;55459;55558.44441555573;57592.99999999958;11285.661430157108;11410.600628977945;11424.143189260838;11568.363739994382;11679.649610511698;20061.498462538555;20138.496537586678;20157.19371225164;20168.092435840423;20174.89912550428;8296.958515207385;8327.50034997902;8373.120822313691;8535.146485351539;8651.04838467768;4639.976800115978;4749.1926372516755;4759.571638552547;4783.4499032611;4838.564529192319;3322.7009569138895;3383.5601371822;3384.3569721752788;3407.9659203408146;3415.7267418606452;643.3277225299573;645.5513418174323;662.6156829039146;664.8736740019381;668.0980676087244;669.8727241824038;719.3130560314887;771.7959982427432;780.750159948811;782.487470706688;9586.616535338648;9603.567839447242;9667.806643867083;9697.127258546765;9800.90199098014;722.8048426924701;729.6862349189793;745.3701622129292;753.1150897695186;771.818622623683;4549.317602359606;4561.635069194456;4568.246239370533;4649.325847752125;4713.175194341045;62419;62613.686931565964;63645;64051.35948640547;64355;49322.50677493179;50515.97936082516;55135.44864551383;56792;58298;51480.48519514757;52421.70939487286;53563;54399.72800135974;54965.450345496036;9713.514324283617;9727.513624318897;9795.167410770164;9839.901600983898;9840.950795245977;32822.179445514055;33568.66431335655;34518.82740586281;34666.306673866886;34870.825645871606;43335.783321083196;45944.7702761484;47853.76073119612;48259.517404826904;48786.5121348782;11857.940710296394;11907;12190.878091219329;12286.447109880255;12846.614601561969;13143.868561314264;13461.86538134606;13651.38568764388;14183.29083545798;15044.398224070914;12645.557405490763;12709.4280757368;13202.075854690464;13407.32963351809;13433.529826456028;11457.427128643369;11521;11712.238704484182;12944.482220711066;13500.594982150551;11944.76110477803;12045.578404756143;12057.457414416547;12101.939490302844;12325.815112773495;9796.069373409515;9954.25343099256;10085.29402941787;10136.847947280648;10164.847527287244;9210.401323913924;9504.192143667866;10238.385696858213;10407.895921040692;10636 11:26:31 INFO - PROCESS | 7540 | __end_tp_report 11:26:31 INFO - PROCESS | 7540 | __start_cc_report 11:26:31 INFO - PROCESS | 7540 | _x_x_mozilla_cycle_collect,932 11:26:31 INFO - PROCESS | 7540 | __end_cc_report 11:26:31 INFO - PROCESS | 7540 | __startTimestamp1462818391477__endTimestamp 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | ------- Summary: start ------- 11:26:31 INFO - PROCESS | 7540 | Number of tests: 6 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#0] dojo.html Cycles:165 Average:5357.97 Median:5493.23 stddev:615.86 (11.2%) stddev-sans-first:592.07 11:26:31 INFO - PROCESS | 7540 | Values: 3114.6 3118.3 3161.3 3168.6 3181.3 5249.5 5274.1 5274.9 5334.9 5348.9 5291.6 5364.4 5377.2 5391.6 5396.0 4830.5 4863.5 5033.4 5065.0 5081.2 4813.9 5010.2 5018.7 5047.8 5078.5 4910.3 4919.9 4969.0 4998.2 5003.4 4991.0 5004.6 5017.9 5025.0 5058.1 4738.0 4781.0 4783.3 4889.3 4922.9 5229.5 5240.3 5250.7 5254.6 5261.8 5664.0 5676.9 5736.3 5795.5 5796.0 5891.1 5895.1 5896.8 5897.5 5898.4 5469.4 5470.8 5509.6 5522.4 5526.1 5682.3 5886.9 5945.3 5969.8 5992.0 5778.8 5816.4 5827.7 5828.4 5832.5 5551.4 5837.5 5861.7 5906.3 5914.7 5574.9 5667.2 5689.9 5725.1 5729.5 5721.6 5725.7 5741.5 5742.5 5743.3 4271.3 4283.1 4367.7 4371.8 4420.7 3846.2 3895.0 3900.4 3913.4 3933.5 5355.1 5359.0 5402.8 5405.5 5462.5 5603.0 5649.3 5716.7 5776.5 5782.1 5356.4 5386.2 5409.9 5417.9 5447.5 4939.1 4941.5 4954.0 4955.7 4995.9 5785.1 5942.4 5943.6 5982.5 6002.2 5891.5 5902.2 5930.2 5950.7 5951.0 6000.7 6026.5 6059.3 6085.6 6092.5 5493.2 5683.6 5690.5 5690.8 5692.5 5805.2 5876.9 5885.2 5893.1 5935.9 5661.2 5709.5 5727.9 5728.2 5732.3 5459.2 5477.2 5514.9 5710.4 5717.3 5407.8 5414.1 5414.7 5425.3 5460.2 5579.9 5581.1 5627.4 5630.9 5634.6 5329.8 5445.9 5453.6 5512.4 5519.6 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#1] ext.html Cycles:180 Average:53244.79 Median:356051.00 stddev:98255.91 (27.6%) stddev-sans-first:98451.97 11:26:31 INFO - PROCESS | 7540 | Values: 579.9 639.8 649.0 651.4 654.5 43175.8 44463.0 44476.1 44589.6 47668.3 44466.8 45230.3 45231.3 45249.8 45259.3 7889.2 8056.8 8970.2 9121.7 10641.4 10520.1 10621.0 10669.7 10671.4 10675.8 10581.0 10667.2 10687.4 10690.6 10706.8 8309.0 10633.3 10878.9 11180.5 11191.3 10651.4 10735.4 10741.8 10751.0 10757.6 41400.8 41684.4 41702.0 41807.8 41815.0 3609.6 3966.9 4200.3 4266.6 4351.2 32545.2 32582.5 32598.8 32846.3 33860.3 4337.2 4345.4 4359.1 4411.8 4459.2 309050.0 310292.0 311881.0 312800.0 313454.0 35523.3 37029.1 59446.7 60041.7 60219.7 37786.6 37853.6 38011.8 38017.6 38022.4 14271.0 14292.6 14315.1 14395.9 14405.1 10841.7 11892.4 12088.1 12102.8 12103.1 8521.1 8653.3 8670.0 8739.3 8750.8 3300.4 3325.7 3334.9 3342.4 3353.3 1053.2 1084.2 1171.0 1202.5 1220.8 32294.8 32357.5 32522.8 32523.7 32930.0 1085.6 1092.2 1119.7 1168.1 1188.5 16358.6 16692.4 16873.6 16882.7 16930.2 436833.0 440455.0 441356.0 442115.0 443496.0 56016.0 57293.7 57320.0 57447.0 57576.0 1293.4 1390.2 1416.9 1440.2 1443.4 31623.5 33466.2 33642.0 33659.7 34282.5 49449.3 49763.5 50189.5 50222.2 50260.5 352312.0 352939.0 355743.0 356028.0 356074.0 26129.5 28262.7 28907.0 28954.0 30160.8 45384.3 46672.0 47166.3 47222.3 49060.5 39604.8 40102.8 41693.4 41905.8 42787.6 39678.6 39896.4 41071.6 41572.8 41783.2 41468.2 42233.4 42283.0 42465.6 42491.6 35223.0 36572.6 36949.6 37010.9 37537.4 28387.5 28388.7 28449.8 28502.4 28518.9 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#2] jquery.html Cycles:180 Average:28950.15 Median:30311.05 stddev:80202.60 (264.6%) stddev-sans-first:80398.96 11:26:31 INFO - PROCESS | 7540 | Values: 412.1 414.0 415.9 419.6 432.4 18500.4 18633.9 19549.3 20128.2 20128.5 12144.7 12211.3 12500.6 12807.7 12812.8 5121.0 5220.3 5241.2 5336.5 5380.8 5883.6 5908.0 5916.3 5939.9 5960.6 5881.6 5886.4 5888.8 5898.3 6941.0 7333.9 7394.2 7482.7 7505.4 7514.8 6988.5 7225.8 7231.9 7234.7 7236.6 23976.0 24895.4 25081.1 25597.6 26271.7 2591.3 2620.1 2657.4 2662.0 3317.4 15334.5 15670.8 15859.3 15871.3 16751.0 1983.8 2066.4 2118.9 2130.5 2142.4 50609.0 51276.7 67752.0 68935.7 85395.0 16947.8 17743.3 17762.3 17889.0 18013.8 26771.0 28393.6 30272.4 32432.8 32721.0 9640.9 9689.2 9743.9 9819.6 9830.5 7616.5 7689.3 7782.4 8088.2 8198.4 8822.3 8970.3 8977.8 9204.3 9239.6 3242.2 3292.9 3340.0 3509.6 3540.2 976.9 998.7 1081.0 1094.5 1108.3 18755.5 19429.7 19559.4 19647.8 19658.8 1047.9 1057.3 1062.1 1089.6 1151.8 10280.2 10917.2 10923.1 10928.3 10951.1 478085.5 478456.0 479207.0 496822.0 516814.0 82342.0 84282.7 84877.0 85513.0 88489.6 1049.4 1055.6 1069.0 1082.3 1086.2 16672.4 16999.5 17001.2 17117.4 17512.5 27268.2 30349.7 36672.6 36746.4 39426.8 47606.0 49216.3 52931.0 53233.5 53638.0 7668.8 8622.7 8807.9 8920.3 8975.1 11595.2 13560.2 13688.9 13798.7 14009.0 11857.6 11946.1 11974.3 12040.6 12187.3 11664.0 11773.5 11909.8 11925.0 11981.8 12119.0 12354.8 12358.1 12362.3 12533.9 8159.2 8174.4 8249.6 8280.9 8446.8 10875.0 12452.3 12477.3 12535.7 12582.2 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#3] mootools.html Cycles:180 Average:5867.32 Median:4783.31 stddev:3291.89 (68.8%) stddev-sans-first:3284.36 11:26:31 INFO - PROCESS | 7540 | Values: 1445.8 1485.0 1547.0 1721.9 1890.3 8244.3 8557.7 8557.9 8729.7 8739.0 8422.2 8583.9 8622.5 8641.6 8691.1 2070.3 2328.5 2344.1 2373.3 2415.0 2427.3 2429.4 2439.5 2443.0 2444.7 2273.3 2356.8 2360.4 2361.3 2364.8 2033.1 2293.8 2379.0 2391.2 2396.5 2306.3 2313.7 2315.5 2316.7 2356.4 8816.6 8863.7 8866.6 8874.3 8881.3 5320.1 5433.7 5460.3 5468.0 5485.0 3465.5 3560.1 3560.3 3575.2 3581.5 1222.0 1236.6 1253.8 1254.4 1262.2 12354.1 12377.1 12382.2 12387.5 12401.0 4776.0 4870.5 4885.6 4919.1 4945.8 10337.6 10385.5 10387.9 10396.8 10406.1 4868.3 5385.9 5408.3 5422.6 5430.2 4790.6 4927.2 4930.3 4939.8 4975.6 4042.3 4073.4 4113.8 4129.5 4160.9 1288.2 1329.3 1334.9 1337.4 1348.8 954.1 961.9 1024.9 1027.5 1047.9 5886.9 5987.1 5995.3 6060.2 6069.5 467.8 468.2 470.2 477.5 486.2 4290.8 4379.4 4386.3 4399.7 4406.3 10536.0 11021.7 11038.2 11059.9 11086.7 10675.1 10724.4 10788.2 10806.6 11035.3 8162.9 8291.1 8295.2 8359.2 8409.5 6067.5 6135.3 6138.0 6235.3 6242.7 9956.8 10033.7 10116.5 10148.2 10184.8 9855.2 10161.6 10230.1 10418.2 10484.9 6803.2 7407.4 7613.0 7720.8 7786.8 8546.0 8605.7 8629.0 8636.8 8651.5 7781.2 7875.4 7969.6 8055.2 8100.0 7546.7 7713.2 7715.5 7812.8 7861.9 7048.9 7074.8 7219.5 7227.3 7229.6 5432.6 5445.5 5557.6 5581.0 5644.2 5399.4 5422.2 5507.6 5556.9 5687.1 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#4] prototype.html Cycles:180 Average:4749.58 Median:5414.50 stddev:1411.88 (26.1%) stddev-sans-first:1376.48 11:26:31 INFO - PROCESS | 7540 | Values: 339.2 343.7 352.8 352.8 360.3 5329.3 5431.2 5431.6 5478.5 5488.5 5349.3 5384.9 5386.3 5388.4 5428.4 3979.5 4154.6 4222.2 4230.8 4230.8 3875.4 4185.2 4185.7 4191.5 4221.8 4130.4 4153.5 4163.2 4186.7 4191.2 4010.0 4141.3 4142.4 4198.0 4204.7 3558.8 3648.9 3686.5 3696.6 3703.1 5180.8 5183.3 5199.3 5200.2 5224.6 4650.5 4767.6 4795.5 4809.9 4814.0 5578.9 5591.9 5615.6 5617.1 5619.5 4012.6 4028.3 4031.0 4035.4 4043.1 5503.6 5720.5 5822.6 5902.5 5914.0 4092.1 4120.2 4126.2 4132.4 4141.3 4200.9 4212.3 4212.9 4213.6 4214.1 4618.2 4788.5 4805.4 4822.9 4824.3 5626.3 5683.0 5703.9 5705.5 5737.9 1391.7 1401.7 1406.3 1413.8 1414.4 908.4 952.5 959.2 967.8 974.3 5296.6 5328.8 5367.0 5369.5 5404.5 5565.3 5583.8 5638.9 5648.9 5693.2 4984.0 5243.5 5264.2 5293.3 5324.3 2961.6 2982.4 2988.5 2995.5 3001.5 5773.5 5791.5 5794.5 5823.9 5830.1 5629.9 6081.7 6085.2 6095.1 6099.4 6054.5 6093.2 6096.2 6110.6 6114.4 5537.3 5839.2 5871.2 5906.9 5947.6 5803.4 5804.2 5811.2 5857.0 5858.5 5813.6 5949.2 6038.9 6100.2 6104.8 4088.9 4118.6 4133.7 4135.0 4139.3 5711.9 5810.2 5884.5 5922.6 5932.3 5729.7 5746.3 5771.5 5772.4 5780.4 5719.0 5749.2 5772.9 5780.1 5800.2 5424.5 5627.2 5637.6 5644.7 5653.9 5612.9 5621.8 5622.8 5668.2 5718.9 5374.9 5574.0 5580.4 5618.8 5619.5 11:26:31 INFO - PROCESS | 7540 | 11:26:31 INFO - PROCESS | 7540 | [#5] yui.html Cycles:180 Average:15102.03 Median:4771.51 stddev:17453.06 (365.8%) stddev-sans-first:17469.18 11:26:31 INFO - PROCESS | 7540 | Values: 844.7 885.2 887.4 888.8 896.0 14568.6 14922.0 14977.3 14981.5 14987.8 13144.2 13417.9 13420.3 13488.4 13507.3 701.9 842.4 855.2 863.2 865.3 856.5 857.3 859.3 860.8 860.9 907.1 910.6 910.6 910.8 911.3 725.0 886.2 899.9 903.7 904.2 664.3 664.4 664.6 664.6 666.1 14032.2 14061.5 14082.2 14093.8 14113.6 13772.4 14011.4 14072.9 14084.2 14214.1 11957.6 12050.8 12111.4 12342.8 12357.9 4536.3 4546.4 4573.9 4725.7 4728.5 55219.7 55325.2 55459.0 55558.4 57593.0 11285.7 11410.6 11424.1 11568.4 11679.6 20061.5 20138.5 20157.2 20168.1 20174.9 8297.0 8327.5 8373.1 8535.1 8651.0 4640.0 4749.2 4759.6 4783.4 4838.6 3322.7 3383.6 3384.4 3408.0 3415.7 643.3 645.6 662.6 664.9 668.1 669.9 719.3 771.8 780.8 782.5 9586.6 9603.6 9667.8 9697.1 9800.9 722.8 729.7 745.4 753.1 771.8 4549.3 4561.6 4568.2 4649.3 4713.2 62419.0 62613.7 63645.0 64051.4 64355.0 49322.5 50516.0 55135.4 56792.0 58298.0 51480.5 52421.7 53563.0 54399.7 54965.5 9713.5 9727.5 9795.2 9839.9 9841.0 32822.2 33568.7 34518.8 34666.3 34870.8 43335.8 45944.8 47853.8 48259.5 48786.5 11857.9 11907.0 12190.9 12286.4 12846.6 13143.9 13461.9 13651.4 14183.3 15044.4 12645.6 12709.4 13202.1 13407.3 13433.5 11457.4 11521.0 11712.2 12944.5 13500.6 11944.8 12045.6 12057.5 12101.9 12325.8 9796.1 9954.3 10085.3 10136.8 10164.8 9210.4 9504.2 10238.4 10407.9 10636.0 11:26:31 INFO - PROCESS | 7540 | -------- Summary: end -------- 11:26:31 INFO - PROCESS | 7540 | 11:26:32 INFO - TEST-INFO | 7540: exit 0 11:26:32 INFO - TEST-OK | dromaeo_css | took 1112491ms 11:26:32 INFO - TEST-START | kraken 11:26:32 INFO - operating with platform_type : linux_ 11:26:32 INFO - Initialising browser for kraken test... 11:26:32 INFO - TEST-INFO | started process 7722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMq4hPM/profile http://localhost:54182/getInfo.html) 11:26:35 INFO - PROCESS | 7722 | __metrics Screen width/height:1600/1200 11:26:35 INFO - PROCESS | 7722 | colorDepth:24 11:26:35 INFO - PROCESS | 7722 | Browser inner width/height: 1024/697 11:26:35 INFO - PROCESS | 7722 | __metrics 11:26:36 ERROR - PROCESS | 7722 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:26:37 INFO - TEST-INFO | 7722: exit 0 11:26:37 INFO - Browser initialized. 11:26:37 INFO - Running cycle 1/1 for kraken test... 11:26:37 INFO - TEST-INFO | started process 7803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMq4hPM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:49 INFO - PROCESS | 7803 | RSS: Main: 152154112 11:26:49 INFO - PROCESS | 7803 | 11:26:52 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:52 INFO - PROCESS | 7803 | RSS: Main: 208392192 11:26:52 INFO - PROCESS | 7803 | 11:26:55 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-dft) 11:26:56 INFO - PROCESS | 7803 | RSS: Main: 197074944 11:26:56 INFO - PROCESS | 7803 | 11:26:59 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-fft) 11:27:00 INFO - PROCESS | 7803 | RSS: Main: 265248768 11:27:00 INFO - PROCESS | 7803 | 11:27:02 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-oscillator) 11:27:02 INFO - PROCESS | 7803 | RSS: Main: 173932544 11:27:02 INFO - PROCESS | 7803 | 11:27:05 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:05 INFO - PROCESS | 7803 | RSS: Main: 178597888 11:27:05 INFO - PROCESS | 7803 | 11:27:08 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:09 INFO - PROCESS | 7803 | RSS: Main: 214458368 11:27:09 INFO - PROCESS | 7803 | 11:27:12 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:13 INFO - PROCESS | 7803 | RSS: Main: 214646784 11:27:13 INFO - PROCESS | 7803 | 11:27:16 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54182/tests/kraken/driver.html?testName=json-parse-financial) 11:27:17 INFO - PROCESS | 7803 | RSS: Main: 214855680 11:27:17 INFO - PROCESS | 7803 | 11:27:18 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:19 INFO - PROCESS | 7803 | RSS: Main: 202891264 11:27:19 INFO - PROCESS | 7803 | 11:27:21 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:21 INFO - PROCESS | 7803 | RSS: Main: 208367616 11:27:21 INFO - PROCESS | 7803 | 11:27:23 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:24 INFO - PROCESS | 7803 | RSS: Main: 217268224 11:27:24 INFO - PROCESS | 7803 | 11:27:27 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:27 INFO - PROCESS | 7803 | RSS: Main: 223686656 11:27:27 INFO - PROCESS | 7803 | 11:27:30 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:31 INFO - PROCESS | 7803 | RSS: Main: 218083328 11:27:31 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54182/tests/kraken/driver.html?testName=ai-astar) 11:27:33 INFO - PROCESS | 7803 | RSS: Main: 263352320 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | __start_tp_report 11:27:33 INFO - PROCESS | 7803 | _x_x_mozilla_page_load 11:27:33 INFO - PROCESS | 7803 | _x_x_mozilla_page_load_details 11:27:33 INFO - PROCESS | 7803 | |i|pagename|runs| 11:27:33 INFO - PROCESS | 7803 | |0;ai-astar;112;106;110;111;110;112;111;113;110;112 11:27:33 INFO - PROCESS | 7803 | |1;audio-beat-detection;167;135;158;216;125;149;148;130;182;124 11:27:33 INFO - PROCESS | 7803 | |2;audio-dft;161;163;164;160;161;162;162;164;161;163 11:27:33 INFO - PROCESS | 7803 | |3;audio-fft;74;75;76;165;75;73;75;75;129;77 11:27:33 INFO - PROCESS | 7803 | |4;audio-oscillator;90;92;156;90;90;90;128;91;91;136 11:27:33 INFO - PROCESS | 7803 | |5;imaging-gaussian-blur;116;116;116;116;117;117;117;116;117;118 11:27:33 INFO - PROCESS | 7803 | |6;imaging-darkroom;146;145;145;145;146;145;146;146;145;145 11:27:33 INFO - PROCESS | 7803 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 11:27:33 INFO - PROCESS | 7803 | |8;json-parse-financial;58;58;58;56;58;58;59;109;56;56 11:27:33 INFO - PROCESS | 7803 | |9;json-stringify-tinderbox;59;58;58;58;58;58;58;58;58;58 11:27:33 INFO - PROCESS | 7803 | |10;stanford-crypto-aes;81;85;80;80;79;84;80;80;82;80 11:27:33 INFO - PROCESS | 7803 | |11;stanford-crypto-ccm;125;134;125;129;125;123;125;124;195;127 11:27:33 INFO - PROCESS | 7803 | |12;stanford-crypto-pbkdf2;166;178;171;170;166;168;170;166;168;167 11:27:33 INFO - PROCESS | 7803 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;63;64;63;63;62 11:27:33 INFO - PROCESS | 7803 | __end_tp_report 11:27:33 INFO - PROCESS | 7803 | __start_cc_report 11:27:33 INFO - PROCESS | 7803 | _x_x_mozilla_cycle_collect,1848 11:27:33 INFO - PROCESS | 7803 | __end_cc_report 11:27:33 INFO - PROCESS | 7803 | __startTimestamp1462818453302__endTimestamp 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | ------- Summary: start ------- 11:27:33 INFO - PROCESS | 7803 | Number of tests: 14 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:1.95 (1.7%) stddev-sans-first:2.01 11:27:33 INFO - PROCESS | 7803 | Values: 112.0 106.0 110.0 111.0 110.0 112.0 111.0 113.0 110.0 112.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:153.50 stddev:28.96 (18.9%) stddev-sans-first:30.30 11:27:33 INFO - PROCESS | 7803 | Values: 167.0 135.0 158.0 216.0 125.0 149.0 148.0 130.0 182.0 124.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.39 11:27:33 INFO - PROCESS | 7803 | Values: 161.0 163.0 164.0 160.0 161.0 162.0 162.0 164.0 161.0 163.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#3] audio-fft Cycles:10 Average:89.40 Median:75.00 stddev:31.54 (42.1%) stddev-sans-first:32.96 11:27:33 INFO - PROCESS | 7803 | Values: 74.0 75.0 76.0 165.0 75.0 73.0 75.0 75.0 129.0 77.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:90.00 stddev:24.83 (27.6%) stddev-sans-first:25.71 11:27:33 INFO - PROCESS | 7803 | Values: 90.0 92.0 156.0 90.0 90.0 90.0 128.0 91.0 91.0 136.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:27:33 INFO - PROCESS | 7803 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:27:33 INFO - PROCESS | 7803 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:27:33 INFO - PROCESS | 7803 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:58.00 stddev:16.34 (28.2%) stddev-sans-first:17.24 11:27:33 INFO - PROCESS | 7803 | Values: 58.0 58.0 58.0 56.0 58.0 58.0 59.0 109.0 56.0 56.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 11:27:33 INFO - PROCESS | 7803 | Values: 59.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:1.97 (2.4%) stddev-sans-first:2.09 11:27:33 INFO - PROCESS | 7803 | Values: 81.0 85.0 80.0 80.0 79.0 84.0 80.0 80.0 82.0 80.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:126.00 stddev:21.94 (17.4%) stddev-sans-first:23.07 11:27:33 INFO - PROCESS | 7803 | Values: 125.0 134.0 125.0 129.0 125.0 123.0 125.0 124.0 195.0 127.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:3.65 (2.2%) stddev-sans-first:3.71 11:27:33 INFO - PROCESS | 7803 | Values: 166.0 178.0 171.0 170.0 166.0 168.0 170.0 166.0 168.0 167.0 11:27:33 INFO - PROCESS | 7803 | 11:27:33 INFO - PROCESS | 7803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.50 stddev:1.72 (2.6%) stddev-sans-first:1.73 11:27:33 INFO - PROCESS | 7803 | Values: 66.0 66.0 65.0 66.0 67.0 63.0 64.0 63.0 63.0 62.0 11:27:33 INFO - PROCESS | 7803 | -------- Summary: end -------- 11:27:33 INFO - PROCESS | 7803 | 11:27:34 INFO - TEST-INFO | 7803: exit 0 11:27:34 INFO - TEST-OK | kraken | took 62143ms 11:27:34 INFO - SUITE-END | took 1174s 11:27:34 INFO - Completed test suite (00:19:34) 11:27:34 INFO - javascript benchmark 11:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.6106736657916, 3118.313970926397, 3161.2571045804234, 3168.6356069052067, 3181.2524056846637, 5249.501297376743, 5274.077036518613, 5274.865903830676, 5334.946650533493, 5348.919766203505, 5291.550218231455, 5364.436734142917, 5377.247185394038, 5391.649542779716, 5396.0, 4830.492798256177, 4863.489333619972, 5033.446320904697, 5065.037642847866, 5081.237814327844, 4813.90372192556, 5010.223415370623, 5018.673786203904, 5047.798088076491, 5078.5175408336145, 4910.263460480938, 4919.852404427873, 4969.0, 4998.175301075318, 5003.399592048941, 4990.950090499121, 5004.574611158019, 5017.899642007176, 5024.9748751256375, 5058.089543882136, 4737.95262047382, 4781.019890922353, 4783.330333753277, 4889.315495830587, 4922.852314430573, 5229.50319719626, 5240.266362709223, 5250.737463126867, 5254.632175747699, 5261.76322065508, 5664.0, 5676.943230567724, 5736.282964629421, 5795.478406943354, 5796.043652797283, 5891.086881533369, 5895.115732640138, 5896.764129434818, 5897.469227769521, 5898.41015898411, 5469.371022332482, 5470.753816078246, 5509.641873278224, 5522.392536820947, 5526.115821468586, 5682.261306030272, 5886.8822623547285, 5945.286565612154, 5969.76120955157, 5991.970040149771, 5778.768849245983, 5816.360200377955, 5827.679477628772, 5828.417158284137, 5832.475077243069, 5551.417101204396, 5837.532997360201, 5861.677607731615, 5906.26171728534, 5914.733836977346, 5574.916376254359, 5667.1782591524825, 5689.857753556112, 5725.141228815711, 5729.541636669056, 5721.599488035881, 5725.685087320154, 5741.511971482387, 5742.54059675225, 5743.282089738783, 4271.252530807096, 4283.079137985285, 4367.67242456817, 4371.825126994948, 4420.734755914656, 3846.249981253685, 3894.9805250973563, 3900.4344370066183, 3913.4325522799036, 3933.468981687493, 5355.062863998784, 5359.0, 5402.783888644489, 5405.5135037846785, 5462.5083742462575, 5603.047481928082, 5649.322081350264, 5716.714164291769, 5776.480116789509, 5782.132680097935, 5356.4107948125675, 5386.165144402624, 5409.918851217235, 5417.918731219035, 5447.4824891635235, 4939.086269040239, 4941.45643979162, 4953.975230123826, 4955.677880937799, 4995.925061124086, 5785.1322301654245, 5942.405759424023, 5943.5839491236065, 5982.4914882234625, 6002.219711437572, 5891.469767720926, 5902.2327097477055, 5930.199423077829, 5950.702464876652, 5951.0, 6000.669963152069, 6026.457618814327, 6059.303180134165, 6085.57400981927, 6092.482139018233, 5493.23094766741, 5683.60214784961, 5690.5163061140265, 5690.829275121753, 5692.459216374438, 5805.245318108618, 5876.942150412967, 5885.205497257815, 5893.116032595145, 5935.940640593712, 5661.150827375926, 5709.486146246858, 5727.885442291047, 5728.226689396878, 5732.254806875079, 5459.181122831607, 5477.178423236546, 5514.91727624094, 5710.4004079572705, 5717.342505611908, 5407.756650950795, 5414.133738601805, 5414.729263536886, 5425.348958125051, 5460.180972854104, 5579.944200557942, 5581.051221292309, 5627.409122042291, 5630.943690563042, 5634.577406694432, 5329.840104796862, 5445.918311225256, 5453.590980676545, 5512.448755124456, 5519.558435325084], "value": 5316.293813657087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9333076696179, 639.7920675780371, 649.0102593544843, 651.4365074210806, 654.4960380507013, 43175.78412107939, 44463.0, 44476.110477790426, 44589.55410445895, 47668.284975725306, 44466.77766611162, 45230.32154517685, 45231.321530177076, 45249.77375113128, 45259.32111018337, 7889.211078892123, 8056.798580035487, 8970.237529809974, 9121.726348209531, 10641.414722190277, 10520.05319521243, 10621.044106030457, 10669.679909602724, 10671.35971841692, 10675.83986240207, 10581.0, 10667.199960002992, 10687.358758474478, 10690.572377104907, 10706.78586428271, 8309.00291964965, 10633.255672102956, 10878.891211087866, 11180.496877640444, 11191.32852028881, 10651.360918344924, 10735.355878647306, 10741.78516429667, 10751.0, 10757.62348317813, 41400.792996035125, 41684.37473437901, 41702.0, 41807.790961045306, 41815.0, 3609.6390360963956, 3966.900827479336, 4200.348945913388, 4266.552012038754, 4351.151525452538, 32545.186370340693, 32582.51126233085, 32598.837005815058, 32846.34307313864, 33860.32279354399, 4337.197618440567, 4345.41336919515, 4359.106383191438, 4411.757353345564, 4459.152760975437, 309050.0, 310292.0, 311881.0, 312800.0, 313454.0, 35523.28953420969, 37029.07427314285, 59446.70276648589, 60041.69979150076, 60219.69890150609, 37786.62213377831, 37853.62146378556, 38011.809940950116, 38017.619823801964, 38022.42966355507, 14271.0, 14292.571222863122, 14315.14109153454, 14395.928020359832, 14405.06367086136, 10841.728956776144, 11892.405379730979, 12088.09339299556, 12102.81845772314, 12103.092268079754, 8521.10528394522, 8653.264472519906, 8670.002949660744, 8739.30085593151, 8750.781230469289, 3300.35643049603, 3325.717314028286, 3334.9333013339597, 3342.38165939302, 3353.3293341331832, 1053.1832588784287, 1084.219362059316, 1170.9578475157116, 1202.4588934979295, 1220.7558488302375, 32294.83852580722, 32357.51463728046, 32522.837385813393, 32523.674763252064, 32930.0, 1085.571199376242, 1092.2190633696946, 1119.7368618374676, 1168.1414160591958, 1188.4948896719034, 16358.591035224215, 16692.41576544815, 16873.565746911405, 16882.66234675324, 16930.238139283763, 436833.0, 440455.0, 441356.0, 442115.0, 443496.0, 56016.0, 57293.713531432906, 57320.0, 57447.0, 57576.0, 1293.3985696651102, 1390.2284232250995, 1416.9433222670978, 1440.229477229677, 1443.3793468808512, 31623.525647115774, 33466.163345916546, 33642.0, 33659.66340336565, 34282.48576271308, 49449.25826112683, 49763.50236497589, 50189.49810501994, 50222.246666300765, 50260.49739502558, 352312.0, 352939.0, 355743.0, 356028.0, 356074.0, 26129.477410451305, 28262.71737282601, 28907.0, 28954.0, 30160.84919575476, 45384.31923521084, 46672.0, 47166.29250561313, 47222.29166562573, 49060.509394905595, 39604.80197598993, 40102.79948600355, 41693.374599380426, 41905.79047104745, 42787.57212427836, 39678.60321396749, 39896.401553977295, 41071.589284106776, 41572.79213603913, 41783.164336712485, 41468.1706365877, 42233.36649950314, 42283.0, 42465.5753442474, 42491.57508424876, 35223.0, 36572.63427365692, 36949.63050369569, 37010.93403348211, 37537.43693844649, 28387.477023895743, 28388.744251927397, 28449.753830004916, 28502.42995140044, 28518.85924563077], "value": 19180.04730394281, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.1057305646746, 413.97128136580574, 415.858608073255, 419.58670709351287, 432.437830819934, 18500.444986650404, 18633.90683046583, 19549.315773947914, 20128.194872205113, 20128.49678758032, 12144.69638259044, 12211.267323960568, 12500.624981250554, 12807.743845123092, 12812.80780788289, 5120.974395128019, 5220.34745656792, 5241.161414173733, 5336.519713225809, 5380.838574842761, 5883.646981181143, 5907.995640741063, 5916.319623243339, 5939.851503712399, 5960.552958528127, 5881.617694849842, 5886.381929897363, 5888.764449422018, 5898.262717160355, 6940.9652951735425, 7333.9266607333775, 7394.223606521318, 7482.663280152352, 7505.399568034544, 7514.774556763278, 6988.545744526589, 7225.783226503213, 7231.927680723231, 7234.674439650228, 7236.638168091627, 23976.0, 24895.377615559573, 25081.122160724288, 25597.616035759478, 26271.737282627313, 2591.3262551736498, 2620.1091628846284, 2657.3755167535614, 2661.9733802661917, 3317.402867483852, 15334.463293784776, 15670.764938525932, 15859.286332115082, 15871.28579213938, 16751.0, 1983.7917018712972, 2066.390414827614, 2118.8728676279475, 2130.4673831542113, 2142.368001439579, 50609.0, 51276.74361628205, 67752.0, 68935.65532172358, 85394.99999999937, 16947.830521694625, 17743.29026838912, 17762.289508419777, 17889.0, 18013.819861801476, 26771.0, 28393.57409638857, 30272.394552108835, 32432.83783581114, 32721.0, 9640.903590964, 9689.224862011022, 9743.853842192373, 9819.607215711434, 9830.459324737209, 7616.466847320745, 7689.307962283309, 7782.416318776114, 8088.150744171778, 8198.38512111594, 8822.33832462555, 8970.282377409792, 8977.820443591223, 9204.318272690844, 9239.584218710173, 3242.189452636841, 3292.851821668031, 3339.9713517101864, 3509.596396414394, 3540.185757275841, 976.9023097690316, 998.6953979036318, 1080.9567617295377, 1094.5020015892908, 1108.2630051015983, 18755.531111722044, 19429.708554371697, 19559.413217603495, 19647.803521964597, 19658.8034119657, 1047.9318844275251, 1057.2757661002238, 1062.134360496193, 1089.6349722842779, 1151.8272259161026, 10280.177585793119, 10917.181211409017, 10923.071538919123, 10928.289661171999, 10951.123910087173, 478085.5340126158, 478456.0, 479207.0, 496822.0, 516814.0, 82342.0, 84282.73575896367, 84877.02930397406, 85513.0, 88489.55755221311, 1049.3861091261697, 1055.625253035177, 1068.9679309620724, 1082.3343643659093, 1086.1745073743853, 16672.416465424136, 16999.49001529956, 17001.234944427284, 17117.400890968755, 17512.474625761246, 27268.181954541396, 30349.69650303557, 36672.63327366692, 36746.448803267434, 39426.80286598549, 47606.0, 49216.26175607297, 52931.0, 53233.46766532285, 53638.0, 7668.769936901902, 8622.698205562776, 8807.867881981903, 8920.286377089687, 8975.057618949917, 11595.246308989888, 13560.186388816703, 13688.93155534216, 13798.724025519634, 14009.0, 11857.5849845255, 11946.104042196695, 11974.341411222467, 12040.638780836589, 12187.268763874195, 11664.0, 11773.52905883755, 11909.821352679543, 11925.045996320447, 11981.820272695742, 12119.0, 12354.814677780021, 12358.134930554776, 12362.258264504158, 12533.93733031329, 8159.224873636995, 8174.427790054639, 8249.628766705393, 8280.917190828015, 8446.831063378575, 10875.0, 12452.252864828139, 12477.313747743598, 12535.749285014432, 12582.24506529611], "value": 10061.811244220067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.8192725909262, 1485.019886874663, 1546.9535913922582, 1721.9483415497532, 1890.281692956677, 8244.34045276378, 8557.700480483176, 8557.871631925518, 8729.65081396745, 8738.95630521848, 8422.241998220159, 8583.87124193136, 8622.525761083138, 8641.611127499262, 8691.130886911305, 2070.2650559051544, 2328.4877326988035, 2344.050659482912, 2373.2880135959144, 2414.9758502415016, 2427.2596857958315, 2429.441228517442, 2439.4755127647554, 2443.0472115874823, 2444.743301953296, 2273.30664147435, 2356.7761062699014, 2360.4334959609655, 2361.2798096580536, 2364.798992085666, 2033.054629597237, 2293.7706229377177, 2379.0483806477546, 2391.234804862445, 2396.484755777499, 2306.3196357074703, 2313.745487996319, 2315.5368926214655, 2316.745158032615, 2356.375560476458, 8816.559172041436, 8863.734087977307, 8866.645334186625, 8874.334424918092, 8881.289496840238, 5320.068987927098, 5433.728313584305, 5460.290162278879, 5467.972660136674, 5485.01269771441, 3465.549478567795, 3560.092176494977, 3560.3413368526644, 3575.249197668493, 3581.4627805829073, 1221.9572314969023, 1236.6351926181799, 1253.7680529102145, 1254.3978890132696, 1262.2237324045739, 12354.0734444917, 12377.071719620975, 12382.195157314745, 12387.504499819996, 12401.0, 4775.976120119447, 4870.464248932614, 4885.633577481632, 4919.065377578248, 4945.802167913315, 10337.586496540205, 10385.480725963822, 10387.948060259801, 10396.844047339297, 10406.063454289151, 4868.342773725572, 5385.865353366119, 5408.323959505062, 5422.647527910752, 5430.239766432703, 4790.640701947298, 4927.162382395001, 4930.309756634074, 4939.827106051271, 4975.577075948512, 4042.272390969595, 4073.429719839225, 4113.794310284534, 4129.525104613008, 4160.895977600584, 1288.1820044271956, 1329.2755448280711, 1334.8665133486768, 1337.4449603414669, 1348.8313960754906, 954.0888451528912, 961.8893827209961, 1024.9282550221562, 1027.4759872465097, 1047.8533005379254, 5886.941130588725, 5987.1318658794235, 5995.2805663319805, 6060.181875446759, 6069.514438844882, 467.7848189832715, 468.20405310971483, 470.1983118782468, 477.5439455320161, 486.151665343977, 4290.764007979591, 4379.430674012422, 4386.298192289219, 4399.6920215584605, 4406.317020861771, 10536.0, 11021.669349919515, 11038.17213708975, 11059.944700276446, 11086.722831929266, 10675.092617127475, 10724.356538607708, 10788.225625996241, 10806.621768238074, 11035.337879727242, 8162.877556836652, 8291.129431409736, 8295.211954864279, 8359.164083591591, 8409.537475438787, 6067.54493412987, 6135.294441139147, 6138.0, 6235.314115447388, 6242.65665388408, 9956.751081222737, 10033.749156271151, 10116.494175291353, 10148.23888208402, 10184.796304074025, 9855.162311203629, 10161.644342447978, 10230.130438912776, 10418.218633602359, 10484.895151048391, 6803.183617965876, 7407.407407407287, 7613.0, 7720.8455830884195, 7786.805329866798, 8546.0, 8605.698800541952, 8629.007664118706, 8636.827263454821, 8651.52416617092, 7781.221877812173, 7875.369970402239, 7969.6015199238645, 8055.194480551898, 8099.959500202462, 7546.735864244725, 7713.2286771322415, 7715.498492597963, 7812.804679883048, 7861.921380786119, 7048.894266586108, 7074.752383666547, 7219.45854060958, 7227.2772722729405, 7229.602371869387, 5432.565394768488, 5445.50990410865, 5557.5553955682635, 5581.023320918742, 5644.153376993484, 5399.406065332889, 5422.213779002102, 5507.642003269774, 5556.91664625039, 5687.0616348302065], "value": 4650.565874436798, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.22994801799916, 343.6529105603341, 352.80771979271327, 352.84827524164615, 360.25607121294524, 5329.321263801905, 5431.185322201672, 5431.646942948715, 5478.534324582405, 5488.451154884509, 5349.331333583302, 5384.946150538503, 5386.326709161355, 5388.407275199725, 5428.4300148484435, 3979.487794638048, 4154.566674497309, 4222.19778242133, 4230.76730779807, 4230.773075808012, 3875.4380614810834, 4185.225733239346, 4185.727927684691, 4191.538930717618, 4221.810018549158, 4130.442390277304, 4153.522344930327, 4163.2298024865495, 4186.665066794649, 4191.197784952469, 4009.959900400988, 4141.295979683461, 4142.399352093959, 4198.03445207604, 4204.684648651348, 3558.7508874378805, 3648.945265821015, 3686.502322186524, 3696.611855755161, 3703.148275896532, 5180.844574662766, 5183.289514460219, 5199.272101905736, 5200.245964335188, 5224.555912747421, 4650.465196502411, 4767.570918617306, 4795.520447955211, 4809.855704328841, 4814.0, 5578.888422231573, 5591.903036361365, 5615.606907516475, 5617.101263797814, 5619.4942455178825, 4012.558618551957, 4028.254772867029, 4031.0, 4035.3543433050572, 4043.130726893732, 5503.624093976506, 5720.542356611502, 5822.592418530705, 5902.468777809975, 5914.0, 4092.0792821615496, 4120.175964806991, 4126.195391898551, 4132.380142978577, 4141.254574176677, 4200.85297014603, 4212.346221880257, 4212.93566152583, 4213.641840443596, 4214.093969796447, 4618.168729628699, 4788.545088216614, 4805.423349198119, 4822.8794280143275, 4824.34871292371, 5626.2685850839125, 5683.044816695296, 5703.857403564944, 5705.486506214377, 5737.942620573825, 1391.6660001599544, 1401.687216093454, 1406.2757679794913, 1413.837408698013, 1414.3847426369562, 908.4420219323891, 952.4903028699589, 959.2421986630624, 967.8047611200162, 974.3179774158118, 5296.622878051734, 5328.8401347959625, 5367.0, 5369.5167434931045, 5404.54061404785, 5565.276514053147, 5583.776648934078, 5638.859028524238, 5648.915266271009, 5693.174489699053, 4983.975080124649, 5243.528082472596, 5264.184051472028, 5293.338332708411, 5324.307839980777, 2961.6297962754657, 2982.4482470742983, 2988.462076826192, 2995.5057415526194, 3001.504751715986, 5773.538116950634, 5791.507721843606, 5794.5364370851075, 5823.864346452401, 5830.125481177857, 5629.915551266734, 6081.695915204222, 6085.17850090241, 6095.146679464879, 6099.359567245464, 6054.545909056927, 6093.177421048191, 6096.237970253718, 6110.633361998294, 6114.357992410822, 5537.335519737658, 5839.2190381933915, 5871.2073870027, 5906.852328691817, 5947.613405128653, 5803.361630220588, 5804.22970993834, 5811.244538210006, 5856.970715146397, 5858.502027327725, 5813.56398270123, 5949.2266005419015, 6038.909416358846, 6100.176476175659, 6104.786332478342, 4088.8773336799945, 4118.588141185857, 4133.669306455537, 4134.958650413578, 4139.288765858368, 5711.882853467828, 5810.186573879576, 5884.47039766423, 5922.555808314308, 5932.300803134477, 5729.684867332337, 5746.281714785652, 5771.537077753314, 5772.422757724194, 5780.364159942487, 5718.971405142947, 5749.223854779551, 5772.913406298825, 5780.132980053026, 5800.216970708901, 5424.457554244544, 5627.240322556566, 5637.605367624391, 5644.6613203207935, 5653.915191272216, 5612.943870561242, 5621.791314867323, 5622.8313150605545, 5668.2064510967675, 5718.885622287447, 5374.946250537445, 5573.972130139324, 5580.38615752275, 5618.775248989995, 5619.522340601095], "value": 4301.817049435429, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.7085755414382, 885.1546772831946, 887.3965703321743, 888.8400087984164, 895.9910400895993, 14568.635784105403, 14922.0, 14977.251137443138, 14981.47564835231, 14987.775183372245, 13144.211347319168, 13417.865821341784, 13420.328983550808, 13488.393022313994, 13507.324633768321, 701.9052427922217, 842.3976856547567, 855.2431098477846, 863.1713554987219, 865.2861389353777, 856.5331894117721, 857.3355649371724, 859.2610355094614, 860.8407444622765, 860.9440386374897, 907.0702529906832, 910.5811326789651, 910.5902343945252, 910.7586489580233, 911.2709832134299, 724.974625888094, 886.1935638568904, 899.941503802254, 903.7333986474006, 904.2449554621899, 664.2925284571916, 664.4418688301802, 664.5514277862424, 664.5547483186277, 666.114068289179, 14032.228227447486, 14061.507847225297, 14082.155070695688, 14093.78859317111, 14113.576592702235, 13772.380242889094, 14011.439542418291, 14072.92963535186, 14084.225367604779, 14214.076085054437, 11957.641270761891, 12050.819237711441, 12111.394430278538, 12342.81485777714, 12357.93821030889, 4536.34223037661, 4546.38623785788, 4573.885652858672, 4725.716457012591, 4728.4562275338085, 55219.72390138024, 55325.170122448195, 55459.0, 55558.44441555573, 57592.99999999958, 11285.661430157108, 11410.600628977945, 11424.143189260838, 11568.363739994382, 11679.649610511698, 20061.498462538555, 20138.496537586678, 20157.19371225164, 20168.092435840423, 20174.89912550428, 8296.958515207385, 8327.50034997902, 8373.120822313691, 8535.146485351539, 8651.04838467768, 4639.976800115978, 4749.1926372516755, 4759.571638552547, 4783.4499032611, 4838.564529192319, 3322.7009569138895, 3383.5601371822, 3384.3569721752788, 3407.9659203408146, 3415.7267418606452, 643.3277225299573, 645.5513418174323, 662.6156829039146, 664.8736740019381, 668.0980676087244, 669.8727241824038, 719.3130560314887, 771.7959982427432, 780.750159948811, 782.487470706688, 9586.616535338648, 9603.567839447242, 9667.806643867083, 9697.127258546765, 9800.90199098014, 722.8048426924701, 729.6862349189793, 745.3701622129292, 753.1150897695186, 771.818622623683, 4549.317602359606, 4561.635069194456, 4568.246239370533, 4649.325847752125, 4713.175194341045, 62419.0, 62613.686931565964, 63645.0, 64051.35948640547, 64355.0, 49322.50677493179, 50515.97936082516, 55135.44864551383, 56792.0, 58298.0, 51480.48519514757, 52421.70939487286, 53563.0, 54399.72800135974, 54965.450345496036, 9713.514324283617, 9727.513624318897, 9795.167410770164, 9839.901600983898, 9840.950795245977, 32822.179445514055, 33568.66431335655, 34518.82740586281, 34666.306673866886, 34870.825645871606, 43335.783321083196, 45944.7702761484, 47853.76073119612, 48259.517404826904, 48786.5121348782, 11857.940710296394, 11907.0, 12190.878091219329, 12286.447109880255, 12846.614601561969, 13143.868561314264, 13461.86538134606, 13651.38568764388, 14183.29083545798, 15044.398224070914, 12645.557405490763, 12709.4280757368, 13202.075854690464, 13407.32963351809, 13433.529826456028, 11457.427128643369, 11521.0, 11712.238704484182, 12944.482220711066, 13500.594982150551, 11944.76110477803, 12045.578404756143, 12057.457414416547, 12101.939490302844, 12325.815112773495, 9796.069373409515, 9954.25343099256, 10085.29402941787, 10136.847947280648, 10164.847527287244, 9210.401323913924, 9504.192143667866, 10238.385696858213, 10407.895921040692, 10636.0], "value": 6940.309905035476, "unit": "score"}], "name": "dromaeo_css", "value": 7226.9082665506385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 111.0, 110.0, 112.0, 111.0, 113.0, 110.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 135.0, 158.0, 216.0, 125.0, 149.0, 148.0, 130.0, 182.0, 124.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 160.0, 161.0, 162.0, 162.0, 164.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 165.0, 75.0, 73.0, 75.0, 75.0, 129.0, 77.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 156.0, 90.0, 90.0, 90.0, 128.0, 91.0, 91.0, 136.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 56.0, 58.0, 58.0, 59.0, 109.0, 56.0, 56.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 80.0, 80.0, 79.0, 84.0, 80.0, 80.0, 82.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 134.0, 125.0, 129.0, 125.0, 123.0, 125.0, 124.0, 195.0, 127.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 178.0, 171.0, 170.0, 166.0, 168.0, 170.0, 166.0, 168.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 63.0, 64.0, 63.0, 63.0, 62.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1546.3999999999999, "alertThreshold": 2.0}]} 11:27:34 INFO - Return code: 0 11:27:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:34 ERROR - # TBPL SUCCESS # 11:27:34 INFO - Running post-action listener: _resource_record_post_action 11:27:34 INFO - ##### 11:27:34 INFO - ##### Finished run-tests step (success) 11:27:34 INFO - ##### 11:27:34 INFO - Running post-run listener: _resource_record_post_run 11:27:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535977984; Read time: 36; Write time: 452856 11:27:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244772864; Read time: 0; Write time: 254188 11:27:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291155968; Read time: 36; Write time: 198640 11:27:35 INFO - Running post-run listener: _upload_blobber_files 11:27:35 INFO - Blob upload gear active. 11:27:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:35 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 11:27:35 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'] 11:27:35 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 11:27:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:37 INFO - (blobuploader) - INFO - Done attempting. 11:27:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:27:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:38 INFO - (blobuploader) - INFO - Done attempting. 11:27:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:38 INFO - Return code: 0 11:27:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2506c9d67b70d095d0fef0a44e511bde521dcf2fdd3a1ef8f077d12d3d1e487007b6b46712ee2713ba343885d678564f38d99ad057bb0b210555fc61d7a5dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/485fc1dba46e3c4a41a7304661248955dfc6deb3f8c0a63ceac524109c3e0700c3633fecf860c87a6c360fb6e5c413606c167191e7d2ceae6efec9d1301f765a"} 11:27:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:38 INFO - Contents: 11:27:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2506c9d67b70d095d0fef0a44e511bde521dcf2fdd3a1ef8f077d12d3d1e487007b6b46712ee2713ba343885d678564f38d99ad057bb0b210555fc61d7a5dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/485fc1dba46e3c4a41a7304661248955dfc6deb3f8c0a63ceac524109c3e0700c3633fecf860c87a6c360fb6e5c413606c167191e7d2ceae6efec9d1301f765a"} 11:27:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:38 INFO - Copying logs to upload dir... 11:27:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.069337 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 11:27:37.971038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 11:27:37.974179) ========= 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-1462816945.911270-1533457901 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/2506c9d67b70d095d0fef0a44e511bde521dcf2fdd3a1ef8f077d12d3d1e487007b6b46712ee2713ba343885d678564f38d99ad057bb0b210555fc61d7a5dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/485fc1dba46e3c4a41a7304661248955dfc6deb3f8c0a63ceac524109c3e0700c3633fecf860c87a6c360fb6e5c413606c167191e7d2ceae6efec9d1301f765a"} build_url:https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/R3fM_50ySJqGU55GtSL1og/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/2506c9d67b70d095d0fef0a44e511bde521dcf2fdd3a1ef8f077d12d3d1e487007b6b46712ee2713ba343885d678564f38d99ad057bb0b210555fc61d7a5dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/485fc1dba46e3c4a41a7304661248955dfc6deb3f8c0a63ceac524109c3e0700c3633fecf860c87a6c360fb6e5c413606c167191e7d2ceae6efec9d1301f765a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 11:27:37.998816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:27:37.999137) ========= 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-1462816945.911270-1533457901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 11:27:38.082622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 11:27:38.082963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 11:27:38.083272) ========= ========= Total master_lag: 0.16 =========