builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1461370213.39 results: success (0) buildid: 20160422143012 builduid: 515f4e07440c48688c69809bcd2dbec1 revision: 21c9846c176b04cda630cbccacaccc789a8c963b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.388681) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.389193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.389465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.408010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.408270) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 17:10:13-- 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% 223M=0s 2016-04-22 17:10:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.524417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.524746) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:13.575300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 17:10:13.575646) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21c9846c176b04cda630cbccacaccc789a8c963b --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 21c9846c176b04cda630cbccacaccc789a8c963b --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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 17:10:13,682 truncating revision to first 12 chars 2016-04-22 17:10:13,682 Setting DEBUG logging. 2016-04-22 17:10:13,682 attempt 1/10 2016-04-22 17:10:13,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21c9846c176b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 17:10:14,815 unpacking tar archive at: fx-team-21c9846c176b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 17:10:14.990339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:14.990700) ========= script_repo_revision: 21c9846c176b04cda630cbccacaccc789a8c963b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:14.991148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:14.991453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.001759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-22 17:10:15.002160) ========= /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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:15 INFO - MultiFileLogger online at 20160422 17:10:15 in /builds/slave/test 17:10:15 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 17:10:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:15 INFO - {'append_to_log': False, 17:10:15 INFO - 'base_work_dir': '/builds/slave/test', 17:10:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:10:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:15 INFO - 'branch': 'Fx-Team', 17:10:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:15 INFO - 'config_files': ('talos/linux_config.py',), 17:10:15 INFO - 'default_actions': ('clobber', 17:10:15 INFO - 'read-buildbot-config', 17:10:15 INFO - 'download-and-extract', 17:10:15 INFO - 'populate-webroot', 17:10:15 INFO - 'create-virtualenv', 17:10:15 INFO - 'install', 17:10:15 INFO - 'run-tests'), 17:10:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:15 INFO - 'download_minidump_stackwalk': True, 17:10:15 INFO - 'download_symbols': 'ondemand', 17:10:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:15 INFO - 'installer_path': 'installer.exe', 17:10:15 INFO - 'log_level': 'info', 17:10:15 INFO - 'log_name': 'talos', 17:10:15 INFO - 'log_to_console': True, 17:10:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:15 INFO - 'opt_config_files': (), 17:10:15 INFO - 'pip_index': False, 17:10:15 INFO - 'sps_profile': False, 17:10:15 INFO - 'sps_profile_interval': 0, 17:10:15 INFO - 'suite': 'dromaeojs', 17:10:15 INFO - 'system_bits': '32', 17:10:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:15 INFO - 'title': 'talos-linux64-ix-047', 17:10:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:15 INFO - 'use_talos_json': True, 17:10:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:15 INFO - 'work_dir': 'build'} 17:10:15 INFO - ##### 17:10:15 INFO - ##### Running clobber step. 17:10:15 INFO - ##### 17:10:15 INFO - Running pre-action listener: _resource_record_pre_action 17:10:15 INFO - Running main action method: clobber 17:10:15 INFO - rmtree: /builds/slave/test/build 17:10:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:15 INFO - Running post-action listener: _resource_record_post_action 17:10:15 INFO - ##### 17:10:15 INFO - ##### Running read-buildbot-config step. 17:10:15 INFO - ##### 17:10:15 INFO - Running pre-action listener: _resource_record_pre_action 17:10:15 INFO - Running main action method: read_buildbot_config 17:10:15 INFO - Using buildbot properties: 17:10:15 INFO - { 17:10:15 INFO - "project": "", 17:10:15 INFO - "product": "firefox", 17:10:15 INFO - "script_repo_revision": "production", 17:10:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:10:15 INFO - "repository": "", 17:10:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:10:15 INFO - "buildid": "20160422143012", 17:10:15 INFO - "pgo_build": "True", 17:10:15 INFO - "basedir": "/builds/slave/test", 17:10:15 INFO - "buildnumber": 54, 17:10:15 INFO - "slavename": "talos-linux64-ix-047", 17:10:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:10:15 INFO - "platform": "ubuntu64_hw", 17:10:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:10:15 INFO - "branch": "fx-team", 17:10:15 INFO - "repo_path": "integration/fx-team", 17:10:15 INFO - "revision": "21c9846c176b04cda630cbccacaccc789a8c963b", 17:10:15 INFO - "stage_platform": "linux64-pgo", 17:10:15 INFO - "builduid": "515f4e07440c48688c69809bcd2dbec1", 17:10:15 INFO - "slavebuilddir": "test" 17:10:15 INFO - } 17:10:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:10:15 INFO - Running post-action listener: _resource_record_post_action 17:10:15 INFO - ##### 17:10:15 INFO - ##### Running download-and-extract step. 17:10:15 INFO - ##### 17:10:15 INFO - Running pre-action listener: _resource_record_pre_action 17:10:15 INFO - Running main action method: download_and_extract 17:10:15 INFO - mkdir: /builds/slave/test/build/tests 17:10: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')]} 17:10:15 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:10:21 INFO - Downloaded 1361 bytes. 17:10:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:21 INFO - Using the following test package requirements: 17:10:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:10:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'jsshell-linux-x86_64.zip'], 17:10:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:10:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:10:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:21 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:31 INFO - Downloaded 23857749 bytes. 17:10:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:32 INFO - Return code: 0 17:10:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:32 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:35 INFO - Downloaded 23857749 bytes. 17:10:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:36 INFO - Return code: 0 17:10:36 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')]} 17:10:36 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:37 INFO - Downloaded 10840145 bytes. 17:10:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:10:38 INFO - Return code: 0 17:10: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')]} 17:10:38 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:10:39 INFO - Downloaded 58349862 bytes. 17:10:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:39 INFO - mkdir: /builds/slave/test/properties 17:10:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:39 INFO - Contents: 17:10:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:40 INFO - Running post-action listener: _resource_record_post_action 17:10:40 INFO - Running post-action listener: set_extra_try_arguments 17:10:40 INFO - ##### 17:10:40 INFO - ##### Running populate-webroot step. 17:10:40 INFO - ##### 17:10:40 INFO - Running pre-action listener: _resource_record_pre_action 17:10:40 INFO - Running main action method: populate_webroot 17:10:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:40 INFO - '--tppagecycles', 17:10:40 INFO - '7'], 17:10:40 INFO - 'tests': ['tsvgm']}}, 17:10:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['damp', 'tps']}, 17:10:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'tests': ['damp', 'tps']}, 17:10:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['dromaeo_dom']}, 17:10:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['a11yr', 17:10:40 INFO - 'ts_paint', 17:10:40 INFO - 'tpaint', 17:10:40 INFO - 'sessionrestore', 17:10:40 INFO - 'sessionrestore_no_auto_restore', 17:10:40 INFO - 'tabpaint']}, 17:10:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['tsvgx', 17:10:40 INFO - 'tsvgr_opacity', 17:10:40 INFO - 'tart', 17:10:40 INFO - 'tscrollx', 17:10:40 INFO - 'cart']}, 17:10:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:40 INFO - 'tsvgr_opacity', 17:10:40 INFO - 'tart', 17:10:40 INFO - 'tscrollx', 17:10:40 INFO - 'cart']}, 17:10:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'talos_options': ['--disable-e10s'], 17:10:40 INFO - 'tests': ['tp5o']}, 17:10:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'tests': ['tp5o']}, 17:10:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'talos_options': ['--disable-e10s', 17:10:40 INFO - '--xperf_path', 17:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:40 INFO - 'tests': ['tp5n']}, 17:10:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:40 INFO - 'talos_options': ['--xperf_path', 17:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:40 INFO - 'tests': ['tp5n']}}, 17:10:40 INFO - 'talos.zip': {'path': '', 17:10:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:40 INFO - Running post-action listener: _resource_record_post_action 17:10:40 INFO - ##### 17:10:40 INFO - ##### Running create-virtualenv step. 17:10:40 INFO - ##### 17:10:40 INFO - Running pre-action listener: _resource_record_pre_action 17:10:40 INFO - Running main action method: create_virtualenv 17:10:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:40 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 17:10:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:40 INFO - Using real prefix '/usr' 17:10:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:43 INFO - Installing pip.................done. 17:10:43 INFO - Return code: 0 17:10:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:10:43 INFO - Using env: {'DISPLAY': ':0', 17:10:43 INFO - 'HOME': '/home/cltbld', 17:10:43 INFO - 'LANG': 'en_US.UTF-8', 17:10:43 INFO - 'LANGUAGE': 'en_US:en', 17:10:43 INFO - 'LOGNAME': 'cltbld', 17:10:43 INFO - 'MAIL': '/var/mail/cltbld', 17:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:43 INFO - 'MOZ_NO_REMOTE': '1', 17:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:43 INFO - 'NO_EM_RESTART': '1', 17:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:43 INFO - 'PWD': '/builds/slave/test', 17:10:43 INFO - 'SHELL': '/bin/bash', 17:10:43 INFO - 'SHLVL': '1', 17:10:43 INFO - 'TERM': 'linux', 17:10:43 INFO - 'TMOUT': '86400', 17:10:43 INFO - 'USER': 'cltbld', 17:10:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:43 INFO - '_': '/tools/buildbot/bin/python'} 17:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:10:43 INFO - Cleaning up... 17:10:43 INFO - Return code: 0 17:10:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:10:43 INFO - Using env: {'DISPLAY': ':0', 17:10:43 INFO - 'HOME': '/home/cltbld', 17:10:43 INFO - 'LANG': 'en_US.UTF-8', 17:10:43 INFO - 'LANGUAGE': 'en_US:en', 17:10:43 INFO - 'LOGNAME': 'cltbld', 17:10:43 INFO - 'MAIL': '/var/mail/cltbld', 17:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:43 INFO - 'MOZ_NO_REMOTE': '1', 17:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:43 INFO - 'NO_EM_RESTART': '1', 17:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:43 INFO - 'PWD': '/builds/slave/test', 17:10:43 INFO - 'SHELL': '/bin/bash', 17:10:43 INFO - 'SHLVL': '1', 17:10:43 INFO - 'TERM': 'linux', 17:10:43 INFO - 'TMOUT': '86400', 17:10:43 INFO - 'USER': 'cltbld', 17:10:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:43 INFO - '_': '/tools/buildbot/bin/python'} 17:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:43 INFO - Downloading/unpacking psutil>=0.7.1 17:10:43 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 17:10:43 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 17:10:43 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 17:10:43 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 17:10:43 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 17:10:43 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 17:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:45 INFO - Installing collected packages: psutil 17:10:45 INFO - Running setup.py install for psutil 17:10:45 INFO - building 'psutil._psutil_linux' extension 17:10:45 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 17:10:45 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 17:10:46 INFO - building 'psutil._psutil_posix' extension 17:10:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:10:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:46 INFO - Successfully installed psutil 17:10:46 INFO - Cleaning up... 17:10:46 INFO - Return code: 0 17:10:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:10:46 INFO - Using env: {'DISPLAY': ':0', 17:10:46 INFO - 'HOME': '/home/cltbld', 17:10:46 INFO - 'LANG': 'en_US.UTF-8', 17:10:46 INFO - 'LANGUAGE': 'en_US:en', 17:10:46 INFO - 'LOGNAME': 'cltbld', 17:10:46 INFO - 'MAIL': '/var/mail/cltbld', 17:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:46 INFO - 'MOZ_NO_REMOTE': '1', 17:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:46 INFO - 'NO_EM_RESTART': '1', 17:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:46 INFO - 'PWD': '/builds/slave/test', 17:10:46 INFO - 'SHELL': '/bin/bash', 17:10:46 INFO - 'SHLVL': '1', 17:10:46 INFO - 'TERM': 'linux', 17:10:46 INFO - 'TMOUT': '86400', 17:10:46 INFO - 'USER': 'cltbld', 17:10:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:46 INFO - '_': '/tools/buildbot/bin/python'} 17:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:48 INFO - Installing collected packages: mozsystemmonitor 17:10:48 INFO - Running setup.py install for mozsystemmonitor 17:10:48 INFO - Successfully installed mozsystemmonitor 17:10:48 INFO - Cleaning up... 17:10:48 INFO - Return code: 0 17:10:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:48 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')]} 17:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:48 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')]} 17:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:48 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 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:48 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 17:10:48 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 17:10:48 INFO - Using env: {'DISPLAY': ':0', 17:10:48 INFO - 'HOME': '/home/cltbld', 17:10:48 INFO - 'LANG': 'en_US.UTF-8', 17:10:48 INFO - 'LANGUAGE': 'en_US:en', 17:10:48 INFO - 'LOGNAME': 'cltbld', 17:10:48 INFO - 'MAIL': '/var/mail/cltbld', 17:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:48 INFO - 'MOZ_NO_REMOTE': '1', 17:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:48 INFO - 'NO_EM_RESTART': '1', 17:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:48 INFO - 'PWD': '/builds/slave/test', 17:10:48 INFO - 'SHELL': '/bin/bash', 17:10:48 INFO - 'SHLVL': '1', 17:10:48 INFO - 'TERM': 'linux', 17:10:48 INFO - 'TMOUT': '86400', 17:10:48 INFO - 'USER': 'cltbld', 17:10:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:48 INFO - '_': '/tools/buildbot/bin/python'} 17:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:48 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 17:10:48 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 17:10:48 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 17:10:48 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 17:10:48 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 17:10:48 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 17:10:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - Downloading docopt-0.6.1.tar.gz 17:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:51 INFO - Running setup.py install for blobuploader 17:10:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:51 INFO - Running setup.py install for requests 17:10:51 INFO - Running setup.py install for docopt 17:10:51 INFO - Successfully installed blobuploader requests docopt 17:10:51 INFO - Cleaning up... 17:10:52 INFO - Return code: 0 17:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:52 INFO - Using env: {'DISPLAY': ':0', 17:10:52 INFO - 'HOME': '/home/cltbld', 17:10:52 INFO - 'LANG': 'en_US.UTF-8', 17:10:52 INFO - 'LANGUAGE': 'en_US:en', 17:10:52 INFO - 'LOGNAME': 'cltbld', 17:10:52 INFO - 'MAIL': '/var/mail/cltbld', 17:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:52 INFO - 'MOZ_NO_REMOTE': '1', 17:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:52 INFO - 'NO_EM_RESTART': '1', 17:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:52 INFO - 'PWD': '/builds/slave/test', 17:10:52 INFO - 'SHELL': '/bin/bash', 17:10:52 INFO - 'SHLVL': '1', 17:10:52 INFO - 'TERM': 'linux', 17:10:52 INFO - 'TMOUT': '86400', 17:10:52 INFO - 'USER': 'cltbld', 17:10:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:52 INFO - '_': '/tools/buildbot/bin/python'} 17:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:52 INFO - Running setup.py (path:/tmp/pip-RrwFHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:52 INFO - Running setup.py (path:/tmp/pip-Q4X8wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:52 INFO - Running setup.py (path:/tmp/pip-r3lsxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:52 INFO - Running setup.py (path:/tmp/pip-jQqKs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:52 INFO - Running setup.py (path:/tmp/pip-5ut9L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:52 INFO - Running setup.py (path:/tmp/pip-km5Hdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:52 INFO - Running setup.py (path:/tmp/pip-aoWiwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:52 INFO - Running setup.py (path:/tmp/pip-aJ1Lh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:52 INFO - Running setup.py (path:/tmp/pip-52zjkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:52 INFO - Running setup.py (path:/tmp/pip-A9Z83N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:52 INFO - Running setup.py (path:/tmp/pip-JEX7kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:53 INFO - Running setup.py (path:/tmp/pip-FvhuJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:53 INFO - Running setup.py (path:/tmp/pip-myTog2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:53 INFO - Running setup.py (path:/tmp/pip-l1J2vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:53 INFO - Running setup.py (path:/tmp/pip-i6UvdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:53 INFO - Running setup.py (path:/tmp/pip-UbhRPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:53 INFO - Running setup.py (path:/tmp/pip-Az0kJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:53 INFO - Running setup.py install for manifestparser 17:10:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:53 INFO - Running setup.py install for mozcrash 17:10:53 INFO - Running setup.py install for mozdebug 17:10:53 INFO - Running setup.py install for mozdevice 17:10:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:53 INFO - Running setup.py install for mozfile 17:10:53 INFO - Running setup.py install for mozhttpd 17:10:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozinfo 17:10:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozInstall 17:10:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozleak 17:10:54 INFO - Running setup.py install for mozlog 17:10:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for moznetwork 17:10:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozprocess 17:10:54 INFO - Running setup.py install for mozprofile 17:10:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozrunner 17:10:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Running setup.py install for mozscreenshot 17:10:55 INFO - Running setup.py install for moztest 17:10:55 INFO - Running setup.py install for mozversion 17:10:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:55 INFO - Cleaning up... 17:10:55 INFO - Return code: 0 17:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:55 INFO - Using env: {'DISPLAY': ':0', 17:10:55 INFO - 'HOME': '/home/cltbld', 17:10:55 INFO - 'LANG': 'en_US.UTF-8', 17:10:55 INFO - 'LANGUAGE': 'en_US:en', 17:10:55 INFO - 'LOGNAME': 'cltbld', 17:10:55 INFO - 'MAIL': '/var/mail/cltbld', 17:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:55 INFO - 'MOZ_NO_REMOTE': '1', 17:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:55 INFO - 'NO_EM_RESTART': '1', 17:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:55 INFO - 'PWD': '/builds/slave/test', 17:10:55 INFO - 'SHELL': '/bin/bash', 17:10:55 INFO - 'SHLVL': '1', 17:10:55 INFO - 'TERM': 'linux', 17:10:55 INFO - 'TMOUT': '86400', 17:10:55 INFO - 'USER': 'cltbld', 17:10:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:55 INFO - '_': '/tools/buildbot/bin/python'} 17:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:55 INFO - Running setup.py (path:/tmp/pip-qeu1aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:55 INFO - Running setup.py (path:/tmp/pip-9LgVHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:55 INFO - Running setup.py (path:/tmp/pip-8s5NPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:55 INFO - Running setup.py (path:/tmp/pip-lJRI5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:55 INFO - Running setup.py (path:/tmp/pip-hHs4xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:55 INFO - Running setup.py (path:/tmp/pip-ckwyWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:55 INFO - Running setup.py (path:/tmp/pip-FFU7nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:55 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)) 17:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:55 INFO - Running setup.py (path:/tmp/pip-XOgFL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:56 INFO - Running setup.py (path:/tmp/pip-JRr_Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:56 INFO - Running setup.py (path:/tmp/pip-sCiuSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:56 INFO - Running setup.py (path:/tmp/pip-Vq_6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:56 INFO - Running setup.py (path:/tmp/pip-u0TyQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:56 INFO - Running setup.py (path:/tmp/pip-q3_rx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:56 INFO - Running setup.py (path:/tmp/pip-a8ZSqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:56 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)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:56 INFO - Running setup.py (path:/tmp/pip-o3H7At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:56 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)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:56 INFO - Running setup.py (path:/tmp/pip-ajQYAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:56 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)) 17:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:56 INFO - Running setup.py (path:/tmp/pip-1Cngbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:56 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)) 17:10:56 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)) 17:10:56 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)) 17:10:56 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)) 17:10:56 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)) 17:10:56 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)) 17:10:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:56 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 17:10:56 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 17:10:56 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 17:10:56 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 17:10:56 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 17:10:56 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 17:10:58 INFO - Downloading blessings-1.6.tar.gz 17:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:58 INFO - Installing collected packages: blessings 17:10:58 INFO - Running setup.py install for blessings 17:10:58 INFO - Successfully installed blessings 17:10:58 INFO - Cleaning up... 17:10:58 INFO - Return code: 0 17:10:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:59 INFO - Reading from file tmpfile_stdout 17:10:59 INFO - Current package versions: 17:10:59 INFO - argparse == 1.2.1 17:10:59 INFO - blessings == 1.6 17:10:59 INFO - blobuploader == 1.2.4 17:10:59 INFO - docopt == 0.6.1 17:10:59 INFO - manifestparser == 1.1 17:10:59 INFO - mozInstall == 1.12 17:10:59 INFO - mozcrash == 0.17 17:10:59 INFO - mozdebug == 0.1 17:10:59 INFO - mozdevice == 0.48 17:10:59 INFO - mozfile == 1.2 17:10:59 INFO - mozhttpd == 0.7 17:10:59 INFO - mozinfo == 0.9 17:10:59 INFO - mozleak == 0.1 17:10:59 INFO - mozlog == 3.1 17:10:59 INFO - moznetwork == 0.27 17:10:59 INFO - mozprocess == 0.22 17:10:59 INFO - mozprofile == 0.28 17:10:59 INFO - mozrunner == 6.11 17:10:59 INFO - mozscreenshot == 0.1 17:10:59 INFO - mozsystemmonitor == 0.0 17:10:59 INFO - moztest == 0.7 17:10:59 INFO - mozversion == 1.4 17:10:59 INFO - psutil == 3.1.1 17:10:59 INFO - requests == 1.2.3 17:10:59 INFO - wsgiref == 0.1.2 17:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:59 INFO - Using env: {'DISPLAY': ':0', 17:10:59 INFO - 'HOME': '/home/cltbld', 17:10:59 INFO - 'LANG': 'en_US.UTF-8', 17:10:59 INFO - 'LANGUAGE': 'en_US:en', 17:10:59 INFO - 'LOGNAME': 'cltbld', 17:10:59 INFO - 'MAIL': '/var/mail/cltbld', 17:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:59 INFO - 'MOZ_NO_REMOTE': '1', 17:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:59 INFO - 'NO_EM_RESTART': '1', 17:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:59 INFO - 'PWD': '/builds/slave/test', 17:10:59 INFO - 'SHELL': '/bin/bash', 17:10:59 INFO - 'SHLVL': '1', 17:10:59 INFO - 'TERM': 'linux', 17:10:59 INFO - 'TMOUT': '86400', 17:10:59 INFO - 'USER': 'cltbld', 17:10:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:59 INFO - '_': '/tools/buildbot/bin/python'} 17:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:59 INFO - Cleaning up... 17:10:59 INFO - Return code: 0 17:10:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:59 INFO - Using env: {'DISPLAY': ':0', 17:10:59 INFO - 'HOME': '/home/cltbld', 17:10:59 INFO - 'LANG': 'en_US.UTF-8', 17:10:59 INFO - 'LANGUAGE': 'en_US:en', 17:10:59 INFO - 'LOGNAME': 'cltbld', 17:10:59 INFO - 'MAIL': '/var/mail/cltbld', 17:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:59 INFO - 'MOZ_NO_REMOTE': '1', 17:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:59 INFO - 'NO_EM_RESTART': '1', 17:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:59 INFO - 'PWD': '/builds/slave/test', 17:10:59 INFO - 'SHELL': '/bin/bash', 17:10:59 INFO - 'SHLVL': '1', 17:10:59 INFO - 'TERM': 'linux', 17:10:59 INFO - 'TMOUT': '86400', 17:10:59 INFO - 'USER': 'cltbld', 17:10:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:59 INFO - '_': '/tools/buildbot/bin/python'} 17:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:59 INFO - Downloading/unpacking jsonschema 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:11:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:01 INFO - Downloading/unpacking functools32 (from jsonschema) 17:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:01 INFO - warning: no files found matching '*.txt' 17:11:01 INFO - no previously-included directories found matching 'build' 17:11:01 INFO - no previously-included directories found matching 'dist' 17:11:01 INFO - no previously-included directories found matching '.git*' 17:11:01 INFO - Installing collected packages: jsonschema, functools32 17:11:01 INFO - Running setup.py install for functools32 17:11:01 INFO - warning: no files found matching '*.txt' 17:11:01 INFO - no previously-included directories found matching 'build' 17:11:01 INFO - no previously-included directories found matching 'dist' 17:11:01 INFO - no previously-included directories found matching '.git*' 17:11:01 INFO - Successfully installed jsonschema functools32 17:11:01 INFO - Cleaning up... 17:11:01 INFO - Return code: 0 17:11:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:11:01 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')]} 17:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:01 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')]} 17:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:01 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 0x7f29a6184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d89a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', '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 17:11:01 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 17:11:01 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 17:11:01 INFO - Using env: {'DISPLAY': ':0', 17:11:01 INFO - 'HOME': '/home/cltbld', 17:11:01 INFO - 'LANG': 'en_US.UTF-8', 17:11:01 INFO - 'LANGUAGE': 'en_US:en', 17:11:01 INFO - 'LOGNAME': 'cltbld', 17:11:01 INFO - 'MAIL': '/var/mail/cltbld', 17:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:01 INFO - 'MOZ_NO_REMOTE': '1', 17:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:01 INFO - 'NO_EM_RESTART': '1', 17:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:01 INFO - 'PWD': '/builds/slave/test', 17:11:01 INFO - 'SHELL': '/bin/bash', 17:11:01 INFO - 'SHLVL': '1', 17:11:01 INFO - 'TERM': 'linux', 17:11:01 INFO - 'TMOUT': '86400', 17:11:01 INFO - 'USER': 'cltbld', 17:11:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:01 INFO - '_': '/tools/buildbot/bin/python'} 17:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:02 INFO - Downloading/unpacking flake8 17:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:11:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:11:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:04 INFO - no previously-included directories found matching 'docs/_build' 17:11:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:11:04 INFO - Running setup.py install for pep8 17:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:04 INFO - no previously-included directories found matching 'docs/_build' 17:11:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:11:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:11:04 INFO - Cleaning up... 17:11:04 INFO - Return code: 0 17:11:04 INFO - Running post-action listener: _resource_record_post_action 17:11:04 INFO - Running post-action listener: _start_resource_monitoring 17:11:04 INFO - Starting resource monitoring. 17:11:04 INFO - ##### 17:11:04 INFO - ##### Running install step. 17:11:04 INFO - ##### 17:11:04 INFO - Running pre-action listener: _resource_record_pre_action 17:11:04 INFO - Running main action method: install 17:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:05 INFO - Reading from file tmpfile_stdout 17:11:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:05 INFO - Reading from file tmpfile_stdout 17:11:05 INFO - Output received: 17:11:05 INFO - Usage: mozinstall [options] installer 17:11:05 INFO - Options: 17:11:05 INFO - -h, --help show this help message and exit 17:11:05 INFO - -d DEST, --destination=DEST 17:11:05 INFO - Directory to install application into. [default: 17:11:05 INFO - "/builds/slave/test"] 17:11:05 INFO - --app=APP Application being installed. [default: firefox] 17:11:05 INFO - mkdir: /builds/slave/test/build/application 17:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:11:21 INFO - Reading from file tmpfile_stdout 17:11:21 INFO - Output received: 17:11:21 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:21 INFO - Running post-action listener: _resource_record_post_action 17:11:21 INFO - ##### 17:11:21 INFO - ##### Running run-tests step. 17:11:21 INFO - ##### 17:11:21 INFO - Running pre-action listener: _resource_record_pre_action 17:11:21 INFO - Running main action method: run_tests 17:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:21 INFO - Python 2.7.3 17:11:21 INFO - Return code: 0 17:11:21 INFO - grabbing minidump binary from tooltool 17:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:21 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 0x1267810>, '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 0x1268710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1268ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:21 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 17:11:21 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 17:11:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:21 INFO - Return code: 0 17:11:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:11:22 INFO - Return code: 0 17:11:22 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/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:11:22 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/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 17:11:22 INFO - Using env: {'DISPLAY': ':0', 17:11:22 INFO - 'HOME': '/home/cltbld', 17:11:22 INFO - 'LANG': 'en_US.UTF-8', 17:11:22 INFO - 'LANGUAGE': 'en_US:en', 17:11:22 INFO - 'LOGNAME': 'cltbld', 17:11:22 INFO - 'MAIL': '/var/mail/cltbld', 17:11:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:22 INFO - 'MOZ_NO_REMOTE': '1', 17:11:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:22 INFO - 'NO_EM_RESTART': '1', 17:11:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:22 INFO - 'PWD': '/builds/slave/test', 17:11:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:22 INFO - 'SHELL': '/bin/bash', 17:11:22 INFO - 'SHLVL': '1', 17:11:22 INFO - 'TERM': 'linux', 17:11:22 INFO - 'TMOUT': '86400', 17:11:22 INFO - 'USER': 'cltbld', 17:11:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837', 17:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:22 INFO - '_': '/tools/buildbot/bin/python'} 17:11:22 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/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 17:11:22 INFO - mozversion application_buildid: 20160422143012 17:11:22 INFO - mozversion application_changeset: 21c9846c176b04cda630cbccacaccc789a8c963b 17:11:22 INFO - mozversion application_display_name: Nightly 17:11:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:22 INFO - mozversion application_name: Firefox 17:11:22 INFO - mozversion application_remotingname: firefox 17:11:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:11:22 INFO - mozversion application_vendor: Mozilla 17:11:22 INFO - mozversion application_version: 48.0a1 17:11:22 INFO - mozversion platform_buildid: 20160422143012 17:11:22 INFO - mozversion platform_changeset: 21c9846c176b04cda630cbccacaccc789a8c963b 17:11:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:11:22 INFO - mozversion platform_version: 48.0a1 17:11:22 INFO - using testdate: 1461370282 17:11:22 INFO - actual date: 1461370282 17:11:22 INFO - starting webserver on 'localhost:41923' 17:11:22 INFO - SUITE-START | Running 2 tests 17:11:22 INFO - TEST-START | dromaeo_css 17:11:22 INFO - operating with platform_type : linux_ 17:11:22 INFO - Initialising browser for dromaeo_css test... 17:11:22 INFO - TEST-INFO | started process 17110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKy9fi/profile http://localhost:41923/getInfo.html) 17:11:27 INFO - PROCESS | 17110 | __metrics Screen width/height:1600/1200 17:11:27 INFO - PROCESS | 17110 | colorDepth:24 17:11:27 INFO - PROCESS | 17110 | Browser inner width/height: 1024/697 17:11:27 INFO - PROCESS | 17110 | __metrics 17:11:28 ERROR - PROCESS | 17110 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:11:28 INFO - TEST-INFO | 17110: exit 0 17:11:28 INFO - Browser initialized. 17:11:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:28 INFO - TEST-INFO | started process 17192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKy9fi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:40 INFO - PROCESS | 17192 | RSS: Main: 153251840 17:11:40 INFO - PROCESS | 17192 | 17:12:31 INFO - PROCESS | 17192 | 1461370351702 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] 17:14:39 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41923/tests/dromaeo/cssquery-ext.html) 17:14:40 INFO - PROCESS | 17192 | RSS: Main: 259047424 17:14:40 INFO - PROCESS | 17192 | 17:17:42 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-ext.html (next: http://localhost:41923/tests/dromaeo/cssquery-jquery.html) 17:17:43 INFO - PROCESS | 17192 | RSS: Main: 235429888 17:17:43 INFO - PROCESS | 17192 | 17:20:45 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41923/tests/dromaeo/cssquery-mootools.html) 17:20:45 INFO - PROCESS | 17192 | RSS: Main: 241094656 17:20:45 INFO - PROCESS | 17192 | 17:23:47 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41923/tests/dromaeo/cssquery-prototype.html) 17:23:48 INFO - PROCESS | 17192 | RSS: Main: 230834176 17:23:48 INFO - PROCESS | 17192 | 17:26:50 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41923/tests/dromaeo/cssquery-yui.html) 17:26:51 INFO - PROCESS | 17192 | RSS: Main: 222818304 17:26:51 INFO - PROCESS | 17192 | 17:29:53 INFO - PROCESS | 17192 | Cycle 1(1): loaded http://localhost:41923/tests/dromaeo/cssquery-yui.html (next: http://localhost:41923/tests/dromaeo/cssquery-dojo.html) 17:29:54 INFO - PROCESS | 17192 | RSS: Main: 282181632 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | __start_tp_report 17:29:54 INFO - PROCESS | 17192 | _x_x_mozilla_page_load 17:29:54 INFO - PROCESS | 17192 | _x_x_mozilla_page_load_details 17:29:54 INFO - PROCESS | 17192 | |i|pagename|runs| 17:29:54 INFO - PROCESS | 17192 | |0;dojo.html;3112.79766815157;3116.9844150779245;3156.1320636824885;3164.224764932592;3191.936161276774;5207.531322181007;5226.6863988160685;5230.790768369266;5265.921011184826;5343.946560534394;5352.063388906936;5381.623286369956;5413.593980451462;5431.945680543194;5460.645058071223;4798.328234047245;4818.156822556056;4823.20417131173;4830.058138662962;4930.580900623451;4928.5564299213065;4950.975245123769;4977.950220497803;4992.725400102993;5005.049040682259;4760.666753327286;4777.856664300077;4834.419869615669;4850.199717046718;4888.926666100011;4842.370491836074;4854.708717476928;4855.951440485585;4862.805487780484;4893.828715994923;4708.788104535304;4823.397075365579;4829.830955916561;4838.346823178861;4872.3422337984275;5306.70813105279;5311.575073994071;5312.070387682179;5328.653637513549;5381.67709937405;5675.886482270332;5686.3744988051285;5687.744051517691;5692.829215123553;5698.487136157766;5613.578981576398;5727.627704199213;5730.512906402961;5731.856703582402;5764.971175144139;5352.464753524617;5353.2237825515085;5358.866028349284;5361.035013697572;5362.624616276862;5813.040848260074;5821.592488525763;5823.70881455934;5827.475527202572;5828.6211396259105;5496.065668836308;5577.386487486373;5626.324841019104;5727.112297593796;5739.139129130664;5699.373068962411;5732.197492351074;5735.082386818089;5746.913796293059;5750.223719797774;5681.289838770153;5712.143178523172;5715.571332150105;5716.79991200306;5718.7426565804635;5627.465390787868;5677.318721753416;5719.942800572025;5723.427657234243;5747.5114615257335;4268.509121451011;4268.786560671954;4268.829246830154;4273.615374616299;4299.97850010748;3821.3503704370323;3834.271488417192;3837.846486140579;3878.5733569307354;3879.650831425185;5273.789048438096;5314.2825718528275;5322.36131664195;5358.035553600389;5373.38206106295;5711.6858572778065;5726.062995653951;5742.397048309867;5746.540276777848;5761.049426844607;5331.973340133352;5395.81114660985;5405.351357837085;5431.5926305526455;5473.7263136843;4875.609951203895;4894.412670479565;4900.852974410774;4933.309336692866;4951.628627852853;5883.882322353529;5906.818636272763;5907.4683278505145;5915.822525324247;5928.822135335947;5532.391436942014;5689.118186681071;5698.800541981011;5761.769529218868;5762.279715035621;5917.3490915998345;5918.378570250062;5918.526517878646;5926.081457374114;5928.881422371443;5603.887922241451;5615.2700148980375;5616.8876622466505;5621.213030175697;5635.915461268166;5597.244372009726;5647.463490968352;5730.398308177581;5743.62666426681;5753.079507278815;5631.324241091095;5631.380548139783;5633.267675202197;5635.774569017193;5636.5208957237455;5571.637843540157;5614.410486898817;5630.8029218977135;5633.295838020247;5643.915341269966;5360.0887849064975;5480.808171713971;5535.363433205233;5570.470805273492;5584.581156413204;5597.44025597437;5622.7750889963945;5635.15472679085;5647.068233741551;5647.785726068915;5299.284596579412;5497.340319161726;5512;5512.586556008235;5518.144687573433 17:29:54 INFO - PROCESS | 17192 | |1;ext.html;611.5352332227509;626.6052386996192;662.013599736393;662.0235153149102;682.9112215411999;30506;31158.844205778994;31196.688033119663;31205.687943120563;36988;39717.205655886864;40169;40283.79858100705;40332;40375;8530.019047809488;8718.041015488323;8739.868901966443;8743.256823170039;8747.825043499126;8784.07767184446;8914.777130571723;8922.955385223066;8925.46447213166;8926.285897128215;8932.374733768638;8969.416987895765;8984.326175536828;8989.820203595924;8997.95501022494;8841.115888411172;8882;8906.910930890674;8908.331875109328;8912.197902188802;8653.913460865373;8695.130486951317;8763.12368763125;8770.035296117421;8775.034746177915;40564.79717601393;41174;41201.381979270336;41209;41339.7933010333;3465.740069494773;3745.8501659933568;3916.490856188706;4086.223617512663;4125.443065186221;31352;31391.529127063113;31464.528032079535;31597;33077.17307067318;4282.379055037033;4293.720908140961;4321.351797230409;4348.782560871975;4370.541093185201;313058;315672;316382;317695;320015.39992300124;51572.22641660378;56657;56821;56873;57080;60833.391666083655;62844;62928.37071629317;62938.37061629417;62978.68510657417;14847.851521484647;14991.475298364505;15097.698046039017;15104;15126.168060756543;11160.218784685156;11376.374299413446;11481.655550333337;11502.367369794574;11579.363135027654;18136.546586335448;18662.440126796217;18741.25034998612;18801.529961751065;18918;6461.967690161613;6728.596284222962;6768.357006084414;6781.8643627127185;6813.705395974749;1038.8909164537615;1044.065561322612;1089.199438412766;1140.4468832616174;1212.9818052729215;32063;32234;32551.18622034468;33180;33331.333373332396;1102;1209.0206932384797;1213.308414203913;1236.2273579013117;1244.5830646733264;17039.233234504478;17467.213975371138;17480.5629859252;17483.56291092733;17523.56191095233;465189;468421;469439;471035;471787;57404.71297643485;57965.42034579685;58027;58081.4191858076;58272.4172758267;1350.1426594112809;1392.7632302508598;1392.78411846164;1398.1331574423923;1399.1744870526236;30700;31935.36129277448;32035.199120021254;32101.839490802395;32298.35403291968;50983.745081274355;51452.22821657603;51535.742321288155;51560.22659660183;51588.74205628948;434129;438528.14718527894;441905;442516;445330;36375;41387;42340.78829605832;43208.35187472253;44109.33835992398;43521.34717979296;44168.55831441644;44548.331775024046;44634.55365446304;45254.773726131156;38662.80668596639;39335;39402.2119557613;39499.2100158001;40842.591574083875;37790.43314350232;38776.80611596924;39151;39215.60784392119;39543.80228098841;39921.60078399179;40115.59884401118;43236.35145472758;44711.55288447074;45032.099358013314;32762.672373275964;34798.82600586981;35383.292334152655;35723;35760.463593045606;26997.46005079848;27237.45525089527;27879.581806273327;28589.571156432256;29740.405191896472 17:29:54 INFO - PROCESS | 17192 | |2;jquery.html;389.26623315051154;391.410926555534;393.9015246188455;401.41994817488734;404.187582958254;14532.491362802304;15489;16810.91594542027;17830.286788528458;17877.731834022485;17630.735538966892;18304.450866473995;18541.90729046353;18829.43511694648;19360.70958935617;5542.695151766651;5656.886862262752;5694.77220911163;5719.084946408576;5719.513841323493;4029.1135950090934;5522.5581953443825;5637.3235211774645;5868.76524939002;6168.4448399644025;6072.453479186872;6096;6120.908186377208;6123.448889599935;6125.264968203799;5179.715115668637;5492.917606235909;5507.807226747084;5515.889682206373;6085.208922840046;5335.306410166692;5341.946580534222;5365.731713414314;5382.461753824626;5386;12863.356832158355;13733.793993090112;13736.93131534336;13740.450381984709;13755.31223438824;2171.86968781872;2272.943176420603;2295.885205739706;2379.2267513058327;2472.70407781891;9808.95095524525;9952.154066904322;10080.344777589507;11816.877396647305;13559.186448813005;1900.961980760377;1953.6288105260098;1963.5385684364162;1985.0769392232537;2003.4390370696228;77439;82167;82744.58627706883;83604;85091;9945.20438364929;10190.796184076276;10268.383896966207;10442.00800923911;10670.839937400946;13691.589252322447;14011;14046.578602641937;14113.506027288995;14149.08030977983;6983.82540436483;7224.963875180695;7238.963805181046;7312.0128782613665;7322.780316590511;6867.965660171767;6898.793036208821;6979.546329488669;7009.894851577231;7030.3321184487395;4257.10600773841;4312.827486900489;4350.695451318441;4353.564643535685;4413.205622987893;1780.3501721871683;1826.7442558041885;1827.524843540689;1829.0671757403554;1834.6055598046216;453.8524979381648;459.2903963376591;996.5067291690659;1008.2538921198407;1112.7663190730038;11122.22144449897;11263.26788758728;11404.258723182966;11471.483783229607;11579;434.12307139577877;445.465441470237;449.2475104200451;449.6784798868824;466.5754163711007;6043.576949613573;6090.969545152246;6098.664573448503;6197.25632924043;6212.192414986113;455577;465089;465997;467865;470070;95800;97120.51439742897;97316;97684;98443.50778246063;477.6012029954957;480.06387544288077;482.3343785575883;483.4367961325017;485.7085748550912;10335;10420.583176673152;16044.197790110682;16895.83104168992;17699.646007080042;37385.626143739304;38037.42943855789;38631.6136838628;39463;40396.1920761589;47795.52204477911;53976.19035714389;54129.188062179885;54545.72727136339;54757.72621136869;7823.413244006836;7937.232185367375;8020.719274825353;8082.35341172693;8137.308328791883;12811.423485942969;13140.802887956497;13153.671158220739;13250.138740981805;13283.867161328262;11592.826107608224;11704.356260405759;11730.70673233176;11767.588134415255;11998.880011200126;11266;11418.600348987746;11613;11931.701707457383;12085.577004805142;11761.764764704487;11820.40897955116;12217.69455763613;12289.446974885972;12415.689607759517;7838.412119090977;7951.840963180588;8077;8126.593670316579;8312.792180195544;10916.448107905582;11667.6499705009;11874;11925.82111268349;12071.215371000857 17:29:54 INFO - PROCESS | 17192 | |3;mootools.html;1301.4101937145072;1476.033198255143;1491.5450787509808;1652.8347165283474;1823.2433540080867;7723.304902558769;7960.9601951990235;7997.760067197979;8002.919970800291;8014.759557213279;8014.519128852273;8216.507009579429;8227.382946279024;8242;8252.092269850311;1959.7648282206155;2231.9107235710635;2284.5316710074435;2303.7674843958484;2307.1463558483383;2284.189112864934;2295.9081636734595;2303.7005189325446;2304.7119110111234;2304.83866129371;2204.6252137136726;2215.9889200553976;2228.2980861028805;2235.0724449353497;2236.9776302236933;1891.300218918995;2125.829933605308;2191.6822060801255;2200.933971980843;2203.8016578508013;2269.2851751698163;2285.9657105143438;2303.5968705476644;2304.4238940264936;2307.48081681622;8176.550289734062;8331.750047498585;8341.04078031022;8355.456895301786;8363.874541881876;4810.95189048112;4980.352554167935;4991.800327986876;5005.774740136702;5006.123928312567;3214.983925080383;3233.9353212935844;3276.918077048069;3307.8015319080932;3316.5522654441584;1000.5897581991348;1015.162490944966;1016.9949150254275;1023.1405619279766;1031.587365053977;10891.67324980252;10926.726831829188;10958.397288149148;10984.340939543654;11009.394483303415;4222.535521092677;4300;4360.193364227628;4479.955200448019;4511.097780443859;9537.284703647254;9562.713118606453;9584.233261339075;9651.758706032406;9672.468014259142;4890.633202509826;4901.166801643658;4908.214685650279;4918.5819205367225;4929.309896614477;4228.6617070634275;4612.169809434267;4735.313379560013;4754.78603462845;4767.475577686451;3785.9242815143543;3802.7147963902817;3884.1454879926373;3917.138229589486;3917.6865850731874;1195.2290772451893;1229.8968763414662;1232.4577186038293;1233.1552886272932;1236.8082947143207;876.4565969099199;941.6374695742188;983.2772911909741;996.3623281100101;1020.0564477857952;5666.2350582670815;5876.764929402776;5897.262842144732;5967.8439930446675;6077.787277445356;893.6425429828121;920.1442658327819;964.0985678390728;967.3808762392075;1018.5518371916334;4132.772697501667;4226.936595951063;4234.55537168599;4239.1521695660995;4245.97877010613;10039.096481316716;10167.593296268067;10179.796404071878;10284.177265818716;10347.63783267582;10050.396976181453;10059.144972677259;10094.394336339696;10107.039831216023;10121.089101980857;7293.927060729431;7664.770056898302;7669.386449083949;7693.230676932374;7832.804179895548;5797.681127537857;5839.503642190291;5903.173555702119;5955.821325360246;6030.216071910623;9246.907530924873;9457.621695132118;9487.762805929908;9491.193248573949;9541.141297283279;9125.77185570366;9559;9656.662016829378;9663.323567350499;9753;7279.199288078201;7363.15323737777;7388.704451821867;7398.408127349691;7410.777676669709;8152.347812174893;8162.142974987541;8184.713535026245;8189.058258300372;8220;7347.7795666130105;7513.39892808563;7531.284527969834;7577.242275772379;7596.898449724869;7321.487495875451;7326.487145899736;7403.555786652602;7468.925310746823;7497.850042999;6695.966520167368;6745.93254067453;6763.797086087426;6766.830829229112;6776.593404395752;5071.644984851025;5179.430262671179;5224.52979231871;5309.893802124013;5324.973375133254;5084.186530155157;5194.610404219623;5205.609579281493;5333;5357.464253574612 17:29:54 INFO - PROCESS | 17192 | |4;prototype.html;327.3975884372754;328.8129851237034;337.8479684142136;340.77679120176276;343.35620711166564;5647.435256474356;5657.547396208303;5716;5721.656700597967;5726.713664316789;5600.327960644729;5645.745941432635;5647.774089036444;5648.293963254593;5657.9434205657935;4158.937615935756;4178.540360560336;4315.201687687788;4357.716748411359;4379.1022840317655;4378.299472084467;4380.299152135659;4398.076403955173;4399.296112621981;4404.735715857043;4158.313878210091;4374.934375984347;4386.495553011397;4391.9121617567625;4392.97803510982;4031.8387264509383;4297.247981603223;4348.21732088224;4348.239058164809;4354.9765805035795;3809.314323421783;3814.5231846019246;3817.351050321452;3820.465134881119;3838.7888666123354;5375.193720941851;5476.890462190774;5478.150886612581;5513.09034009388;5537.612367134302;4990.426100998396;5035.169197082477;5058.4688607696025;5065.809534759365;5066.46802085783;5930.881382372371;5957.642541447527;5985.940140598582;6006.699665016732;6022.5181985441495;4145.191687620915;4194.6853985951175;4272.077565095719;4273.423087883127;4288.33530802723;6221.813345599639;6226;6249.593776404519;6253.9999999999545;6255.499560035232;4313.827446902089;4341.196878577473;4345.283028300359;4345.34819777036;4358.193734159191;4235.4917409910395;4336.544662810423;4370.912581748347;4376.234159022159;4383.583559561836;5056.873578160576;5067.467915868854;5069.873253168626;5070.61970352225;5072.949270507322;5954.285485741739;5963.671998040063;5981;5990.6705131218205;6028.758849645965;1393.8048673185763;1465.7947887295786;1524.4969160177116;1539.9769003464958;1550.2326348457361;941.7316064921464;946.9384490008127;969.3602222533094;982.8230918434607;986.1075726467558;5701;5701.515371193495;5718.571107166979;5736.42635736423;5752.712364381848;6070.6357618543025;6085.421884920926;6096.268447786205;6096.786612468631;6119.867824452491;5581.804636837691;5674.886502270014;5690.715464226772;5698.088305871123;5749.7700091996685;3210.6949839765184;3219.436598595283;3234.054453566645;3248.545203671488;3265.4448743713624;6123.2652081750475;6286.277078135981;6305.180326557518;6337.524685648503;6350.110984462087;6249.812505624838;6256.7810126645345;6263.217097862767;6267.2792628847355;6289.7484100635465;6314.526410519229;6352.14246076783;6359.904601430982;6368;6382;5914.4381283777975;6225.785971735468;6244.344343843831;6252.656103914328;6270.780522681866;6149.815505534841;6191.133241346125;6192.411720886508;6210.503159747119;6234.594751341148;6298.559100863079;6453.09656648079;6491.642959637265;6492.64290464029;6509.576877502947;4252.213340532012;4272.700910936204;4298.3552467130185;4299.634531064895;4307.353896915488;6092.817215483543;6208.782692605737;6223.222097237845;6241.188645476059;6251.4061164189325;6047.879042419039;6065.909011364922;6071.180390647206;6077.604955678044;6094.939050609614;6009.399060093956;6065.120557519223;6072.05883088122;6082.391760823883;6100.389961003864;5650.23721797552;5773.682447465262;5857.677827719516;5940.821775346746;5968.432998865101;6102.084687296763;6104.236970378703;6105.48103411215;6122.326544080237;6138.662373569497;5827.475527202572;5961.105834124743;5970.373110823301;5983.820485385445;5988.664420875774 17:29:54 INFO - PROCESS | 17192 | |5;yui.html;747.0325927923338;751.5603372027364;783.6199443270013;849.7833052571593;896.1128482802026;14721;14726.484573039947;15067.095974241525;15097.471588494405;15131.31909064092;14051.648708782286;14092.43630254791;14124;14125.929370353133;14140.505082322095;698.0332239847822;810.9513429194267;817.3502065857642;837.1377481194379;841.6633346661323;845.0999685335098;846.6063280574532;846.6317152038852;847.9915200848005;849.8385306791721;876.3909083187187;878.2139984713677;879.2218886285651;879.2570278115014;879.5162660536711;732.9157146928092;850.4387104511025;871.6644092024616;872.5419154943642;873.1268731268731;625.4464798653179;630.6878095342789;632.1055706175756;632.667849379075;632.7943418389042;14465.13209207451;14468.421263149461;14591.197484138369;14596.197209153492;14598.635034124125;13648.590542283748;13689.794653080211;13876.653083672989;13964.168131851668;14026.92986535071;11420.828687569694;11455.828162577567;11513.539458421654;11528.884711152949;11773.705657358549;3841.519810023747;3908.6482216600643;3920.803959802027;3932.803359831997;4016.979915100435;51729.20243328827;52371.73814130943;52722.736386317825;53132;53337.46662533364;11235.213535052631;11269.774604507864;11357.148213883991;11415.372154531415;11447.484863181176;19223.61552768937;19646.21415143407;19664.60670786576;19734.60530789405;19884;8337.416380853281;8458.577071146417;8545.401821872409;8583.65665373378;8721.476711397336;4819.903601927942;4848.490908454632;4850.248211527219;4967.602591792648;4974.875628109254;3300.5214243934497;3356.295178012596;3374;3391.8304084795664;3396.6942975132356;515.4767910570773;582.8018473718871;596.8448203467043;640.4908098062052;645.7772068636312;611.9938800612026;729.0846322629851;750.4446709434978;765.2309429023907;770.3875419041875;8330.166983301622;8558.315334773204;8657.27737073052;8681.869771953427;8731.60707768152;715.6779449247755;726.6512074204305;737.2075019354108;739.7780665800238;750.5909279442717;4106.301928672133;4130.607592278729;4165.604267594574;4168.895777605523;4226.450561426995;60316;61914;62030.37969620336;62320.68839655773;62787.6860615694;53375.46624533705;53923;54065;54178.458215418126;55654;51423.7428812861;51712.48287517077;51741.48258517367;52435.73782131141;52923.47076529185;8758;8975.730728078168;9023.684171053981;9095.49974751395;9124.771880703036;29779.70220297856;30384.84807575948;30484.695153048186;30721.391791231494;30982.380352393277;43763.78118109389;44048.55951440445;45397.54602454065;46497.18785151856;47298.76350618225;12394.566190183301;12409.689757756129;12528.87471125277;12599.43302551369;12779.680507987374;13854;13970.231637259642;14531.92734036323;14782.48261310849;14822.25888705582;9886.752831179278;11383.43082845871;11699.88300116988;11766.88233117658;11983.580574679845;12704.428300726304;12876.678083047998;12960.805587916;12984.805227921777;13088.149270297401;11903.285802851857;12146.817797733218;12224.083193760325;12426.937865310616;12846.678833028875;10255.7436064099;10364.119049880845;10631.468426578795;10697.358158510515;11132.220744547803;9697.096656741167;10736.892631073903;11264.774704506028;11272.66182014541;11283.830742538705 17:29:54 INFO - PROCESS | 17192 | __end_tp_report 17:29:54 INFO - PROCESS | 17192 | __start_cc_report 17:29:54 INFO - PROCESS | 17192 | _x_x_mozilla_cycle_collect,810 17:29:54 INFO - PROCESS | 17192 | __end_cc_report 17:29:54 INFO - PROCESS | 17192 | __startTimestamp1461371394137__endTimestamp 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | ------- Summary: start ------- 17:29:54 INFO - PROCESS | 17192 | Number of tests: 6 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#0] dojo.html Cycles:165 Average:5303.21 Median:5518.14 stddev:603.95 (10.9%) stddev-sans-first:580.85 17:29:54 INFO - PROCESS | 17192 | Values: 3112.8 3117.0 3156.1 3164.2 3191.9 5207.5 5226.7 5230.8 5265.9 5343.9 5352.1 5381.6 5413.6 5431.9 5460.6 4798.3 4818.2 4823.2 4830.1 4930.6 4928.6 4951.0 4978.0 4992.7 5005.0 4760.7 4777.9 4834.4 4850.2 4888.9 4842.4 4854.7 4856.0 4862.8 4893.8 4708.8 4823.4 4829.8 4838.3 4872.3 5306.7 5311.6 5312.1 5328.7 5381.7 5675.9 5686.4 5687.7 5692.8 5698.5 5613.6 5727.6 5730.5 5731.9 5765.0 5352.5 5353.2 5358.9 5361.0 5362.6 5813.0 5821.6 5823.7 5827.5 5828.6 5496.1 5577.4 5626.3 5727.1 5739.1 5699.4 5732.2 5735.1 5746.9 5750.2 5681.3 5712.1 5715.6 5716.8 5718.7 5627.5 5677.3 5719.9 5723.4 5747.5 4268.5 4268.8 4268.8 4273.6 4300.0 3821.4 3834.3 3837.8 3878.6 3879.7 5273.8 5314.3 5322.4 5358.0 5373.4 5711.7 5726.1 5742.4 5746.5 5761.0 5332.0 5395.8 5405.4 5431.6 5473.7 4875.6 4894.4 4900.9 4933.3 4951.6 5883.9 5906.8 5907.5 5915.8 5928.8 5532.4 5689.1 5698.8 5761.8 5762.3 5917.3 5918.4 5918.5 5926.1 5928.9 5603.9 5615.3 5616.9 5621.2 5635.9 5597.2 5647.5 5730.4 5743.6 5753.1 5631.3 5631.4 5633.3 5635.8 5636.5 5571.6 5614.4 5630.8 5633.3 5643.9 5360.1 5480.8 5535.4 5570.5 5584.6 5597.4 5622.8 5635.2 5647.1 5647.8 5299.3 5497.3 5512.0 5512.6 5518.1 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#1] ext.html Cycles:180 Average:57208.70 Median:40703.69 stddev:109483.29 (269.0%) stddev-sans-first:109707.96 17:29:54 INFO - PROCESS | 17192 | Values: 611.5 626.6 662.0 662.0 682.9 30506.0 31158.8 31196.7 31205.7 36988.0 39717.2 40169.0 40283.8 40332.0 40375.0 8530.0 8718.0 8739.9 8743.3 8747.8 8784.1 8914.8 8923.0 8925.5 8926.3 8932.4 8969.4 8984.3 8989.8 8998.0 8841.1 8882.0 8906.9 8908.3 8912.2 8653.9 8695.1 8763.1 8770.0 8775.0 40564.8 41174.0 41201.4 41209.0 41339.8 3465.7 3745.9 3916.5 4086.2 4125.4 31352.0 31391.5 31464.5 31597.0 33077.2 4282.4 4293.7 4321.4 4348.8 4370.5 313058.0 315672.0 316382.0 317695.0 320015.4 51572.2 56657.0 56821.0 56873.0 57080.0 60833.4 62844.0 62928.4 62938.4 62978.7 14847.9 14991.5 15097.7 15104.0 15126.2 11160.2 11376.4 11481.7 11502.4 11579.4 18136.5 18662.4 18741.3 18801.5 18918.0 6462.0 6728.6 6768.4 6781.9 6813.7 1038.9 1044.1 1089.2 1140.4 1213.0 32063.0 32234.0 32551.2 33180.0 33331.3 1102.0 1209.0 1213.3 1236.2 1244.6 17039.2 17467.2 17480.6 17483.6 17523.6 465189.0 468421.0 469439.0 471035.0 471787.0 57404.7 57965.4 58027.0 58081.4 58272.4 1350.1 1392.8 1392.8 1398.1 1399.2 30700.0 31935.4 32035.2 32101.8 32298.4 50983.7 51452.2 51535.7 51560.2 51588.7 434129.0 438528.1 441905.0 442516.0 445330.0 36375.0 41387.0 42340.8 43208.4 44109.3 43521.3 44168.6 44548.3 44634.6 45254.8 38662.8 39335.0 39402.2 39499.2 40842.6 37790.4 38776.8 39151.0 39215.6 39543.8 39921.6 40115.6 43236.4 44711.6 45032.1 32762.7 34798.8 35383.3 35723.0 35760.5 26997.5 27237.5 27879.6 28589.6 29740.4 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#2] jquery.html Cycles:180 Average:27312.30 Median:4284.97 stddev:77068.32 (1798.6%) stddev-sans-first:77258.00 17:29:54 INFO - PROCESS | 17192 | Values: 389.3 391.4 393.9 401.4 404.2 14532.5 15489.0 16810.9 17830.3 17877.7 17630.7 18304.5 18541.9 18829.4 19360.7 5542.7 5656.9 5694.8 5719.1 5719.5 4029.1 5522.6 5637.3 5868.8 6168.4 6072.5 6096.0 6120.9 6123.4 6125.3 5179.7 5492.9 5507.8 5515.9 6085.2 5335.3 5341.9 5365.7 5382.5 5386.0 12863.4 13733.8 13736.9 13740.5 13755.3 2171.9 2272.9 2295.9 2379.2 2472.7 9809.0 9952.2 10080.3 11816.9 13559.2 1901.0 1953.6 1963.5 1985.1 2003.4 77439.0 82167.0 82744.6 83604.0 85091.0 9945.2 10190.8 10268.4 10442.0 10670.8 13691.6 14011.0 14046.6 14113.5 14149.1 6983.8 7225.0 7239.0 7312.0 7322.8 6868.0 6898.8 6979.5 7009.9 7030.3 4257.1 4312.8 4350.7 4353.6 4413.2 1780.4 1826.7 1827.5 1829.1 1834.6 453.9 459.3 996.5 1008.3 1112.8 11122.2 11263.3 11404.3 11471.5 11579.0 434.1 445.5 449.2 449.7 466.6 6043.6 6091.0 6098.7 6197.3 6212.2 455577.0 465089.0 465997.0 467865.0 470070.0 95800.0 97120.5 97316.0 97684.0 98443.5 477.6 480.1 482.3 483.4 485.7 10335.0 10420.6 16044.2 16895.8 17699.6 37385.6 38037.4 38631.6 39463.0 40396.2 47795.5 53976.2 54129.2 54545.7 54757.7 7823.4 7937.2 8020.7 8082.4 8137.3 12811.4 13140.8 13153.7 13250.1 13283.9 11592.8 11704.4 11730.7 11767.6 11998.9 11266.0 11418.6 11613.0 11931.7 12085.6 11761.8 11820.4 12217.7 12289.4 12415.7 7838.4 7951.8 8077.0 8126.6 8312.8 10916.4 11667.6 11874.0 11925.8 12071.2 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#3] mootools.html Cycles:180 Average:5513.04 Median:5005.95 stddev:3030.23 (60.5%) stddev-sans-first:3022.20 17:29:54 INFO - PROCESS | 17192 | Values: 1301.4 1476.0 1491.5 1652.8 1823.2 7723.3 7961.0 7997.8 8002.9 8014.8 8014.5 8216.5 8227.4 8242.0 8252.1 1959.8 2231.9 2284.5 2303.8 2307.1 2284.2 2295.9 2303.7 2304.7 2304.8 2204.6 2216.0 2228.3 2235.1 2237.0 1891.3 2125.8 2191.7 2200.9 2203.8 2269.3 2286.0 2303.6 2304.4 2307.5 8176.6 8331.8 8341.0 8355.5 8363.9 4811.0 4980.4 4991.8 5005.8 5006.1 3215.0 3233.9 3276.9 3307.8 3316.6 1000.6 1015.2 1017.0 1023.1 1031.6 10891.7 10926.7 10958.4 10984.3 11009.4 4222.5 4300.0 4360.2 4480.0 4511.1 9537.3 9562.7 9584.2 9651.8 9672.5 4890.6 4901.2 4908.2 4918.6 4929.3 4228.7 4612.2 4735.3 4754.8 4767.5 3785.9 3802.7 3884.1 3917.1 3917.7 1195.2 1229.9 1232.5 1233.2 1236.8 876.5 941.6 983.3 996.4 1020.1 5666.2 5876.8 5897.3 5967.8 6077.8 893.6 920.1 964.1 967.4 1018.6 4132.8 4226.9 4234.6 4239.2 4246.0 10039.1 10167.6 10179.8 10284.2 10347.6 10050.4 10059.1 10094.4 10107.0 10121.1 7293.9 7664.8 7669.4 7693.2 7832.8 5797.7 5839.5 5903.2 5955.8 6030.2 9246.9 9457.6 9487.8 9491.2 9541.1 9125.8 9559.0 9656.7 9663.3 9753.0 7279.2 7363.2 7388.7 7398.4 7410.8 8152.3 8162.1 8184.7 8189.1 8220.0 7347.8 7513.4 7531.3 7577.2 7596.9 7321.5 7326.5 7403.6 7468.9 7497.9 6696.0 6745.9 6763.8 6766.8 6776.6 5071.6 5179.4 5224.5 5309.9 5325.0 5084.2 5194.6 5205.6 5333.0 5357.5 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#4] prototype.html Cycles:180 Average:5025.83 Median:5720.11 stddev:1514.12 (26.5%) stddev-sans-first:1476.73 17:29:54 INFO - PROCESS | 17192 | Values: 327.4 328.8 337.8 340.8 343.4 5647.4 5657.5 5716.0 5721.7 5726.7 5600.3 5645.7 5647.8 5648.3 5657.9 4158.9 4178.5 4315.2 4357.7 4379.1 4378.3 4380.3 4398.1 4399.3 4404.7 4158.3 4374.9 4386.5 4391.9 4393.0 4031.8 4297.2 4348.2 4348.2 4355.0 3809.3 3814.5 3817.4 3820.5 3838.8 5375.2 5476.9 5478.2 5513.1 5537.6 4990.4 5035.2 5058.5 5065.8 5066.5 5930.9 5957.6 5985.9 6006.7 6022.5 4145.2 4194.7 4272.1 4273.4 4288.3 6221.8 6226.0 6249.6 6254.0 6255.5 4313.8 4341.2 4345.3 4345.3 4358.2 4235.5 4336.5 4370.9 4376.2 4383.6 5056.9 5067.5 5069.9 5070.6 5072.9 5954.3 5963.7 5981.0 5990.7 6028.8 1393.8 1465.8 1524.5 1540.0 1550.2 941.7 946.9 969.4 982.8 986.1 5701.0 5701.5 5718.6 5736.4 5752.7 6070.6 6085.4 6096.3 6096.8 6119.9 5581.8 5674.9 5690.7 5698.1 5749.8 3210.7 3219.4 3234.1 3248.5 3265.4 6123.3 6286.3 6305.2 6337.5 6350.1 6249.8 6256.8 6263.2 6267.3 6289.7 6314.5 6352.1 6359.9 6368.0 6382.0 5914.4 6225.8 6244.3 6252.7 6270.8 6149.8 6191.1 6192.4 6210.5 6234.6 6298.6 6453.1 6491.6 6492.6 6509.6 4252.2 4272.7 4298.4 4299.6 4307.4 6092.8 6208.8 6223.2 6241.2 6251.4 6047.9 6065.9 6071.2 6077.6 6094.9 6009.4 6065.1 6072.1 6082.4 6100.4 5650.2 5773.7 5857.7 5940.8 5968.4 6102.1 6104.2 6105.5 6122.3 6138.7 5827.5 5961.1 5970.4 5983.8 5988.7 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - PROCESS | 17192 | [#5] yui.html Cycles:180 Average:14748.32 Median:45947.37 stddev:16906.32 (36.8%) stddev-sans-first:16921.05 17:29:54 INFO - PROCESS | 17192 | Values: 747.0 751.6 783.6 849.8 896.1 14721.0 14726.5 15067.1 15097.5 15131.3 14051.6 14092.4 14124.0 14125.9 14140.5 698.0 811.0 817.4 837.1 841.7 845.1 846.6 846.6 848.0 849.8 876.4 878.2 879.2 879.3 879.5 732.9 850.4 871.7 872.5 873.1 625.4 630.7 632.1 632.7 632.8 14465.1 14468.4 14591.2 14596.2 14598.6 13648.6 13689.8 13876.7 13964.2 14026.9 11420.8 11455.8 11513.5 11528.9 11773.7 3841.5 3908.6 3920.8 3932.8 4017.0 51729.2 52371.7 52722.7 53132.0 53337.5 11235.2 11269.8 11357.1 11415.4 11447.5 19223.6 19646.2 19664.6 19734.6 19884.0 8337.4 8458.6 8545.4 8583.7 8721.5 4819.9 4848.5 4850.2 4967.6 4974.9 3300.5 3356.3 3374.0 3391.8 3396.7 515.5 582.8 596.8 640.5 645.8 612.0 729.1 750.4 765.2 770.4 8330.2 8558.3 8657.3 8681.9 8731.6 715.7 726.7 737.2 739.8 750.6 4106.3 4130.6 4165.6 4168.9 4226.5 60316.0 61914.0 62030.4 62320.7 62787.7 53375.5 53923.0 54065.0 54178.5 55654.0 51423.7 51712.5 51741.5 52435.7 52923.5 8758.0 8975.7 9023.7 9095.5 9124.8 29779.7 30384.8 30484.7 30721.4 30982.4 43763.8 44048.6 45397.5 46497.2 47298.8 12394.6 12409.7 12528.9 12599.4 12779.7 13854.0 13970.2 14531.9 14782.5 14822.3 9886.8 11383.4 11699.9 11766.9 11983.6 12704.4 12876.7 12960.8 12984.8 13088.1 11903.3 12146.8 12224.1 12426.9 12846.7 10255.7 10364.1 10631.5 10697.4 11132.2 9697.1 10736.9 11264.8 11272.7 11283.8 17:29:54 INFO - PROCESS | 17192 | -------- Summary: end -------- 17:29:54 INFO - PROCESS | 17192 | 17:29:54 INFO - TEST-INFO | 17192: exit 0 17:29:54 INFO - TEST-OK | dromaeo_css | took 1111907ms 17:29:54 INFO - TEST-START | kraken 17:29:54 INFO - operating with platform_type : linux_ 17:29:54 INFO - Initialising browser for kraken test... 17:29:54 INFO - TEST-INFO | started process 17376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSWIgu/profile http://localhost:41923/getInfo.html) 17:29:58 INFO - PROCESS | 17376 | __metrics Screen width/height:1600/1200 17:29:58 INFO - PROCESS | 17376 | colorDepth:24 17:29:58 INFO - PROCESS | 17376 | Browser inner width/height: 1024/697 17:29:58 INFO - PROCESS | 17376 | __metrics 17:29:59 ERROR - PROCESS | 17376 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:30:00 INFO - TEST-INFO | 17376: exit 0 17:30:00 INFO - Browser initialized. 17:30:00 INFO - Running cycle 1/1 for kraken test... 17:30:00 INFO - TEST-INFO | started process 17458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSWIgu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:12 INFO - PROCESS | 17458 | RSS: Main: 153284608 17:30:12 INFO - PROCESS | 17458 | 17:30:14 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41923/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:15 INFO - PROCESS | 17458 | RSS: Main: 208678912 17:30:15 INFO - PROCESS | 17458 | 17:30:18 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41923/tests/kraken/driver.html?testName=audio-dft) 17:30:19 INFO - PROCESS | 17458 | RSS: Main: 194441216 17:30:19 INFO - PROCESS | 17458 | 17:30:22 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41923/tests/kraken/driver.html?testName=audio-fft) 17:30:22 INFO - PROCESS | 17458 | RSS: Main: 264974336 17:30:22 INFO - PROCESS | 17458 | 17:30:24 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41923/tests/kraken/driver.html?testName=audio-oscillator) 17:30:25 INFO - PROCESS | 17458 | RSS: Main: 173731840 17:30:25 INFO - PROCESS | 17458 | 17:30:27 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:28 INFO - PROCESS | 17458 | RSS: Main: 177590272 17:30:28 INFO - PROCESS | 17458 | 17:30:31 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41923/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:31 INFO - PROCESS | 17458 | RSS: Main: 213643264 17:30:31 INFO - PROCESS | 17458 | 17:30:35 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41923/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:35 INFO - PROCESS | 17458 | RSS: Main: 213508096 17:30:35 INFO - PROCESS | 17458 | 17:30:38 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41923/tests/kraken/driver.html?testName=json-parse-financial) 17:30:39 INFO - PROCESS | 17458 | RSS: Main: 214614016 17:30:39 INFO - PROCESS | 17458 | 17:30:40 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:41 INFO - PROCESS | 17458 | RSS: Main: 205094912 17:30:41 INFO - PROCESS | 17458 | 17:30:43 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:43 INFO - PROCESS | 17458 | RSS: Main: 204791808 17:30:43 INFO - PROCESS | 17458 | 17:30:45 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:46 INFO - PROCESS | 17458 | RSS: Main: 213909504 17:30:46 INFO - PROCESS | 17458 | 17:30:48 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:49 INFO - PROCESS | 17458 | RSS: Main: 223002624 17:30:49 INFO - PROCESS | 17458 | 17:30:52 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:52 INFO - PROCESS | 17458 | RSS: Main: 218128384 17:30:52 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | Cycle 1(1): loaded http://localhost:41923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41923/tests/kraken/driver.html?testName=ai-astar) 17:30:54 INFO - PROCESS | 17458 | RSS: Main: 281182208 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | __start_tp_report 17:30:54 INFO - PROCESS | 17458 | _x_x_mozilla_page_load 17:30:54 INFO - PROCESS | 17458 | _x_x_mozilla_page_load_details 17:30:54 INFO - PROCESS | 17458 | |i|pagename|runs| 17:30:54 INFO - PROCESS | 17458 | |0;ai-astar;111;111;106;110;111;112;101;111;110;111 17:30:54 INFO - PROCESS | 17458 | |1;audio-beat-detection;149;126;154;176;135;154;160;127;188;129 17:30:54 INFO - PROCESS | 17458 | |2;audio-dft;161;161;160;160;160;160;160;161;160;160 17:30:54 INFO - PROCESS | 17458 | |3;audio-fft;75;77;126;104;77;72;71;146;100;72 17:30:54 INFO - PROCESS | 17458 | |4;audio-oscillator;92;92;147;94;92;93;145;93;93;155 17:30:54 INFO - PROCESS | 17458 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;116;117;117 17:30:54 INFO - PROCESS | 17458 | |6;imaging-darkroom;146;145;145;145;145;145;146;145;145;146 17:30:54 INFO - PROCESS | 17458 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 17:30:54 INFO - PROCESS | 17458 | |8;json-parse-financial;58;58;56;57;57;64;60;82;54;54 17:30:54 INFO - PROCESS | 17458 | |9;json-stringify-tinderbox;62;62;61;60;61;61;60;61;61;61 17:30:54 INFO - PROCESS | 17458 | |10;stanford-crypto-aes;76;75;76;77;76;76;78;76;77;77 17:30:54 INFO - PROCESS | 17458 | |11;stanford-crypto-ccm;126;133;127;123;123;126;128;126;158;126 17:30:54 INFO - PROCESS | 17458 | |12;stanford-crypto-pbkdf2;168;165;168;164;170;171;164;170;166;166 17:30:54 INFO - PROCESS | 17458 | |13;stanford-crypto-sha256-iterative;69;72;68;68;70;69;70;68;67;69 17:30:54 INFO - PROCESS | 17458 | __end_tp_report 17:30:54 INFO - PROCESS | 17458 | __start_cc_report 17:30:54 INFO - PROCESS | 17458 | _x_x_mozilla_cycle_collect,1643 17:30:54 INFO - PROCESS | 17458 | __end_cc_report 17:30:54 INFO - PROCESS | 17458 | __startTimestamp1461371454785__endTimestamp 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | ------- Summary: start ------- 17:30:54 INFO - PROCESS | 17458 | Number of tests: 14 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:3.53 17:30:54 INFO - PROCESS | 17458 | Values: 111.0 111.0 106.0 110.0 111.0 112.0 101.0 111.0 110.0 111.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.00 stddev:21.14 (13.7%) stddev-sans-first:22.42 17:30:54 INFO - PROCESS | 17458 | Values: 149.0 126.0 154.0 176.0 135.0 154.0 160.0 127.0 188.0 129.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 17:30:54 INFO - PROCESS | 17458 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 160.0 161.0 160.0 160.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#3] audio-fft Cycles:10 Average:92.00 Median:72.00 stddev:26.37 (36.6%) stddev-sans-first:27.25 17:30:54 INFO - PROCESS | 17458 | Values: 75.0 77.0 126.0 104.0 77.0 72.0 71.0 146.0 100.0 72.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.50 stddev:27.31 (29.5%) stddev-sans-first:28.21 17:30:54 INFO - PROCESS | 17458 | Values: 92.0 92.0 147.0 94.0 92.0 93.0 145.0 93.0 93.0 155.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:30:54 INFO - PROCESS | 17458 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 17:30:54 INFO - PROCESS | 17458 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:30:54 INFO - PROCESS | 17458 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:58.00 stddev:8.26 (14.2%) stddev-sans-first:8.73 17:30:54 INFO - PROCESS | 17458 | Values: 58.0 58.0 56.0 57.0 57.0 64.0 60.0 82.0 54.0 54.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 17:30:54 INFO - PROCESS | 17458 | Values: 62.0 62.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 17:30:54 INFO - PROCESS | 17458 | Values: 76.0 75.0 76.0 77.0 76.0 76.0 78.0 76.0 77.0 77.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:126.50 stddev:10.36 (8.2%) stddev-sans-first:10.91 17:30:54 INFO - PROCESS | 17458 | Values: 126.0 133.0 127.0 123.0 123.0 126.0 128.0 126.0 158.0 126.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:168.00 stddev:2.57 (1.5%) stddev-sans-first:2.71 17:30:54 INFO - PROCESS | 17458 | Values: 168.0 165.0 168.0 164.0 170.0 171.0 164.0 170.0 166.0 166.0 17:30:54 INFO - PROCESS | 17458 | 17:30:54 INFO - PROCESS | 17458 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.41 (2.0%) stddev-sans-first:1.50 17:30:54 INFO - PROCESS | 17458 | Values: 69.0 72.0 68.0 68.0 70.0 69.0 70.0 68.0 67.0 69.0 17:30:54 INFO - PROCESS | 17458 | -------- Summary: end -------- 17:30:54 INFO - PROCESS | 17458 | 17:30:55 INFO - TEST-INFO | 17458: exit 0 17:30:55 INFO - TEST-OK | kraken | took 60923ms 17:30:55 INFO - SUITE-END | took 1172s 17:30:55 INFO - Completed test suite (00:19:32) 17:30:55 INFO - javascript benchmark 17:30:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.79766815157, 3116.9844150779245, 3156.1320636824885, 3164.224764932592, 3191.936161276774, 5207.531322181007, 5226.6863988160685, 5230.790768369266, 5265.921011184826, 5343.946560534394, 5352.063388906936, 5381.623286369956, 5413.593980451462, 5431.945680543194, 5460.645058071223, 4798.328234047245, 4818.156822556056, 4823.20417131173, 4830.058138662962, 4930.580900623451, 4928.5564299213065, 4950.975245123769, 4977.950220497803, 4992.725400102993, 5005.049040682259, 4760.666753327286, 4777.856664300077, 4834.419869615669, 4850.199717046718, 4888.926666100011, 4842.370491836074, 4854.708717476928, 4855.951440485585, 4862.805487780484, 4893.828715994923, 4708.788104535304, 4823.397075365579, 4829.830955916561, 4838.346823178861, 4872.3422337984275, 5306.70813105279, 5311.575073994071, 5312.070387682179, 5328.653637513549, 5381.67709937405, 5675.886482270332, 5686.3744988051285, 5687.744051517691, 5692.829215123553, 5698.487136157766, 5613.578981576398, 5727.627704199213, 5730.512906402961, 5731.856703582402, 5764.971175144139, 5352.464753524617, 5353.2237825515085, 5358.866028349284, 5361.035013697572, 5362.624616276862, 5813.040848260074, 5821.592488525763, 5823.70881455934, 5827.475527202572, 5828.6211396259105, 5496.065668836308, 5577.386487486373, 5626.324841019104, 5727.112297593796, 5739.139129130664, 5699.373068962411, 5732.197492351074, 5735.082386818089, 5746.913796293059, 5750.223719797774, 5681.289838770153, 5712.143178523172, 5715.571332150105, 5716.79991200306, 5718.7426565804635, 5627.465390787868, 5677.318721753416, 5719.942800572025, 5723.427657234243, 5747.5114615257335, 4268.509121451011, 4268.786560671954, 4268.829246830154, 4273.615374616299, 4299.97850010748, 3821.3503704370323, 3834.271488417192, 3837.846486140579, 3878.5733569307354, 3879.650831425185, 5273.789048438096, 5314.2825718528275, 5322.36131664195, 5358.035553600389, 5373.38206106295, 5711.6858572778065, 5726.062995653951, 5742.397048309867, 5746.540276777848, 5761.049426844607, 5331.973340133352, 5395.81114660985, 5405.351357837085, 5431.5926305526455, 5473.7263136843, 4875.609951203895, 4894.412670479565, 4900.852974410774, 4933.309336692866, 4951.628627852853, 5883.882322353529, 5906.818636272763, 5907.4683278505145, 5915.822525324247, 5928.822135335947, 5532.391436942014, 5689.118186681071, 5698.800541981011, 5761.769529218868, 5762.279715035621, 5917.3490915998345, 5918.378570250062, 5918.526517878646, 5926.081457374114, 5928.881422371443, 5603.887922241451, 5615.2700148980375, 5616.8876622466505, 5621.213030175697, 5635.915461268166, 5597.244372009726, 5647.463490968352, 5730.398308177581, 5743.62666426681, 5753.079507278815, 5631.324241091095, 5631.380548139783, 5633.267675202197, 5635.774569017193, 5636.5208957237455, 5571.637843540157, 5614.410486898817, 5630.8029218977135, 5633.295838020247, 5643.915341269966, 5360.0887849064975, 5480.808171713971, 5535.363433205233, 5570.470805273492, 5584.581156413204, 5597.44025597437, 5622.7750889963945, 5635.15472679085, 5647.068233741551, 5647.785726068915, 5299.284596579412, 5497.340319161726, 5512.0, 5512.586556008235, 5518.144687573433], "value": 5262.532377798601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5352332227509, 626.6052386996192, 662.013599736393, 662.0235153149102, 682.9112215411999, 30506.0, 31158.844205778994, 31196.688033119663, 31205.687943120563, 36988.0, 39717.205655886864, 40169.0, 40283.79858100705, 40332.0, 40375.0, 8530.019047809488, 8718.041015488323, 8739.868901966443, 8743.256823170039, 8747.825043499126, 8784.07767184446, 8914.777130571723, 8922.955385223066, 8925.46447213166, 8926.285897128215, 8932.374733768638, 8969.416987895765, 8984.326175536828, 8989.820203595924, 8997.95501022494, 8841.115888411172, 8882.0, 8906.910930890674, 8908.331875109328, 8912.197902188802, 8653.913460865373, 8695.130486951317, 8763.12368763125, 8770.035296117421, 8775.034746177915, 40564.79717601393, 41174.0, 41201.381979270336, 41209.0, 41339.7933010333, 3465.740069494773, 3745.8501659933568, 3916.490856188706, 4086.223617512663, 4125.443065186221, 31352.0, 31391.529127063113, 31464.528032079535, 31597.0, 33077.17307067318, 4282.379055037033, 4293.720908140961, 4321.351797230409, 4348.782560871975, 4370.541093185201, 313058.0, 315672.0, 316382.0, 317695.0, 320015.39992300124, 51572.22641660378, 56657.0, 56821.0, 56873.0, 57080.0, 60833.391666083655, 62844.0, 62928.37071629317, 62938.37061629417, 62978.68510657417, 14847.851521484647, 14991.475298364505, 15097.698046039017, 15104.0, 15126.168060756543, 11160.218784685156, 11376.374299413446, 11481.655550333337, 11502.367369794574, 11579.363135027654, 18136.546586335448, 18662.440126796217, 18741.25034998612, 18801.529961751065, 18918.0, 6461.967690161613, 6728.596284222962, 6768.357006084414, 6781.8643627127185, 6813.705395974749, 1038.8909164537615, 1044.065561322612, 1089.199438412766, 1140.4468832616174, 1212.9818052729215, 32063.0, 32234.0, 32551.18622034468, 33180.0, 33331.333373332396, 1102.0, 1209.0206932384797, 1213.308414203913, 1236.2273579013117, 1244.5830646733264, 17039.233234504478, 17467.213975371138, 17480.5629859252, 17483.56291092733, 17523.56191095233, 465189.0, 468421.0, 469439.0, 471035.0, 471787.0, 57404.71297643485, 57965.42034579685, 58027.0, 58081.4191858076, 58272.4172758267, 1350.1426594112809, 1392.7632302508598, 1392.78411846164, 1398.1331574423923, 1399.1744870526236, 30700.0, 31935.36129277448, 32035.199120021254, 32101.839490802395, 32298.35403291968, 50983.745081274355, 51452.22821657603, 51535.742321288155, 51560.22659660183, 51588.74205628948, 434129.0, 438528.14718527894, 441905.0, 442516.0, 445330.0, 36375.0, 41387.0, 42340.78829605832, 43208.35187472253, 44109.33835992398, 43521.34717979296, 44168.55831441644, 44548.331775024046, 44634.55365446304, 45254.773726131156, 38662.80668596639, 39335.0, 39402.2119557613, 39499.2100158001, 40842.591574083875, 37790.43314350232, 38776.80611596924, 39151.0, 39215.60784392119, 39543.80228098841, 39921.60078399179, 40115.59884401118, 43236.35145472758, 44711.55288447074, 45032.099358013314, 32762.672373275964, 34798.82600586981, 35383.292334152655, 35723.0, 35760.463593045606, 26997.46005079848, 27237.45525089527, 27879.581806273327, 28589.571156432256, 29740.405191896472], "value": 19897.575946081295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.26623315051154, 391.410926555534, 393.9015246188455, 401.41994817488734, 404.187582958254, 14532.491362802304, 15489.0, 16810.91594542027, 17830.286788528458, 17877.731834022485, 17630.735538966892, 18304.450866473995, 18541.90729046353, 18829.43511694648, 19360.70958935617, 5542.695151766651, 5656.886862262752, 5694.77220911163, 5719.084946408576, 5719.513841323493, 4029.1135950090934, 5522.5581953443825, 5637.3235211774645, 5868.76524939002, 6168.4448399644025, 6072.453479186872, 6096.0, 6120.908186377208, 6123.448889599935, 6125.264968203799, 5179.715115668637, 5492.917606235909, 5507.807226747084, 5515.889682206373, 6085.208922840046, 5335.306410166692, 5341.946580534222, 5365.731713414314, 5382.461753824626, 5386.0, 12863.356832158355, 13733.793993090112, 13736.93131534336, 13740.450381984709, 13755.31223438824, 2171.86968781872, 2272.943176420603, 2295.885205739706, 2379.2267513058327, 2472.70407781891, 9808.95095524525, 9952.154066904322, 10080.344777589507, 11816.877396647305, 13559.186448813005, 1900.961980760377, 1953.6288105260098, 1963.5385684364162, 1985.0769392232537, 2003.4390370696228, 77439.0, 82167.0, 82744.58627706883, 83604.0, 85091.0, 9945.20438364929, 10190.796184076276, 10268.383896966207, 10442.00800923911, 10670.839937400946, 13691.589252322447, 14011.0, 14046.578602641937, 14113.506027288995, 14149.08030977983, 6983.82540436483, 7224.963875180695, 7238.963805181046, 7312.0128782613665, 7322.780316590511, 6867.965660171767, 6898.793036208821, 6979.546329488669, 7009.894851577231, 7030.3321184487395, 4257.10600773841, 4312.827486900489, 4350.695451318441, 4353.564643535685, 4413.205622987893, 1780.3501721871683, 1826.7442558041885, 1827.524843540689, 1829.0671757403554, 1834.6055598046216, 453.8524979381648, 459.2903963376591, 996.5067291690659, 1008.2538921198407, 1112.7663190730038, 11122.22144449897, 11263.26788758728, 11404.258723182966, 11471.483783229607, 11579.0, 434.12307139577877, 445.465441470237, 449.2475104200451, 449.6784798868824, 466.5754163711007, 6043.576949613573, 6090.969545152246, 6098.664573448503, 6197.25632924043, 6212.192414986113, 455577.0, 465089.0, 465997.0, 467865.0, 470070.0, 95800.0, 97120.51439742897, 97316.0, 97684.0, 98443.50778246063, 477.6012029954957, 480.06387544288077, 482.3343785575883, 483.4367961325017, 485.7085748550912, 10335.0, 10420.583176673152, 16044.197790110682, 16895.83104168992, 17699.646007080042, 37385.626143739304, 38037.42943855789, 38631.6136838628, 39463.0, 40396.1920761589, 47795.52204477911, 53976.19035714389, 54129.188062179885, 54545.72727136339, 54757.72621136869, 7823.413244006836, 7937.232185367375, 8020.719274825353, 8082.35341172693, 8137.308328791883, 12811.423485942969, 13140.802887956497, 13153.671158220739, 13250.138740981805, 13283.867161328262, 11592.826107608224, 11704.356260405759, 11730.70673233176, 11767.588134415255, 11998.880011200126, 11266.0, 11418.600348987746, 11613.0, 11931.701707457383, 12085.577004805142, 11761.764764704487, 11820.40897955116, 12217.69455763613, 12289.446974885972, 12415.689607759517, 7838.412119090977, 7951.840963180588, 8077.0, 8126.593670316579, 8312.792180195544, 10916.448107905582, 11667.6499705009, 11874.0, 11925.82111268349, 12071.215371000857], "value": 8130.967649547331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.4101937145072, 1476.033198255143, 1491.5450787509808, 1652.8347165283474, 1823.2433540080867, 7723.304902558769, 7960.9601951990235, 7997.760067197979, 8002.919970800291, 8014.759557213279, 8014.519128852273, 8216.507009579429, 8227.382946279024, 8242.0, 8252.092269850311, 1959.7648282206155, 2231.9107235710635, 2284.5316710074435, 2303.7674843958484, 2307.1463558483383, 2284.189112864934, 2295.9081636734595, 2303.7005189325446, 2304.7119110111234, 2304.83866129371, 2204.6252137136726, 2215.9889200553976, 2228.2980861028805, 2235.0724449353497, 2236.9776302236933, 1891.300218918995, 2125.829933605308, 2191.6822060801255, 2200.933971980843, 2203.8016578508013, 2269.2851751698163, 2285.9657105143438, 2303.5968705476644, 2304.4238940264936, 2307.48081681622, 8176.550289734062, 8331.750047498585, 8341.04078031022, 8355.456895301786, 8363.874541881876, 4810.95189048112, 4980.352554167935, 4991.800327986876, 5005.774740136702, 5006.123928312567, 3214.983925080383, 3233.9353212935844, 3276.918077048069, 3307.8015319080932, 3316.5522654441584, 1000.5897581991348, 1015.162490944966, 1016.9949150254275, 1023.1405619279766, 1031.587365053977, 10891.67324980252, 10926.726831829188, 10958.397288149148, 10984.340939543654, 11009.394483303415, 4222.535521092677, 4300.0, 4360.193364227628, 4479.955200448019, 4511.097780443859, 9537.284703647254, 9562.713118606453, 9584.233261339075, 9651.758706032406, 9672.468014259142, 4890.633202509826, 4901.166801643658, 4908.214685650279, 4918.5819205367225, 4929.309896614477, 4228.6617070634275, 4612.169809434267, 4735.313379560013, 4754.78603462845, 4767.475577686451, 3785.9242815143543, 3802.7147963902817, 3884.1454879926373, 3917.138229589486, 3917.6865850731874, 1195.2290772451893, 1229.8968763414662, 1232.4577186038293, 1233.1552886272932, 1236.8082947143207, 876.4565969099199, 941.6374695742188, 983.2772911909741, 996.3623281100101, 1020.0564477857952, 5666.2350582670815, 5876.764929402776, 5897.262842144732, 5967.8439930446675, 6077.787277445356, 893.6425429828121, 920.1442658327819, 964.0985678390728, 967.3808762392075, 1018.5518371916334, 4132.772697501667, 4226.936595951063, 4234.55537168599, 4239.1521695660995, 4245.97877010613, 10039.096481316716, 10167.593296268067, 10179.796404071878, 10284.177265818716, 10347.63783267582, 10050.396976181453, 10059.144972677259, 10094.394336339696, 10107.039831216023, 10121.089101980857, 7293.927060729431, 7664.770056898302, 7669.386449083949, 7693.230676932374, 7832.804179895548, 5797.681127537857, 5839.503642190291, 5903.173555702119, 5955.821325360246, 6030.216071910623, 9246.907530924873, 9457.621695132118, 9487.762805929908, 9491.193248573949, 9541.141297283279, 9125.77185570366, 9559.0, 9656.662016829378, 9663.323567350499, 9753.0, 7279.199288078201, 7363.15323737777, 7388.704451821867, 7398.408127349691, 7410.777676669709, 8152.347812174893, 8162.142974987541, 8184.713535026245, 8189.058258300372, 8220.0, 7347.7795666130105, 7513.39892808563, 7531.284527969834, 7577.242275772379, 7596.898449724869, 7321.487495875451, 7326.487145899736, 7403.555786652602, 7468.925310746823, 7497.850042999, 6695.966520167368, 6745.93254067453, 6763.797086087426, 6766.830829229112, 6776.593404395752, 5071.644984851025, 5179.430262671179, 5224.52979231871, 5309.893802124013, 5324.973375133254, 5084.186530155157, 5194.610404219623, 5205.609579281493, 5333.0, 5357.464253574612], "value": 4452.233911409562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3975884372754, 328.8129851237034, 337.8479684142136, 340.77679120176276, 343.35620711166564, 5647.435256474356, 5657.547396208303, 5716.0, 5721.656700597967, 5726.713664316789, 5600.327960644729, 5645.745941432635, 5647.774089036444, 5648.293963254593, 5657.9434205657935, 4158.937615935756, 4178.540360560336, 4315.201687687788, 4357.716748411359, 4379.1022840317655, 4378.299472084467, 4380.299152135659, 4398.076403955173, 4399.296112621981, 4404.735715857043, 4158.313878210091, 4374.934375984347, 4386.495553011397, 4391.9121617567625, 4392.97803510982, 4031.8387264509383, 4297.247981603223, 4348.21732088224, 4348.239058164809, 4354.9765805035795, 3809.314323421783, 3814.5231846019246, 3817.351050321452, 3820.465134881119, 3838.7888666123354, 5375.193720941851, 5476.890462190774, 5478.150886612581, 5513.09034009388, 5537.612367134302, 4990.426100998396, 5035.169197082477, 5058.4688607696025, 5065.809534759365, 5066.46802085783, 5930.881382372371, 5957.642541447527, 5985.940140598582, 6006.699665016732, 6022.5181985441495, 4145.191687620915, 4194.6853985951175, 4272.077565095719, 4273.423087883127, 4288.33530802723, 6221.813345599639, 6226.0, 6249.593776404519, 6253.9999999999545, 6255.499560035232, 4313.827446902089, 4341.196878577473, 4345.283028300359, 4345.34819777036, 4358.193734159191, 4235.4917409910395, 4336.544662810423, 4370.912581748347, 4376.234159022159, 4383.583559561836, 5056.873578160576, 5067.467915868854, 5069.873253168626, 5070.61970352225, 5072.949270507322, 5954.285485741739, 5963.671998040063, 5981.0, 5990.6705131218205, 6028.758849645965, 1393.8048673185763, 1465.7947887295786, 1524.4969160177116, 1539.9769003464958, 1550.2326348457361, 941.7316064921464, 946.9384490008127, 969.3602222533094, 982.8230918434607, 986.1075726467558, 5701.0, 5701.515371193495, 5718.571107166979, 5736.42635736423, 5752.712364381848, 6070.6357618543025, 6085.421884920926, 6096.268447786205, 6096.786612468631, 6119.867824452491, 5581.804636837691, 5674.886502270014, 5690.715464226772, 5698.088305871123, 5749.7700091996685, 3210.6949839765184, 3219.436598595283, 3234.054453566645, 3248.545203671488, 3265.4448743713624, 6123.2652081750475, 6286.277078135981, 6305.180326557518, 6337.524685648503, 6350.110984462087, 6249.812505624838, 6256.7810126645345, 6263.217097862767, 6267.2792628847355, 6289.7484100635465, 6314.526410519229, 6352.14246076783, 6359.904601430982, 6368.0, 6382.0, 5914.4381283777975, 6225.785971735468, 6244.344343843831, 6252.656103914328, 6270.780522681866, 6149.815505534841, 6191.133241346125, 6192.411720886508, 6210.503159747119, 6234.594751341148, 6298.559100863079, 6453.09656648079, 6491.642959637265, 6492.64290464029, 6509.576877502947, 4252.213340532012, 4272.700910936204, 4298.3552467130185, 4299.634531064895, 4307.353896915488, 6092.817215483543, 6208.782692605737, 6223.222097237845, 6241.188645476059, 6251.4061164189325, 6047.879042419039, 6065.909011364922, 6071.180390647206, 6077.604955678044, 6094.939050609614, 6009.399060093956, 6065.120557519223, 6072.05883088122, 6082.391760823883, 6100.389961003864, 5650.23721797552, 5773.682447465262, 5857.677827719516, 5940.821775346746, 5968.432998865101, 6102.084687296763, 6104.236970378703, 6105.48103411215, 6122.326544080237, 6138.662373569497, 5827.475527202572, 5961.105834124743, 5970.373110823301, 5983.820485385445, 5988.664420875774], "value": 4533.016709065001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.0325927923338, 751.5603372027364, 783.6199443270013, 849.7833052571593, 896.1128482802026, 14721.0, 14726.484573039947, 15067.095974241525, 15097.471588494405, 15131.31909064092, 14051.648708782286, 14092.43630254791, 14124.0, 14125.929370353133, 14140.505082322095, 698.0332239847822, 810.9513429194267, 817.3502065857642, 837.1377481194379, 841.6633346661323, 845.0999685335098, 846.6063280574532, 846.6317152038852, 847.9915200848005, 849.8385306791721, 876.3909083187187, 878.2139984713677, 879.2218886285651, 879.2570278115014, 879.5162660536711, 732.9157146928092, 850.4387104511025, 871.6644092024616, 872.5419154943642, 873.1268731268731, 625.4464798653179, 630.6878095342789, 632.1055706175756, 632.667849379075, 632.7943418389042, 14465.13209207451, 14468.421263149461, 14591.197484138369, 14596.197209153492, 14598.635034124125, 13648.590542283748, 13689.794653080211, 13876.653083672989, 13964.168131851668, 14026.92986535071, 11420.828687569694, 11455.828162577567, 11513.539458421654, 11528.884711152949, 11773.705657358549, 3841.519810023747, 3908.6482216600643, 3920.803959802027, 3932.803359831997, 4016.979915100435, 51729.20243328827, 52371.73814130943, 52722.736386317825, 53132.0, 53337.46662533364, 11235.213535052631, 11269.774604507864, 11357.148213883991, 11415.372154531415, 11447.484863181176, 19223.61552768937, 19646.21415143407, 19664.60670786576, 19734.60530789405, 19884.0, 8337.416380853281, 8458.577071146417, 8545.401821872409, 8583.65665373378, 8721.476711397336, 4819.903601927942, 4848.490908454632, 4850.248211527219, 4967.602591792648, 4974.875628109254, 3300.5214243934497, 3356.295178012596, 3374.0, 3391.8304084795664, 3396.6942975132356, 515.4767910570773, 582.8018473718871, 596.8448203467043, 640.4908098062052, 645.7772068636312, 611.9938800612026, 729.0846322629851, 750.4446709434978, 765.2309429023907, 770.3875419041875, 8330.166983301622, 8558.315334773204, 8657.27737073052, 8681.869771953427, 8731.60707768152, 715.6779449247755, 726.6512074204305, 737.2075019354108, 739.7780665800238, 750.5909279442717, 4106.301928672133, 4130.607592278729, 4165.604267594574, 4168.895777605523, 4226.450561426995, 60316.0, 61914.0, 62030.37969620336, 62320.68839655773, 62787.6860615694, 53375.46624533705, 53923.0, 54065.0, 54178.458215418126, 55654.0, 51423.7428812861, 51712.48287517077, 51741.48258517367, 52435.73782131141, 52923.47076529185, 8758.0, 8975.730728078168, 9023.684171053981, 9095.49974751395, 9124.771880703036, 29779.70220297856, 30384.84807575948, 30484.695153048186, 30721.391791231494, 30982.380352393277, 43763.78118109389, 44048.55951440445, 45397.54602454065, 46497.18785151856, 47298.76350618225, 12394.566190183301, 12409.689757756129, 12528.87471125277, 12599.43302551369, 12779.680507987374, 13854.0, 13970.231637259642, 14531.92734036323, 14782.48261310849, 14822.25888705582, 9886.752831179278, 11383.43082845871, 11699.88300116988, 11766.88233117658, 11983.580574679845, 12704.428300726304, 12876.678083047998, 12960.805587916, 12984.805227921777, 13088.149270297401, 11903.285802851857, 12146.817797733218, 12224.083193760325, 12426.937865310616, 12846.678833028875, 10255.7436064099, 10364.119049880845, 10631.468426578795, 10697.358158510515, 11132.220744547803, 9697.096656741167, 10736.892631073903, 11264.774704506028, 11272.66182014541, 11283.830742538705], "value": 6759.262994264904, "unit": "score"}], "name": "dromaeo_css", "value": 6985.122429641092, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 110.0, 111.0, 112.0, 101.0, 111.0, 110.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 154.0, 176.0, 135.0, 154.0, 160.0, 127.0, 188.0, 129.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 126.0, 104.0, 77.0, 72.0, 71.0, 146.0, 100.0, 72.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 94.0, 92.0, 93.0, 145.0, 93.0, 93.0, 155.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 57.0, 57.0, 64.0, 60.0, 82.0, 54.0, 54.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 77.0, 76.0, 76.0, 78.0, 76.0, 77.0, 77.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 127.0, 123.0, 123.0, 126.0, 128.0, 126.0, 158.0, 126.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 168.0, 164.0, 170.0, 171.0, 164.0, 170.0, 166.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 68.0, 68.0, 70.0, 69.0, 70.0, 68.0, 67.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1541.0000000000002, "alertThreshold": 2.0}]} 17:30:56 INFO - Return code: 0 17:30:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:56 ERROR - # TBPL SUCCESS # 17:30:56 INFO - Running post-action listener: _resource_record_post_action 17:30:56 INFO - Running post-run listener: _resource_record_post_run 17:30:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536006656; Read time: 16; Write time: 503484 17:30:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244793344; Read time: 0; Write time: 305416 17:30:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291213312; Read time: 16; Write time: 198068 17:30:57 INFO - Running post-run listener: _upload_blobber_files 17:30:57 INFO - Blob upload gear active. 17:30:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:30:57 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'] 17:30:57 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 17:30:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:58 INFO - (blobuploader) - INFO - Done attempting. 17:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:59 INFO - (blobuploader) - INFO - Done attempting. 17:30:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:59 INFO - Return code: 0 17:30:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123c3ac9502af0271ca43dab21b0264990d3ee8d95bfc121d9597226b67d1e954064f9767169531a75e8ae0de5f2772c5f9de8ede5c75e90aad53d5ba0905dd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cee1c65f3ca6854b0dad0aa59ac71d3f9672975627ed5ad5af8cd7a5f91b1c5e9948d9d6f014415549bbc4f6d0c423110a9bcff60ffd504d702615e901f05225"} 17:30:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:59 INFO - Contents: 17:30:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123c3ac9502af0271ca43dab21b0264990d3ee8d95bfc121d9597226b67d1e954064f9767169531a75e8ae0de5f2772c5f9de8ede5c75e90aad53d5ba0905dd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cee1c65f3ca6854b0dad0aa59ac71d3f9672975627ed5ad5af8cd7a5f91b1c5e9948d9d6f014415549bbc4f6d0c423110a9bcff60ffd504d702615e901f05225"} 17:30:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:59 INFO - Copying logs to upload dir... 17:30:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.234287 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-22 17:30:59.278757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:59.286293) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 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/123c3ac9502af0271ca43dab21b0264990d3ee8d95bfc121d9597226b67d1e954064f9767169531a75e8ae0de5f2772c5f9de8ede5c75e90aad53d5ba0905dd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cee1c65f3ca6854b0dad0aa59ac71d3f9672975627ed5ad5af8cd7a5f91b1c5e9948d9d6f014415549bbc4f6d0c423110a9bcff60ffd504d702615e901f05225"} build_url:https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123c3ac9502af0271ca43dab21b0264990d3ee8d95bfc121d9597226b67d1e954064f9767169531a75e8ae0de5f2772c5f9de8ede5c75e90aad53d5ba0905dd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cee1c65f3ca6854b0dad0aa59ac71d3f9672975627ed5ad5af8cd7a5f91b1c5e9948d9d6f014415549bbc4f6d0c423110a9bcff60ffd504d702615e901f05225"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:59.316061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:59.316458) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461370148.130611-1258638837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:59.398971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:30:59.399330) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:30:59.399666) ========= ========= Total master_lag: 0.20 =========