builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1466549267.5 results: success (0) buildid: 20160621142601 builduid: ccce332521bd4814801cd7f5205a0955 revision: 6cb5178d51b3980a46c1719ce3ad74757307c44a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.505217) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.505691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.505977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.564893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.565168) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 15:47:47-- 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% 227M=0s 2016-06-21 15:47:47 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138444 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.732819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.733163) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.116996 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.862757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:47.863135) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6cb5178d51b3980a46c1719ce3ad74757307c44a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6cb5178d51b3980a46c1719ce3ad74757307c44a --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=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 15:47:47,923 truncating revision to first 12 chars 2016-06-21 15:47:47,923 Setting DEBUG logging. 2016-06-21 15:47:47,923 attempt 1/10 2016-06-21 15:47:47,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6cb5178d51b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 15:47:48,212 unpacking tar archive at: fx-team-6cb5178d51b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:48.543398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:48.543775) ========= script_repo_revision: 6cb5178d51b3980a46c1719ce3ad74757307c44a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:48.544299) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:48.544585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 15:47:48.555187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-21 15:47:48.555639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:48 INFO - MultiFileLogger online at 20160621 15:47:48 in /builds/slave/test 15:47:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:47:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:48 INFO - {'append_to_log': False, 15:47:48 INFO - 'base_work_dir': '/builds/slave/test', 15:47:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:47:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:48 INFO - 'branch': 'Fx-Team-Non-PGO', 15:47:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:48 INFO - 'config_files': ('talos/linux_config.py',), 15:47:48 INFO - 'default_actions': ('clobber', 15:47:48 INFO - 'read-buildbot-config', 15:47:48 INFO - 'download-and-extract', 15:47:48 INFO - 'populate-webroot', 15:47:48 INFO - 'create-virtualenv', 15:47:48 INFO - 'install', 15:47:48 INFO - 'run-tests'), 15:47:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:48 INFO - 'download_minidump_stackwalk': True, 15:47:48 INFO - 'download_symbols': 'ondemand', 15:47:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:48 INFO - 'installer_path': 'installer.exe', 15:47:48 INFO - 'log_level': 'info', 15:47:48 INFO - 'log_name': 'talos', 15:47:48 INFO - 'log_to_console': True, 15:47:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:48 INFO - 'opt_config_files': (), 15:47:48 INFO - 'pip_index': False, 15:47:48 INFO - 'sps_profile': False, 15:47:48 INFO - 'sps_profile_interval': 0, 15:47:48 INFO - 'suite': 'dromaeojs-e10s', 15:47:48 INFO - 'system_bits': '32', 15:47:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:48 INFO - 'title': 'talos-linux64-ix-059', 15:47:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:48 INFO - 'use_talos_json': True, 15:47:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:48 INFO - 'work_dir': 'build'} 15:47:48 INFO - ##### 15:47:48 INFO - ##### Running clobber step. 15:47:48 INFO - ##### 15:47:48 INFO - Running pre-action listener: _resource_record_pre_action 15:47:48 INFO - Running main action method: clobber 15:47:48 INFO - rmtree: /builds/slave/test/build 15:47:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:52 INFO - Running post-action listener: _resource_record_post_action 15:47:52 INFO - ##### 15:47:52 INFO - ##### Finished clobber step (success) 15:47:52 INFO - ##### 15:47:52 INFO - ##### 15:47:52 INFO - ##### Running read-buildbot-config step. 15:47:52 INFO - ##### 15:47:52 INFO - Running pre-action listener: _resource_record_pre_action 15:47:52 INFO - Running main action method: read_buildbot_config 15:47:52 INFO - Using buildbot properties: 15:47:52 INFO - { 15:47:52 INFO - "project": "", 15:47:52 INFO - "product": "firefox", 15:47:52 INFO - "script_repo_revision": "production", 15:47:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:47:52 INFO - "repository": "", 15:47:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:47:52 INFO - "buildid": "20160621142601", 15:47:52 INFO - "pgo_build": "False", 15:47:52 INFO - "basedir": "/builds/slave/test", 15:47:52 INFO - "buildnumber": 1419, 15:47:52 INFO - "slavename": "talos-linux64-ix-059", 15:47:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:52 INFO - "platform": "ubuntu64_hw", 15:47:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:47:52 INFO - "branch": "fx-team", 15:47:52 INFO - "repo_path": "integration/fx-team", 15:47:52 INFO - "revision": "6cb5178d51b3980a46c1719ce3ad74757307c44a", 15:47:52 INFO - "stage_platform": "linux64", 15:47:52 INFO - "builduid": "ccce332521bd4814801cd7f5205a0955", 15:47:52 INFO - "slavebuilddir": "test" 15:47:52 INFO - } 15:47:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:47:52 INFO - Running post-action listener: _resource_record_post_action 15:47:52 INFO - ##### 15:47:52 INFO - ##### Finished read-buildbot-config step (success) 15:47:52 INFO - ##### 15:47:52 INFO - ##### 15:47:52 INFO - ##### Running download-and-extract step. 15:47:52 INFO - ##### 15:47:52 INFO - Running pre-action listener: _resource_record_pre_action 15:47:52 INFO - Running main action method: download_and_extract 15:47:52 INFO - mkdir: /builds/slave/test/build/tests 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:52 INFO - https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:47:54 INFO - Downloaded 1361 bytes. 15:47:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:54 INFO - Using the following test package requirements: 15:47:54 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:54 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:54 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:54 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'jsshell-linux-x86_64.zip'], 15:47:54 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:54 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:54 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:54 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:54 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:54 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:54 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')]} 15:47:54 INFO - https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:55 INFO - Downloaded 22701903 bytes. 15:47:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:47:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:47:56 INFO - Return code: 0 15:47:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:56 INFO - https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:58 INFO - Downloaded 22701903 bytes. 15:47:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:47:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:47:59 INFO - Return code: 0 15:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:59 INFO - https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:48:01 INFO - Downloaded 14405384 bytes. 15:48:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:48:01 INFO - Return code: 0 15:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:01 INFO - https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:48:02 INFO - Downloaded 56241209 bytes. 15:48:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:02 INFO - mkdir: /builds/slave/test/properties 15:48:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:02 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:02 INFO - Contents: 15:48:02 INFO - build_url:https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - Running post-action listener: set_extra_try_arguments 15:48:03 INFO - ##### 15:48:03 INFO - ##### Finished download-and-extract step (success) 15:48:03 INFO - ##### 15:48:03 INFO - ##### 15:48:03 INFO - ##### Running populate-webroot step. 15:48:03 INFO - ##### 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: populate_webroot 15:48:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:03 INFO - '--tppagecycles', 15:48:03 INFO - '7'], 15:48:03 INFO - 'tests': ['tsvgm']}}, 15:48:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['damp', 'tps']}, 15:48:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'tests': ['damp', 'tps']}, 15:48:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['dromaeo_dom']}, 15:48:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['basic_compositor_video']}, 15:48:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['a11yr', 15:48:03 INFO - 'ts_paint', 15:48:03 INFO - 'tpaint', 15:48:03 INFO - 'sessionrestore', 15:48:03 INFO - 'sessionrestore_no_auto_restore', 15:48:03 INFO - 'tabpaint']}, 15:48:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['tsvgx', 15:48:03 INFO - 'tsvgr_opacity', 15:48:03 INFO - 'tart', 15:48:03 INFO - 'tscrollx', 15:48:03 INFO - 'cart']}, 15:48:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:03 INFO - 'tsvgr_opacity', 15:48:03 INFO - 'tart', 15:48:03 INFO - 'tscrollx', 15:48:03 INFO - 'cart']}, 15:48:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'talos_options': ['--disable-e10s'], 15:48:03 INFO - 'tests': ['tp5o']}, 15:48:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'tests': ['tp5o']}, 15:48:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'talos_options': ['--disable-e10s', 15:48:03 INFO - '--xperf_path', 15:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:03 INFO - 'tests': ['tp5n']}, 15:48:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:03 INFO - 'talos_options': ['--xperf_path', 15:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:03 INFO - 'tests': ['tp5n']}}, 15:48:03 INFO - 'talos.zip': {'path': '', 15:48:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - ##### 15:48:03 INFO - ##### Finished populate-webroot step (success) 15:48:03 INFO - ##### 15:48:03 INFO - ##### 15:48:03 INFO - ##### Running create-virtualenv step. 15:48:03 INFO - ##### 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: create_virtualenv 15:48:03 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:03 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 15:48:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:03 INFO - Using real prefix '/usr' 15:48:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:06 INFO - Installing pip.................done. 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:06 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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:06 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 15:48:06 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 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 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 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:06 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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:06 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>=3.1.1'] in /builds/slave/test/build 15:48:06 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>=3.1.1 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:07 INFO - Downloading/unpacking psutil>=3.1.1 15:48:07 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 15:48:07 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 15:48:07 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 15:48:07 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 15:48:07 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 15:48:07 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 15:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:09 INFO - Installing collected packages: psutil 15:48:09 INFO - Running setup.py install for psutil 15:48:09 INFO - building 'psutil._psutil_linux' extension 15:48:09 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 15:48:10 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 15:48:10 INFO - building 'psutil._psutil_posix' extension 15:48:10 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 15:48:10 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 15:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:10 INFO - Successfully installed psutil 15:48:10 INFO - Cleaning up... 15:48:10 INFO - Return code: 0 15:48:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:48:10 INFO - Using env: {'DISPLAY': ':0', 15:48:10 INFO - 'HOME': '/home/cltbld', 15:48:10 INFO - 'LANG': 'en_US.UTF-8', 15:48:10 INFO - 'LANGUAGE': 'en_US:en', 15:48:10 INFO - 'LOGNAME': 'cltbld', 15:48:10 INFO - 'MAIL': '/var/mail/cltbld', 15:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:10 INFO - 'MOZ_NO_REMOTE': '1', 15:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:10 INFO - 'NO_EM_RESTART': '1', 15:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:10 INFO - 'PWD': '/builds/slave/test', 15:48:10 INFO - 'SHELL': '/bin/bash', 15:48:10 INFO - 'SHLVL': '1', 15:48:10 INFO - 'TERM': 'linux', 15:48:10 INFO - 'TMOUT': '86400', 15:48:10 INFO - 'USER': 'cltbld', 15:48:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:10 INFO - '_': '/tools/buildbot/bin/python'} 15:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:12 INFO - Installing collected packages: mozsystemmonitor 15:48:12 INFO - Running setup.py install for mozsystemmonitor 15:48:12 INFO - Successfully installed mozsystemmonitor 15:48:12 INFO - Cleaning up... 15:48:13 INFO - Return code: 0 15:48:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:13 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')]} 15:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:13 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')]} 15:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:13 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:13 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==2.5.1'] in /builds/slave/test/build 15:48:13 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==2.5.1 15:48:13 INFO - Using env: {'DISPLAY': ':0', 15:48:13 INFO - 'HOME': '/home/cltbld', 15:48:13 INFO - 'LANG': 'en_US.UTF-8', 15:48:13 INFO - 'LANGUAGE': 'en_US:en', 15:48:13 INFO - 'LOGNAME': 'cltbld', 15:48:13 INFO - 'MAIL': '/var/mail/cltbld', 15:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:13 INFO - 'MOZ_NO_REMOTE': '1', 15:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:13 INFO - 'NO_EM_RESTART': '1', 15:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:13 INFO - 'PWD': '/builds/slave/test', 15:48:13 INFO - 'SHELL': '/bin/bash', 15:48:13 INFO - 'SHLVL': '1', 15:48:13 INFO - 'TERM': 'linux', 15:48:13 INFO - 'TMOUT': '86400', 15:48:13 INFO - 'USER': 'cltbld', 15:48:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:13 INFO - '_': '/tools/buildbot/bin/python'} 15:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:13 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:15 INFO - warning: no files found matching '*.txt' 15:48:15 INFO - no previously-included directories found matching 'build' 15:48:15 INFO - no previously-included directories found matching 'dist' 15:48:15 INFO - no previously-included directories found matching '.git*' 15:48:15 INFO - Installing collected packages: jsonschema, functools32 15:48:15 INFO - Running setup.py install for functools32 15:48:15 INFO - warning: no files found matching '*.txt' 15:48:15 INFO - no previously-included directories found matching 'build' 15:48:15 INFO - no previously-included directories found matching 'dist' 15:48:15 INFO - no previously-included directories found matching '.git*' 15:48:15 INFO - Successfully installed jsonschema functools32 15:48:15 INFO - Cleaning up... 15:48:15 INFO - Return code: 0 15:48:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:15 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 15:48:15 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 15:48:15 INFO - Using env: {'DISPLAY': ':0', 15:48:15 INFO - 'HOME': '/home/cltbld', 15:48:15 INFO - 'LANG': 'en_US.UTF-8', 15:48:15 INFO - 'LANGUAGE': 'en_US:en', 15:48:15 INFO - 'LOGNAME': 'cltbld', 15:48:15 INFO - 'MAIL': '/var/mail/cltbld', 15:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:15 INFO - 'MOZ_NO_REMOTE': '1', 15:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:15 INFO - 'NO_EM_RESTART': '1', 15:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:15 INFO - 'PWD': '/builds/slave/test', 15:48:15 INFO - 'SHELL': '/bin/bash', 15:48:15 INFO - 'SHLVL': '1', 15:48:15 INFO - 'TERM': 'linux', 15:48:15 INFO - 'TMOUT': '86400', 15:48:15 INFO - 'USER': 'cltbld', 15:48:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:15 INFO - '_': '/tools/buildbot/bin/python'} 15:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:15 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 15:48:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:17 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 15:48:17 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 15:48:17 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 15:48:17 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 15:48:17 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 15:48:17 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 15:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:18 INFO - Downloading docopt-0.6.1.tar.gz 15:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:18 INFO - Running setup.py install for blobuploader 15:48:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:18 INFO - Running setup.py install for requests 15:48:18 INFO - Running setup.py install for docopt 15:48:19 INFO - Successfully installed blobuploader requests docopt 15:48:19 INFO - Cleaning up... 15:48:19 INFO - Return code: 0 15:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:19 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:19 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 15:48:19 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 15:48:19 INFO - Using env: {'DISPLAY': ':0', 15:48:19 INFO - 'HOME': '/home/cltbld', 15:48:19 INFO - 'LANG': 'en_US.UTF-8', 15:48:19 INFO - 'LANGUAGE': 'en_US:en', 15:48:19 INFO - 'LOGNAME': 'cltbld', 15:48:19 INFO - 'MAIL': '/var/mail/cltbld', 15:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:19 INFO - 'MOZ_NO_REMOTE': '1', 15:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:19 INFO - 'NO_EM_RESTART': '1', 15:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:19 INFO - 'PWD': '/builds/slave/test', 15:48:19 INFO - 'SHELL': '/bin/bash', 15:48:19 INFO - 'SHLVL': '1', 15:48:19 INFO - 'TERM': 'linux', 15:48:19 INFO - 'TMOUT': '86400', 15:48:19 INFO - 'USER': 'cltbld', 15:48:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:19 INFO - '_': '/tools/buildbot/bin/python'} 15:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:19 INFO - Running setup.py (path:/tmp/pip-cX9X_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:19 INFO - Running setup.py (path:/tmp/pip-aefktW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:19 INFO - Running setup.py (path:/tmp/pip-dL_Qpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:19 INFO - Running setup.py (path:/tmp/pip-sIYA7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:19 INFO - Running setup.py (path:/tmp/pip-obMqJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:19 INFO - Running setup.py (path:/tmp/pip-qTqlVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:19 INFO - Running setup.py (path:/tmp/pip-edHjj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:19 INFO - Running setup.py (path:/tmp/pip-Y8JOHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:19 INFO - Running setup.py (path:/tmp/pip-Kozu7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:19 INFO - Running setup.py (path:/tmp/pip-iBH6_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:20 INFO - Running setup.py (path:/tmp/pip-13JVvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:20 INFO - Running setup.py (path:/tmp/pip-zfpWa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:20 INFO - Running setup.py (path:/tmp/pip-__0eEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:20 INFO - Running setup.py (path:/tmp/pip-H2FjDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:20 INFO - Running setup.py (path:/tmp/pip-JcQl0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:20 INFO - Running setup.py (path:/tmp/pip-HqUich-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:20 INFO - Running setup.py (path:/tmp/pip-QJdL0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:20 INFO - Running setup.py install for manifestparser 15:48:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:20 INFO - Running setup.py install for mozcrash 15:48:20 INFO - Running setup.py install for mozdebug 15:48:20 INFO - Running setup.py install for mozdevice 15:48:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:20 INFO - Running setup.py install for mozfile 15:48:21 INFO - Running setup.py install for mozhttpd 15:48:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for mozinfo 15:48:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for mozInstall 15:48:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for mozleak 15:48:21 INFO - Running setup.py install for mozlog 15:48:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for moznetwork 15:48:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for mozprocess 15:48:21 INFO - Running setup.py install for mozprofile 15:48:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:21 INFO - Running setup.py install for mozrunner 15:48:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:22 INFO - Running setup.py install for mozscreenshot 15:48:22 INFO - Running setup.py install for moztest 15:48:22 INFO - Running setup.py install for mozversion 15:48:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:22 INFO - Cleaning up... 15:48:22 INFO - Return code: 0 15:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:22 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:22 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 15:48:22 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 15:48:22 INFO - Using env: {'DISPLAY': ':0', 15:48:22 INFO - 'HOME': '/home/cltbld', 15:48:22 INFO - 'LANG': 'en_US.UTF-8', 15:48:22 INFO - 'LANGUAGE': 'en_US:en', 15:48:22 INFO - 'LOGNAME': 'cltbld', 15:48:22 INFO - 'MAIL': '/var/mail/cltbld', 15:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:22 INFO - 'MOZ_NO_REMOTE': '1', 15:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:22 INFO - 'NO_EM_RESTART': '1', 15:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:22 INFO - 'PWD': '/builds/slave/test', 15:48:22 INFO - 'SHELL': '/bin/bash', 15:48:22 INFO - 'SHLVL': '1', 15:48:22 INFO - 'TERM': 'linux', 15:48:22 INFO - 'TMOUT': '86400', 15:48:22 INFO - 'USER': 'cltbld', 15:48:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:22 INFO - '_': '/tools/buildbot/bin/python'} 15:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:22 INFO - Running setup.py (path:/tmp/pip-ORDlTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:22 INFO - Running setup.py (path:/tmp/pip-K_Cbob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:22 INFO - Running setup.py (path:/tmp/pip-xk3T6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:22 INFO - Running setup.py (path:/tmp/pip-bEYMua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:22 INFO - Running setup.py (path:/tmp/pip-DwBYL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:22 INFO - Running setup.py (path:/tmp/pip-XYMgAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:22 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)) 15:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:22 INFO - Running setup.py (path:/tmp/pip-dDcCTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:23 INFO - Running setup.py (path:/tmp/pip-TmmyCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:23 INFO - Running setup.py (path:/tmp/pip-6manxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:23 INFO - Running setup.py (path:/tmp/pip-WNPak3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:23 INFO - Running setup.py (path:/tmp/pip-iChW5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:23 INFO - Running setup.py (path:/tmp/pip-aKjNMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:23 INFO - Running setup.py (path:/tmp/pip-e0ngaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:23 INFO - Running setup.py (path:/tmp/pip-2iaIAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:23 INFO - Running setup.py (path:/tmp/pip-48gpPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:23 INFO - Running setup.py (path:/tmp/pip-uUFEZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:23 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)) 15:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:23 INFO - Running setup.py (path:/tmp/pip-coqRqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:23 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)) 15:48:23 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)) 15:48:23 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)) 15:48:23 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)) 15:48:23 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)) 15:48:23 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)) 15:48:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:25 INFO - Downloading blessings-1.6.tar.gz 15:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:25 INFO - Installing collected packages: blessings 15:48:25 INFO - Running setup.py install for blessings 15:48:25 INFO - Successfully installed blessings 15:48:25 INFO - Cleaning up... 15:48:25 INFO - Return code: 0 15:48:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:26 INFO - Reading from file tmpfile_stdout 15:48:26 INFO - Current package versions: 15:48:26 INFO - argparse == 1.2.1 15:48:26 INFO - blessings == 1.6 15:48:26 INFO - blobuploader == 1.2.4 15:48:26 INFO - docopt == 0.6.1 15:48:26 INFO - functools32 == 3.2.3-2 15:48:26 INFO - jsonschema == 2.5.1 15:48:26 INFO - manifestparser == 1.1 15:48:26 INFO - mozInstall == 1.12 15:48:26 INFO - mozcrash == 0.17 15:48:26 INFO - mozdebug == 0.1 15:48:26 INFO - mozdevice == 0.48 15:48:26 INFO - mozfile == 1.2 15:48:26 INFO - mozhttpd == 0.7 15:48:26 INFO - mozinfo == 0.9 15:48:26 INFO - mozleak == 0.1 15:48:26 INFO - mozlog == 3.2 15:48:26 INFO - moznetwork == 0.27 15:48:26 INFO - mozprocess == 0.22 15:48:26 INFO - mozprofile == 0.28 15:48:26 INFO - mozrunner == 6.11 15:48:26 INFO - mozscreenshot == 0.1 15:48:26 INFO - mozsystemmonitor == 0.3 15:48:26 INFO - moztest == 0.7 15:48:26 INFO - mozversion == 1.4 15:48:26 INFO - psutil == 3.1.1 15:48:26 INFO - requests == 1.2.3 15:48:26 INFO - wsgiref == 0.1.2 15:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:26 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')]} 15:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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')]} 15:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:26 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 15:48:26 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 15:48:26 INFO - Using env: {'DISPLAY': ':0', 15:48:26 INFO - 'HOME': '/home/cltbld', 15:48:26 INFO - 'LANG': 'en_US.UTF-8', 15:48:26 INFO - 'LANGUAGE': 'en_US:en', 15:48:26 INFO - 'LOGNAME': 'cltbld', 15:48:26 INFO - 'MAIL': '/var/mail/cltbld', 15:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:26 INFO - 'MOZ_NO_REMOTE': '1', 15:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:26 INFO - 'NO_EM_RESTART': '1', 15:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:26 INFO - 'PWD': '/builds/slave/test', 15:48:26 INFO - 'SHELL': '/bin/bash', 15:48:26 INFO - 'SHLVL': '1', 15:48:26 INFO - 'TERM': 'linux', 15:48:26 INFO - 'TMOUT': '86400', 15:48:26 INFO - 'USER': 'cltbld', 15:48:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:26 INFO - '_': '/tools/buildbot/bin/python'} 15:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 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)) 15:48:26 INFO - Cleaning up... 15:48:26 INFO - Return code: 0 15:48:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:26 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')]} 15:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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')]} 15:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:26 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 15:48:26 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 15:48:26 INFO - Using env: {'DISPLAY': ':0', 15:48:26 INFO - 'HOME': '/home/cltbld', 15:48:26 INFO - 'LANG': 'en_US.UTF-8', 15:48:26 INFO - 'LANGUAGE': 'en_US:en', 15:48:26 INFO - 'LOGNAME': 'cltbld', 15:48:26 INFO - 'MAIL': '/var/mail/cltbld', 15:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:26 INFO - 'MOZ_NO_REMOTE': '1', 15:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:26 INFO - 'NO_EM_RESTART': '1', 15:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:26 INFO - 'PWD': '/builds/slave/test', 15:48:26 INFO - 'SHELL': '/bin/bash', 15:48:26 INFO - 'SHLVL': '1', 15:48:26 INFO - 'TERM': 'linux', 15:48:26 INFO - 'TMOUT': '86400', 15:48:26 INFO - 'USER': 'cltbld', 15:48:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:26 INFO - '_': '/tools/buildbot/bin/python'} 15:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:26 INFO - Cleaning up... 15:48:26 INFO - Return code: 0 15:48:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:48:26 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')]} 15:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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')]} 15:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:26 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 0x7f9a7e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1211350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', '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 15:48:26 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 15:48:26 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 15:48:26 INFO - Using env: {'DISPLAY': ':0', 15:48:26 INFO - 'HOME': '/home/cltbld', 15:48:26 INFO - 'LANG': 'en_US.UTF-8', 15:48:26 INFO - 'LANGUAGE': 'en_US:en', 15:48:26 INFO - 'LOGNAME': 'cltbld', 15:48:26 INFO - 'MAIL': '/var/mail/cltbld', 15:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:26 INFO - 'MOZ_NO_REMOTE': '1', 15:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:26 INFO - 'NO_EM_RESTART': '1', 15:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:26 INFO - 'PWD': '/builds/slave/test', 15:48:26 INFO - 'SHELL': '/bin/bash', 15:48:26 INFO - 'SHLVL': '1', 15:48:26 INFO - 'TERM': 'linux', 15:48:26 INFO - 'TMOUT': '86400', 15:48:26 INFO - 'USER': 'cltbld', 15:48:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:26 INFO - '_': '/tools/buildbot/bin/python'} 15:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:26 INFO - Downloading/unpacking flake8 15:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:48:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:48:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:28 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 15:48:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:29 INFO - no previously-included directories found matching 'docs/_build' 15:48:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:48:29 INFO - Running setup.py install for pep8 15:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:29 INFO - no previously-included directories found matching 'docs/_build' 15:48:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:48:29 INFO - Cleaning up... 15:48:29 INFO - Return code: 0 15:48:29 INFO - Running post-action listener: _resource_record_post_action 15:48:29 INFO - Running post-action listener: _start_resource_monitoring 15:48:29 INFO - Starting resource monitoring. 15:48:29 INFO - ##### 15:48:29 INFO - ##### Finished create-virtualenv step (success) 15:48:29 INFO - ##### 15:48:29 INFO - ##### 15:48:29 INFO - ##### Running install step. 15:48:29 INFO - ##### 15:48:29 INFO - Running pre-action listener: _resource_record_pre_action 15:48:29 INFO - Running main action method: install 15:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:29 INFO - Reading from file tmpfile_stdout 15:48:29 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:29 INFO - Reading from file tmpfile_stdout 15:48:29 INFO - Output received: 15:48:29 INFO - Usage: mozinstall [options] installer 15:48:29 INFO - Options: 15:48:29 INFO - -h, --help show this help message and exit 15:48:29 INFO - -d DEST, --destination=DEST 15:48:29 INFO - Directory to install application into. [default: 15:48:29 INFO - "/builds/slave/test"] 15:48:29 INFO - --app=APP Application being installed. [default: firefox] 15:48:29 INFO - mkdir: /builds/slave/test/build/application 15:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:48:46 INFO - Reading from file tmpfile_stdout 15:48:46 INFO - Output received: 15:48:46 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:46 INFO - Running post-action listener: _resource_record_post_action 15:48:46 INFO - ##### 15:48:46 INFO - ##### Finished install step (success) 15:48:46 INFO - ##### 15:48:46 INFO - ##### 15:48:46 INFO - ##### Running run-tests step. 15:48:46 INFO - ##### 15:48:46 INFO - Running pre-action listener: _resource_record_pre_action 15:48:46 INFO - Running main action method: run_tests 15:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:46 INFO - Python 2.7.3 15:48:46 INFO - Return code: 0 15:48:46 INFO - grabbing minidump binary from tooltool 15:48: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')]} 15:48:46 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a01c0>, '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 0x12a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:46 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 15:48:46 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 15:48:46 INFO - Calling ['/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'] with output_timeout 600 15:48:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:46 INFO - Return code: 0 15:48:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:48:47 INFO - Return code: 0 15:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 15:48:47 INFO - Using env: {'DISPLAY': ':0', 15:48:47 INFO - 'HOME': '/home/cltbld', 15:48:47 INFO - 'LANG': 'en_US.UTF-8', 15:48:47 INFO - 'LANGUAGE': 'en_US:en', 15:48:47 INFO - 'LOGNAME': 'cltbld', 15:48:47 INFO - 'MAIL': '/var/mail/cltbld', 15:48:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:47 INFO - 'MOZ_NO_REMOTE': '1', 15:48:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:47 INFO - 'NO_EM_RESTART': '1', 15:48:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:47 INFO - 'PWD': '/builds/slave/test', 15:48:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:47 INFO - 'SHELL': '/bin/bash', 15:48:47 INFO - 'SHLVL': '1', 15:48:47 INFO - 'TERM': 'linux', 15:48:47 INFO - 'TMOUT': '86400', 15:48:47 INFO - 'USER': 'cltbld', 15:48:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621', 15:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:47 INFO - '_': '/tools/buildbot/bin/python'} 15:48:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:48:47 INFO - mozversion application_buildid: 20160621142601 15:48:47 INFO - mozversion application_changeset: 6cb5178d51b3980a46c1719ce3ad74757307c44a 15:48:47 INFO - mozversion application_display_name: Nightly 15:48:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:47 INFO - mozversion application_name: Firefox 15:48:47 INFO - mozversion application_remotingname: firefox 15:48:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:48:47 INFO - mozversion application_vendor: Mozilla 15:48:47 INFO - mozversion application_version: 50.0a1 15:48:47 INFO - mozversion platform_buildid: 20160621142601 15:48:47 INFO - mozversion platform_changeset: 6cb5178d51b3980a46c1719ce3ad74757307c44a 15:48:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:48:47 INFO - mozversion platform_version: 50.0a1 15:48:47 INFO - using testdate: 1466549327 15:48:47 INFO - actual date: 1466549327 15:48:47 INFO - starting webserver on 'localhost:33100' 15:48:47 INFO - SUITE-START | Running 2 tests 15:48:47 INFO - TEST-START | dromaeo_css 15:48:47 INFO - operating with platform_type : linux_ 15:48:47 INFO - Initialising browser for dromaeo_css test... 15:48:47 INFO - TEST-INFO | started process 3329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTtskOB/profile http://localhost:33100/getInfo.html) 15:48:53 INFO - PROCESS | 3329 | __metrics Screen width/height:1600/1200 15:48:53 INFO - PROCESS | 3329 | colorDepth:24 15:48:53 INFO - PROCESS | 3329 | Browser inner width/height: 1024/697 15:48:53 INFO - PROCESS | 3329 | __metrics 15:48:54 ERROR - PROCESS | 3329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:48:54 INFO - TEST-INFO | 3329: exit 0 15:48:54 INFO - Browser initialized. 15:48:54 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:54 INFO - TEST-INFO | started process 3447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTtskOB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:07 INFO - PROCESS | 3447 | RSS: Main: 185954304 15:49:07 INFO - PROCESS | 3447 | 15:49:56 INFO - PROCESS | 3447 | 1466549396673 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] 15:52:09 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33100/tests/dromaeo/cssquery-ext.html) 15:52:10 INFO - PROCESS | 3447 | RSS: Main: 188887040 15:52:10 INFO - PROCESS | 3447 | 15:55:12 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-ext.html (next: http://localhost:33100/tests/dromaeo/cssquery-jquery.html) 15:55:13 INFO - PROCESS | 3447 | RSS: Main: 188411904 15:55:13 INFO - PROCESS | 3447 | 15:58:15 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33100/tests/dromaeo/cssquery-mootools.html) 15:58:15 INFO - PROCESS | 3447 | RSS: Main: 189665280 15:58:15 INFO - PROCESS | 3447 | 16:01:17 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33100/tests/dromaeo/cssquery-prototype.html) 16:01:18 INFO - PROCESS | 3447 | RSS: Main: 186810368 16:01:18 INFO - PROCESS | 3447 | 16:04:20 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33100/tests/dromaeo/cssquery-yui.html) 16:04:21 INFO - PROCESS | 3447 | RSS: Main: 189161472 16:04:21 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:33100/tests/dromaeo/cssquery-yui.html (next: http://localhost:33100/tests/dromaeo/cssquery-dojo.html) 16:07:24 INFO - PROCESS | 3447 | RSS: Main: 189997056 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | __start_tp_report 16:07:24 INFO - PROCESS | 3447 | _x_x_mozilla_page_load 16:07:24 INFO - PROCESS | 3447 | _x_x_mozilla_page_load_details 16:07:24 INFO - PROCESS | 3447 | |i|pagename|runs| 16:07:24 INFO - PROCESS | 3447 | |0;dojo.html;2615.5292047431462;2687.784977201824;2691.582804665277;2700.62191293219;2718.5650295952637;4797.208460604001;4810.927836082457;4836.2020266656;4897.681650692712;4909.803607855691;4632.0967411354795;4835.951640483594;4850;4863.489333619972;4921.261810728383;4418.690691651594;4444.377787109791;4557.954420455802;4569.748663823489;4579.473360563527;570.7673601053904;4378.430803995476;4406.339049142623;4450.910981780363;4489.46126464823;4418.82324707013;4457.576530229623;4460.1525710114975;4474.932876006863;4514.074614703978;4462.107578484316;4466.977665111686;4473.418455600784;4522.982328975987;4547.681662283641;4287.399764033038;4416.911661766747;4419.779011049434;4433.290673492225;4451.643868490513;4803.56767890888;4858.076965376567;4865.78103985318;4871.756412179377;4965.106280869442;5084.745762711849;5232.555232805216;5243;5252.737363131828;5305.495977882095;5133.409657889353;5173.611979101583;5175.974120129413;5178.4562620924635;5233.267342572043;4788.090262850117;4825.493323201048;4830.203016502238;4843.2250839865455;4873.244647079709;5180.378354597472;5214.504622060898;5250.422453530108;5258.553022993012;5267.631265811357;5027.673201241908;5045.117104506697;5061.063703214917;5062.797488100508;5103.055934652101;5108.897822043538;5121.8463446096675;5124.256982737482;5128.8717782055;5165.354330708661;5119.539241468211;5168.8449346519665;5185.014847179099;5191.6625419348375;5193.1171700810955;5152.871178220575;5160.793568257228;5168.069747445421;5168.302279192261;5236.29310043147;4319.740815551014;4411.29419292918;4414.84548040817;4462.308342206963;4503.954960450354;3832.559255685632;3864.381698928158;3865.033741564609;3899.434581985596;3920.2747491713553;4315.28797748368;4385.846495372647;4414.779261036935;4456.554344565518;4460.330950357407;5051.1160546904875;5202.115640341151;5214.061468935628;5220.7128607926925;5260.92108618371;4430.822767089345;4468.285074388083;4492.842750503717;4502.594766471033;4513.368128462018;4721.976390118096;4722.386089808303;4722.6221902247735;4731.952680473151;4776.14029474691;4650.767461626972;4813.350197723403;4904.975475122673;4929.383827021622;4940.728259945738;5171.586273098068;5202.739863006759;5227.032998895064;5248;5248.475152484873;4897.216445368724;4914;4915.680480768739;4923.532264434873;4928.21148616234;4981.8007279709855;5060.671056381323;5126.897462050663;5160.329157209539;5180.197069454241;5202.271681964604;5231.581473482036;5252.238425428215;5253.054450199001;5283.1546952487415;5075.390953085505;5087.4403815581;5091.821786237464;5100.285959965534;5139.049275883974;4866;4986.6010719143105;5010.674306170087;5016.846125391107;5086.465921078234;4919.7540122993;4940.382452193476;4950.455449900436;4957.677750946177;4978.7510624467905;5021.07110184617;5046.545810877039;5066.544011039025;5084.898302034013;5119.257707632298;4829.492903245249;4948.480409557089;4983.8504844854715;4984.975075124601;4991.101601711582 16:07:24 INFO - PROCESS | 3447 | |1;ext.html;565.2256408720054;585.7100735136108;587.8765459253557;596.6032588328765;599.4155698194264;37280.81359593201;38272.234555308874;38368;38419.42370864436;38444.61555384445;37976.240475190476;38693.61306386935;38741.22517549654;38777.806110969475;38851.41722874159;7573.999999999986;7714.305712485875;7737.845243095135;7740.419468539854;7764.18476060014;7771;7825.474032563652;7838.490498117632;7842.451028428012;7860.174681658429;7818.218178182165;7826.413019023567;7830.804229894241;7832.882506762403;7851.764447066568;7794.259545343183;7838.412119091034;7842.960785196095;7847.332976696931;7853.057633084067;7618.352440042603;7638.656260468292;7697;7726.150123486468;7761.379089672869;36318;36437.45343819845;36497;36654.8167259162;36804.631953680386;2549.3754030262703;2939.779516536268;2973.747231485326;3055.9847200764075;3057.8929737459302;25849.09528166505;26966.865165674244;27482.725172748218;27602;28192.436151277067;3437.742169337285;3452.478471958588;3473.6526347365316;3483.3033393321184;3509.894703158909;225618;226150;226279;227715.99999999834;229146;31674.68325316717;32107.678923210937;32419.18952026171;32441.18897027546;32767.672323276463;34102.82948585291;34393.140171495914;34393.484097738554;34400.483992740126;34456.82771586126;13993.790093148611;14027.859721402656;14146.929265353814;14185.929070354583;14247.931405144656;11162.386068766133;11259.718507037389;11261.887381126247;11308.773824523463;11333.26333788301;7896.644650990719;7995.680712682342;8006.879896801553;8010.359171266285;8027.638756255982;3106.7980581262145;3112.4086423579447;3133.3576616793503;3143.4184675835045;3161.873525059018;866.67066514724;878.9891624631724;901.0178904993588;928.6471140966389;966.9371490853072;28248.29379265494;28264.29339266535;28588.714112859023;28735.42529149405;28869;970.7767213540925;1024.6618615856748;1034.9586016559404;1062.4634559547378;1070.539667942792;14944.775828362583;15094.320755566026;15207.771883421758;15378.692426151414;15512.534623961299;366698;369196;373925;374529;375359;49762.50237497579;50016.74991625091;50139.49860501421;50258.246126308135;50467;1159.2291126401017;1187.8396416483663;1189.690680423079;1201.1471854982885;1203.5787474384072;27165.320866977694;27541;27770.583441247993;28167;28314.150575482767;44075.77962110169;44090.55909440864;44167.77916110399;44379.77810110929;44487.11025779402;318167;320383.39808300807;320597;321175;322250;25214.495710085328;25620.23139305824;25705;25909.352266193495;26044.609330859672;42626.57373426226;42839;42873;43026;43563;36657.63342366542;37209.813950930074;37343.43984840284;37607.811960940024;38088.809555952044;35896.46155307725;36311.09222269359;36415.817920911286;36508.26983460369;36530.452043219906;33387.83306083454;36091.45862812112;36184;37257.813710931274;37317;30348.544771827997;31779.841100794347;33734.49398258979;33775.3244935095;34040.48939265864;25250.873745631154;25339.87330063338;25571.488570228863;26038;26225.213243602724 16:07:24 INFO - PROCESS | 3447 | |2;jquery.html;362.1941180872559;364.3532729405306;376.3808534959989;382.54060758207436;385.41609461665564;16434.753478697814;17074.40239591613;17592.912035439836;17600.823991760077;17601.55996100098;16254;16666.416675416363;17300.567485812862;17319.91340043301;17342.306307747705;4984.7756850941705;5149.253358263049;5192.610554208431;5208.895822083556;5209.400918894337;3729.6829769469628;5115.4884511548735;5735.340435849868;6010.8797824043495;6031.457168854802;6047.788327408542;6056.939430605704;6058.96970515149;6059.272887253535;6083.847903802418;5007.924881126786;5295.920561191585;5320.201969704536;5352.785888564453;5355.277037599952;5079.644424890259;5130.153524668425;5213.32226810516;5225.686458812484;5247;10854.72863178419;11082;11338.036266917323;11423;11423.314601123959;1873.7002079667188;1910.3982245592733;1986.6920627302648;1998.810113039259;2045.8056484633937;8629.784255393666;8753.255973242281;8857.11428857109;8886.955565222197;9130.77173070672;1681.9579510512335;1685.2500637216444;1720.4150588799869;1726.5252055684662;1739.9739003914951;39034;61084;66392.33607663862;66708.6664566674;68197.65901170463;9610.135087842127;9735.756606084904;9898.356606820533;10115.848262276071;10534.36793792375;13636.59090227275;13830.861691382957;13854;13880.93059534696;13911;7177.784666460015;7244.710211591583;7278;7281.381082608038;7476.850462990709;7025.754098606626;7031.1211098612675;7109.111361079865;7182.102237220348;7223.566586004857;4306.310990241609;4324.243257429937;4325.1565944641125;4337.457817772778;4443.466783985942;1497.139144991634;1669.691107145182;1749.6238308763677;1770.663573920951;1872.8127187281164;869.0440515433099;870.5168631409501;874.5190145419994;922.8615707643772;927.0312523413049;16187.352505899633;16643.667126657398;16718.665626687398;16753.07858067818;16773.24520396585;862.3575436299997;869.9695510657097;928.7770934975557;938.254088000028;944.5088553951906;9031.142041506046;9388.389754666061;9428;9664.323497355117;9750.707478775648;381205;387272;389828;393181;395266;74645.62677186579;76085;76857;77568.61215693885;78929.60535197402;874.1608056266056;882.4895494658585;889.0664801957919;895.6775560798108;905.5336501701629;14899.851001489846;14986.925065374604;15072.698546029238;15184.329723730601;15213.239338033276;24799;25846.61230081588;33280.667193327754;35171;35221.29557408889;46524.767376162905;48526.75736621294;49274.75362623164;49318.75340623274;49323.50676493333;7417.740379086922;7453.440991925519;7533.962330188314;7629.961850190935;7726.49777764466;10659.89340106589;11498.712532186762;11601.651950441501;11762.117841161777;11947.223430476992;9865.556049977624;10176.18590512772;10330.793384132425;10506.317089389166;10533.104686101768;10262.692119236435;10442.269041167045;10445.843312350473;10463.639726835463;10655.733606659896;7227.638618069181;10354.223433242687;10550.841737373792;10683.626073087406;10768.3538987661;7226.458015648742;7323.231060738546;7400.185979542139;7482.96258518704;7565.68265498315;8699.260562852229;10147.49262536885;10191.388516688727;10416.32293900894;10459.424731639529 16:07:24 INFO - PROCESS | 3447 | |3;mootools.html;1300.3628222171133;1369.9930551044981;1385.6258810121262;1611.6937781821453;1636.0674415583123;6701.631410272433;7469;7569.318761311481;8051.114377418487;8055.154208808071;7472.925270747291;7698.846023079535;7711.652975616111;7762.650680719367;7769.456138070337;2198.7801219878043;2235.642297232443;2239.2498512998163;2242.5739109569213;2248.2805502239207;2112.366290112968;2139.2512620582747;2206.5366273082673;2207.2716003718733;2213.3581261434165;2181.2474696229774;2182.127149140341;2190.518086021073;2198.1756841184556;2207.8454508184354;2137.9037943292587;2142.0360837623134;2147.5812216617765;2149.849510534263;2150.161437039548;2151.569686062778;2187.6171669957853;2191.375457994464;2198.296545105567;2205.0738689750183;7873.606319683993;7976.601169941538;7980.201979802031;8002.51984880909;8005.279524842734;4490.3937968374175;4567.063751930847;4587.678862479628;4601.861944141681;4610.746408947506;2912.2137023003884;2969.2725282305973;3093.7989030712934;3101.720845123927;3105.4720697481484;943.9103285187896;984.1093810101869;987.2546227598117;1004.1314263162385;1010.2271762101998;10366.222533310032;10369.948150259275;10516.263861529696;10555.208359373079;10595.364278143335;4027.0939038716056;4091.6931230157857;4134.400511925754;4170.04089059518;4231.936520952188;9090.772730681654;9091.590878410487;9104.544772761335;9105.635774569075;9136.63453461854;4570.177368073779;4580.541945805393;4586.380838586748;4592.931106033412;4594.977025114853;3739.457778622085;4048.21059893318;4120.361343991686;4174.08170202555;4347.869563913087;3694.9445758313645;3719.4420836874683;3731.6081811409413;3816.0841398064263;3933.62630550103;1177.9764404711857;1224.7140502472369;1224.8608793821654;1236.1038247270837;1239.1573729863778;826.7147833997261;832.983340333202;839.9454035487673;842.7935155886847;844.0673056272731;5417.729113544386;5481;5683.175939488751;5705.600607957404;5763.567732420085;839.9622017009249;903.0653273861653;905.4838741917175;918.205752024494;918.3800934369274;3782;3806.1055651921774;3830.502034735522;3876.9224615507533;3881.184951160288;9481.146696797321;9680.612775488902;9762.877269114;9764.267679923893;9787.853182202272;9602.66390676337;9648.75878103039;9689.70930872075;9716.659916903016;9718.951405242928;7121.715131394686;7121.967314739334;7242.23956484572;7331.41348692114;7331.450141239322;5434.75543600531;5439.129739241703;5443.564514838883;5481.588880833874;5544.7227638618715;9011;9023.639054437748;9041.81916361656;9091.409058411182;9151.908480915372;8429.915700843158;8818.514981675813;8832.779180520281;9122.270218382646;9124.771880703036;6204.348543402878;6654.700538475683;6805.421539169028;6916.446684265347;7023.648817559204;7430.331270185709;7475.7009719610605;7486.7005319786595;7489.9625501874325;7495.662695178621;6712.9664351679885;6918.827029324307;6952.339527744856;6958.965205173941;7018.526109517059;6795;6823.488238382042;6835.692393842389;6842.349976752201;6844.041834143323;5993.9700301498215;6160.876782464416;6225.097360882737;6277.15258440123;6312.873742525216;4675.485696573306;4791.209450440778;4795.9280610790165;4907.730074845917;4996.650234483552;4878.146324393288;4904.460509343898;4921.680090794087;4942.4316203637045;4945.876353091202 16:07:24 INFO - PROCESS | 3447 | |4;prototype.html;304.77446689449806;305.12581454133914;308.5063897763577;308.5864940979088;308.91659252001944;5005.949940500598;5137.666051706641;5152.252923326116;5154.355705536803;5188.896222075566;5027.245913113025;5046.671966322187;5056.292119103328;5064.873378165538;5077.49225077493;3775.188334508087;3823.21624067067;3916.6279203475624;3921.117748506592;3939.133390654066;3910.511186101737;3934.8785596105117;3937.2716047531153;3958.8812335629977;3980;3917.6082391760883;3946.2502124596376;3969.7221194516396;3969.8610548630804;3978.5026871641044;3814.18530732843;3959.1685745993086;3960.386140148282;3965.8017099145072;3987.2224916141363;3500.6324335944614;3504.1590018395655;3518.1732292911147;3526.2418580005424;3527.488514165457;4987.625928055374;4993.550580447741;5001.44984051754;5011.198208286693;5022.618779835538;4353.847615333448;4487.551244875519;4498.392716983198;4506.301523263899;4517.503074661785;5212.609054320941;5230.686158830445;5234.16253399458;5238.952209558103;5294.867628309285;3760.417135344026;3762.962370376316;3781;3781.962180378216;3786.5645450773236;5406.243125962368;5529.391766905637;5534.833954981357;5543.695096769676;5565.220869078333;3797.5442946846556;3865.362215234511;3866.3427217373114;3875.70932180082;3879.2047630235734;3901.31726947783;3949.7827619481204;3952.1700442906736;3952.4071389291835;3964.623360780721;4480;4491;4496.437945256843;4504.684672072924;4538.137753826828;5058.266551350033;5321.521063104262;5327.920081198785;5366.2755528004;5373.785048598091;1325.5691900132495;1340.7184491256946;1341.1751772659743;1351.067763243359;1353.2759973414372;817.1215942861447;838.7106448275335;849.6006876767909;866.9956650216835;867.4144952157269;4458.5318541553315;4630.3748993886065;4640.303954406866;4644.86065418038;4647.697899636512;5480.314960629921;5486.286782718301;5506.339239291311;5508.118701007819;5514.28314319144;4469.888252793641;4639.37368455261;4651.62786977041;4654.162250794821;4685.297205419214;2916.2271997920566;2932.929480739515;2934.281101130237;2937.427201695649;2950.704929507032;5104.795808167706;5111.412187598399;5111.437741848394;5136.4606716295;5142.845714628567;5417.8103766367985;5589.385167631557;5632.324121105494;5651.406602306781;5666.490015898589;5133.204353325241;5133.640645154804;5141.583455775854;5153.484651534892;5174.223866419917;5445.564354851523;5446.945530544644;5476.397596264487;5485.122380419114;5528.19841123043;5113.463086376026;5289.841304760864;5312.920306195488;5332.12065484634;5366.048673229786;5069.746512674278;5085.288059671575;5092.949070509396;5093.388793344822;5095.694258344512;3833.3291673956387;3845.9038524036005;3862.594427585063;3896.6687831534637;3915.5301363835383;5291.841244762663;5464.836054918359;5482.972585137049;5506.779728810963;5619.494245517923;5270.710110943782;5294.179402192666;5298.337707786527;5305.532927188876;5314.4393256519;5242.509807841398;5258.079836028756;5265.368155821326;5276;5283.656562323436;4937.77779999908;5199.870003249949;5213.504717051874;5219.538529211827;5235.816746413857;5082.313887625123;5242.318498595311;5314.707691077027;5382.4886635769535;5387.703676297841;5244.449332819999;5244.947550524598;5277.261183434399;5290.65610735301;5303.071962406486 16:07:24 INFO - PROCESS | 3447 | |5;yui.html;626.7399029402798;655.564049906812;658.1937127019405;702.994717553898;717.4009701898914;11657.941710291447;12347.938260308709;12362.567310144146;12515.186512876657;12518.4992600296;12585.433655485502;12737.172083814545;12748.745025099492;12751.298678572697;12793.552225672103;605.9636421814705;741.4439170622034;747.0325927923325;763.4579448591506;765.2347652347653;761.5849362097642;762.2796457347808;762.4929421934407;766.4673052228703;766.7508059880561;812.2486699802688;814.3892080939296;815.1318845429628;818.1491249100928;821.4537332673765;800.5636927874323;807.5397023696495;808.4906508899385;809.073610715733;811.9431639785217;592.238972919796;595.9493443057345;597.047708904297;597.0745344715673;598.2581598817478;11290.774184516264;11313.208075434723;11327.490262938187;11352.318860868374;11416.600418985296;13429.597112086652;13861;13990.580282591538;14007.439702411892;14296;10550.78898422035;10651.84022239667;10763.62327318548;10824.350538967687;10897.346159230472;3316.6351701312838;3380.7464440167087;3382.272811345548;3392.675356921167;3416.555847739778;59056.704716476146;60092.69953650248;62882.05676914804;62982.68508657473;63806.68096659533;10357.533910973874;10544.260197067399;10545.578176872992;10605.681829545127;10678.893211067945;15809.604759880865;16600.4189853357;16669.083200424095;17387;17419.825801742074;6892.104026476526;7086;7107.857842843114;7107.928920710727;7193.280671932869;3789.412641040643;3871.264459752638;3879.1465877506903;3897.8830635080994;3915.9608403915595;2961.2744877505147;2995.655499617572;3013.050888969967;3048.2227032107116;3051.542268659719;515.1474310016928;526.1791605096063;559.420999265758;565.124057710547;589.666838236395;548.6899901555608;551.5615086006634;612.2133059019139;616.1158737212115;624.5160000999261;7964.442489025829;8329.250367466957;8541.914580854113;8684.565771711515;8836.91163088361;582.9941700583024;602.2321540036488;610.2829175718513;610.484140900938;612.6569121292091;4413.117376524708;4493.393391892118;4510.188166130128;4542.727436353829;4563.726176429424;106764;107090.46454767832;107628;108316;110253.24366890731;68110;68418.3158168422;69336.30663693299;79521.20478795253;79936.20063799404;78516;80761.59619201867;81809.18190818015;82554;82783;9296.535173241176;9356.298277629341;9533.285003624616;9667.854982175413;9875.753106172404;47160.292595611776;49111.508884912124;49846.75076624594;49878.00243995172;50299.24551131809;64132.67933660302;71752.64123679556;73584.63207684142;74273;75238.62380688061;11702.35637039971;11750.647480575597;11763.235389699643;11887.28676279426;12138.635840924786;12486.37568121572;12578;12968.221906685629;13595.116317439335;13777.296050276249;12343.444544995316;12592.129050201393;12680.112392132462;12885.226886386847;12957.22256664603;11855.940720296689;11984.340861252715;12310.75378492443;12397.318147501974;12507.437165327765;12908.870911290767;13118.737625247633;13360.93319533396;13504.054716169774;13639.863601364257;10174.13519850821;10442.425666588411;10553.419561924167;10578.365298082139;10703;10786.191035672513;10895.618653347095;10989.835152472559;11064.834027489755;11122.165837562054 16:07:24 INFO - PROCESS | 3447 | __end_tp_report 16:07:24 INFO - PROCESS | 3447 | __start_cc_report 16:07:24 INFO - PROCESS | 3447 | _x_x_mozilla_cycle_collect,379 16:07:24 INFO - PROCESS | 3447 | __end_cc_report 16:07:24 INFO - PROCESS | 3447 | __startTimestamp1466550444318__endTimestamp 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | ------- Summary: start ------- 16:07:24 INFO - PROCESS | 3447 | Number of tests: 6 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#0] dojo.html Cycles:165 Average:4765.67 Median:4923.53 stddev:598.93 (12.2%) stddev-sans-first:576.53 16:07:24 INFO - PROCESS | 3447 | Values: 2615.5 2687.8 2691.6 2700.6 2718.6 4797.2 4810.9 4836.2 4897.7 4909.8 4632.1 4836.0 4850.0 4863.5 4921.3 4418.7 4444.4 4558.0 4569.7 4579.5 570.8 4378.4 4406.3 4450.9 4489.5 4418.8 4457.6 4460.2 4474.9 4514.1 4462.1 4467.0 4473.4 4523.0 4547.7 4287.4 4416.9 4419.8 4433.3 4451.6 4803.6 4858.1 4865.8 4871.8 4965.1 5084.7 5232.6 5243.0 5252.7 5305.5 5133.4 5173.6 5176.0 5178.5 5233.3 4788.1 4825.5 4830.2 4843.2 4873.2 5180.4 5214.5 5250.4 5258.6 5267.6 5027.7 5045.1 5061.1 5062.8 5103.1 5108.9 5121.8 5124.3 5128.9 5165.4 5119.5 5168.8 5185.0 5191.7 5193.1 5152.9 5160.8 5168.1 5168.3 5236.3 4319.7 4411.3 4414.8 4462.3 4504.0 3832.6 3864.4 3865.0 3899.4 3920.3 4315.3 4385.8 4414.8 4456.6 4460.3 5051.1 5202.1 5214.1 5220.7 5260.9 4430.8 4468.3 4492.8 4502.6 4513.4 4722.0 4722.4 4722.6 4732.0 4776.1 4650.8 4813.4 4905.0 4929.4 4940.7 5171.6 5202.7 5227.0 5248.0 5248.5 4897.2 4914.0 4915.7 4923.5 4928.2 4981.8 5060.7 5126.9 5160.3 5180.2 5202.3 5231.6 5252.2 5253.1 5283.2 5075.4 5087.4 5091.8 5100.3 5139.0 4866.0 4986.6 5010.7 5016.8 5086.5 4919.8 4940.4 4950.5 4957.7 4978.8 5021.1 5046.5 5066.5 5084.9 5119.3 4829.5 4948.5 4983.9 4985.0 4991.1 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#1] ext.html Cycles:180 Average:44858.01 Median:35993.96 stddev:82334.62 (228.7%) stddev-sans-first:82498.43 16:07:24 INFO - PROCESS | 3447 | Values: 565.2 585.7 587.9 596.6 599.4 37280.8 38272.2 38368.0 38419.4 38444.6 37976.2 38693.6 38741.2 38777.8 38851.4 7574.0 7714.3 7737.8 7740.4 7764.2 7771.0 7825.5 7838.5 7842.5 7860.2 7818.2 7826.4 7830.8 7832.9 7851.8 7794.3 7838.4 7843.0 7847.3 7853.1 7618.4 7638.7 7697.0 7726.2 7761.4 36318.0 36437.5 36497.0 36654.8 36804.6 2549.4 2939.8 2973.7 3056.0 3057.9 25849.1 26966.9 27482.7 27602.0 28192.4 3437.7 3452.5 3473.7 3483.3 3509.9 225618.0 226150.0 226279.0 227716.0 229146.0 31674.7 32107.7 32419.2 32441.2 32767.7 34102.8 34393.1 34393.5 34400.5 34456.8 13993.8 14027.9 14146.9 14185.9 14247.9 11162.4 11259.7 11261.9 11308.8 11333.3 7896.6 7995.7 8006.9 8010.4 8027.6 3106.8 3112.4 3133.4 3143.4 3161.9 866.7 879.0 901.0 928.6 966.9 28248.3 28264.3 28588.7 28735.4 28869.0 970.8 1024.7 1035.0 1062.5 1070.5 14944.8 15094.3 15207.8 15378.7 15512.5 366698.0 369196.0 373925.0 374529.0 375359.0 49762.5 50016.7 50139.5 50258.2 50467.0 1159.2 1187.8 1189.7 1201.1 1203.6 27165.3 27541.0 27770.6 28167.0 28314.2 44075.8 44090.6 44167.8 44379.8 44487.1 318167.0 320383.4 320597.0 321175.0 322250.0 25214.5 25620.2 25705.0 25909.4 26044.6 42626.6 42839.0 42873.0 43026.0 43563.0 36657.6 37209.8 37343.4 37607.8 38088.8 35896.5 36311.1 36415.8 36508.3 36530.5 33387.8 36091.5 36184.0 37257.8 37317.0 30348.5 31779.8 33734.5 33775.3 34040.5 25250.9 25339.9 25571.5 26038.0 26225.2 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#2] jquery.html Cycles:180 Average:23511.93 Median:25484.12 stddev:64149.86 (251.7%) stddev-sans-first:64306.27 16:07:24 INFO - PROCESS | 3447 | Values: 362.2 364.4 376.4 382.5 385.4 16434.8 17074.4 17592.9 17600.8 17601.6 16254.0 16666.4 17300.6 17319.9 17342.3 4984.8 5149.3 5192.6 5208.9 5209.4 3729.7 5115.5 5735.3 6010.9 6031.5 6047.8 6056.9 6059.0 6059.3 6083.8 5007.9 5295.9 5320.2 5352.8 5355.3 5079.6 5130.2 5213.3 5225.7 5247.0 10854.7 11082.0 11338.0 11423.0 11423.3 1873.7 1910.4 1986.7 1998.8 2045.8 8629.8 8753.3 8857.1 8887.0 9130.8 1682.0 1685.3 1720.4 1726.5 1740.0 39034.0 61084.0 66392.3 66708.7 68197.7 9610.1 9735.8 9898.4 10115.8 10534.4 13636.6 13830.9 13854.0 13880.9 13911.0 7177.8 7244.7 7278.0 7281.4 7476.9 7025.8 7031.1 7109.1 7182.1 7223.6 4306.3 4324.2 4325.2 4337.5 4443.5 1497.1 1669.7 1749.6 1770.7 1872.8 869.0 870.5 874.5 922.9 927.0 16187.4 16643.7 16718.7 16753.1 16773.2 862.4 870.0 928.8 938.3 944.5 9031.1 9388.4 9428.0 9664.3 9750.7 381205.0 387272.0 389828.0 393181.0 395266.0 74645.6 76085.0 76857.0 77568.6 78929.6 874.2 882.5 889.1 895.7 905.5 14899.9 14986.9 15072.7 15184.3 15213.2 24799.0 25846.6 33280.7 35171.0 35221.3 46524.8 48526.8 49274.8 49318.8 49323.5 7417.7 7453.4 7534.0 7630.0 7726.5 10659.9 11498.7 11601.7 11762.1 11947.2 9865.6 10176.2 10330.8 10506.3 10533.1 10262.7 10442.3 10445.8 10463.6 10655.7 7227.6 10354.2 10550.8 10683.6 10768.4 7226.5 7323.2 7400.2 7483.0 7565.7 8699.3 10147.5 10191.4 10416.3 10459.4 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#3] mootools.html Cycles:180 Average:5184.93 Median:5462.28 stddev:2859.11 (52.3%) stddev-sans-first:2852.23 16:07:24 INFO - PROCESS | 3447 | Values: 1300.4 1370.0 1385.6 1611.7 1636.1 6701.6 7469.0 7569.3 8051.1 8055.2 7472.9 7698.8 7711.7 7762.7 7769.5 2198.8 2235.6 2239.2 2242.6 2248.3 2112.4 2139.3 2206.5 2207.3 2213.4 2181.2 2182.1 2190.5 2198.2 2207.8 2137.9 2142.0 2147.6 2149.8 2150.2 2151.6 2187.6 2191.4 2198.3 2205.1 7873.6 7976.6 7980.2 8002.5 8005.3 4490.4 4567.1 4587.7 4601.9 4610.7 2912.2 2969.3 3093.8 3101.7 3105.5 943.9 984.1 987.3 1004.1 1010.2 10366.2 10369.9 10516.3 10555.2 10595.4 4027.1 4091.7 4134.4 4170.0 4231.9 9090.8 9091.6 9104.5 9105.6 9136.6 4570.2 4580.5 4586.4 4592.9 4595.0 3739.5 4048.2 4120.4 4174.1 4347.9 3694.9 3719.4 3731.6 3816.1 3933.6 1178.0 1224.7 1224.9 1236.1 1239.2 826.7 833.0 839.9 842.8 844.1 5417.7 5481.0 5683.2 5705.6 5763.6 840.0 903.1 905.5 918.2 918.4 3782.0 3806.1 3830.5 3876.9 3881.2 9481.1 9680.6 9762.9 9764.3 9787.9 9602.7 9648.8 9689.7 9716.7 9719.0 7121.7 7122.0 7242.2 7331.4 7331.5 5434.8 5439.1 5443.6 5481.6 5544.7 9011.0 9023.6 9041.8 9091.4 9151.9 8429.9 8818.5 8832.8 9122.3 9124.8 6204.3 6654.7 6805.4 6916.4 7023.6 7430.3 7475.7 7486.7 7490.0 7495.7 6713.0 6918.8 6952.3 6959.0 7018.5 6795.0 6823.5 6835.7 6842.3 6844.0 5994.0 6160.9 6225.1 6277.2 6312.9 4675.5 4791.2 4795.9 4907.7 4996.7 4878.1 4904.5 4921.7 4942.4 4945.9 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#4] prototype.html Cycles:180 Average:4402.64 Median:5061.57 stddev:1283.04 (25.3%) stddev-sans-first:1249.23 16:07:24 INFO - PROCESS | 3447 | Values: 304.8 305.1 308.5 308.6 308.9 5005.9 5137.7 5152.3 5154.4 5188.9 5027.2 5046.7 5056.3 5064.9 5077.5 3775.2 3823.2 3916.6 3921.1 3939.1 3910.5 3934.9 3937.3 3958.9 3980.0 3917.6 3946.3 3969.7 3969.9 3978.5 3814.2 3959.2 3960.4 3965.8 3987.2 3500.6 3504.2 3518.2 3526.2 3527.5 4987.6 4993.6 5001.4 5011.2 5022.6 4353.8 4487.6 4498.4 4506.3 4517.5 5212.6 5230.7 5234.2 5239.0 5294.9 3760.4 3763.0 3781.0 3782.0 3786.6 5406.2 5529.4 5534.8 5543.7 5565.2 3797.5 3865.4 3866.3 3875.7 3879.2 3901.3 3949.8 3952.2 3952.4 3964.6 4480.0 4491.0 4496.4 4504.7 4538.1 5058.3 5321.5 5327.9 5366.3 5373.8 1325.6 1340.7 1341.2 1351.1 1353.3 817.1 838.7 849.6 867.0 867.4 4458.5 4630.4 4640.3 4644.9 4647.7 5480.3 5486.3 5506.3 5508.1 5514.3 4469.9 4639.4 4651.6 4654.2 4685.3 2916.2 2932.9 2934.3 2937.4 2950.7 5104.8 5111.4 5111.4 5136.5 5142.8 5417.8 5589.4 5632.3 5651.4 5666.5 5133.2 5133.6 5141.6 5153.5 5174.2 5445.6 5446.9 5476.4 5485.1 5528.2 5113.5 5289.8 5312.9 5332.1 5366.0 5069.7 5085.3 5092.9 5093.4 5095.7 3833.3 3845.9 3862.6 3896.7 3915.5 5291.8 5464.8 5483.0 5506.8 5619.5 5270.7 5294.2 5298.3 5305.5 5314.4 5242.5 5258.1 5265.4 5276.0 5283.7 4937.8 5199.9 5213.5 5219.5 5235.8 5082.3 5242.3 5314.7 5382.5 5387.7 5244.4 5244.9 5277.3 5290.7 5303.1 16:07:24 INFO - PROCESS | 3447 | 16:07:24 INFO - PROCESS | 3447 | [#5] yui.html Cycles:180 Average:18446.94 Median:4453.26 stddev:26561.93 (596.5%) stddev-sans-first:26602.74 16:07:24 INFO - PROCESS | 3447 | Values: 626.7 655.6 658.2 703.0 717.4 11657.9 12347.9 12362.6 12515.2 12518.5 12585.4 12737.2 12748.7 12751.3 12793.6 606.0 741.4 747.0 763.5 765.2 761.6 762.3 762.5 766.5 766.8 812.2 814.4 815.1 818.1 821.5 800.6 807.5 808.5 809.1 811.9 592.2 595.9 597.0 597.1 598.3 11290.8 11313.2 11327.5 11352.3 11416.6 13429.6 13861.0 13990.6 14007.4 14296.0 10550.8 10651.8 10763.6 10824.4 10897.3 3316.6 3380.7 3382.3 3392.7 3416.6 59056.7 60092.7 62882.1 62982.7 63806.7 10357.5 10544.3 10545.6 10605.7 10678.9 15809.6 16600.4 16669.1 17387.0 17419.8 6892.1 7086.0 7107.9 7107.9 7193.3 3789.4 3871.3 3879.1 3897.9 3916.0 2961.3 2995.7 3013.1 3048.2 3051.5 515.1 526.2 559.4 565.1 589.7 548.7 551.6 612.2 616.1 624.5 7964.4 8329.3 8541.9 8684.6 8836.9 583.0 602.2 610.3 610.5 612.7 4413.1 4493.4 4510.2 4542.7 4563.7 106764.0 107090.5 107628.0 108316.0 110253.2 68110.0 68418.3 69336.3 79521.2 79936.2 78516.0 80761.6 81809.2 82554.0 82783.0 9296.5 9356.3 9533.3 9667.9 9875.8 47160.3 49111.5 49846.8 49878.0 50299.2 64132.7 71752.6 73584.6 74273.0 75238.6 11702.4 11750.6 11763.2 11887.3 12138.6 12486.4 12578.0 12968.2 13595.1 13777.3 12343.4 12592.1 12680.1 12885.2 12957.2 11855.9 11984.3 12310.8 12397.3 12507.4 12908.9 13118.7 13360.9 13504.1 13639.9 10174.1 10442.4 10553.4 10578.4 10703.0 10786.2 10895.6 10989.8 11064.8 11122.2 16:07:24 INFO - PROCESS | 3447 | -------- Summary: end -------- 16:07:24 INFO - PROCESS | 3447 | 16:07:25 INFO - TEST-INFO | 3447: exit 0 16:07:25 INFO - TEST-OK | dromaeo_css | took 1117400ms 16:07:25 INFO - TEST-START | kraken 16:07:25 INFO - operating with platform_type : linux_ 16:07:25 INFO - Initialising browser for kraken test... 16:07:25 INFO - TEST-INFO | started process 3681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKFOnV/profile http://localhost:33100/getInfo.html) 16:07:30 INFO - PROCESS | 3681 | __metrics Screen width/height:1600/1200 16:07:30 INFO - PROCESS | 3681 | colorDepth:24 16:07:30 INFO - PROCESS | 3681 | Browser inner width/height: 1024/697 16:07:30 INFO - PROCESS | 3681 | __metrics 16:07:30 ERROR - PROCESS | 3681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:07:31 INFO - TEST-INFO | 3681: exit 0 16:07:31 INFO - Browser initialized. 16:07:31 INFO - Running cycle 1/1 for kraken test... 16:07:31 INFO - TEST-INFO | started process 3799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKFOnV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:43 INFO - PROCESS | 3799 | RSS: Main: 186060800 16:07:43 INFO - PROCESS | 3799 | 16:07:46 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33100/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:47 INFO - PROCESS | 3799 | RSS: Main: 190865408 16:07:47 INFO - PROCESS | 3799 | 16:07:50 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33100/tests/kraken/driver.html?testName=audio-dft) 16:07:50 INFO - PROCESS | 3799 | RSS: Main: 190898176 16:07:50 INFO - PROCESS | 3799 | 16:07:53 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33100/tests/kraken/driver.html?testName=audio-fft) 16:07:54 INFO - PROCESS | 3799 | RSS: Main: 186671104 16:07:54 INFO - PROCESS | 3799 | 16:07:56 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33100/tests/kraken/driver.html?testName=audio-oscillator) 16:07:57 INFO - PROCESS | 3799 | RSS: Main: 186916864 16:07:57 INFO - PROCESS | 3799 | 16:07:59 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:00 INFO - PROCESS | 3799 | RSS: Main: 187256832 16:08:00 INFO - PROCESS | 3799 | 16:08:03 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33100/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:04 INFO - PROCESS | 3799 | RSS: Main: 188203008 16:08:04 INFO - PROCESS | 3799 | 16:08:07 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33100/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:08 INFO - PROCESS | 3799 | RSS: Main: 184909824 16:08:08 INFO - PROCESS | 3799 | 16:08:11 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33100/tests/kraken/driver.html?testName=json-parse-financial) 16:08:11 INFO - PROCESS | 3799 | RSS: Main: 186322944 16:08:11 INFO - PROCESS | 3799 | 16:08:13 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:14 INFO - PROCESS | 3799 | RSS: Main: 186621952 16:08:14 INFO - PROCESS | 3799 | 16:08:16 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:16 INFO - PROCESS | 3799 | RSS: Main: 187629568 16:08:16 INFO - PROCESS | 3799 | 16:08:18 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:19 INFO - PROCESS | 3799 | RSS: Main: 187392000 16:08:19 INFO - PROCESS | 3799 | 16:08:22 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:23 INFO - PROCESS | 3799 | RSS: Main: 187863040 16:08:23 INFO - PROCESS | 3799 | 16:08:25 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:26 INFO - PROCESS | 3799 | RSS: Main: 187138048 16:08:26 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | Cycle 1(1): loaded http://localhost:33100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33100/tests/kraken/driver.html?testName=ai-astar) 16:08:28 INFO - PROCESS | 3799 | RSS: Main: 188026880 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | __start_tp_report 16:08:28 INFO - PROCESS | 3799 | _x_x_mozilla_page_load 16:08:28 INFO - PROCESS | 3799 | _x_x_mozilla_page_load_details 16:08:28 INFO - PROCESS | 3799 | |i|pagename|runs| 16:08:28 INFO - PROCESS | 3799 | |0;ai-astar;114;109;115;114;114;114;113;113;111;112 16:08:28 INFO - PROCESS | 3799 | |1;audio-beat-detection;159;133;153;186;136;161;155;134;196;133 16:08:28 INFO - PROCESS | 3799 | |2;audio-dft;163;169;188;163;162;165;165;162;163;166 16:08:28 INFO - PROCESS | 3799 | |3;audio-fft;77;76;75;172;83;76;76;76;159;76 16:08:28 INFO - PROCESS | 3799 | |4;audio-oscillator;88;86;143;87;86;87;131;86;86;137 16:08:28 INFO - PROCESS | 3799 | |5;imaging-gaussian-blur;118;119;118;118;117;118;119;121;118;118 16:08:28 INFO - PROCESS | 3799 | |6;imaging-darkroom;149;149;147;147;148;148;149;148;148;147 16:08:28 INFO - PROCESS | 3799 | |7;imaging-desaturate;96;96;95;96;96;96;97;95;95;96 16:08:28 INFO - PROCESS | 3799 | |8;json-parse-financial;64;64;64;63;65;64;65;65;63;62 16:08:28 INFO - PROCESS | 3799 | |9;json-stringify-tinderbox;65;65;65;66;66;66;65;66;65;65 16:08:28 INFO - PROCESS | 3799 | |10;stanford-crypto-aes;85;84;90;85;86;85;89;85;118;84 16:08:28 INFO - PROCESS | 3799 | |11;stanford-crypto-ccm;136;133;142;132;141;131;149;135;147;140 16:08:28 INFO - PROCESS | 3799 | |12;stanford-crypto-pbkdf2;177;176;174;173;173;174;171;176;172;170 16:08:28 INFO - PROCESS | 3799 | |13;stanford-crypto-sha256-iterative;68;70;70;68;69;70;67;70;66;70 16:08:28 INFO - PROCESS | 3799 | __end_tp_report 16:08:28 INFO - PROCESS | 3799 | __start_cc_report 16:08:28 INFO - PROCESS | 3799 | _x_x_mozilla_cycle_collect,1017 16:08:28 INFO - PROCESS | 3799 | __end_cc_report 16:08:28 INFO - PROCESS | 3799 | __startTimestamp1466550508656__endTimestamp 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | ------- Summary: start ------- 16:08:28 INFO - PROCESS | 3799 | Number of tests: 14 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:1.79 (1.6%) stddev-sans-first:1.86 16:08:28 INFO - PROCESS | 3799 | Values: 114.0 109.0 115.0 114.0 114.0 114.0 113.0 113.0 111.0 112.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:157.00 stddev:22.28 (14.2%) stddev-sans-first:23.57 16:08:28 INFO - PROCESS | 3799 | Values: 159.0 133.0 153.0 186.0 136.0 161.0 155.0 134.0 196.0 133.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#2] audio-dft Cycles:10 Average:166.60 Median:165.00 stddev:7.82 (4.7%) stddev-sans-first:8.19 16:08:28 INFO - PROCESS | 3799 | Values: 163.0 169.0 188.0 163.0 162.0 165.0 165.0 162.0 163.0 166.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:37.56 (49.4%) stddev-sans-first:39.29 16:08:28 INFO - PROCESS | 3799 | Values: 77.0 76.0 75.0 172.0 83.0 76.0 76.0 76.0 159.0 76.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.00 stddev:24.53 (28.5%) stddev-sans-first:25.51 16:08:28 INFO - PROCESS | 3799 | Values: 88.0 86.0 143.0 87.0 86.0 87.0 131.0 86.0 86.0 137.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 16:08:28 INFO - PROCESS | 3799 | Values: 118.0 119.0 118.0 118.0 117.0 118.0 119.0 121.0 118.0 118.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 16:08:28 INFO - PROCESS | 3799 | Values: 149.0 149.0 147.0 147.0 148.0 148.0 149.0 148.0 148.0 147.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:08:28 INFO - PROCESS | 3799 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 97.0 95.0 95.0 96.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 16:08:28 INFO - PROCESS | 3799 | Values: 64.0 64.0 64.0 63.0 65.0 64.0 65.0 65.0 63.0 62.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:08:28 INFO - PROCESS | 3799 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:85.00 stddev:10.35 (12.2%) stddev-sans-first:10.88 16:08:28 INFO - PROCESS | 3799 | Values: 85.0 84.0 90.0 85.0 86.0 85.0 89.0 85.0 118.0 84.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:140.50 stddev:6.24 (4.4%) stddev-sans-first:6.55 16:08:28 INFO - PROCESS | 3799 | Values: 136.0 133.0 142.0 132.0 141.0 131.0 149.0 135.0 147.0 140.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:2.27 (1.3%) stddev-sans-first:2.05 16:08:28 INFO - PROCESS | 3799 | Values: 177.0 176.0 174.0 173.0 173.0 174.0 171.0 176.0 172.0 170.0 16:08:28 INFO - PROCESS | 3799 | 16:08:28 INFO - PROCESS | 3799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.54 16:08:28 INFO - PROCESS | 3799 | Values: 68.0 70.0 70.0 68.0 69.0 70.0 67.0 70.0 66.0 70.0 16:08:28 INFO - PROCESS | 3799 | -------- Summary: end -------- 16:08:28 INFO - PROCESS | 3799 | 16:08:29 INFO - TEST-INFO | 3799: exit 0 16:08:29 INFO - TEST-OK | kraken | took 64554ms 16:08:29 INFO - SUITE-END | took 1181s 16:08:29 INFO - Completed test suite (00:19:42) 16:08:29 INFO - javascript benchmark 16:08:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6408.216988081649, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.5292047431462, 2687.784977201824, 2691.582804665277, 2700.62191293219, 2718.5650295952637, 4797.208460604001, 4810.927836082457, 4836.2020266656, 4897.681650692712, 4909.803607855691, 4632.0967411354795, 4835.951640483594, 4850.0, 4863.489333619972, 4921.261810728383, 4418.690691651594, 4444.377787109791, 4557.954420455802, 4569.748663823489, 4579.473360563527, 570.7673601053904, 4378.430803995476, 4406.339049142623, 4450.910981780363, 4489.46126464823, 4418.82324707013, 4457.576530229623, 4460.1525710114975, 4474.932876006863, 4514.074614703978, 4462.107578484316, 4466.977665111686, 4473.418455600784, 4522.982328975987, 4547.681662283641, 4287.399764033038, 4416.911661766747, 4419.779011049434, 4433.290673492225, 4451.643868490513, 4803.56767890888, 4858.076965376567, 4865.78103985318, 4871.756412179377, 4965.106280869442, 5084.745762711849, 5232.555232805216, 5243.0, 5252.737363131828, 5305.495977882095, 5133.409657889353, 5173.611979101583, 5175.974120129413, 5178.4562620924635, 5233.267342572043, 4788.090262850117, 4825.493323201048, 4830.203016502238, 4843.2250839865455, 4873.244647079709, 5180.378354597472, 5214.504622060898, 5250.422453530108, 5258.553022993012, 5267.631265811357, 5027.673201241908, 5045.117104506697, 5061.063703214917, 5062.797488100508, 5103.055934652101, 5108.897822043538, 5121.8463446096675, 5124.256982737482, 5128.8717782055, 5165.354330708661, 5119.539241468211, 5168.8449346519665, 5185.014847179099, 5191.6625419348375, 5193.1171700810955, 5152.871178220575, 5160.793568257228, 5168.069747445421, 5168.302279192261, 5236.29310043147, 4319.740815551014, 4411.29419292918, 4414.84548040817, 4462.308342206963, 4503.954960450354, 3832.559255685632, 3864.381698928158, 3865.033741564609, 3899.434581985596, 3920.2747491713553, 4315.28797748368, 4385.846495372647, 4414.779261036935, 4456.554344565518, 4460.330950357407, 5051.1160546904875, 5202.115640341151, 5214.061468935628, 5220.7128607926925, 5260.92108618371, 4430.822767089345, 4468.285074388083, 4492.842750503717, 4502.594766471033, 4513.368128462018, 4721.976390118096, 4722.386089808303, 4722.6221902247735, 4731.952680473151, 4776.14029474691, 4650.767461626972, 4813.350197723403, 4904.975475122673, 4929.383827021622, 4940.728259945738, 5171.586273098068, 5202.739863006759, 5227.032998895064, 5248.0, 5248.475152484873, 4897.216445368724, 4914.0, 4915.680480768739, 4923.532264434873, 4928.21148616234, 4981.8007279709855, 5060.671056381323, 5126.897462050663, 5160.329157209539, 5180.197069454241, 5202.271681964604, 5231.581473482036, 5252.238425428215, 5253.054450199001, 5283.1546952487415, 5075.390953085505, 5087.4403815581, 5091.821786237464, 5100.285959965534, 5139.049275883974, 4866.0, 4986.6010719143105, 5010.674306170087, 5016.846125391107, 5086.465921078234, 4919.7540122993, 4940.382452193476, 4950.455449900436, 4957.677750946177, 4978.7510624467905, 5021.07110184617, 5046.545810877039, 5066.544011039025, 5084.898302034013, 5119.257707632298, 4829.492903245249, 4948.480409557089, 4983.8504844854715, 4984.975075124601, 4991.101601711582], "value": 4729.359493191822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2256408720054, 585.7100735136108, 587.8765459253557, 596.6032588328765, 599.4155698194264, 37280.81359593201, 38272.234555308874, 38368.0, 38419.42370864436, 38444.61555384445, 37976.240475190476, 38693.61306386935, 38741.22517549654, 38777.806110969475, 38851.41722874159, 7573.999999999986, 7714.305712485875, 7737.845243095135, 7740.419468539854, 7764.18476060014, 7771.0, 7825.474032563652, 7838.490498117632, 7842.451028428012, 7860.174681658429, 7818.218178182165, 7826.413019023567, 7830.804229894241, 7832.882506762403, 7851.764447066568, 7794.259545343183, 7838.412119091034, 7842.960785196095, 7847.332976696931, 7853.057633084067, 7618.352440042603, 7638.656260468292, 7697.0, 7726.150123486468, 7761.379089672869, 36318.0, 36437.45343819845, 36497.0, 36654.8167259162, 36804.631953680386, 2549.3754030262703, 2939.779516536268, 2973.747231485326, 3055.9847200764075, 3057.8929737459302, 25849.09528166505, 26966.865165674244, 27482.725172748218, 27602.0, 28192.436151277067, 3437.742169337285, 3452.478471958588, 3473.6526347365316, 3483.3033393321184, 3509.894703158909, 225618.0, 226150.0, 226279.0, 227715.99999999834, 229146.0, 31674.68325316717, 32107.678923210937, 32419.18952026171, 32441.18897027546, 32767.672323276463, 34102.82948585291, 34393.140171495914, 34393.484097738554, 34400.483992740126, 34456.82771586126, 13993.790093148611, 14027.859721402656, 14146.929265353814, 14185.929070354583, 14247.931405144656, 11162.386068766133, 11259.718507037389, 11261.887381126247, 11308.773824523463, 11333.26333788301, 7896.644650990719, 7995.680712682342, 8006.879896801553, 8010.359171266285, 8027.638756255982, 3106.7980581262145, 3112.4086423579447, 3133.3576616793503, 3143.4184675835045, 3161.873525059018, 866.67066514724, 878.9891624631724, 901.0178904993588, 928.6471140966389, 966.9371490853072, 28248.29379265494, 28264.29339266535, 28588.714112859023, 28735.42529149405, 28869.0, 970.7767213540925, 1024.6618615856748, 1034.9586016559404, 1062.4634559547378, 1070.539667942792, 14944.775828362583, 15094.320755566026, 15207.771883421758, 15378.692426151414, 15512.534623961299, 366698.0, 369196.0, 373925.0, 374529.0, 375359.0, 49762.50237497579, 50016.74991625091, 50139.49860501421, 50258.246126308135, 50467.0, 1159.2291126401017, 1187.8396416483663, 1189.690680423079, 1201.1471854982885, 1203.5787474384072, 27165.320866977694, 27541.0, 27770.583441247993, 28167.0, 28314.150575482767, 44075.77962110169, 44090.55909440864, 44167.77916110399, 44379.77810110929, 44487.11025779402, 318167.0, 320383.39808300807, 320597.0, 321175.0, 322250.0, 25214.495710085328, 25620.23139305824, 25705.0, 25909.352266193495, 26044.609330859672, 42626.57373426226, 42839.0, 42873.0, 43026.0, 43563.0, 36657.63342366542, 37209.813950930074, 37343.43984840284, 37607.811960940024, 38088.809555952044, 35896.46155307725, 36311.09222269359, 36415.817920911286, 36508.26983460369, 36530.452043219906, 33387.83306083454, 36091.45862812112, 36184.0, 37257.813710931274, 37317.0, 30348.544771827997, 31779.841100794347, 33734.49398258979, 33775.3244935095, 34040.48939265864, 25250.873745631154, 25339.87330063338, 25571.488570228863, 26038.0, 26225.213243602724], "value": 16265.766309610563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1941180872559, 364.3532729405306, 376.3808534959989, 382.54060758207436, 385.41609461665564, 16434.753478697814, 17074.40239591613, 17592.912035439836, 17600.823991760077, 17601.55996100098, 16254.0, 16666.416675416363, 17300.567485812862, 17319.91340043301, 17342.306307747705, 4984.7756850941705, 5149.253358263049, 5192.610554208431, 5208.895822083556, 5209.400918894337, 3729.6829769469628, 5115.4884511548735, 5735.340435849868, 6010.8797824043495, 6031.457168854802, 6047.788327408542, 6056.939430605704, 6058.96970515149, 6059.272887253535, 6083.847903802418, 5007.924881126786, 5295.920561191585, 5320.201969704536, 5352.785888564453, 5355.277037599952, 5079.644424890259, 5130.153524668425, 5213.32226810516, 5225.686458812484, 5247.0, 10854.72863178419, 11082.0, 11338.036266917323, 11423.0, 11423.314601123959, 1873.7002079667188, 1910.3982245592733, 1986.6920627302648, 1998.810113039259, 2045.8056484633937, 8629.784255393666, 8753.255973242281, 8857.11428857109, 8886.955565222197, 9130.77173070672, 1681.9579510512335, 1685.2500637216444, 1720.4150588799869, 1726.5252055684662, 1739.9739003914951, 39034.0, 61084.0, 66392.33607663862, 66708.6664566674, 68197.65901170463, 9610.135087842127, 9735.756606084904, 9898.356606820533, 10115.848262276071, 10534.36793792375, 13636.59090227275, 13830.861691382957, 13854.0, 13880.93059534696, 13911.0, 7177.784666460015, 7244.710211591583, 7278.0, 7281.381082608038, 7476.850462990709, 7025.754098606626, 7031.1211098612675, 7109.111361079865, 7182.102237220348, 7223.566586004857, 4306.310990241609, 4324.243257429937, 4325.1565944641125, 4337.457817772778, 4443.466783985942, 1497.139144991634, 1669.691107145182, 1749.6238308763677, 1770.663573920951, 1872.8127187281164, 869.0440515433099, 870.5168631409501, 874.5190145419994, 922.8615707643772, 927.0312523413049, 16187.352505899633, 16643.667126657398, 16718.665626687398, 16753.07858067818, 16773.24520396585, 862.3575436299997, 869.9695510657097, 928.7770934975557, 938.254088000028, 944.5088553951906, 9031.142041506046, 9388.389754666061, 9428.0, 9664.323497355117, 9750.707478775648, 381205.0, 387272.0, 389828.0, 393181.0, 395266.0, 74645.62677186579, 76085.0, 76857.0, 77568.61215693885, 78929.60535197402, 874.1608056266056, 882.4895494658585, 889.0664801957919, 895.6775560798108, 905.5336501701629, 14899.851001489846, 14986.925065374604, 15072.698546029238, 15184.329723730601, 15213.239338033276, 24799.0, 25846.61230081588, 33280.667193327754, 35171.0, 35221.29557408889, 46524.767376162905, 48526.75736621294, 49274.75362623164, 49318.75340623274, 49323.50676493333, 7417.740379086922, 7453.440991925519, 7533.962330188314, 7629.961850190935, 7726.49777764466, 10659.89340106589, 11498.712532186762, 11601.651950441501, 11762.117841161777, 11947.223430476992, 9865.556049977624, 10176.18590512772, 10330.793384132425, 10506.317089389166, 10533.104686101768, 10262.692119236435, 10442.269041167045, 10445.843312350473, 10463.639726835463, 10655.733606659896, 7227.638618069181, 10354.223433242687, 10550.841737373792, 10683.626073087406, 10768.3538987661, 7226.458015648742, 7323.231060738546, 7400.185979542139, 7482.96258518704, 7565.68265498315, 8699.260562852229, 10147.49262536885, 10191.388516688727, 10416.32293900894, 10459.424731639529], "value": 7967.708239121171, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.3628222171133, 1369.9930551044981, 1385.6258810121262, 1611.6937781821453, 1636.0674415583123, 6701.631410272433, 7469.0, 7569.318761311481, 8051.114377418487, 8055.154208808071, 7472.925270747291, 7698.846023079535, 7711.652975616111, 7762.650680719367, 7769.456138070337, 2198.7801219878043, 2235.642297232443, 2239.2498512998163, 2242.5739109569213, 2248.2805502239207, 2112.366290112968, 2139.2512620582747, 2206.5366273082673, 2207.2716003718733, 2213.3581261434165, 2181.2474696229774, 2182.127149140341, 2190.518086021073, 2198.1756841184556, 2207.8454508184354, 2137.9037943292587, 2142.0360837623134, 2147.5812216617765, 2149.849510534263, 2150.161437039548, 2151.569686062778, 2187.6171669957853, 2191.375457994464, 2198.296545105567, 2205.0738689750183, 7873.606319683993, 7976.601169941538, 7980.201979802031, 8002.51984880909, 8005.279524842734, 4490.3937968374175, 4567.063751930847, 4587.678862479628, 4601.861944141681, 4610.746408947506, 2912.2137023003884, 2969.2725282305973, 3093.7989030712934, 3101.720845123927, 3105.4720697481484, 943.9103285187896, 984.1093810101869, 987.2546227598117, 1004.1314263162385, 1010.2271762101998, 10366.222533310032, 10369.948150259275, 10516.263861529696, 10555.208359373079, 10595.364278143335, 4027.0939038716056, 4091.6931230157857, 4134.400511925754, 4170.04089059518, 4231.936520952188, 9090.772730681654, 9091.590878410487, 9104.544772761335, 9105.635774569075, 9136.63453461854, 4570.177368073779, 4580.541945805393, 4586.380838586748, 4592.931106033412, 4594.977025114853, 3739.457778622085, 4048.21059893318, 4120.361343991686, 4174.08170202555, 4347.869563913087, 3694.9445758313645, 3719.4420836874683, 3731.6081811409413, 3816.0841398064263, 3933.62630550103, 1177.9764404711857, 1224.7140502472369, 1224.8608793821654, 1236.1038247270837, 1239.1573729863778, 826.7147833997261, 832.983340333202, 839.9454035487673, 842.7935155886847, 844.0673056272731, 5417.729113544386, 5481.0, 5683.175939488751, 5705.600607957404, 5763.567732420085, 839.9622017009249, 903.0653273861653, 905.4838741917175, 918.205752024494, 918.3800934369274, 3782.0, 3806.1055651921774, 3830.502034735522, 3876.9224615507533, 3881.184951160288, 9481.146696797321, 9680.612775488902, 9762.877269114, 9764.267679923893, 9787.853182202272, 9602.66390676337, 9648.75878103039, 9689.70930872075, 9716.659916903016, 9718.951405242928, 7121.715131394686, 7121.967314739334, 7242.23956484572, 7331.41348692114, 7331.450141239322, 5434.75543600531, 5439.129739241703, 5443.564514838883, 5481.588880833874, 5544.7227638618715, 9011.0, 9023.639054437748, 9041.81916361656, 9091.409058411182, 9151.908480915372, 8429.915700843158, 8818.514981675813, 8832.779180520281, 9122.270218382646, 9124.771880703036, 6204.348543402878, 6654.700538475683, 6805.421539169028, 6916.446684265347, 7023.648817559204, 7430.331270185709, 7475.7009719610605, 7486.7005319786595, 7489.9625501874325, 7495.662695178621, 6712.9664351679885, 6918.827029324307, 6952.339527744856, 6958.965205173941, 7018.526109517059, 6795.0, 6823.488238382042, 6835.692393842389, 6842.349976752201, 6844.041834143323, 5993.9700301498215, 6160.876782464416, 6225.097360882737, 6277.15258440123, 6312.873742525216, 4675.485696573306, 4791.209450440778, 4795.9280610790165, 4907.730074845917, 4996.650234483552, 4878.146324393288, 4904.460509343898, 4921.680090794087, 4942.4316203637045, 4945.876353091202], "value": 4196.751586479387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.77446689449806, 305.12581454133914, 308.5063897763577, 308.5864940979088, 308.91659252001944, 5005.949940500598, 5137.666051706641, 5152.252923326116, 5154.355705536803, 5188.896222075566, 5027.245913113025, 5046.671966322187, 5056.292119103328, 5064.873378165538, 5077.49225077493, 3775.188334508087, 3823.21624067067, 3916.6279203475624, 3921.117748506592, 3939.133390654066, 3910.511186101737, 3934.8785596105117, 3937.2716047531153, 3958.8812335629977, 3980.0, 3917.6082391760883, 3946.2502124596376, 3969.7221194516396, 3969.8610548630804, 3978.5026871641044, 3814.18530732843, 3959.1685745993086, 3960.386140148282, 3965.8017099145072, 3987.2224916141363, 3500.6324335944614, 3504.1590018395655, 3518.1732292911147, 3526.2418580005424, 3527.488514165457, 4987.625928055374, 4993.550580447741, 5001.44984051754, 5011.198208286693, 5022.618779835538, 4353.847615333448, 4487.551244875519, 4498.392716983198, 4506.301523263899, 4517.503074661785, 5212.609054320941, 5230.686158830445, 5234.16253399458, 5238.952209558103, 5294.867628309285, 3760.417135344026, 3762.962370376316, 3781.0, 3781.962180378216, 3786.5645450773236, 5406.243125962368, 5529.391766905637, 5534.833954981357, 5543.695096769676, 5565.220869078333, 3797.5442946846556, 3865.362215234511, 3866.3427217373114, 3875.70932180082, 3879.2047630235734, 3901.31726947783, 3949.7827619481204, 3952.1700442906736, 3952.4071389291835, 3964.623360780721, 4480.0, 4491.0, 4496.437945256843, 4504.684672072924, 4538.137753826828, 5058.266551350033, 5321.521063104262, 5327.920081198785, 5366.2755528004, 5373.785048598091, 1325.5691900132495, 1340.7184491256946, 1341.1751772659743, 1351.067763243359, 1353.2759973414372, 817.1215942861447, 838.7106448275335, 849.6006876767909, 866.9956650216835, 867.4144952157269, 4458.5318541553315, 4630.3748993886065, 4640.303954406866, 4644.86065418038, 4647.697899636512, 5480.314960629921, 5486.286782718301, 5506.339239291311, 5508.118701007819, 5514.28314319144, 4469.888252793641, 4639.37368455261, 4651.62786977041, 4654.162250794821, 4685.297205419214, 2916.2271997920566, 2932.929480739515, 2934.281101130237, 2937.427201695649, 2950.704929507032, 5104.795808167706, 5111.412187598399, 5111.437741848394, 5136.4606716295, 5142.845714628567, 5417.8103766367985, 5589.385167631557, 5632.324121105494, 5651.406602306781, 5666.490015898589, 5133.204353325241, 5133.640645154804, 5141.583455775854, 5153.484651534892, 5174.223866419917, 5445.564354851523, 5446.945530544644, 5476.397596264487, 5485.122380419114, 5528.19841123043, 5113.463086376026, 5289.841304760864, 5312.920306195488, 5332.12065484634, 5366.048673229786, 5069.746512674278, 5085.288059671575, 5092.949070509396, 5093.388793344822, 5095.694258344512, 3833.3291673956387, 3845.9038524036005, 3862.594427585063, 3896.6687831534637, 3915.5301363835383, 5291.841244762663, 5464.836054918359, 5482.972585137049, 5506.779728810963, 5619.494245517923, 5270.710110943782, 5294.179402192666, 5298.337707786527, 5305.532927188876, 5314.4393256519, 5242.509807841398, 5258.079836028756, 5265.368155821326, 5276.0, 5283.656562323436, 4937.77779999908, 5199.870003249949, 5213.504717051874, 5219.538529211827, 5235.816746413857, 5082.313887625123, 5242.318498595311, 5314.707691077027, 5382.4886635769535, 5387.703676297841, 5244.449332819999, 5244.947550524598, 5277.261183434399, 5290.65610735301, 5303.071962406486], "value": 3988.51350312842, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.7399029402798, 655.564049906812, 658.1937127019405, 702.994717553898, 717.4009701898914, 11657.941710291447, 12347.938260308709, 12362.567310144146, 12515.186512876657, 12518.4992600296, 12585.433655485502, 12737.172083814545, 12748.745025099492, 12751.298678572697, 12793.552225672103, 605.9636421814705, 741.4439170622034, 747.0325927923325, 763.4579448591506, 765.2347652347653, 761.5849362097642, 762.2796457347808, 762.4929421934407, 766.4673052228703, 766.7508059880561, 812.2486699802688, 814.3892080939296, 815.1318845429628, 818.1491249100928, 821.4537332673765, 800.5636927874323, 807.5397023696495, 808.4906508899385, 809.073610715733, 811.9431639785217, 592.238972919796, 595.9493443057345, 597.047708904297, 597.0745344715673, 598.2581598817478, 11290.774184516264, 11313.208075434723, 11327.490262938187, 11352.318860868374, 11416.600418985296, 13429.597112086652, 13861.0, 13990.580282591538, 14007.439702411892, 14296.0, 10550.78898422035, 10651.84022239667, 10763.62327318548, 10824.350538967687, 10897.346159230472, 3316.6351701312838, 3380.7464440167087, 3382.272811345548, 3392.675356921167, 3416.555847739778, 59056.704716476146, 60092.69953650248, 62882.05676914804, 62982.68508657473, 63806.68096659533, 10357.533910973874, 10544.260197067399, 10545.578176872992, 10605.681829545127, 10678.893211067945, 15809.604759880865, 16600.4189853357, 16669.083200424095, 17387.0, 17419.825801742074, 6892.104026476526, 7086.0, 7107.857842843114, 7107.928920710727, 7193.280671932869, 3789.412641040643, 3871.264459752638, 3879.1465877506903, 3897.8830635080994, 3915.9608403915595, 2961.2744877505147, 2995.655499617572, 3013.050888969967, 3048.2227032107116, 3051.542268659719, 515.1474310016928, 526.1791605096063, 559.420999265758, 565.124057710547, 589.666838236395, 548.6899901555608, 551.5615086006634, 612.2133059019139, 616.1158737212115, 624.5160000999261, 7964.442489025829, 8329.250367466957, 8541.914580854113, 8684.565771711515, 8836.91163088361, 582.9941700583024, 602.2321540036488, 610.2829175718513, 610.484140900938, 612.6569121292091, 4413.117376524708, 4493.393391892118, 4510.188166130128, 4542.727436353829, 4563.726176429424, 106764.0, 107090.46454767832, 107628.0, 108316.0, 110253.24366890731, 68110.0, 68418.3158168422, 69336.30663693299, 79521.20478795253, 79936.20063799404, 78516.0, 80761.59619201867, 81809.18190818015, 82554.0, 82783.0, 9296.535173241176, 9356.298277629341, 9533.285003624616, 9667.854982175413, 9875.753106172404, 47160.292595611776, 49111.508884912124, 49846.75076624594, 49878.00243995172, 50299.24551131809, 64132.67933660302, 71752.64123679556, 73584.63207684142, 74273.0, 75238.62380688061, 11702.35637039971, 11750.647480575597, 11763.235389699643, 11887.28676279426, 12138.635840924786, 12486.37568121572, 12578.0, 12968.221906685629, 13595.116317439335, 13777.296050276249, 12343.444544995316, 12592.129050201393, 12680.112392132462, 12885.226886386847, 12957.22256664603, 11855.940720296689, 11984.340861252715, 12310.75378492443, 12397.318147501974, 12507.437165327765, 12908.870911290767, 13118.737625247633, 13360.93319533396, 13504.054716169774, 13639.863601364257, 10174.13519850821, 10442.425666588411, 10553.419561924167, 10578.365298082139, 10703.0, 10786.191035672513, 10895.618653347095, 10989.835152472559, 11064.834027489755, 11122.165837562054], "value": 6749.094863256953, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 111.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 153.0, 186.0, 136.0, 161.0, 155.0, 134.0, 196.0, 133.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 188.0, 163.0, 162.0, 165.0, 165.0, 162.0, 163.0, 166.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 172.0, 83.0, 76.0, 76.0, 76.0, 159.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 143.0, 87.0, 86.0, 87.0, 131.0, 86.0, 86.0, 137.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 118.0, 119.0, 121.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 65.0, 65.0, 63.0, 62.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 90.0, 85.0, 86.0, 85.0, 89.0, 85.0, 118.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 142.0, 132.0, 141.0, 131.0, 149.0, 135.0, 147.0, 140.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 174.0, 173.0, 173.0, 174.0, 171.0, 176.0, 172.0, 170.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 68.0, 69.0, 70.0, 67.0, 70.0, 66.0, 70.0], "value": 68.8, "unit": "score"}]}]} 16:08:29 INFO - Return code: 0 16:08:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:29 ERROR - # TBPL SUCCESS # 16:08:29 INFO - Running post-action listener: _resource_record_post_action 16:08:29 INFO - ##### 16:08:29 INFO - ##### Finished run-tests step (success) 16:08:29 INFO - ##### 16:08:29 INFO - Running post-run listener: _resource_record_post_run 16:08:30 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 441630720; Read time: 2228; Write time: 353280 16:08:30 INFO - TinderboxPrint: CPU usage
13.4% 16:08:30 INFO - TinderboxPrint: I/O read bytes / time
7,802,880 / 2,228 16:08:30 INFO - TinderboxPrint: I/O write bytes / time
441,630,720 / 353,280 16:08:30 INFO - TinderboxPrint: CPU idle
8,284.4 (86.5%) 16:08:30 INFO - TinderboxPrint: CPU user
1,232.2 (12.9%) 16:08:30 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 19230720; Read time: 92; Write time: 5400 16:08:30 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6037504; Write bytes: 343089152; Read time: 1876; Write time: 263864 16:08:30 INFO - Running post-run listener: _upload_blobber_files 16:08:30 INFO - Blob upload gear active. 16:08:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:30 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 16:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:31 INFO - (blobuploader) - INFO - Done attempting. 16:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:35 INFO - (blobuploader) - INFO - Done attempting. 16:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:36 INFO - (blobuploader) - INFO - Done attempting. 16:08:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:36 INFO - Return code: 0 16:08:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9e2d34d4fb0ecc4b4bc62593c7e79f0e3b3054c1ae8894bfe584b5e357684ef989b5debe501b15ef16b7e67aff3a614e4dfaf555f4785e107cc434aee724fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576d4119c307d9f51572ce6e431185913b056887bd453b51bee3a90b2dd62d769284614fff81141b625f0fa017fd2600d7ddc002b2206a97e9fd7a3dcd3480ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d891af7e81d0fd6decf016e869500a6e3fc92922e11c62c563095deb84274b1776e67863ac7156a7d4d56fbfbb0cf91429a608ee75f7caaad15ac0cbfa3c2edc"} 16:08:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:36 INFO - Contents: 16:08:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9e2d34d4fb0ecc4b4bc62593c7e79f0e3b3054c1ae8894bfe584b5e357684ef989b5debe501b15ef16b7e67aff3a614e4dfaf555f4785e107cc434aee724fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576d4119c307d9f51572ce6e431185913b056887bd453b51bee3a90b2dd62d769284614fff81141b625f0fa017fd2600d7ddc002b2206a97e9fd7a3dcd3480ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d891af7e81d0fd6decf016e869500a6e3fc92922e11c62c563095deb84274b1776e67863ac7156a7d4d56fbfbb0cf91429a608ee75f7caaad15ac0cbfa3c2edc"} 16:08:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:36 INFO - Copying logs to upload dir... 16:08:36 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.482172 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-21 16:08:36.036288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 16:08:36.039942) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 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/Fx-Team-Non-PGO/sha512/f9e2d34d4fb0ecc4b4bc62593c7e79f0e3b3054c1ae8894bfe584b5e357684ef989b5debe501b15ef16b7e67aff3a614e4dfaf555f4785e107cc434aee724fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576d4119c307d9f51572ce6e431185913b056887bd453b51bee3a90b2dd62d769284614fff81141b625f0fa017fd2600d7ddc002b2206a97e9fd7a3dcd3480ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d891af7e81d0fd6decf016e869500a6e3fc92922e11c62c563095deb84274b1776e67863ac7156a7d4d56fbfbb0cf91429a608ee75f7caaad15ac0cbfa3c2edc"} build_url:https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/c8tt3nOXRau8FwSZwMb_vw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9e2d34d4fb0ecc4b4bc62593c7e79f0e3b3054c1ae8894bfe584b5e357684ef989b5debe501b15ef16b7e67aff3a614e4dfaf555f4785e107cc434aee724fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576d4119c307d9f51572ce6e431185913b056887bd453b51bee3a90b2dd62d769284614fff81141b625f0fa017fd2600d7ddc002b2206a97e9fd7a3dcd3480ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d891af7e81d0fd6decf016e869500a6e3fc92922e11c62c563095deb84274b1776e67863ac7156a7d4d56fbfbb0cf91429a608ee75f7caaad15ac0cbfa3c2edc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 16:08:36.065601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 16:08:36.065941) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466549188.758253-1923398621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 16:08:36.149367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 16:08:36.149724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 16:08:36.150051) ========= ========= Total master_lag: 0.15 =========