builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1467073094.73 results: success (0) buildid: 20160627144420 builduid: 4360f4d245a549be90444bafc60905d0 revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.733349) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.733828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.734109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.749365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.749792) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 17:18:14-- 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% 24.2M=0s 2016-06-27 17:18:14 (24.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.848125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.848549) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020083 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.898414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:14.898787) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 17:18:14,924 truncating revision to first 12 chars 2016-06-27 17:18:14,924 Setting DEBUG logging. 2016-06-27 17:18:14,924 attempt 1/10 2016-06-27 17:18:14,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/676a32cdd41f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 17:18:15,388 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.787244 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:15.700087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:15.700456) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:15.700917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:15.701192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:15.712677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-27 17:18:15.713099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:18:15 INFO - MultiFileLogger online at 20160627 17:18:15 in /builds/slave/test 17:18:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:18:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:15 INFO - {'append_to_log': False, 17:18:15 INFO - 'base_work_dir': '/builds/slave/test', 17:18:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:18:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:15 INFO - 'branch': 'Mozilla-Beta', 17:18:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:15 INFO - 'config_files': ('talos/linux_config.py',), 17:18:15 INFO - 'default_actions': ('clobber', 17:18:15 INFO - 'read-buildbot-config', 17:18:15 INFO - 'download-and-extract', 17:18:15 INFO - 'populate-webroot', 17:18:15 INFO - 'create-virtualenv', 17:18:15 INFO - 'install', 17:18:15 INFO - 'run-tests'), 17:18:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:15 INFO - 'download_minidump_stackwalk': True, 17:18:15 INFO - 'download_symbols': 'ondemand', 17:18:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:15 INFO - 'installer_path': 'installer.exe', 17:18:15 INFO - 'log_level': 'info', 17:18:15 INFO - 'log_name': 'talos', 17:18:15 INFO - 'log_to_console': True, 17:18:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:18:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:18:15 INFO - 'opt_config_files': (), 17:18:15 INFO - 'pip_index': False, 17:18:15 INFO - 'sps_profile': False, 17:18:15 INFO - 'sps_profile_interval': 0, 17:18:15 INFO - 'suite': 'dromaeojs-e10s', 17:18:15 INFO - 'system_bits': '32', 17:18:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:15 INFO - 'title': 'talos-linux64-ix-013', 17:18:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:15 INFO - 'use_talos_json': True, 17:18:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:15 INFO - 'work_dir': 'build'} 17:18:15 INFO - ##### 17:18:15 INFO - ##### Running clobber step. 17:18:15 INFO - ##### 17:18:15 INFO - Running pre-action listener: _resource_record_pre_action 17:18:15 INFO - Running main action method: clobber 17:18:15 INFO - rmtree: /builds/slave/test/build 17:18:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:16 INFO - Running post-action listener: _resource_record_post_action 17:18:16 INFO - ##### 17:18:16 INFO - ##### Running read-buildbot-config step. 17:18:16 INFO - ##### 17:18:16 INFO - Running pre-action listener: _resource_record_pre_action 17:18:16 INFO - Running main action method: read_buildbot_config 17:18:16 INFO - Using buildbot properties: 17:18:16 INFO - { 17:18:16 INFO - "project": "", 17:18:16 INFO - "product": "firefox", 17:18:16 INFO - "script_repo_revision": "production", 17:18:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:18:16 INFO - "repository": "", 17:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:18:16 INFO - "buildid": "20160627144420", 17:18:16 INFO - "pgo_build": "True", 17:18:16 INFO - "basedir": "/builds/slave/test", 17:18:16 INFO - "buildnumber": 63, 17:18:16 INFO - "slavename": "talos-linux64-ix-013", 17:18:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:18:16 INFO - "platform": "ubuntu64_hw", 17:18:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:18:16 INFO - "branch": "mozilla-beta", 17:18:16 INFO - "repo_path": "releases/mozilla-beta", 17:18:16 INFO - "revision": "676a32cdd41fd372f4c6df3a4954939f73a6ef02", 17:18:16 INFO - "stage_platform": "linux64-pgo", 17:18:16 INFO - "builduid": "4360f4d245a549be90444bafc60905d0", 17:18:16 INFO - "slavebuilddir": "test" 17:18:16 INFO - } 17:18:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 17:18:16 INFO - Running post-action listener: _resource_record_post_action 17:18:16 INFO - ##### 17:18:16 INFO - ##### Running download-and-extract step. 17:18:16 INFO - ##### 17:18:16 INFO - Running pre-action listener: _resource_record_pre_action 17:18:16 INFO - Running main action method: download_and_extract 17:18:16 INFO - mkdir: /builds/slave/test/build/tests 17:18:16 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:18:16 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:18:16 INFO - Downloaded 1327 bytes. 17:18:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:16 INFO - Using the following test package requirements: 17:18:16 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:18:16 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:18:16 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 17:18:16 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'jsshell-linux-x86_64.zip'], 17:18:16 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:18:16 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:18:16 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 17:18:16 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 17:18:16 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:18:16 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:16 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:18:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:18:16 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:18:16 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:18 INFO - Downloaded 24236181 bytes. 17:18:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:18:19 INFO - Return code: 0 17:18:19 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:19 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:21 INFO - Downloaded 24236181 bytes. 17:18:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:18:22 INFO - Return code: 0 17:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:22 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:18:24 INFO - Downloaded 10840145 bytes. 17:18:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:18:24 INFO - Return code: 0 17:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:24 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:18:25 INFO - Downloaded 56013298 bytes. 17:18:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:25 INFO - mkdir: /builds/slave/test/properties 17:18:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:25 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:25 INFO - Contents: 17:18:25 INFO - build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:26 INFO - Running post-action listener: _resource_record_post_action 17:18:26 INFO - Running post-action listener: set_extra_try_arguments 17:18:26 INFO - ##### 17:18:26 INFO - ##### Running populate-webroot step. 17:18:26 INFO - ##### 17:18:26 INFO - Running pre-action listener: _resource_record_pre_action 17:18:26 INFO - Running main action method: populate_webroot 17:18:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:26 INFO - '--tppagecycles', 17:18:26 INFO - '7'], 17:18:26 INFO - 'tests': ['tsvgm']}}, 17:18:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['damp', 'tps']}, 17:18:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['damp', 'tps']}, 17:18:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['dromaeo_dom']}, 17:18:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['a11yr', 17:18:26 INFO - 'ts_paint', 17:18:26 INFO - 'tpaint', 17:18:26 INFO - 'sessionrestore', 17:18:26 INFO - 'sessionrestore_no_auto_restore', 17:18:26 INFO - 'tabpaint']}, 17:18:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tsvgx', 17:18:26 INFO - 'tsvgr_opacity', 17:18:26 INFO - 'tart', 17:18:26 INFO - 'tscrollx', 17:18:26 INFO - 'cart']}, 17:18:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:26 INFO - 'tsvgr_opacity', 17:18:26 INFO - 'tart', 17:18:26 INFO - 'tscrollx', 17:18:26 INFO - 'cart']}, 17:18:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s'], 17:18:26 INFO - 'tests': ['tp5o']}, 17:18:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'tests': ['tp5o']}, 17:18:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--disable-e10s', 17:18:26 INFO - '--xperf_path', 17:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:26 INFO - 'tests': ['tp5n']}, 17:18:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:26 INFO - 'talos_options': ['--xperf_path', 17:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:26 INFO - 'tests': ['tp5n']}}, 17:18:26 INFO - 'talos.zip': {'path': '', 17:18:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:26 INFO - Running post-action listener: _resource_record_post_action 17:18:26 INFO - ##### 17:18:26 INFO - ##### Running create-virtualenv step. 17:18:26 INFO - ##### 17:18:26 INFO - Running pre-action listener: _resource_record_pre_action 17:18:26 INFO - Running main action method: create_virtualenv 17:18:26 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:26 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:18:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:26 INFO - Using real prefix '/usr' 17:18:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:29 INFO - Installing pip.................done. 17:18:29 INFO - Return code: 0 17:18:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18:29 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:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:29 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:18:29 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:18:29 INFO - Using env: {'DISPLAY': ':0', 17:18:29 INFO - 'HOME': '/home/cltbld', 17:18:29 INFO - 'LANG': 'en_US.UTF-8', 17:18:29 INFO - 'LANGUAGE': 'en_US:en', 17:18:29 INFO - 'LOGNAME': 'cltbld', 17:18:29 INFO - 'MAIL': '/var/mail/cltbld', 17:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:29 INFO - 'MOZ_NO_REMOTE': '1', 17:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:29 INFO - 'NO_EM_RESTART': '1', 17:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:29 INFO - 'PWD': '/builds/slave/test', 17:18:29 INFO - 'SHELL': '/bin/bash', 17:18:29 INFO - 'SHLVL': '1', 17:18:29 INFO - 'TERM': 'linux', 17:18:29 INFO - 'TMOUT': '86400', 17:18:29 INFO - 'USER': 'cltbld', 17:18:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:29 INFO - '_': '/tools/buildbot/bin/python'} 17:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:29 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:18:29 INFO - Cleaning up... 17:18:29 INFO - Return code: 0 17:18:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:18:29 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:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:29 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:18:29 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:18:29 INFO - Using env: {'DISPLAY': ':0', 17:18:29 INFO - 'HOME': '/home/cltbld', 17:18:29 INFO - 'LANG': 'en_US.UTF-8', 17:18:29 INFO - 'LANGUAGE': 'en_US:en', 17:18:29 INFO - 'LOGNAME': 'cltbld', 17:18:29 INFO - 'MAIL': '/var/mail/cltbld', 17:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:29 INFO - 'MOZ_NO_REMOTE': '1', 17:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:29 INFO - 'NO_EM_RESTART': '1', 17:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:29 INFO - 'PWD': '/builds/slave/test', 17:18:29 INFO - 'SHELL': '/bin/bash', 17:18:29 INFO - 'SHLVL': '1', 17:18:29 INFO - 'TERM': 'linux', 17:18:29 INFO - 'TMOUT': '86400', 17:18:29 INFO - 'USER': 'cltbld', 17:18:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:29 INFO - '_': '/tools/buildbot/bin/python'} 17:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:29 INFO - Downloading/unpacking psutil>=0.7.1 17:18:29 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:18:29 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:18:29 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:18:29 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:18:29 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:18:29 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:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:32 INFO - Installing collected packages: psutil 17:18:32 INFO - Running setup.py install for psutil 17:18:32 INFO - building 'psutil._psutil_linux' extension 17:18:32 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:18:32 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:18:32 INFO - building 'psutil._psutil_posix' extension 17:18:32 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:18:32 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:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:32 INFO - Successfully installed psutil 17:18:32 INFO - Cleaning up... 17:18:32 INFO - Return code: 0 17:18:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:18: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:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:32 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:32 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:18:32 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:18:32 INFO - Using env: {'DISPLAY': ':0', 17:18:32 INFO - 'HOME': '/home/cltbld', 17:18:32 INFO - 'LANG': 'en_US.UTF-8', 17:18:32 INFO - 'LANGUAGE': 'en_US:en', 17:18:32 INFO - 'LOGNAME': 'cltbld', 17:18:32 INFO - 'MAIL': '/var/mail/cltbld', 17:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:32 INFO - 'MOZ_NO_REMOTE': '1', 17:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:32 INFO - 'NO_EM_RESTART': '1', 17:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:32 INFO - 'PWD': '/builds/slave/test', 17:18:32 INFO - 'SHELL': '/bin/bash', 17:18:32 INFO - 'SHLVL': '1', 17:18:32 INFO - 'TERM': 'linux', 17:18:32 INFO - 'TMOUT': '86400', 17:18:32 INFO - 'USER': 'cltbld', 17:18:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:32 INFO - '_': '/tools/buildbot/bin/python'} 17:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:18:32 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:18:32 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:18:32 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:18:32 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:18:32 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:18:32 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:18:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18:34 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:18:34 INFO - Installing collected packages: mozsystemmonitor 17:18:34 INFO - Running setup.py install for mozsystemmonitor 17:18:35 INFO - Successfully installed mozsystemmonitor 17:18:35 INFO - Cleaning up... 17:18:35 INFO - Return code: 0 17:18:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:18:35 INFO - Using env: {'DISPLAY': ':0', 17:18:35 INFO - 'HOME': '/home/cltbld', 17:18:35 INFO - 'LANG': 'en_US.UTF-8', 17:18:35 INFO - 'LANGUAGE': 'en_US:en', 17:18:35 INFO - 'LOGNAME': 'cltbld', 17:18:35 INFO - 'MAIL': '/var/mail/cltbld', 17:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:35 INFO - 'MOZ_NO_REMOTE': '1', 17:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:35 INFO - 'NO_EM_RESTART': '1', 17:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:35 INFO - 'PWD': '/builds/slave/test', 17:18:35 INFO - 'SHELL': '/bin/bash', 17:18:35 INFO - 'SHLVL': '1', 17:18:35 INFO - 'TERM': 'linux', 17:18:35 INFO - 'TMOUT': '86400', 17:18:35 INFO - 'USER': 'cltbld', 17:18:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:35 INFO - '_': '/tools/buildbot/bin/python'} 17:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:38 INFO - Downloading docopt-0.6.1.tar.gz 17:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:38 INFO - Running setup.py install for blobuploader 17:18:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:38 INFO - Running setup.py install for requests 17:18:39 INFO - Running setup.py install for docopt 17:18:39 INFO - Successfully installed blobuploader requests docopt 17:18:39 INFO - Cleaning up... 17:18:39 INFO - Return code: 0 17:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:39 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:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:39 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:18:39 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:18:39 INFO - Using env: {'DISPLAY': ':0', 17:18:39 INFO - 'HOME': '/home/cltbld', 17:18:39 INFO - 'LANG': 'en_US.UTF-8', 17:18:39 INFO - 'LANGUAGE': 'en_US:en', 17:18:39 INFO - 'LOGNAME': 'cltbld', 17:18:39 INFO - 'MAIL': '/var/mail/cltbld', 17:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:39 INFO - 'MOZ_NO_REMOTE': '1', 17:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:39 INFO - 'NO_EM_RESTART': '1', 17:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:39 INFO - 'PWD': '/builds/slave/test', 17:18:39 INFO - 'SHELL': '/bin/bash', 17:18:39 INFO - 'SHLVL': '1', 17:18:39 INFO - 'TERM': 'linux', 17:18:39 INFO - 'TMOUT': '86400', 17:18:39 INFO - 'USER': 'cltbld', 17:18:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:39 INFO - '_': '/tools/buildbot/bin/python'} 17:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:39 INFO - Running setup.py (path:/tmp/pip-Afes32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:39 INFO - Running setup.py (path:/tmp/pip-_GwhfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:39 INFO - Running setup.py (path:/tmp/pip-6Rn9AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:39 INFO - Running setup.py (path:/tmp/pip-hnmqFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:39 INFO - Running setup.py (path:/tmp/pip-jDQ56o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:39 INFO - Running setup.py (path:/tmp/pip-UVC_wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:39 INFO - Running setup.py (path:/tmp/pip-eqEb9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:40 INFO - Running setup.py (path:/tmp/pip-DVm15w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:40 INFO - Running setup.py (path:/tmp/pip-VVumTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:40 INFO - Running setup.py (path:/tmp/pip-TOgbKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:40 INFO - Running setup.py (path:/tmp/pip-p9Rk0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:40 INFO - Running setup.py (path:/tmp/pip-rUSZif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:40 INFO - Running setup.py (path:/tmp/pip-nmy13P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:40 INFO - Running setup.py (path:/tmp/pip-lAtPCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:40 INFO - Running setup.py (path:/tmp/pip-93_Wy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:40 INFO - Running setup.py (path:/tmp/pip-6yGKOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:40 INFO - Running setup.py (path:/tmp/pip-Q6SIX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:40 INFO - Running setup.py install for manifestparser 17:18:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:40 INFO - Running setup.py install for mozcrash 17:18:40 INFO - Running setup.py install for mozdebug 17:18:41 INFO - Running setup.py install for mozdevice 17:18:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for mozfile 17:18:41 INFO - Running setup.py install for mozhttpd 17:18:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for mozinfo 17:18:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for mozInstall 17:18:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for mozleak 17:18:41 INFO - Running setup.py install for mozlog 17:18:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for moznetwork 17:18:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:41 INFO - Running setup.py install for mozprocess 17:18:41 INFO - Running setup.py install for mozprofile 17:18:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozrunner 17:18:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozscreenshot 17:18:42 INFO - Running setup.py install for moztest 17:18:42 INFO - Running setup.py install for mozversion 17:18:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:42 INFO - Cleaning up... 17:18:42 INFO - Return code: 0 17:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:42 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:42 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:18:42 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:18:42 INFO - Using env: {'DISPLAY': ':0', 17:18:42 INFO - 'HOME': '/home/cltbld', 17:18:42 INFO - 'LANG': 'en_US.UTF-8', 17:18:42 INFO - 'LANGUAGE': 'en_US:en', 17:18:42 INFO - 'LOGNAME': 'cltbld', 17:18:42 INFO - 'MAIL': '/var/mail/cltbld', 17:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:42 INFO - 'MOZ_NO_REMOTE': '1', 17:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:42 INFO - 'NO_EM_RESTART': '1', 17:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:42 INFO - 'PWD': '/builds/slave/test', 17:18:42 INFO - 'SHELL': '/bin/bash', 17:18:42 INFO - 'SHLVL': '1', 17:18:42 INFO - 'TERM': 'linux', 17:18:42 INFO - 'TMOUT': '86400', 17:18:42 INFO - 'USER': 'cltbld', 17:18:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:42 INFO - '_': '/tools/buildbot/bin/python'} 17:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:42 INFO - Running setup.py (path:/tmp/pip-UcGupG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:42 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:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:42 INFO - Running setup.py (path:/tmp/pip-rsMh7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:42 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:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:42 INFO - Running setup.py (path:/tmp/pip-cPZlBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:42 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:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:42 INFO - Running setup.py (path:/tmp/pip-ntLMKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:42 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:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:43 INFO - Running setup.py (path:/tmp/pip-RCsLxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:43 INFO - Running setup.py (path:/tmp/pip-OZmZsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:43 INFO - Running setup.py (path:/tmp/pip-AeCN6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:43 INFO - Running setup.py (path:/tmp/pip-Kz1aiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:43 INFO - Running setup.py (path:/tmp/pip-1wQr3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:43 INFO - Running setup.py (path:/tmp/pip-jNCXSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:43 INFO - Running setup.py (path:/tmp/pip-UtY5QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:43 INFO - Running setup.py (path:/tmp/pip-cOWP7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:43 INFO - Running setup.py (path:/tmp/pip-0I_8FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:43 INFO - Running setup.py (path:/tmp/pip-cHYEoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:43 INFO - Running setup.py (path:/tmp/pip-UliMbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:43 INFO - Running setup.py (path:/tmp/pip-deRews-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:43 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:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:43 INFO - Running setup.py (path:/tmp/pip-R0F7dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:43 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:18:43 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:18:43 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:18:43 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:18:43 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:18:43 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:18:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:46 INFO - Downloading blessings-1.6.tar.gz 17:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:46 INFO - Installing collected packages: blessings 17:18:46 INFO - Running setup.py install for blessings 17:18:46 INFO - Successfully installed blessings 17:18:46 INFO - Cleaning up... 17:18:46 INFO - Return code: 0 17:18:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:46 INFO - Reading from file tmpfile_stdout 17:18:46 INFO - Current package versions: 17:18:46 INFO - argparse == 1.2.1 17:18:46 INFO - blessings == 1.6 17:18:46 INFO - blobuploader == 1.2.4 17:18:46 INFO - docopt == 0.6.1 17:18:46 INFO - manifestparser == 1.1 17:18:46 INFO - mozInstall == 1.12 17:18:46 INFO - mozcrash == 0.17 17:18:46 INFO - mozdebug == 0.1 17:18:46 INFO - mozdevice == 0.48 17:18:46 INFO - mozfile == 1.2 17:18:46 INFO - mozhttpd == 0.7 17:18:46 INFO - mozinfo == 0.9 17:18:46 INFO - mozleak == 0.1 17:18:46 INFO - mozlog == 3.1 17:18:46 INFO - moznetwork == 0.27 17:18:46 INFO - mozprocess == 0.22 17:18:46 INFO - mozprofile == 0.28 17:18:46 INFO - mozrunner == 6.11 17:18:46 INFO - mozscreenshot == 0.1 17:18:46 INFO - mozsystemmonitor == 0.0 17:18:46 INFO - moztest == 0.7 17:18:46 INFO - mozversion == 1.4 17:18:46 INFO - psutil == 3.1.1 17:18:46 INFO - requests == 1.2.3 17:18:46 INFO - wsgiref == 0.1.2 17:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:46 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 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:46 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:18:46 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:18:46 INFO - Using env: {'DISPLAY': ':0', 17:18:46 INFO - 'HOME': '/home/cltbld', 17:18:46 INFO - 'LANG': 'en_US.UTF-8', 17:18:46 INFO - 'LANGUAGE': 'en_US:en', 17:18:46 INFO - 'LOGNAME': 'cltbld', 17:18:46 INFO - 'MAIL': '/var/mail/cltbld', 17:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:46 INFO - 'MOZ_NO_REMOTE': '1', 17:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:46 INFO - 'NO_EM_RESTART': '1', 17:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:46 INFO - 'PWD': '/builds/slave/test', 17:18:46 INFO - 'SHELL': '/bin/bash', 17:18:46 INFO - 'SHLVL': '1', 17:18:46 INFO - 'TERM': 'linux', 17:18:46 INFO - 'TMOUT': '86400', 17:18:46 INFO - 'USER': 'cltbld', 17:18:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:46 INFO - '_': '/tools/buildbot/bin/python'} 17:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 INFO - Cleaning up... 17:18:46 INFO - Return code: 0 17:18:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18: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:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18: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', 'jsonschema'] in /builds/slave/test/build 17:18: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 jsonschema 17:18:46 INFO - Using env: {'DISPLAY': ':0', 17:18:46 INFO - 'HOME': '/home/cltbld', 17:18:46 INFO - 'LANG': 'en_US.UTF-8', 17:18:46 INFO - 'LANGUAGE': 'en_US:en', 17:18:46 INFO - 'LOGNAME': 'cltbld', 17:18:46 INFO - 'MAIL': '/var/mail/cltbld', 17:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:46 INFO - 'MOZ_NO_REMOTE': '1', 17:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:46 INFO - 'NO_EM_RESTART': '1', 17:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:46 INFO - 'PWD': '/builds/slave/test', 17:18:46 INFO - 'SHELL': '/bin/bash', 17:18:46 INFO - 'SHLVL': '1', 17:18:46 INFO - 'TERM': 'linux', 17:18:46 INFO - 'TMOUT': '86400', 17:18:46 INFO - 'USER': 'cltbld', 17:18:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:46 INFO - '_': '/tools/buildbot/bin/python'} 17:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:46 INFO - Downloading/unpacking jsonschema 17:18: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:18: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:18: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:18: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:18: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:18: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:18:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:49 INFO - warning: no files found matching '*.txt' 17:18:49 INFO - no previously-included directories found matching 'build' 17:18:49 INFO - no previously-included directories found matching 'dist' 17:18:49 INFO - no previously-included directories found matching '.git*' 17:18:49 INFO - Installing collected packages: jsonschema, functools32 17:18:49 INFO - Running setup.py install for functools32 17:18:49 INFO - warning: no files found matching '*.txt' 17:18:49 INFO - no previously-included directories found matching 'build' 17:18:49 INFO - no previously-included directories found matching 'dist' 17:18:49 INFO - no previously-included directories found matching '.git*' 17:18:49 INFO - Successfully installed jsonschema functools32 17:18:49 INFO - Cleaning up... 17:18:49 INFO - Return code: 0 17:18:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265d283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', '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:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:18:49 INFO - Using env: {'DISPLAY': ':0', 17:18:49 INFO - 'HOME': '/home/cltbld', 17:18:49 INFO - 'LANG': 'en_US.UTF-8', 17:18:49 INFO - 'LANGUAGE': 'en_US:en', 17:18:49 INFO - 'LOGNAME': 'cltbld', 17:18:49 INFO - 'MAIL': '/var/mail/cltbld', 17:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:49 INFO - 'MOZ_NO_REMOTE': '1', 17:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:49 INFO - 'NO_EM_RESTART': '1', 17:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:49 INFO - 'PWD': '/builds/slave/test', 17:18:49 INFO - 'SHELL': '/bin/bash', 17:18:49 INFO - 'SHLVL': '1', 17:18:49 INFO - 'TERM': 'linux', 17:18:49 INFO - 'TMOUT': '86400', 17:18:49 INFO - 'USER': 'cltbld', 17:18:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:49 INFO - '_': '/tools/buildbot/bin/python'} 17:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:49 INFO - Downloading/unpacking flake8 17:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:52 INFO - no previously-included directories found matching 'docs/_build' 17:18:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:52 INFO - Running setup.py install for pep8 17:18:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:52 INFO - no previously-included directories found matching 'docs/_build' 17:18:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:18:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:52 INFO - Cleaning up... 17:18:52 INFO - Return code: 0 17:18:52 INFO - Running post-action listener: _resource_record_post_action 17:18:52 INFO - Running post-action listener: _start_resource_monitoring 17:18:52 INFO - Starting resource monitoring. 17:18:52 INFO - ##### 17:18:52 INFO - ##### Running install step. 17:18:52 INFO - ##### 17:18:52 INFO - Running pre-action listener: _resource_record_pre_action 17:18:52 INFO - Running main action method: install 17:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:52 INFO - Reading from file tmpfile_stdout 17:18:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:52 INFO - Reading from file tmpfile_stdout 17:18:52 INFO - Output received: 17:18:52 INFO - Usage: mozinstall [options] installer 17:18:52 INFO - Options: 17:18:52 INFO - -h, --help show this help message and exit 17:18:52 INFO - -d DEST, --destination=DEST 17:18:52 INFO - Directory to install application into. [default: 17:18:52 INFO - "/builds/slave/test"] 17:18:52 INFO - --app=APP Application being installed. [default: firefox] 17:18:52 INFO - mkdir: /builds/slave/test/build/application 17:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:19:05 INFO - Reading from file tmpfile_stdout 17:19:05 INFO - Output received: 17:19:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:19:05 INFO - Running post-action listener: _resource_record_post_action 17:19:05 INFO - ##### 17:19:05 INFO - ##### Running run-tests step. 17:19:05 INFO - ##### 17:19:05 INFO - Running pre-action listener: _resource_record_pre_action 17:19:05 INFO - Running main action method: run_tests 17:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:05 INFO - Python 2.7.3 17:19:05 INFO - Return code: 0 17:19:05 INFO - grabbing minidump binary from tooltool 17:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:05 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 0x16b8410>, '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 0x16b9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:05 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:19:05 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:19:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:05 INFO - Return code: 0 17:19:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:19:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:19:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:19:06 INFO - Return code: 0 17:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:19:06 INFO - Using env: {'DISPLAY': ':0', 17:19:06 INFO - 'HOME': '/home/cltbld', 17:19:06 INFO - 'LANG': 'en_US.UTF-8', 17:19:06 INFO - 'LANGUAGE': 'en_US:en', 17:19:06 INFO - 'LOGNAME': 'cltbld', 17:19:06 INFO - 'MAIL': '/var/mail/cltbld', 17:19:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:06 INFO - 'MOZ_NO_REMOTE': '1', 17:19:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:06 INFO - 'NO_EM_RESTART': '1', 17:19:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:06 INFO - 'PWD': '/builds/slave/test', 17:19:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:06 INFO - 'SHELL': '/bin/bash', 17:19:06 INFO - 'SHLVL': '1', 17:19:06 INFO - 'TERM': 'linux', 17:19:06 INFO - 'TMOUT': '86400', 17:19:06 INFO - 'USER': 'cltbld', 17:19:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415', 17:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:06 INFO - '_': '/tools/buildbot/bin/python'} 17:19:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:19:07 INFO - mozversion application_buildid: 20160627144420 17:19:07 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 17:19:07 INFO - mozversion application_display_name: Firefox 17:19:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:07 INFO - mozversion application_name: Firefox 17:19:07 INFO - mozversion application_remotingname: firefox 17:19:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:19:07 INFO - mozversion application_vendor: Mozilla 17:19:07 INFO - mozversion application_version: 48.0 17:19:07 INFO - mozversion platform_buildid: 20160627144420 17:19:07 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 17:19:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:19:07 INFO - mozversion platform_version: 48.0 17:19:07 INFO - using testdate: 1467073147 17:19:07 INFO - actual date: 1467073147 17:19:07 INFO - starting webserver on 'localhost:38311' 17:19:07 INFO - SUITE-START | Running 2 tests 17:19:07 INFO - TEST-START | dromaeo_css 17:19:07 INFO - operating with platform_type : linux_ 17:19:07 INFO - Initialising browser for dromaeo_css test... 17:19:07 INFO - TEST-INFO | started process 9142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBh_96X/profile http://localhost:38311/getInfo.html) 17:19:11 INFO - PROCESS | 9142 | 17:19:11 INFO - PROCESS | 9142 | (process:9218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:11 INFO - PROCESS | 9142 | __metrics Screen width/height:1600/1200 17:19:11 INFO - PROCESS | 9142 | colorDepth:24 17:19:11 INFO - PROCESS | 9142 | Browser inner width/height: 1024/697 17:19:11 INFO - PROCESS | 9142 | __metrics 17:19:12 ERROR - PROCESS | 9142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:19:13 INFO - TEST-INFO | 9142: exit 0 17:19:13 INFO - Browser initialized. 17:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:13 INFO - TEST-INFO | started process 9269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBh_96X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:15 INFO - PROCESS | 9269 | 17:19:15 INFO - PROCESS | 9269 | (process:9337): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:25 INFO - PROCESS | 9269 | RSS: Main: 151134208 17:19:25 INFO - PROCESS | 9269 | 17:20:14 INFO - PROCESS | 9269 | 1467073214816 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:22:22 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38311/tests/dromaeo/cssquery-ext.html) 17:22:23 INFO - PROCESS | 9269 | RSS: Main: 155922432 17:22:23 INFO - PROCESS | 9269 | 17:25:24 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-ext.html (next: http://localhost:38311/tests/dromaeo/cssquery-jquery.html) 17:25:25 INFO - PROCESS | 9269 | RSS: Main: 152834048 17:25:25 INFO - PROCESS | 9269 | 17:28:27 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38311/tests/dromaeo/cssquery-mootools.html) 17:28:27 INFO - PROCESS | 9269 | RSS: Main: 152506368 17:28:27 INFO - PROCESS | 9269 | 17:31:29 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38311/tests/dromaeo/cssquery-prototype.html) 17:31:30 INFO - PROCESS | 9269 | RSS: Main: 154165248 17:31:30 INFO - PROCESS | 9269 | 17:34:32 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38311/tests/dromaeo/cssquery-yui.html) 17:34:33 INFO - PROCESS | 9269 | RSS: Main: 152571904 17:34:33 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:38311/tests/dromaeo/cssquery-yui.html (next: http://localhost:38311/tests/dromaeo/cssquery-dojo.html) 17:37:35 INFO - PROCESS | 9269 | RSS: Main: 156282880 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | __start_tp_report 17:37:35 INFO - PROCESS | 9269 | _x_x_mozilla_page_load 17:37:35 INFO - PROCESS | 9269 | _x_x_mozilla_page_load_details 17:37:35 INFO - PROCESS | 9269 | |i|pagename|runs| 17:37:35 INFO - PROCESS | 9269 | |0;dojo.html;3340.0814775936615;3367.0740546349734;3370.6123795763497;3390.6778856008677;3392.321535692862;5522.806701765439;5557.138643510258;5561.082421400464;5567.164925261208;5596.2165296858475;5545.861353466165;5551.77792888284;5575.721213939297;5601.467860553241;5602.1596760485945;5045.293658887749;5062.341895553592;5120.283160357553;5124.052050370675;5141.717205553693;5058.342415485981;5077.923831142517;5106.285120083191;5139.743012849362;5168.715720635363;5078.898422031557;5092.28707980883;5093.363329583802;5097.184450487923;5122.6158038147105;4951.702897826142;5017.422996355429;5022.673526220784;5035.974820125876;5105.591552675795;4906.092372910987;4935.284383764334;4940.4318503372215;4974.801007959677;4997.475265097185;5404.32445944257;5410.810621628263;5422.593305502063;5437.075697131497;5443.2107344434835;5814.709264536798;5839.678817665027;5896.911546326808;5903.144044113579;5921;6021.6989150542295;6022.277326720821;6024.548158888101;6038.637681739066;6065.150878876961;5619.859503512404;5623.437656234344;5624.662520248758;5625.6905870177125;5634.605577609528;5913.113033045078;6025.397460253939;6064.878702425926;6114.938850611437;6136.263648362135;5818.156367326798;5818.389069147764;5823.679697616672;5828.6211396259105;5853.122031695195;5866.296044474605;5904.704764761745;5905.40945905406;5905.76376944926;5906.49794767441;5784.132380143013;5869.941300587025;5879.794207202727;5998.220231369894;6016.969915150396;5824.475797178275;5836.1245813127525;5842.795502157404;5845.210896528914;5853.5317174625925;4469.865904022885;4475.48531918827;4478.820847166076;4479.932801007987;4483.708558943724;3973.5033120859894;4005.1589166274825;4047.5750046245307;4062.654674352654;4091.284025295561;5557;5577.944220557823;5621.213030175779;5677.744501497443;5811;5967.492763115184;6016.578839481194;6068.605540639845;6071.180390647294;6084.239470066242;5595;5716.828495145152;5765.077587585966;5771.595988280864;5790.044642633919;5023.773930173151;5051.267566202953;5055.9494405055475;5067.594592432597;5104.464031276662;6135.049067394471;6183.288921774054;6184.257889053342;6194.628322300677;6199.938000620026;5824.446677565625;5875.853103672443;5919.7632094717455;5961.463468287875;5988.161657367885;6058.969705151446;6060.424259695322;6063.787767428119;6071.544634152545;6121.693915304306;5640.125780504029;5650.180723794944;5651.321841379061;5671.6597004179885;5697.059985102577;5678.403767604507;5779.595428319977;5887.587868849139;5951.91072133927;6031;5795.855103622274;5803.767849285981;5805.071188609802;5818.796342128006;5820.563457740602;5770.336411312753;5798.652080875161;5818.76724930998;5821.912671309849;5825.970870145622;5611.915821262766;5670.74481648335;5788.305403351625;5793.304803423616;5798.797042103675;5840.182374467663;5846.064629659234;5870.530357571299;5886.646801191942;5886.764529418775;5622.606417550732;5743.023685973478;5751.913721294268;5753.827385178452;5764.048931926185 17:37:35 INFO - PROCESS | 9269 | |1;ext.html;670.249320760748;683.0198664915846;701.6421624971263;745.642091795938;752.315392992377;31286.374272514535;32413.67586324139;39924.401133982974;40611.18777624446;40769;43373.34939975903;43450.56549434505;43545.78227108868;43827.78086109573;43866;8820.647174113028;8994.28045756338;8994.86507702385;8996.68511602094;8998.460092394445;8766.254868336198;8885.600147993357;8927.464352138892;8929.642814287421;8933.731988040337;9164.404313719588;9168.358214924958;9179.127982841619;9181.495017774054;9189.218916392081;9045.864312035324;9124.817503649923;9133.223675987549;9146.314026447977;9159.725208243763;8908.8663670045;9033.683821066297;9045.321600879895;9071.909280907172;9077.591508382138;44137;44883.32675009877;45052.774736126106;45113.548864511264;45116.54883451157;3840.9423858642144;3863.208042351311;3892.805359732002;4170.874873753793;4446.888827779299;29812.587911325925;30235.546466803014;30382.54426183609;34719;35281;4410.360497727812;4458.108378324348;4509.120721459317;4578.885527861797;4602;353440;356779;359003;359614;361856;57928.71035644879;58004;58291.417085829446;58313.12530312049;58343.41656583465;71203.2879671207;71787.2821271791;72364.63817680877;72519;72604.27395726081;18930.716039259423;19251.807481925283;19259.711104333448;19298.22807087701;19375.224991000483;14710.19093949843;14764.852351476347;14858.777118343234;14862;14871.925640371728;20030.298939537046;20075.698864517042;20301.28945486901;20477.89761051215;21253.78746212518;7591.354734847489;7769;7796.610169491616;7854.136045035041;7956.482828616122;1167.7255844876447;1207.3963018490754;1218.232513516479;1227.5703503773607;1250.562303193893;33421;33718.662813372044;33774.83112584421;33803.98588042363;33856.661433385845;1209.3348658237935;1248.36333469931;1260.710036691566;1294.4757373263844;1324.059917458596;17622.91188544049;17667.38164164248;17677.469675909742;17727.822721772875;17751.46745597634;466162;977110;985906.2818743729;994948;1026964;63574.68212658999;64214.67892660507;64245;64366.35633643604;64563.67718161379;1553.9456119035779;1558.4389619736885;1575.3777257983033;1577.89743666659;1659.8506134447716;33107.50338744969;33829.83085084657;34064.65935340615;34123;34127.31745365128;54299.18551221656;55310;55344.72327638336;55385.44614553803;55437.44562554323;439877;440025;442477;443063;444876;31397;31971;32125.03624891257;32266.193345166557;32271.67728322687;51319.23021154611;51349.48650513597;51490.74254628853;52662.15682451096;53038;41658.79170604249;42792.57207427886;43493.3475997854;43924.56075439205;44802.77598611986;42246.78876605597;42626.36060459157;42809.35785963275;42882.571174287856;44295;43413;43597.56402436062;43724.56275437205;44001.339979900964;44258;36024.099397515274;36734;37194.6280537202;37646.62353376541;37836.48654053807;29513;29778.851105744332;30144.397112058075;30470.695293047673;30494 17:37:35 INFO - PROCESS | 9269 | |2;jquery.html;432.401124442647;433.59951800326934;438.75868272450157;439.3300217168819;452.7985046654238;18577.442676719704;18942.90528547359;19469.902650486747;20660.070296836642;20670.793292067076;13099.803502947463;19081.52296192596;19539.023048847535;20039.198432062738;20065.699014514794;5305.7877684892555;5513.696746678931;5546.334439867202;5546.77812887486;5548.667079975195;5374.381946076212;5407.188921661743;5415.323084614423;5484.533814625742;5503.9174412383845;5482.890342193154;5496.120620700689;5509.449055094498;5529.364123125832;5535.806246781363;5503.20203570482;5514.779408823642;5517.089680202782;5531.25328080708;5646.40712725162;5696.857578560528;5737.483626473638;5748.626339287933;5764.913526297109;5773.307203135609;15090.924545377313;23970.161044363536;24069.15757948481;24337.63493547598;24338.63492047621;2528.620706893962;2546.312495626189;2646.3913299940928;3139.1053549738217;3176.3012137329983;10607.363558186533;10647.361158330525;10910.61812836547;10957.890421095766;11238.943805281004;1935.2259096361568;2063.4428704249767;2067.8138967492996;2071.326818783901;2115.175081718116;77016.61491692562;78254.21745782583;79289.60355198245;80299.59850200711;81289.18710812875;11256.887431125584;11782.410879455992;11825.88174118265;11934.28394296345;11960.282383057045;16649.750253746202;16746.246418911178;16802.57993550171;16822.57943551421;16861.325546977983;8466.703665371682;8825.20573148407;8867.512286824158;8874.112588741074;9088.227500662386;8686.609102590399;8935.240504557056;9027.232685221697;9046.728598142066;9106.86339704905;5065.113605119163;5131.2559678846355;5213.895722085537;5217.947820521822;5235.895282094337;2122.7558830734356;2134.274346722122;2138.5564743798186;2217.113154738118;2220.3893929169285;948.4451595816387;1105.5025238642643;1129.0459561670375;1139.8347239650204;1153.5616465742964;18961.43115706531;19362;19397.8060219396;19416.611667766567;19870.205191792455;1069.6790962711154;1086.7011571817654;1105.0993440346092;1113.9387333696725;1124.5164579230845;10388.636397726195;11004.504797284142;11068.28056176346;11136.721581960515;11213.3832639204;187084.06457967623;189366;430590;529290;529796;88398;90015;90350;92154.53922730344;93045;1123.971566017118;1144.8339990701468;1159.5245949160803;1165.918385713009;1168.1063986050679;17326.653466930842;17346.91326543359;17409.30362785525;17565.912170439067;17644.117794109985;35440.822795885855;35793.1051723709;36461.63538364582;36702;38802.41796373113;49858.50141498539;53339;53667.731661341444;54048;54226.45773542214;8498.235158835487;8771.649134034567;8803.295736341206;8855.158759917798;8858.955705221433;12901.290429026494;13150;13318.467261309439;13394.397252123483;13434.865651343362;11174.888251117385;11965.222260553037;12240;12241.326727030098;12433.564825231073;11727.648170554898;12003.63989080329;12207.755844882875;12224.266544007389;12344.135910486539;10907.400092994962;11421.885781142082;12563.811542827048;12700.618981430573;12895.677608059874;8974.86537701922;9082.228010618906;9150.176484116462;9400.764980875532;9460.148586627236;12128.939355303168;12522.49910003626;12620.621381358575;12644.810327844905;12689 17:37:35 INFO - PROCESS | 9269 | |3;mootools.html;1580.4626427014816;1604.1177352456154;1851.6111616560522;1961.0586918279234;1964.6365422396848;7328.633568321576;8020.67917283308;8145.185481451852;8338.791530211747;8344.45761025533;8047.637856296466;8248.092709801916;8277.627506762195;8367.079621241659;8474;2356.8468049576722;2382;2390.86433943877;2395.544846479172;2402.843815152018;2388.9641655375185;2423.357810180295;2429.392651837041;2437.695288088989;2443.743406942272;2380.27401642499;2403.615421532555;2409.975900240993;2431.173401043645;2447.412620970972;2390.40239940015;2395.64065390192;2402.9306958403604;2403.351095204294;2436.817238707104;2383.4041489627593;2396.364963284731;2402.5435167318155;2405.579023670851;2409.253131529214;8531;8541.103184165697;8555.486670799772;8579.013413457407;8583.313334933253;5341.278927344798;5419.214213938996;5445.428230035829;5459.727013649302;5460.836174914759;3454.447288433864;3479.9652003479896;3491.91270218244;3524.1718196223865;3547.219611685425;1104.1718710966775;1108.9390083545402;1135.2904434728296;1142.3431526872082;1147;11686.24039437434;11777.88222117785;11841;11863.99156071735;11900.40497975089;4488.865334039984;4523.977380113079;4567.406237189144;4587.977060114745;4594.5864872161665;9557.092076252746;9565.569549370295;9578.616855325849;9595.952020239994;9598.9040109598;5225.817096401608;5263.684178949199;5273.78904843802;5299.655522391032;5309.628326017141;4767.308740232646;4909.87725306863;4943.72809495474;4950.554450099508;4953.8513844583995;3718.386466233041;3800.524934383202;3832.865849695247;3833.884983450501;3915.393114067324;1145.8109411946934;1151.9136064795173;1157.7973854575416;1163.168334640736;1188.5542921404474;1049.192122066005;1071.7588542578014;1072.2547829258747;1087.363892123101;1087.6519513755522;5885.764569417175;6024.608400454044;6117.602355846856;6142;6194.783182588678;437.05159803227076;439.39583073274247;439.7383556783773;441.76365644380746;450.82417857035784;4157.3140431829015;4310.698251122454;4343.109662519176;4378.190034843564;4381.1237752449;10204.285700001077;10559.577616895393;10563.154947604173;10601.363918164781;10605.522751476203;9974.650887218913;10429.634962776418;10434.5826166954;10448.059674629169;10462.424566648908;8129.674813007414;8130.837383252302;8212;8228.794280143044;8253.380996425292;5949.167116603766;5964.761409543569;6018.277806663228;6073.392660733891;6074.240719910012;9305.488198148896;9324.347295689236;9476.905230947603;9495.572699228689;9535.189508891823;9296.442213467213;9491.525423728648;9661.71014869555;9666.98496657869;9807.55865986018;7289.890651640124;7308.817279567841;7347.8163045924275;7436.107667079768;7473.701051957861;7962.800929976797;7972.162922893012;7988.081370642218;8021.5187088774865;8024.759257222293;7258.600776957318;7445.9627701861145;7455.105387353336;7552.244775522404;7555;7209.243029482039;7296.452766042462;7337.74317898871;7345.192028876712;7425.034745483269;6928.826779330356;6935.514513984174;6966.582005079711;6984.825379365557;6991.510594258353;5264.9736751315995;5318.840434786963;5358.303420555303;5424.620276580601;5523.558115350682;5155.793768249378;5198.9740051299505;5216.765245563883;5222.869428264324;5253.711045892513 17:37:35 INFO - PROCESS | 9269 | |4;prototype.html;351.3114295979879;368.63689266072913;370.57569083399505;377.1043771043771;381.5002346925526;6487.410584406821;6494.155759751232;6549.639769812658;6585.440237579805;6600.900986485194;6453.8709225815455;6457;6491.123698300728;6507.6420796856155;6529.053287273343;4890.559849613543;4895.31465594817;4897.289892965536;4911.950880491203;5039.521245481674;4982;4984.75076246188;4988.127077761395;4994.725290109042;5006.874828129307;4912.38595175603;4922.926156107644;4930.433000204968;4932.80268789248;4935.136351138554;4926.704397736129;4930.112579735646;4943.802247910079;4946.060248552763;4953.777080031407;4467.128909862578;4470.396496472999;4473.9105217895785;4476.194285028693;4480.283154695266;6291.370862913672;6292.4966002719675;6302.653354065525;6305.306416294204;6307.463865571432;5714.399988001242;5832.591718579701;5841.47426731592;5842.795502157446;5847.298324201123;6774.949882768179;6832.59004459734;6836.521443498957;6840.110785597841;6841.144856892888;4907.484714105003;4913.287573301851;4920.286558449041;4925.655204135712;4928.679635823696;7061.752838650674;7129.679164437561;7144.46416518758;7150.463715221327;7152.678129484186;4764.618830493552;4995.350604421402;4998.575121114746;5003.399592048904;5004.824831130965;4942.950570494249;4984.950150498448;4988.700677959334;4992.600591952635;5005.27423523587;5747.25285712863;5750.25246717924;5755.36690964002;5763.596548241667;5763.6541807491685;6602.966985165043;6779.389854913082;6803.115594972721;6835.213950395669;6841.726330946806;1774.4942691332908;1804.927802887896;1805.2147315917618;1806.2413786209822;1814.7822261328724;1198.6823491774512;1208.8428504294386;1211.6970757310673;1233.4387853526623;1241.993790031044;6678.599284042973;6697.8995315070315;6700.329967003358;6704.229013663394;6709.161354830646;7068.540544864567;7072.964635176894;7082.39799617028;7082.433405327562;7085.291470852873;6645.767398141042;6656.933430665728;6672.199336079604;6674.332566743286;6691.665416729144;3769.849206031728;3796.032011837019;3816.790076545761;3818.6181381862148;3837.194189220239;7464.1416237132335;7464.70141194357;7486.326230639269;7495.62521873915;7495.8500829983095;7176.605286709281;7197.676104575306;7202.603856787927;7215.67529461165;7236.96381518089;7424.109106907205;7443.2184620615135;7457.627118644046;7461.626918654046;7469.551826890295;6959.234484206834;7015;7081.8937715935335;7146.64266786669;7167.390771784457;6938.8612227756175;6973.755918542826;6978.825529361807;6983.825404364931;7017.859642807218;7345.77962661121;7423.146338171179;7429.07136607924;7445.9255407445235;7461.701531938662;5049.368828896388;5055.266986287042;5064.7467626619255;5065.214891691794;5068.6451948363265;6939.826504337432;7020.297970202939;7053.717851285891;7092.326229008236;7149.642517873982;6891.414229790324;6926;6927.134108236471;6939.375456208965;7002.509824312249;6900.654967251517;6911.930880691129;6914.585124892523;6928.757493487704;6935.618540980295;6783.3894949452815;6799.2520822708475;6803.795886123226;6813.318668133147;6817.89773153413;6801.89797153053;6871.725130994704;6924;6935.722571097302;6940.201876784235;6721.22705888829;6758.966205168943;6762.560433571802;6764.763233286812;6773.153355830521 17:37:35 INFO - PROCESS | 9269 | |5;yui.html;848.291676450164;940.1350757303276;944.9905500944989;958.123317164794;960.3901522533189;14662;14746.483873064444;14798.112113273211;15203.771943420843;15433;14562.199079050675;14626.707465850677;14630.268486575682;14690.045147065433;14702.779458308134;897.0670502677241;908.4276905549494;932.4684929590136;936.0452338614643;936.2743873498059;923.4182465047011;923.4367036107968;923.7967647117623;925.9629614815399;928.8513837785955;969.9369540979849;972.6158167523823;973.5862258540128;973.8880028796673;975.9560819763128;961.0917682789767;962.499500259861;963.4556475591269;967.032967032967;968.2883080935542;711.6726305899292;713.5112447973103;713.6966789114606;714.0681410758957;716.7527203114917;15490.45783397587;15541.611459713484;15740.44908428211;15793.368265269375;15876.920615396964;14228.146311221257;14390.928045359706;14566.635834104127;14606.926965365212;14615.123092614476;11399.148961524468;11629.70925726855;11656.184067115306;11814;11956.521739130425;3967.246223217608;3967.246223217608;4031.1534577738416;4050.7569545827346;4056.9594304056877;56421.15368269479;56751.43248567544;56860.43139568634;56876.71561642165;57347.42652573463;10561.630342938113;10643.46782660864;11097.778044439066;11126.777464450666;11547.422628868522;20664.690029649566;20710.482237944172;20731.689024664644;20773;20793.480162996046;8551.1448855114;8554.766027746204;8724.43291186071;8779.736607901774;8818.779530511789;4800.255960326155;4842.5157484251295;4879.414470263591;4967.361885050192;4970.378702662168;3525.453554699026;3578.5526809148855;3584.1577229351083;3585.5697316322207;3592.2815436912724;695.6382681005848;698.8252936765808;700.8037749430167;709.4324540367685;715.8854583266652;719.586237913202;817.8691409374471;825.8719898415756;831.4969443486724;858.532100005486;9885;10400.375977441377;10408.375497470177;10566.207534434794;10706.785864282827;801.8195905921237;817.7587611654576;833.6957010691054;844.50174397106;855.4610595324906;4762.59517940972;4835.734034628129;4838.758062096881;4877.195262781602;4877.5366340197625;69332.3066769336;69924.65037674778;70070;70295;70944.64527677328;59808;60240;60408.395916040274;61128.694356528824;61822.38177618166;54107.72946135244;54262.186067209026;55047.449525505035;55173.172402414;55832;9573.521323933915;9596.616135354787;9650.903490965;9709.56306966174;9807.362521436084;40086.599134008284;40130;40886.38670419886;41298;41432.1713565733;49115;51363;51431;52446.47553524416;53107.73446132745;11954;12085.75828483443;12104.273743575413;12302.200356976768;12311.384430778604;13145.145565538209;13352.399142038437;13437;13442.596722098353;13493.865061349654;12699.365031748192;12892.871071289166;12899.226046437243;12939.805902911276;12967.740645187232;11978.76042479163;12220.327881966577;12318.322492263012;12342.75314493723;12370.938145309576;12584;12623.36883155857;12663.620091397273;12677.936610316889;12692.238465692088;10547.419891906018;10597.47012649349;10696;10784.191185661264;10925.617603384162;10948.178886583697;10980.121590272918;11128;11128.666140015812;11286.66140015768 17:37:35 INFO - PROCESS | 9269 | __end_tp_report 17:37:35 INFO - PROCESS | 9269 | __start_cc_report 17:37:35 INFO - PROCESS | 9269 | _x_x_mozilla_cycle_collect,343 17:37:35 INFO - PROCESS | 9269 | __end_cc_report 17:37:35 INFO - PROCESS | 9269 | __startTimestamp1467074255315__endTimestamp 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | ------- Summary: start ------- 17:37:35 INFO - PROCESS | 9269 | Number of tests: 6 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#0] dojo.html Cycles:165 Average:5512.38 Median:5753.83 stddev:610.11 (10.6%) stddev-sans-first:587.70 17:37:35 INFO - PROCESS | 9269 | Values: 3340.1 3367.1 3370.6 3390.7 3392.3 5522.8 5557.1 5561.1 5567.2 5596.2 5545.9 5551.8 5575.7 5601.5 5602.2 5045.3 5062.3 5120.3 5124.1 5141.7 5058.3 5077.9 5106.3 5139.7 5168.7 5078.9 5092.3 5093.4 5097.2 5122.6 4951.7 5017.4 5022.7 5036.0 5105.6 4906.1 4935.3 4940.4 4974.8 4997.5 5404.3 5410.8 5422.6 5437.1 5443.2 5814.7 5839.7 5896.9 5903.1 5921.0 6021.7 6022.3 6024.5 6038.6 6065.2 5619.9 5623.4 5624.7 5625.7 5634.6 5913.1 6025.4 6064.9 6114.9 6136.3 5818.2 5818.4 5823.7 5828.6 5853.1 5866.3 5904.7 5905.4 5905.8 5906.5 5784.1 5869.9 5879.8 5998.2 6017.0 5824.5 5836.1 5842.8 5845.2 5853.5 4469.9 4475.5 4478.8 4479.9 4483.7 3973.5 4005.2 4047.6 4062.7 4091.3 5557.0 5577.9 5621.2 5677.7 5811.0 5967.5 6016.6 6068.6 6071.2 6084.2 5595.0 5716.8 5765.1 5771.6 5790.0 5023.8 5051.3 5055.9 5067.6 5104.5 6135.0 6183.3 6184.3 6194.6 6199.9 5824.4 5875.9 5919.8 5961.5 5988.2 6059.0 6060.4 6063.8 6071.5 6121.7 5640.1 5650.2 5651.3 5671.7 5697.1 5678.4 5779.6 5887.6 5951.9 6031.0 5795.9 5803.8 5805.1 5818.8 5820.6 5770.3 5798.7 5818.8 5821.9 5826.0 5611.9 5670.7 5788.3 5793.3 5798.8 5840.2 5846.1 5870.5 5886.6 5886.8 5622.6 5743.0 5751.9 5753.8 5764.0 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#1] ext.html Cycles:180 Average:71801.99 Median:43571.67 stddev:168270.20 (386.2%) stddev-sans-first:168657.49 17:37:35 INFO - PROCESS | 9269 | Values: 670.2 683.0 701.6 745.6 752.3 31286.4 32413.7 39924.4 40611.2 40769.0 43373.3 43450.6 43545.8 43827.8 43866.0 8820.6 8994.3 8994.9 8996.7 8998.5 8766.3 8885.6 8927.5 8929.6 8933.7 9164.4 9168.4 9179.1 9181.5 9189.2 9045.9 9124.8 9133.2 9146.3 9159.7 8908.9 9033.7 9045.3 9071.9 9077.6 44137.0 44883.3 45052.8 45113.5 45116.5 3840.9 3863.2 3892.8 4170.9 4446.9 29812.6 30235.5 30382.5 34719.0 35281.0 4410.4 4458.1 4509.1 4578.9 4602.0 353440.0 356779.0 359003.0 359614.0 361856.0 57928.7 58004.0 58291.4 58313.1 58343.4 71203.3 71787.3 72364.6 72519.0 72604.3 18930.7 19251.8 19259.7 19298.2 19375.2 14710.2 14764.9 14858.8 14862.0 14871.9 20030.3 20075.7 20301.3 20477.9 21253.8 7591.4 7769.0 7796.6 7854.1 7956.5 1167.7 1207.4 1218.2 1227.6 1250.6 33421.0 33718.7 33774.8 33804.0 33856.7 1209.3 1248.4 1260.7 1294.5 1324.1 17622.9 17667.4 17677.5 17727.8 17751.5 466162.0 977110.0 985906.3 994948.0 1026964.0 63574.7 64214.7 64245.0 64366.4 64563.7 1553.9 1558.4 1575.4 1577.9 1659.9 33107.5 33829.8 34064.7 34123.0 34127.3 54299.2 55310.0 55344.7 55385.4 55437.4 439877.0 440025.0 442477.0 443063.0 444876.0 31397.0 31971.0 32125.0 32266.2 32271.7 51319.2 51349.5 51490.7 52662.2 53038.0 41658.8 42792.6 43493.3 43924.6 44802.8 42246.8 42626.4 42809.4 42882.6 44295.0 43413.0 43597.6 43724.6 44001.3 44258.0 36024.1 36734.0 37194.6 37646.6 37836.5 29513.0 29778.9 30144.4 30470.7 30494.0 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#2] jquery.html Cycles:180 Average:25610.23 Median:2218.75 stddev:67345.50 (3035.3%) stddev-sans-first:67507.89 17:37:35 INFO - PROCESS | 9269 | Values: 432.4 433.6 438.8 439.3 452.8 18577.4 18942.9 19469.9 20660.1 20670.8 13099.8 19081.5 19539.0 20039.2 20065.7 5305.8 5513.7 5546.3 5546.8 5548.7 5374.4 5407.2 5415.3 5484.5 5503.9 5482.9 5496.1 5509.4 5529.4 5535.8 5503.2 5514.8 5517.1 5531.3 5646.4 5696.9 5737.5 5748.6 5764.9 5773.3 15090.9 23970.2 24069.2 24337.6 24338.6 2528.6 2546.3 2646.4 3139.1 3176.3 10607.4 10647.4 10910.6 10957.9 11238.9 1935.2 2063.4 2067.8 2071.3 2115.2 77016.6 78254.2 79289.6 80299.6 81289.2 11256.9 11782.4 11825.9 11934.3 11960.3 16649.8 16746.2 16802.6 16822.6 16861.3 8466.7 8825.2 8867.5 8874.1 9088.2 8686.6 8935.2 9027.2 9046.7 9106.9 5065.1 5131.3 5213.9 5217.9 5235.9 2122.8 2134.3 2138.6 2217.1 2220.4 948.4 1105.5 1129.0 1139.8 1153.6 18961.4 19362.0 19397.8 19416.6 19870.2 1069.7 1086.7 1105.1 1113.9 1124.5 10388.6 11004.5 11068.3 11136.7 11213.4 187084.1 189366.0 430590.0 529290.0 529796.0 88398.0 90015.0 90350.0 92154.5 93045.0 1124.0 1144.8 1159.5 1165.9 1168.1 17326.7 17346.9 17409.3 17565.9 17644.1 35440.8 35793.1 36461.6 36702.0 38802.4 49858.5 53339.0 53667.7 54048.0 54226.5 8498.2 8771.6 8803.3 8855.2 8859.0 12901.3 13150.0 13318.5 13394.4 13434.9 11174.9 11965.2 12240.0 12241.3 12433.6 11727.6 12003.6 12207.8 12224.3 12344.1 10907.4 11421.9 12563.8 12700.6 12895.7 8974.9 9082.2 9150.2 9400.8 9460.1 12128.9 12522.5 12620.6 12644.8 12689.0 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#3] mootools.html Cycles:180 Average:5653.52 Median:5207.87 stddev:3088.30 (59.3%) stddev-sans-first:3081.80 17:37:35 INFO - PROCESS | 9269 | Values: 1580.5 1604.1 1851.6 1961.1 1964.6 7328.6 8020.7 8145.2 8338.8 8344.5 8047.6 8248.1 8277.6 8367.1 8474.0 2356.8 2382.0 2390.9 2395.5 2402.8 2389.0 2423.4 2429.4 2437.7 2443.7 2380.3 2403.6 2410.0 2431.2 2447.4 2390.4 2395.6 2402.9 2403.4 2436.8 2383.4 2396.4 2402.5 2405.6 2409.3 8531.0 8541.1 8555.5 8579.0 8583.3 5341.3 5419.2 5445.4 5459.7 5460.8 3454.4 3480.0 3491.9 3524.2 3547.2 1104.2 1108.9 1135.3 1142.3 1147.0 11686.2 11777.9 11841.0 11864.0 11900.4 4488.9 4524.0 4567.4 4588.0 4594.6 9557.1 9565.6 9578.6 9596.0 9598.9 5225.8 5263.7 5273.8 5299.7 5309.6 4767.3 4909.9 4943.7 4950.6 4953.9 3718.4 3800.5 3832.9 3833.9 3915.4 1145.8 1151.9 1157.8 1163.2 1188.6 1049.2 1071.8 1072.3 1087.4 1087.7 5885.8 6024.6 6117.6 6142.0 6194.8 437.1 439.4 439.7 441.8 450.8 4157.3 4310.7 4343.1 4378.2 4381.1 10204.3 10559.6 10563.2 10601.4 10605.5 9974.7 10429.6 10434.6 10448.1 10462.4 8129.7 8130.8 8212.0 8228.8 8253.4 5949.2 5964.8 6018.3 6073.4 6074.2 9305.5 9324.3 9476.9 9495.6 9535.2 9296.4 9491.5 9661.7 9667.0 9807.6 7289.9 7308.8 7347.8 7436.1 7473.7 7962.8 7972.2 7988.1 8021.5 8024.8 7258.6 7446.0 7455.1 7552.2 7555.0 7209.2 7296.5 7337.7 7345.2 7425.0 6928.8 6935.5 6966.6 6984.8 6991.5 5265.0 5318.8 5358.3 5424.6 5523.6 5155.8 5199.0 5216.8 5222.9 5253.7 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#4] prototype.html Cycles:180 Average:5789.40 Median:6624.37 stddev:1724.73 (26.0%) stddev-sans-first:1680.57 17:37:35 INFO - PROCESS | 9269 | Values: 351.3 368.6 370.6 377.1 381.5 6487.4 6494.2 6549.6 6585.4 6600.9 6453.9 6457.0 6491.1 6507.6 6529.1 4890.6 4895.3 4897.3 4912.0 5039.5 4982.0 4984.8 4988.1 4994.7 5006.9 4912.4 4922.9 4930.4 4932.8 4935.1 4926.7 4930.1 4943.8 4946.1 4953.8 4467.1 4470.4 4473.9 4476.2 4480.3 6291.4 6292.5 6302.7 6305.3 6307.5 5714.4 5832.6 5841.5 5842.8 5847.3 6774.9 6832.6 6836.5 6840.1 6841.1 4907.5 4913.3 4920.3 4925.7 4928.7 7061.8 7129.7 7144.5 7150.5 7152.7 4764.6 4995.4 4998.6 5003.4 5004.8 4943.0 4985.0 4988.7 4992.6 5005.3 5747.3 5750.3 5755.4 5763.6 5763.7 6603.0 6779.4 6803.1 6835.2 6841.7 1774.5 1804.9 1805.2 1806.2 1814.8 1198.7 1208.8 1211.7 1233.4 1242.0 6678.6 6697.9 6700.3 6704.2 6709.2 7068.5 7073.0 7082.4 7082.4 7085.3 6645.8 6656.9 6672.2 6674.3 6691.7 3769.8 3796.0 3816.8 3818.6 3837.2 7464.1 7464.7 7486.3 7495.6 7495.9 7176.6 7197.7 7202.6 7215.7 7237.0 7424.1 7443.2 7457.6 7461.6 7469.6 6959.2 7015.0 7081.9 7146.6 7167.4 6938.9 6973.8 6978.8 6983.8 7017.9 7345.8 7423.1 7429.1 7445.9 7461.7 5049.4 5055.3 5064.7 5065.2 5068.6 6939.8 7020.3 7053.7 7092.3 7149.6 6891.4 6926.0 6927.1 6939.4 7002.5 6900.7 6911.9 6914.6 6928.8 6935.6 6783.4 6799.3 6803.8 6813.3 6817.9 6801.9 6871.7 6924.0 6935.7 6940.2 6721.2 6759.0 6762.6 6764.8 6773.2 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - PROCESS | 9269 | [#5] yui.html Cycles:180 Average:16026.01 Median:4817.99 stddev:18979.41 (393.9%) stddev-sans-first:18998.43 17:37:35 INFO - PROCESS | 9269 | Values: 848.3 940.1 945.0 958.1 960.4 14662.0 14746.5 14798.1 15203.8 15433.0 14562.2 14626.7 14630.3 14690.0 14702.8 897.1 908.4 932.5 936.0 936.3 923.4 923.4 923.8 926.0 928.9 969.9 972.6 973.6 973.9 976.0 961.1 962.5 963.5 967.0 968.3 711.7 713.5 713.7 714.1 716.8 15490.5 15541.6 15740.4 15793.4 15876.9 14228.1 14390.9 14566.6 14606.9 14615.1 11399.1 11629.7 11656.2 11814.0 11956.5 3967.2 3967.2 4031.2 4050.8 4057.0 56421.2 56751.4 56860.4 56876.7 57347.4 10561.6 10643.5 11097.8 11126.8 11547.4 20664.7 20710.5 20731.7 20773.0 20793.5 8551.1 8554.8 8724.4 8779.7 8818.8 4800.3 4842.5 4879.4 4967.4 4970.4 3525.5 3578.6 3584.2 3585.6 3592.3 695.6 698.8 700.8 709.4 715.9 719.6 817.9 825.9 831.5 858.5 9885.0 10400.4 10408.4 10566.2 10706.8 801.8 817.8 833.7 844.5 855.5 4762.6 4835.7 4838.8 4877.2 4877.5 69332.3 69924.7 70070.0 70295.0 70944.6 59808.0 60240.0 60408.4 61128.7 61822.4 54107.7 54262.2 55047.4 55173.2 55832.0 9573.5 9596.6 9650.9 9709.6 9807.4 40086.6 40130.0 40886.4 41298.0 41432.2 49115.0 51363.0 51431.0 52446.5 53107.7 11954.0 12085.8 12104.3 12302.2 12311.4 13145.1 13352.4 13437.0 13442.6 13493.9 12699.4 12892.9 12899.2 12939.8 12967.7 11978.8 12220.3 12318.3 12342.8 12370.9 12584.0 12623.4 12663.6 12677.9 12692.2 10547.4 10597.5 10696.0 10784.2 10925.6 10948.2 10980.1 11128.0 11128.7 11286.7 17:37:35 INFO - PROCESS | 9269 | -------- Summary: end -------- 17:37:35 INFO - PROCESS | 9269 | 17:37:35 INFO - TEST-INFO | 9269: exit 0 17:37:35 INFO - TEST-OK | dromaeo_css | took 1108885ms 17:37:35 INFO - TEST-START | kraken 17:37:35 INFO - operating with platform_type : linux_ 17:37:35 INFO - Initialising browser for kraken test... 17:37:36 INFO - TEST-INFO | started process 9508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3uotFp/profile http://localhost:38311/getInfo.html) 17:37:39 INFO - PROCESS | 9508 | 17:37:39 INFO - PROCESS | 9508 | (process:9584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:37:40 INFO - PROCESS | 9508 | __metrics Screen width/height:1600/1200 17:37:40 INFO - PROCESS | 9508 | colorDepth:24 17:37:40 INFO - PROCESS | 9508 | Browser inner width/height: 1024/697 17:37:40 INFO - PROCESS | 9508 | __metrics 17:37:41 ERROR - PROCESS | 9508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:37:41 INFO - TEST-INFO | 9508: exit 0 17:37:41 INFO - Browser initialized. 17:37:41 INFO - Running cycle 1/1 for kraken test... 17:37:41 INFO - TEST-INFO | started process 9634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3uotFp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:43 INFO - PROCESS | 9634 | 17:37:43 INFO - PROCESS | 9634 | (process:9700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:37:53 INFO - PROCESS | 9634 | RSS: Main: 150855680 17:37:53 INFO - PROCESS | 9634 | 17:37:56 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38311/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:57 INFO - PROCESS | 9634 | RSS: Main: 156323840 17:37:57 INFO - PROCESS | 9634 | 17:37:59 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38311/tests/kraken/driver.html?testName=audio-dft) 17:38:00 INFO - PROCESS | 9634 | RSS: Main: 156610560 17:38:00 INFO - PROCESS | 9634 | 17:38:03 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38311/tests/kraken/driver.html?testName=audio-fft) 17:38:03 INFO - PROCESS | 9634 | RSS: Main: 156872704 17:38:03 INFO - PROCESS | 9634 | 17:38:05 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38311/tests/kraken/driver.html?testName=audio-oscillator) 17:38:06 INFO - PROCESS | 9634 | RSS: Main: 156864512 17:38:06 INFO - PROCESS | 9634 | 17:38:08 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:09 INFO - PROCESS | 9634 | RSS: Main: 156676096 17:38:09 INFO - PROCESS | 9634 | 17:38:12 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38311/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:12 INFO - PROCESS | 9634 | RSS: Main: 156798976 17:38:12 INFO - PROCESS | 9634 | 17:38:16 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38311/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:16 INFO - PROCESS | 9634 | RSS: Main: 157159424 17:38:16 INFO - PROCESS | 9634 | 17:38:19 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38311/tests/kraken/driver.html?testName=json-parse-financial) 17:38:20 INFO - PROCESS | 9634 | RSS: Main: 156631040 17:38:20 INFO - PROCESS | 9634 | 17:38:21 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:22 INFO - PROCESS | 9634 | RSS: Main: 156184576 17:38:22 INFO - PROCESS | 9634 | 17:38:23 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:24 INFO - PROCESS | 9634 | RSS: Main: 156463104 17:38:24 INFO - PROCESS | 9634 | 17:38:26 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:27 INFO - PROCESS | 9634 | RSS: Main: 156987392 17:38:27 INFO - PROCESS | 9634 | 17:38:29 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:30 INFO - PROCESS | 9634 | RSS: Main: 157315072 17:38:30 INFO - PROCESS | 9634 | 17:38:33 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:33 INFO - PROCESS | 9634 | RSS: Main: 157495296 17:38:33 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:38311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38311/tests/kraken/driver.html?testName=ai-astar) 17:38:35 INFO - PROCESS | 9634 | RSS: Main: 158924800 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | __start_tp_report 17:38:35 INFO - PROCESS | 9634 | _x_x_mozilla_page_load 17:38:35 INFO - PROCESS | 9634 | _x_x_mozilla_page_load_details 17:38:35 INFO - PROCESS | 9634 | |i|pagename|runs| 17:38:35 INFO - PROCESS | 9634 | |0;ai-astar;108;111;105;114;113;110;101;114;110;111 17:38:35 INFO - PROCESS | 9634 | |1;audio-beat-detection;158;130;150;177;127;154;158;128;171;132 17:38:35 INFO - PROCESS | 9634 | |2;audio-dft;161;163;161;163;163;162;170;161;162;160 17:38:35 INFO - PROCESS | 9634 | |3;audio-fft;74;73;75;173;76;74;76;76;166;73 17:38:35 INFO - PROCESS | 9634 | |4;audio-oscillator;91;92;157;91;92;91;151;91;92;144 17:38:35 INFO - PROCESS | 9634 | |5;imaging-gaussian-blur;118;117;116;117;116;117;117;117;117;117 17:38:35 INFO - PROCESS | 9634 | |6;imaging-darkroom;146;148;147;146;151;147;148;146;145;147 17:38:35 INFO - PROCESS | 9634 | |7;imaging-desaturate;94;94;95;95;97;95;95;94;95;96 17:38:35 INFO - PROCESS | 9634 | |8;json-parse-financial;55;55;57;56;55;61;56;68;55;55 17:38:35 INFO - PROCESS | 9634 | |9;json-stringify-tinderbox;56;57;56;58;58;57;57;57;57;58 17:38:35 INFO - PROCESS | 9634 | |10;stanford-crypto-aes;74;73;73;75;81;74;74;74;74;73 17:38:35 INFO - PROCESS | 9634 | |11;stanford-crypto-ccm;114;115;125;121;118;116;116;124;137;130 17:38:35 INFO - PROCESS | 9634 | |12;stanford-crypto-pbkdf2;163;162;157;159;167;162;159;157;161;167 17:38:35 INFO - PROCESS | 9634 | |13;stanford-crypto-sha256-iterative;68;75;66;68;70;66;67;69;66;70 17:38:35 INFO - PROCESS | 9634 | __end_tp_report 17:38:35 INFO - PROCESS | 9634 | __start_cc_report 17:38:35 INFO - PROCESS | 9634 | _x_x_mozilla_cycle_collect,871 17:38:35 INFO - PROCESS | 9634 | __end_cc_report 17:38:35 INFO - PROCESS | 9634 | __startTimestamp1467074315611__endTimestamp 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | ------- Summary: start ------- 17:38:35 INFO - PROCESS | 9634 | Number of tests: 14 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:4.11 (3.7%) stddev-sans-first:4.31 17:38:35 INFO - PROCESS | 9634 | Values: 108.0 111.0 105.0 114.0 113.0 110.0 101.0 114.0 110.0 111.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:156.00 stddev:18.34 (11.8%) stddev-sans-first:19.13 17:38:35 INFO - PROCESS | 9634 | Values: 158.0 130.0 150.0 177.0 127.0 154.0 158.0 128.0 171.0 132.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.80 (1.7%) stddev-sans-first:2.91 17:38:35 INFO - PROCESS | 9634 | Values: 161.0 163.0 161.0 163.0 163.0 162.0 170.0 161.0 162.0 160.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#3] audio-fft Cycles:10 Average:93.60 Median:74.50 stddev:40.05 (53.8%) stddev-sans-first:41.85 17:38:35 INFO - PROCESS | 9634 | Values: 74.0 73.0 75.0 173.0 76.0 74.0 76.0 76.0 166.0 73.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:91.00 stddev:28.78 (31.6%) stddev-sans-first:29.76 17:38:35 INFO - PROCESS | 9634 | Values: 91.0 92.0 157.0 91.0 92.0 91.0 151.0 91.0 92.0 144.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 17:38:35 INFO - PROCESS | 9634 | Values: 118.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.66 (1.1%) stddev-sans-first:1.72 17:38:35 INFO - PROCESS | 9634 | Values: 146.0 148.0 147.0 146.0 151.0 147.0 148.0 146.0 145.0 147.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 17:38:35 INFO - PROCESS | 9634 | Values: 94.0 94.0 95.0 95.0 97.0 95.0 95.0 94.0 95.0 96.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:4.19 (7.5%) stddev-sans-first:4.36 17:38:35 INFO - PROCESS | 9634 | Values: 55.0 55.0 57.0 56.0 55.0 61.0 56.0 68.0 55.0 55.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 17:38:35 INFO - PROCESS | 9634 | Values: 56.0 57.0 56.0 58.0 58.0 57.0 57.0 57.0 57.0 58.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.37 (3.2%) stddev-sans-first:2.51 17:38:35 INFO - PROCESS | 9634 | Values: 74.0 73.0 73.0 75.0 81.0 74.0 74.0 74.0 74.0 73.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.50 stddev:7.47 (6.1%) stddev-sans-first:7.40 17:38:35 INFO - PROCESS | 9634 | Values: 114.0 115.0 125.0 121.0 118.0 116.0 116.0 124.0 137.0 130.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:3.60 (2.2%) stddev-sans-first:3.77 17:38:35 INFO - PROCESS | 9634 | Values: 163.0 162.0 157.0 159.0 167.0 162.0 159.0 157.0 161.0 167.0 17:38:35 INFO - PROCESS | 9634 | 17:38:35 INFO - PROCESS | 9634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.76 (4.0%) stddev-sans-first:2.92 17:38:35 INFO - PROCESS | 9634 | Values: 68.0 75.0 66.0 68.0 70.0 66.0 67.0 69.0 66.0 70.0 17:38:35 INFO - PROCESS | 9634 | -------- Summary: end -------- 17:38:35 INFO - PROCESS | 9634 | 17:38:36 INFO - TEST-INFO | 9634: exit 0 17:38:36 INFO - TEST-OK | kraken | took 60463ms 17:38:36 INFO - SUITE-END | took 1169s 17:38:36 INFO - Completed test suite (00:19:29) 17:38:36 INFO - javascript benchmark 17:38:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.0814775936615, 3367.0740546349734, 3370.6123795763497, 3390.6778856008677, 3392.321535692862, 5522.806701765439, 5557.138643510258, 5561.082421400464, 5567.164925261208, 5596.2165296858475, 5545.861353466165, 5551.77792888284, 5575.721213939297, 5601.467860553241, 5602.1596760485945, 5045.293658887749, 5062.341895553592, 5120.283160357553, 5124.052050370675, 5141.717205553693, 5058.342415485981, 5077.923831142517, 5106.285120083191, 5139.743012849362, 5168.715720635363, 5078.898422031557, 5092.28707980883, 5093.363329583802, 5097.184450487923, 5122.6158038147105, 4951.702897826142, 5017.422996355429, 5022.673526220784, 5035.974820125876, 5105.591552675795, 4906.092372910987, 4935.284383764334, 4940.4318503372215, 4974.801007959677, 4997.475265097185, 5404.32445944257, 5410.810621628263, 5422.593305502063, 5437.075697131497, 5443.2107344434835, 5814.709264536798, 5839.678817665027, 5896.911546326808, 5903.144044113579, 5921.0, 6021.6989150542295, 6022.277326720821, 6024.548158888101, 6038.637681739066, 6065.150878876961, 5619.859503512404, 5623.437656234344, 5624.662520248758, 5625.6905870177125, 5634.605577609528, 5913.113033045078, 6025.397460253939, 6064.878702425926, 6114.938850611437, 6136.263648362135, 5818.156367326798, 5818.389069147764, 5823.679697616672, 5828.6211396259105, 5853.122031695195, 5866.296044474605, 5904.704764761745, 5905.40945905406, 5905.76376944926, 5906.49794767441, 5784.132380143013, 5869.941300587025, 5879.794207202727, 5998.220231369894, 6016.969915150396, 5824.475797178275, 5836.1245813127525, 5842.795502157404, 5845.210896528914, 5853.5317174625925, 4469.865904022885, 4475.48531918827, 4478.820847166076, 4479.932801007987, 4483.708558943724, 3973.5033120859894, 4005.1589166274825, 4047.5750046245307, 4062.654674352654, 4091.284025295561, 5557.0, 5577.944220557823, 5621.213030175779, 5677.744501497443, 5811.0, 5967.492763115184, 6016.578839481194, 6068.605540639845, 6071.180390647294, 6084.239470066242, 5595.0, 5716.828495145152, 5765.077587585966, 5771.595988280864, 5790.044642633919, 5023.773930173151, 5051.267566202953, 5055.9494405055475, 5067.594592432597, 5104.464031276662, 6135.049067394471, 6183.288921774054, 6184.257889053342, 6194.628322300677, 6199.938000620026, 5824.446677565625, 5875.853103672443, 5919.7632094717455, 5961.463468287875, 5988.161657367885, 6058.969705151446, 6060.424259695322, 6063.787767428119, 6071.544634152545, 6121.693915304306, 5640.125780504029, 5650.180723794944, 5651.321841379061, 5671.6597004179885, 5697.059985102577, 5678.403767604507, 5779.595428319977, 5887.587868849139, 5951.91072133927, 6031.0, 5795.855103622274, 5803.767849285981, 5805.071188609802, 5818.796342128006, 5820.563457740602, 5770.336411312753, 5798.652080875161, 5818.76724930998, 5821.912671309849, 5825.970870145622, 5611.915821262766, 5670.74481648335, 5788.305403351625, 5793.304803423616, 5798.797042103675, 5840.182374467663, 5846.064629659234, 5870.530357571299, 5886.646801191942, 5886.764529418775, 5622.606417550732, 5743.023685973478, 5751.913721294268, 5753.827385178452, 5764.048931926185], "value": 5472.97304992161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.249320760748, 683.0198664915846, 701.6421624971263, 745.642091795938, 752.315392992377, 31286.374272514535, 32413.67586324139, 39924.401133982974, 40611.18777624446, 40769.0, 43373.34939975903, 43450.56549434505, 43545.78227108868, 43827.78086109573, 43866.0, 8820.647174113028, 8994.28045756338, 8994.86507702385, 8996.68511602094, 8998.460092394445, 8766.254868336198, 8885.600147993357, 8927.464352138892, 8929.642814287421, 8933.731988040337, 9164.404313719588, 9168.358214924958, 9179.127982841619, 9181.495017774054, 9189.218916392081, 9045.864312035324, 9124.817503649923, 9133.223675987549, 9146.314026447977, 9159.725208243763, 8908.8663670045, 9033.683821066297, 9045.321600879895, 9071.909280907172, 9077.591508382138, 44137.0, 44883.32675009877, 45052.774736126106, 45113.548864511264, 45116.54883451157, 3840.9423858642144, 3863.208042351311, 3892.805359732002, 4170.874873753793, 4446.888827779299, 29812.587911325925, 30235.546466803014, 30382.54426183609, 34719.0, 35281.0, 4410.360497727812, 4458.108378324348, 4509.120721459317, 4578.885527861797, 4602.0, 353440.0, 356779.0, 359003.0, 359614.0, 361856.0, 57928.71035644879, 58004.0, 58291.417085829446, 58313.12530312049, 58343.41656583465, 71203.2879671207, 71787.2821271791, 72364.63817680877, 72519.0, 72604.27395726081, 18930.716039259423, 19251.807481925283, 19259.711104333448, 19298.22807087701, 19375.224991000483, 14710.19093949843, 14764.852351476347, 14858.777118343234, 14862.0, 14871.925640371728, 20030.298939537046, 20075.698864517042, 20301.28945486901, 20477.89761051215, 21253.78746212518, 7591.354734847489, 7769.0, 7796.610169491616, 7854.136045035041, 7956.482828616122, 1167.7255844876447, 1207.3963018490754, 1218.232513516479, 1227.5703503773607, 1250.562303193893, 33421.0, 33718.662813372044, 33774.83112584421, 33803.98588042363, 33856.661433385845, 1209.3348658237935, 1248.36333469931, 1260.710036691566, 1294.4757373263844, 1324.059917458596, 17622.91188544049, 17667.38164164248, 17677.469675909742, 17727.822721772875, 17751.46745597634, 466162.0, 977110.0, 985906.2818743729, 994948.0, 1026964.0, 63574.68212658999, 64214.67892660507, 64245.0, 64366.35633643604, 64563.67718161379, 1553.9456119035779, 1558.4389619736885, 1575.3777257983033, 1577.89743666659, 1659.8506134447716, 33107.50338744969, 33829.83085084657, 34064.65935340615, 34123.0, 34127.31745365128, 54299.18551221656, 55310.0, 55344.72327638336, 55385.44614553803, 55437.44562554323, 439877.0, 440025.0, 442477.0, 443063.0, 444876.0, 31397.0, 31971.0, 32125.03624891257, 32266.193345166557, 32271.67728322687, 51319.23021154611, 51349.48650513597, 51490.74254628853, 52662.15682451096, 53038.0, 41658.79170604249, 42792.57207427886, 43493.3475997854, 43924.56075439205, 44802.77598611986, 42246.78876605597, 42626.36060459157, 42809.35785963275, 42882.571174287856, 44295.0, 43413.0, 43597.56402436062, 43724.56275437205, 44001.339979900964, 44258.0, 36024.099397515274, 36734.0, 37194.6280537202, 37646.62353376541, 37836.48654053807, 29513.0, 29778.851105744332, 30144.397112058075, 30470.695293047673, 30494.0], "value": 21695.624618734168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.401124442647, 433.59951800326934, 438.75868272450157, 439.3300217168819, 452.7985046654238, 18577.442676719704, 18942.90528547359, 19469.902650486747, 20660.070296836642, 20670.793292067076, 13099.803502947463, 19081.52296192596, 19539.023048847535, 20039.198432062738, 20065.699014514794, 5305.7877684892555, 5513.696746678931, 5546.334439867202, 5546.77812887486, 5548.667079975195, 5374.381946076212, 5407.188921661743, 5415.323084614423, 5484.533814625742, 5503.9174412383845, 5482.890342193154, 5496.120620700689, 5509.449055094498, 5529.364123125832, 5535.806246781363, 5503.20203570482, 5514.779408823642, 5517.089680202782, 5531.25328080708, 5646.40712725162, 5696.857578560528, 5737.483626473638, 5748.626339287933, 5764.913526297109, 5773.307203135609, 15090.924545377313, 23970.161044363536, 24069.15757948481, 24337.63493547598, 24338.63492047621, 2528.620706893962, 2546.312495626189, 2646.3913299940928, 3139.1053549738217, 3176.3012137329983, 10607.363558186533, 10647.361158330525, 10910.61812836547, 10957.890421095766, 11238.943805281004, 1935.2259096361568, 2063.4428704249767, 2067.8138967492996, 2071.326818783901, 2115.175081718116, 77016.61491692562, 78254.21745782583, 79289.60355198245, 80299.59850200711, 81289.18710812875, 11256.887431125584, 11782.410879455992, 11825.88174118265, 11934.28394296345, 11960.282383057045, 16649.750253746202, 16746.246418911178, 16802.57993550171, 16822.57943551421, 16861.325546977983, 8466.703665371682, 8825.20573148407, 8867.512286824158, 8874.112588741074, 9088.227500662386, 8686.609102590399, 8935.240504557056, 9027.232685221697, 9046.728598142066, 9106.86339704905, 5065.113605119163, 5131.2559678846355, 5213.895722085537, 5217.947820521822, 5235.895282094337, 2122.7558830734356, 2134.274346722122, 2138.5564743798186, 2217.113154738118, 2220.3893929169285, 948.4451595816387, 1105.5025238642643, 1129.0459561670375, 1139.8347239650204, 1153.5616465742964, 18961.43115706531, 19362.0, 19397.8060219396, 19416.611667766567, 19870.205191792455, 1069.6790962711154, 1086.7011571817654, 1105.0993440346092, 1113.9387333696725, 1124.5164579230845, 10388.636397726195, 11004.504797284142, 11068.28056176346, 11136.721581960515, 11213.3832639204, 187084.06457967623, 189366.0, 430590.0, 529290.0, 529796.0, 88398.0, 90015.0, 90350.0, 92154.53922730344, 93045.0, 1123.971566017118, 1144.8339990701468, 1159.5245949160803, 1165.918385713009, 1168.1063986050679, 17326.653466930842, 17346.91326543359, 17409.30362785525, 17565.912170439067, 17644.117794109985, 35440.822795885855, 35793.1051723709, 36461.63538364582, 36702.0, 38802.41796373113, 49858.50141498539, 53339.0, 53667.731661341444, 54048.0, 54226.45773542214, 8498.235158835487, 8771.649134034567, 8803.295736341206, 8855.158759917798, 8858.955705221433, 12901.290429026494, 13150.0, 13318.467261309439, 13394.397252123483, 13434.865651343362, 11174.888251117385, 11965.222260553037, 12240.0, 12241.326727030098, 12433.564825231073, 11727.648170554898, 12003.63989080329, 12207.755844882875, 12224.266544007389, 12344.135910486539, 10907.400092994962, 11421.885781142082, 12563.811542827048, 12700.618981430573, 12895.677608059874, 8974.86537701922, 9082.228010618906, 9150.176484116462, 9400.764980875532, 9460.148586627236, 12128.939355303168, 12522.49910003626, 12620.621381358575, 12644.810327844905, 12689.0], "value": 9447.514773883135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.4626427014816, 1604.1177352456154, 1851.6111616560522, 1961.0586918279234, 1964.6365422396848, 7328.633568321576, 8020.67917283308, 8145.185481451852, 8338.791530211747, 8344.45761025533, 8047.637856296466, 8248.092709801916, 8277.627506762195, 8367.079621241659, 8474.0, 2356.8468049576722, 2382.0, 2390.86433943877, 2395.544846479172, 2402.843815152018, 2388.9641655375185, 2423.357810180295, 2429.392651837041, 2437.695288088989, 2443.743406942272, 2380.27401642499, 2403.615421532555, 2409.975900240993, 2431.173401043645, 2447.412620970972, 2390.40239940015, 2395.64065390192, 2402.9306958403604, 2403.351095204294, 2436.817238707104, 2383.4041489627593, 2396.364963284731, 2402.5435167318155, 2405.579023670851, 2409.253131529214, 8531.0, 8541.103184165697, 8555.486670799772, 8579.013413457407, 8583.313334933253, 5341.278927344798, 5419.214213938996, 5445.428230035829, 5459.727013649302, 5460.836174914759, 3454.447288433864, 3479.9652003479896, 3491.91270218244, 3524.1718196223865, 3547.219611685425, 1104.1718710966775, 1108.9390083545402, 1135.2904434728296, 1142.3431526872082, 1147.0, 11686.24039437434, 11777.88222117785, 11841.0, 11863.99156071735, 11900.40497975089, 4488.865334039984, 4523.977380113079, 4567.406237189144, 4587.977060114745, 4594.5864872161665, 9557.092076252746, 9565.569549370295, 9578.616855325849, 9595.952020239994, 9598.9040109598, 5225.817096401608, 5263.684178949199, 5273.78904843802, 5299.655522391032, 5309.628326017141, 4767.308740232646, 4909.87725306863, 4943.72809495474, 4950.554450099508, 4953.8513844583995, 3718.386466233041, 3800.524934383202, 3832.865849695247, 3833.884983450501, 3915.393114067324, 1145.8109411946934, 1151.9136064795173, 1157.7973854575416, 1163.168334640736, 1188.5542921404474, 1049.192122066005, 1071.7588542578014, 1072.2547829258747, 1087.363892123101, 1087.6519513755522, 5885.764569417175, 6024.608400454044, 6117.602355846856, 6142.0, 6194.783182588678, 437.05159803227076, 439.39583073274247, 439.7383556783773, 441.76365644380746, 450.82417857035784, 4157.3140431829015, 4310.698251122454, 4343.109662519176, 4378.190034843564, 4381.1237752449, 10204.285700001077, 10559.577616895393, 10563.154947604173, 10601.363918164781, 10605.522751476203, 9974.650887218913, 10429.634962776418, 10434.5826166954, 10448.059674629169, 10462.424566648908, 8129.674813007414, 8130.837383252302, 8212.0, 8228.794280143044, 8253.380996425292, 5949.167116603766, 5964.761409543569, 6018.277806663228, 6073.392660733891, 6074.240719910012, 9305.488198148896, 9324.347295689236, 9476.905230947603, 9495.572699228689, 9535.189508891823, 9296.442213467213, 9491.525423728648, 9661.71014869555, 9666.98496657869, 9807.55865986018, 7289.890651640124, 7308.817279567841, 7347.8163045924275, 7436.107667079768, 7473.701051957861, 7962.800929976797, 7972.162922893012, 7988.081370642218, 8021.5187088774865, 8024.759257222293, 7258.600776957318, 7445.9627701861145, 7455.105387353336, 7552.244775522404, 7555.0, 7209.243029482039, 7296.452766042462, 7337.74317898871, 7345.192028876712, 7425.034745483269, 6928.826779330356, 6935.514513984174, 6966.582005079711, 6984.825379365557, 6991.510594258353, 5264.9736751315995, 5318.840434786963, 5358.303420555303, 5424.620276580601, 5523.558115350682, 5155.793768249378, 5198.9740051299505, 5216.765245563883, 5222.869428264324, 5253.711045892513], "value": 4523.274797687206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3114295979879, 368.63689266072913, 370.57569083399505, 377.1043771043771, 381.5002346925526, 6487.410584406821, 6494.155759751232, 6549.639769812658, 6585.440237579805, 6600.900986485194, 6453.8709225815455, 6457.0, 6491.123698300728, 6507.6420796856155, 6529.053287273343, 4890.559849613543, 4895.31465594817, 4897.289892965536, 4911.950880491203, 5039.521245481674, 4982.0, 4984.75076246188, 4988.127077761395, 4994.725290109042, 5006.874828129307, 4912.38595175603, 4922.926156107644, 4930.433000204968, 4932.80268789248, 4935.136351138554, 4926.704397736129, 4930.112579735646, 4943.802247910079, 4946.060248552763, 4953.777080031407, 4467.128909862578, 4470.396496472999, 4473.9105217895785, 4476.194285028693, 4480.283154695266, 6291.370862913672, 6292.4966002719675, 6302.653354065525, 6305.306416294204, 6307.463865571432, 5714.399988001242, 5832.591718579701, 5841.47426731592, 5842.795502157446, 5847.298324201123, 6774.949882768179, 6832.59004459734, 6836.521443498957, 6840.110785597841, 6841.144856892888, 4907.484714105003, 4913.287573301851, 4920.286558449041, 4925.655204135712, 4928.679635823696, 7061.752838650674, 7129.679164437561, 7144.46416518758, 7150.463715221327, 7152.678129484186, 4764.618830493552, 4995.350604421402, 4998.575121114746, 5003.399592048904, 5004.824831130965, 4942.950570494249, 4984.950150498448, 4988.700677959334, 4992.600591952635, 5005.27423523587, 5747.25285712863, 5750.25246717924, 5755.36690964002, 5763.596548241667, 5763.6541807491685, 6602.966985165043, 6779.389854913082, 6803.115594972721, 6835.213950395669, 6841.726330946806, 1774.4942691332908, 1804.927802887896, 1805.2147315917618, 1806.2413786209822, 1814.7822261328724, 1198.6823491774512, 1208.8428504294386, 1211.6970757310673, 1233.4387853526623, 1241.993790031044, 6678.599284042973, 6697.8995315070315, 6700.329967003358, 6704.229013663394, 6709.161354830646, 7068.540544864567, 7072.964635176894, 7082.39799617028, 7082.433405327562, 7085.291470852873, 6645.767398141042, 6656.933430665728, 6672.199336079604, 6674.332566743286, 6691.665416729144, 3769.849206031728, 3796.032011837019, 3816.790076545761, 3818.6181381862148, 3837.194189220239, 7464.1416237132335, 7464.70141194357, 7486.326230639269, 7495.62521873915, 7495.8500829983095, 7176.605286709281, 7197.676104575306, 7202.603856787927, 7215.67529461165, 7236.96381518089, 7424.109106907205, 7443.2184620615135, 7457.627118644046, 7461.626918654046, 7469.551826890295, 6959.234484206834, 7015.0, 7081.8937715935335, 7146.64266786669, 7167.390771784457, 6938.8612227756175, 6973.755918542826, 6978.825529361807, 6983.825404364931, 7017.859642807218, 7345.77962661121, 7423.146338171179, 7429.07136607924, 7445.9255407445235, 7461.701531938662, 5049.368828896388, 5055.266986287042, 5064.7467626619255, 5065.214891691794, 5068.6451948363265, 6939.826504337432, 7020.297970202939, 7053.717851285891, 7092.326229008236, 7149.642517873982, 6891.414229790324, 6926.0, 6927.134108236471, 6939.375456208965, 7002.509824312249, 6900.654967251517, 6911.930880691129, 6914.585124892523, 6928.757493487704, 6935.618540980295, 6783.3894949452815, 6799.2520822708475, 6803.795886123226, 6813.318668133147, 6817.89773153413, 6801.89797153053, 6871.725130994704, 6924.0, 6935.722571097302, 6940.201876784235, 6721.22705888829, 6758.966205168943, 6762.560433571802, 6764.763233286812, 6773.153355830521], "value": 5233.129954110284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.291676450164, 940.1350757303276, 944.9905500944989, 958.123317164794, 960.3901522533189, 14662.0, 14746.483873064444, 14798.112113273211, 15203.771943420843, 15433.0, 14562.199079050675, 14626.707465850677, 14630.268486575682, 14690.045147065433, 14702.779458308134, 897.0670502677241, 908.4276905549494, 932.4684929590136, 936.0452338614643, 936.2743873498059, 923.4182465047011, 923.4367036107968, 923.7967647117623, 925.9629614815399, 928.8513837785955, 969.9369540979849, 972.6158167523823, 973.5862258540128, 973.8880028796673, 975.9560819763128, 961.0917682789767, 962.499500259861, 963.4556475591269, 967.032967032967, 968.2883080935542, 711.6726305899292, 713.5112447973103, 713.6966789114606, 714.0681410758957, 716.7527203114917, 15490.45783397587, 15541.611459713484, 15740.44908428211, 15793.368265269375, 15876.920615396964, 14228.146311221257, 14390.928045359706, 14566.635834104127, 14606.926965365212, 14615.123092614476, 11399.148961524468, 11629.70925726855, 11656.184067115306, 11814.0, 11956.521739130425, 3967.246223217608, 3967.246223217608, 4031.1534577738416, 4050.7569545827346, 4056.9594304056877, 56421.15368269479, 56751.43248567544, 56860.43139568634, 56876.71561642165, 57347.42652573463, 10561.630342938113, 10643.46782660864, 11097.778044439066, 11126.777464450666, 11547.422628868522, 20664.690029649566, 20710.482237944172, 20731.689024664644, 20773.0, 20793.480162996046, 8551.1448855114, 8554.766027746204, 8724.43291186071, 8779.736607901774, 8818.779530511789, 4800.255960326155, 4842.5157484251295, 4879.414470263591, 4967.361885050192, 4970.378702662168, 3525.453554699026, 3578.5526809148855, 3584.1577229351083, 3585.5697316322207, 3592.2815436912724, 695.6382681005848, 698.8252936765808, 700.8037749430167, 709.4324540367685, 715.8854583266652, 719.586237913202, 817.8691409374471, 825.8719898415756, 831.4969443486724, 858.532100005486, 9885.0, 10400.375977441377, 10408.375497470177, 10566.207534434794, 10706.785864282827, 801.8195905921237, 817.7587611654576, 833.6957010691054, 844.50174397106, 855.4610595324906, 4762.59517940972, 4835.734034628129, 4838.758062096881, 4877.195262781602, 4877.5366340197625, 69332.3066769336, 69924.65037674778, 70070.0, 70295.0, 70944.64527677328, 59808.0, 60240.0, 60408.395916040274, 61128.694356528824, 61822.38177618166, 54107.72946135244, 54262.186067209026, 55047.449525505035, 55173.172402414, 55832.0, 9573.521323933915, 9596.616135354787, 9650.903490965, 9709.56306966174, 9807.362521436084, 40086.599134008284, 40130.0, 40886.38670419886, 41298.0, 41432.1713565733, 49115.0, 51363.0, 51431.0, 52446.47553524416, 53107.73446132745, 11954.0, 12085.75828483443, 12104.273743575413, 12302.200356976768, 12311.384430778604, 13145.145565538209, 13352.399142038437, 13437.0, 13442.596722098353, 13493.865061349654, 12699.365031748192, 12892.871071289166, 12899.226046437243, 12939.805902911276, 12967.740645187232, 11978.76042479163, 12220.327881966577, 12318.322492263012, 12342.75314493723, 12370.938145309576, 12584.0, 12623.36883155857, 12663.620091397273, 12677.936610316889, 12692.238465692088, 10547.419891906018, 10597.47012649349, 10696.0, 10784.191185661264, 10925.617603384162, 10948.178886583697, 10980.121590272918, 11128.0, 11128.666140015812, 11286.66140015768], "value": 7277.205065490215, "unit": "score"}], "name": "dromaeo_css", "value": 7603.652209057819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 105.0, 114.0, 113.0, 110.0, 101.0, 114.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 150.0, 177.0, 127.0, 154.0, 158.0, 128.0, 171.0, 132.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 163.0, 162.0, 170.0, 161.0, 162.0, 160.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 173.0, 76.0, 74.0, 76.0, 76.0, 166.0, 73.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 157.0, 91.0, 92.0, 91.0, 151.0, 91.0, 92.0, 144.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 151.0, 147.0, 148.0, 146.0, 145.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 56.0, 55.0, 61.0, 56.0, 68.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 75.0, 81.0, 74.0, 74.0, 74.0, 74.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 125.0, 121.0, 118.0, 116.0, 116.0, 124.0, 137.0, 130.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 157.0, 159.0, 167.0, 162.0, 159.0, 157.0, 161.0, 167.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 66.0, 68.0, 70.0, 66.0, 67.0, 69.0, 66.0, 70.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1523.0, "alertThreshold": 2.0}]} 17:38:36 INFO - Return code: 0 17:38:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:38:36 ERROR - # TBPL SUCCESS # 17:38:36 INFO - Running post-action listener: _resource_record_post_action 17:38:36 INFO - Running post-run listener: _resource_record_post_run 17:38:37 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 218304512; Read time: 260; Write time: 108120 17:38:37 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 700416; Read time: 0; Write time: 40 17:38:37 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 217006080; Read time: 260; Write time: 108080 17:38:37 INFO - Running post-run listener: _upload_blobber_files 17:38:37 INFO - Blob upload gear active. 17:38:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:38 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:38:38 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:38 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:38:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:39 INFO - (blobuploader) - INFO - Done attempting. 17:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:39 INFO - (blobuploader) - INFO - Done attempting. 17:38:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:39 INFO - Return code: 0 17:38:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4c3cd0c35259b9378359078bd939a7e2c8636376ed615bc270e43c13d43ee3950765060da077718e0b8007028589849e0102482994f6ad4cde0c886652d48fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/786a04be64a6e852c13861fa874abd442eb2963466ffb267d95c678b2fce91b1750a86a05fc494b72e323d81979dba8fb789d821a022cee17678e5a3b40c6132"} 17:38:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:39 INFO - Contents: 17:38:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4c3cd0c35259b9378359078bd939a7e2c8636376ed615bc270e43c13d43ee3950765060da077718e0b8007028589849e0102482994f6ad4cde0c886652d48fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/786a04be64a6e852c13861fa874abd442eb2963466ffb267d95c678b2fce91b1750a86a05fc494b72e323d81979dba8fb789d821a022cee17678e5a3b40c6132"} 17:38:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:39 INFO - Copying logs to upload dir... 17:38:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.318913 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-27 17:38:40.051603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:40.054955) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4c3cd0c35259b9378359078bd939a7e2c8636376ed615bc270e43c13d43ee3950765060da077718e0b8007028589849e0102482994f6ad4cde0c886652d48fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/786a04be64a6e852c13861fa874abd442eb2963466ffb267d95c678b2fce91b1750a86a05fc494b72e323d81979dba8fb789d821a022cee17678e5a3b40c6132"} build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4c3cd0c35259b9378359078bd939a7e2c8636376ed615bc270e43c13d43ee3950765060da077718e0b8007028589849e0102482994f6ad4cde0c886652d48fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/786a04be64a6e852c13861fa874abd442eb2963466ffb267d95c678b2fce91b1750a86a05fc494b72e323d81979dba8fb789d821a022cee17678e5a3b40c6132"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:40.080515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:40.080966) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467073094.60547-1738580415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:40.164161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:38:40.164471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:38:40.164766) ========= ========= Total master_lag: 0.17 =========