builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1466590359.39 results: success (0) buildid: 20160622024801 builduid: 4eb963d017df4cf3ae13ca969ffbd51e revision: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.391614) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.392214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.392504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.409997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.410369) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 03:12:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-22 03:12:39 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.535597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.535930) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014075 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.589322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.589643) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f --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 ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 03:12:39,897 truncating revision to first 12 chars 2016-06-22 03:12:39,897 Setting DEBUG logging. 2016-06-22 03:12:39,897 attempt 1/10 2016-06-22 03:12:39,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ee2eba8cdedd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 03:12:40,205 unpacking tar archive at: fx-team-ee2eba8cdedd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.257499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.257798) ========= script_repo_revision: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.258249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.258522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.266410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-22 03:12:40.266709) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:12:40 INFO - MultiFileLogger online at 20160622 03:12:40 in /builds/slave/test 03:12:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:12:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:40 INFO - {'append_to_log': False, 03:12:40 INFO - 'base_work_dir': '/builds/slave/test', 03:12:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:12:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:40 INFO - 'branch': 'Fx-Team-Non-PGO', 03:12:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:40 INFO - 'config_files': ('talos/linux_config.py',), 03:12:40 INFO - 'default_actions': ('clobber', 03:12:40 INFO - 'read-buildbot-config', 03:12:40 INFO - 'download-and-extract', 03:12:40 INFO - 'populate-webroot', 03:12:40 INFO - 'create-virtualenv', 03:12:40 INFO - 'install', 03:12:40 INFO - 'run-tests'), 03:12:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:40 INFO - 'download_minidump_stackwalk': True, 03:12:40 INFO - 'download_symbols': 'ondemand', 03:12:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:40 INFO - 'installer_path': 'installer.exe', 03:12:40 INFO - 'log_level': 'info', 03:12:40 INFO - 'log_name': 'talos', 03:12:40 INFO - 'log_to_console': True, 03:12:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:12:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:12:40 INFO - 'opt_config_files': (), 03:12:40 INFO - 'pip_index': False, 03:12:40 INFO - 'sps_profile': False, 03:12:40 INFO - 'sps_profile_interval': 0, 03:12:40 INFO - 'suite': 'dromaeojs', 03:12:40 INFO - 'system_bits': '32', 03:12:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:40 INFO - 'title': 'talos-linux64-ix-047', 03:12:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:40 INFO - 'use_talos_json': True, 03:12:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:40 INFO - 'work_dir': 'build'} 03:12:40 INFO - ##### 03:12:40 INFO - ##### Running clobber step. 03:12:40 INFO - ##### 03:12:40 INFO - Running pre-action listener: _resource_record_pre_action 03:12:40 INFO - Running main action method: clobber 03:12:40 INFO - rmtree: /builds/slave/test/build 03:12:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:41 INFO - Running post-action listener: _resource_record_post_action 03:12:41 INFO - ##### 03:12:41 INFO - ##### Finished clobber step (success) 03:12:41 INFO - ##### 03:12:41 INFO - ##### 03:12:41 INFO - ##### Running read-buildbot-config step. 03:12:41 INFO - ##### 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: read_buildbot_config 03:12:41 INFO - Using buildbot properties: 03:12:41 INFO - { 03:12:41 INFO - "project": "", 03:12:41 INFO - "product": "firefox", 03:12:41 INFO - "script_repo_revision": "production", 03:12:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:12:41 INFO - "repository": "", 03:12:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:12:41 INFO - "buildid": "20160622024801", 03:12:41 INFO - "pgo_build": "False", 03:12:41 INFO - "basedir": "/builds/slave/test", 03:12:41 INFO - "buildnumber": 3098, 03:12:41 INFO - "slavename": "talos-linux64-ix-047", 03:12:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:12:41 INFO - "platform": "ubuntu64_hw", 03:12:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:12:41 INFO - "branch": "fx-team", 03:12:41 INFO - "repo_path": "integration/fx-team", 03:12:41 INFO - "revision": "ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f", 03:12:41 INFO - "stage_platform": "linux64", 03:12:41 INFO - "builduid": "4eb963d017df4cf3ae13ca969ffbd51e", 03:12:41 INFO - "slavebuilddir": "test" 03:12:41 INFO - } 03:12:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:12:41 INFO - Running post-action listener: _resource_record_post_action 03:12:41 INFO - ##### 03:12:41 INFO - ##### Finished read-buildbot-config step (success) 03:12:41 INFO - ##### 03:12:41 INFO - ##### 03:12:41 INFO - ##### Running download-and-extract step. 03:12:41 INFO - ##### 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: download_and_extract 03:12:41 INFO - mkdir: /builds/slave/test/build/tests 03:12:41 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')]} 03:12:41 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:49 INFO - Downloaded 1361 bytes. 03:12:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:49 INFO - Using the following test package requirements: 03:12:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:12:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:12:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'jsshell-linux-x86_64.zip'], 03:12:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:12:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:12:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:12:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:12:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:12:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:49 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:55 INFO - Downloaded 22702379 bytes. 03:12: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'] 03:12: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 03:12:57 INFO - Return code: 0 03:12:57 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 03:12:57 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')]} 03:12:57 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:58 INFO - Downloaded 22702379 bytes. 03:12: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'] 03:12: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 03:12:59 INFO - Return code: 0 03:12: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')]} 03:12:59 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:00 INFO - Downloaded 14405384 bytes. 03:13:00 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'] 03:13:00 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 03:13:00 INFO - Return code: 0 03:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:00 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:02 INFO - Downloaded 56247199 bytes. 03:13:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:02 INFO - mkdir: /builds/slave/test/properties 03:13:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:13:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:13:02 INFO - Contents: 03:13:02 INFO - build_url:https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:03 INFO - Running post-action listener: _resource_record_post_action 03:13:03 INFO - Running post-action listener: set_extra_try_arguments 03:13:03 INFO - ##### 03:13:03 INFO - ##### Finished download-and-extract step (success) 03:13:03 INFO - ##### 03:13:03 INFO - ##### 03:13:03 INFO - ##### Running populate-webroot step. 03:13:03 INFO - ##### 03:13:03 INFO - Running pre-action listener: _resource_record_pre_action 03:13:03 INFO - Running main action method: populate_webroot 03:13:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:13:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:13:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:13:03 INFO - '--tppagecycles', 03:13:03 INFO - '7'], 03:13:03 INFO - 'tests': ['tsvgm']}}, 03:13:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:13:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:13:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:13:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:13:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['damp', 'tps']}, 03:13:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'tests': ['damp', 'tps']}, 03:13:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['dromaeo_dom']}, 03:13:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['basic_compositor_video']}, 03:13:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:13:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['a11yr', 03:13:03 INFO - 'ts_paint', 03:13:03 INFO - 'tpaint', 03:13:03 INFO - 'sessionrestore', 03:13:03 INFO - 'sessionrestore_no_auto_restore', 03:13:03 INFO - 'tabpaint']}, 03:13:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['tsvgx', 03:13:03 INFO - 'tsvgr_opacity', 03:13:03 INFO - 'tart', 03:13:03 INFO - 'tscrollx', 03:13:03 INFO - 'cart']}, 03:13:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:13:03 INFO - 'tsvgr_opacity', 03:13:03 INFO - 'tart', 03:13:03 INFO - 'tscrollx', 03:13:03 INFO - 'cart']}, 03:13:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'talos_options': ['--disable-e10s'], 03:13:03 INFO - 'tests': ['tp5o']}, 03:13:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'tests': ['tp5o']}, 03:13:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'talos_options': ['--disable-e10s', 03:13:03 INFO - '--xperf_path', 03:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:03 INFO - 'tests': ['tp5n']}, 03:13:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:03 INFO - 'talos_options': ['--xperf_path', 03:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:03 INFO - 'tests': ['tp5n']}}, 03:13:03 INFO - 'talos.zip': {'path': '', 03:13:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:13:03 INFO - Running post-action listener: _resource_record_post_action 03:13:03 INFO - ##### 03:13:03 INFO - ##### Finished populate-webroot step (success) 03:13:03 INFO - ##### 03:13:03 INFO - ##### 03:13:03 INFO - ##### Running create-virtualenv step. 03:13:03 INFO - ##### 03:13:03 INFO - Running pre-action listener: _resource_record_pre_action 03:13:03 INFO - Running main action method: create_virtualenv 03:13:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:13: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 03:13:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:13:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:03 INFO - Using real prefix '/usr' 03:13:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:13:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:05 INFO - Installing pip.................done. 03:13:05 INFO - Return code: 0 03:13:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:05 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:05 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 03:13:05 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 03:13:05 INFO - Using env: {'DISPLAY': ':0', 03:13:05 INFO - 'HOME': '/home/cltbld', 03:13:05 INFO - 'LANG': 'en_US.UTF-8', 03:13:05 INFO - 'LANGUAGE': 'en_US:en', 03:13:05 INFO - 'LOGNAME': 'cltbld', 03:13:05 INFO - 'MAIL': '/var/mail/cltbld', 03:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:05 INFO - 'MOZ_NO_REMOTE': '1', 03:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:05 INFO - 'NO_EM_RESTART': '1', 03:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:05 INFO - 'PWD': '/builds/slave/test', 03:13:05 INFO - 'SHELL': '/bin/bash', 03:13:05 INFO - 'SHLVL': '1', 03:13:05 INFO - 'TERM': 'linux', 03:13:05 INFO - 'TMOUT': '86400', 03:13:05 INFO - 'USER': 'cltbld', 03:13:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:05 INFO - '_': '/tools/buildbot/bin/python'} 03:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:05 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 03:13:05 INFO - Cleaning up... 03:13:05 INFO - Return code: 0 03:13:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:05 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:05 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 03:13:05 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 03:13:05 INFO - Using env: {'DISPLAY': ':0', 03:13:05 INFO - 'HOME': '/home/cltbld', 03:13:05 INFO - 'LANG': 'en_US.UTF-8', 03:13:05 INFO - 'LANGUAGE': 'en_US:en', 03:13:05 INFO - 'LOGNAME': 'cltbld', 03:13:05 INFO - 'MAIL': '/var/mail/cltbld', 03:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:05 INFO - 'MOZ_NO_REMOTE': '1', 03:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:05 INFO - 'NO_EM_RESTART': '1', 03:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:05 INFO - 'PWD': '/builds/slave/test', 03:13:05 INFO - 'SHELL': '/bin/bash', 03:13:05 INFO - 'SHLVL': '1', 03:13:05 INFO - 'TERM': 'linux', 03:13:05 INFO - 'TMOUT': '86400', 03:13:05 INFO - 'USER': 'cltbld', 03:13:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:05 INFO - '_': '/tools/buildbot/bin/python'} 03:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:06 INFO - Downloading/unpacking psutil>=3.1.1 03:13:06 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 03:13:06 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 03:13:06 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 03:13:06 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 03:13:06 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 03:13:06 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 03:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:08 INFO - Installing collected packages: psutil 03:13:08 INFO - Running setup.py install for psutil 03:13:08 INFO - building 'psutil._psutil_linux' extension 03:13:08 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 03:13:08 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 03:13:08 INFO - building 'psutil._psutil_posix' extension 03:13:08 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 03:13:08 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 03:13:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:08 INFO - Successfully installed psutil 03:13:08 INFO - Cleaning up... 03:13:08 INFO - Return code: 0 03:13:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:13:08 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')]} 03:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:08 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')]} 03:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:08 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:08 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 03:13:08 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 03:13:08 INFO - Using env: {'DISPLAY': ':0', 03:13:08 INFO - 'HOME': '/home/cltbld', 03:13:08 INFO - 'LANG': 'en_US.UTF-8', 03:13:08 INFO - 'LANGUAGE': 'en_US:en', 03:13:08 INFO - 'LOGNAME': 'cltbld', 03:13:08 INFO - 'MAIL': '/var/mail/cltbld', 03:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:08 INFO - 'MOZ_NO_REMOTE': '1', 03:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:08 INFO - 'NO_EM_RESTART': '1', 03:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:08 INFO - 'PWD': '/builds/slave/test', 03:13:08 INFO - 'SHELL': '/bin/bash', 03:13:08 INFO - 'SHLVL': '1', 03:13:08 INFO - 'TERM': 'linux', 03:13:08 INFO - 'TMOUT': '86400', 03:13:08 INFO - 'USER': 'cltbld', 03:13:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:08 INFO - '_': '/tools/buildbot/bin/python'} 03:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:13:08 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 03:13:08 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 03:13:08 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 03:13:08 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 03:13:08 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 03:13:08 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 03:13:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:13:10 INFO - Installing collected packages: mozsystemmonitor 03:13:10 INFO - Running setup.py install for mozsystemmonitor 03:13:10 INFO - Successfully installed mozsystemmonitor 03:13:10 INFO - Cleaning up... 03:13:10 INFO - Return code: 0 03:13:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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', '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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:13: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 jsonschema==2.5.1 03:13:10 INFO - Using env: {'DISPLAY': ':0', 03:13:10 INFO - 'HOME': '/home/cltbld', 03:13:10 INFO - 'LANG': 'en_US.UTF-8', 03:13:10 INFO - 'LANGUAGE': 'en_US:en', 03:13:10 INFO - 'LOGNAME': 'cltbld', 03:13:10 INFO - 'MAIL': '/var/mail/cltbld', 03:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:10 INFO - 'MOZ_NO_REMOTE': '1', 03:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:10 INFO - 'NO_EM_RESTART': '1', 03:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:10 INFO - 'PWD': '/builds/slave/test', 03:13:10 INFO - 'SHELL': '/bin/bash', 03:13:10 INFO - 'SHLVL': '1', 03:13:10 INFO - 'TERM': 'linux', 03:13:10 INFO - 'TMOUT': '86400', 03:13:10 INFO - 'USER': 'cltbld', 03:13:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:10 INFO - '_': '/tools/buildbot/bin/python'} 03:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:13:11 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 03:13:11 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 03:13:11 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 03:13:11 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 03:13:11 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 03:13:11 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 03:13:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:13:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:13:12 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 03:13:12 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 03:13:12 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 03:13:12 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 03:13:12 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 03:13:12 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 03:13:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:13:13 INFO - warning: no files found matching '*.txt' 03:13:13 INFO - no previously-included directories found matching 'build' 03:13:13 INFO - no previously-included directories found matching 'dist' 03:13:13 INFO - no previously-included directories found matching '.git*' 03:13:13 INFO - Installing collected packages: jsonschema, functools32 03:13:13 INFO - Running setup.py install for functools32 03:13:13 INFO - warning: no files found matching '*.txt' 03:13:13 INFO - no previously-included directories found matching 'build' 03:13:13 INFO - no previously-included directories found matching 'dist' 03:13:13 INFO - no previously-included directories found matching '.git*' 03:13:13 INFO - Successfully installed jsonschema functools32 03:13:13 INFO - Cleaning up... 03:13:13 INFO - Return code: 0 03:13:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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', '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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:13: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 blobuploader==1.2.4 03:13:13 INFO - Using env: {'DISPLAY': ':0', 03:13:13 INFO - 'HOME': '/home/cltbld', 03:13:13 INFO - 'LANG': 'en_US.UTF-8', 03:13:13 INFO - 'LANGUAGE': 'en_US:en', 03:13:13 INFO - 'LOGNAME': 'cltbld', 03:13:13 INFO - 'MAIL': '/var/mail/cltbld', 03:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:13 INFO - 'MOZ_NO_REMOTE': '1', 03:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:13 INFO - 'NO_EM_RESTART': '1', 03:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:13 INFO - 'PWD': '/builds/slave/test', 03:13:13 INFO - 'SHELL': '/bin/bash', 03:13:13 INFO - 'SHLVL': '1', 03:13:13 INFO - 'TERM': 'linux', 03:13:13 INFO - 'TMOUT': '86400', 03:13:13 INFO - 'USER': 'cltbld', 03:13:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:13 INFO - '_': '/tools/buildbot/bin/python'} 03:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:16 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 03:13:16 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 03:13:16 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 03:13:16 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 03:13:16 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 03:13:16 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 03:13:16 INFO - Downloading docopt-0.6.1.tar.gz 03:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:16 INFO - Running setup.py install for blobuploader 03:13:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:16 INFO - Running setup.py install for requests 03:13:16 INFO - Running setup.py install for docopt 03:13:16 INFO - Successfully installed blobuploader requests docopt 03:13:16 INFO - Cleaning up... 03:13:16 INFO - Return code: 0 03:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:16 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:16 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 03:13:16 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 03:13:16 INFO - Using env: {'DISPLAY': ':0', 03:13:16 INFO - 'HOME': '/home/cltbld', 03:13:16 INFO - 'LANG': 'en_US.UTF-8', 03:13:16 INFO - 'LANGUAGE': 'en_US:en', 03:13:16 INFO - 'LOGNAME': 'cltbld', 03:13:16 INFO - 'MAIL': '/var/mail/cltbld', 03:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:16 INFO - 'MOZ_NO_REMOTE': '1', 03:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:16 INFO - 'NO_EM_RESTART': '1', 03:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:16 INFO - 'PWD': '/builds/slave/test', 03:13:16 INFO - 'SHELL': '/bin/bash', 03:13:16 INFO - 'SHLVL': '1', 03:13:16 INFO - 'TERM': 'linux', 03:13:16 INFO - 'TMOUT': '86400', 03:13:16 INFO - 'USER': 'cltbld', 03:13:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:16 INFO - '_': '/tools/buildbot/bin/python'} 03:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:17 INFO - Running setup.py (path:/tmp/pip-N0m3xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:17 INFO - Running setup.py (path:/tmp/pip-o7Y7Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:17 INFO - Running setup.py (path:/tmp/pip-VbDE4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:17 INFO - Running setup.py (path:/tmp/pip-ztaF6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:17 INFO - Running setup.py (path:/tmp/pip-CIPIIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:17 INFO - Running setup.py (path:/tmp/pip-DmhikF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:17 INFO - Running setup.py (path:/tmp/pip-8YIq1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:17 INFO - Running setup.py (path:/tmp/pip-xidh9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:17 INFO - Running setup.py (path:/tmp/pip-gGMo0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:17 INFO - Running setup.py (path:/tmp/pip-LXd7PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:17 INFO - Running setup.py (path:/tmp/pip-4aNS6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:17 INFO - Running setup.py (path:/tmp/pip-FCqy8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:18 INFO - Running setup.py (path:/tmp/pip-gOkiIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:18 INFO - Running setup.py (path:/tmp/pip-H15z2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:18 INFO - Running setup.py (path:/tmp/pip-GG29jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:18 INFO - Running setup.py (path:/tmp/pip-z_bGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:18 INFO - Running setup.py (path:/tmp/pip-UmApyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:18 INFO - Running setup.py install for manifestparser 03:13:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:18 INFO - Running setup.py install for mozcrash 03:13:18 INFO - Running setup.py install for mozdebug 03:13:18 INFO - Running setup.py install for mozdevice 03:13:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:13:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:18 INFO - Running setup.py install for mozfile 03:13:18 INFO - Running setup.py install for mozhttpd 03:13:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:18 INFO - Running setup.py install for mozinfo 03:13:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for mozInstall 03:13:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for mozleak 03:13:19 INFO - Running setup.py install for mozlog 03:13:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for moznetwork 03:13:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for mozprocess 03:13:19 INFO - Running setup.py install for mozprofile 03:13:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for mozrunner 03:13:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:19 INFO - Running setup.py install for mozscreenshot 03:13:19 INFO - Running setup.py install for moztest 03:13:20 INFO - Running setup.py install for mozversion 03:13:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:20 INFO - Cleaning up... 03:13:20 INFO - Return code: 0 03:13:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:20 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:20 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 03:13:20 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 03:13:20 INFO - Using env: {'DISPLAY': ':0', 03:13:20 INFO - 'HOME': '/home/cltbld', 03:13:20 INFO - 'LANG': 'en_US.UTF-8', 03:13:20 INFO - 'LANGUAGE': 'en_US:en', 03:13:20 INFO - 'LOGNAME': 'cltbld', 03:13:20 INFO - 'MAIL': '/var/mail/cltbld', 03:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:20 INFO - 'MOZ_NO_REMOTE': '1', 03:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:20 INFO - 'NO_EM_RESTART': '1', 03:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:20 INFO - 'PWD': '/builds/slave/test', 03:13:20 INFO - 'SHELL': '/bin/bash', 03:13:20 INFO - 'SHLVL': '1', 03:13:20 INFO - 'TERM': 'linux', 03:13:20 INFO - 'TMOUT': '86400', 03:13:20 INFO - 'USER': 'cltbld', 03:13:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:20 INFO - '_': '/tools/buildbot/bin/python'} 03:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:20 INFO - Running setup.py (path:/tmp/pip-vvSj4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:20 INFO - Running setup.py (path:/tmp/pip-Q7n1iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:20 INFO - Running setup.py (path:/tmp/pip-1UZwNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:20 INFO - Running setup.py (path:/tmp/pip-8iOrH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:20 INFO - Running setup.py (path:/tmp/pip-4XlcgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:20 INFO - Running setup.py (path:/tmp/pip-3kjIP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:20 INFO - Running setup.py (path:/tmp/pip-dzBhdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:20 INFO - Running setup.py (path:/tmp/pip-sMvyA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:20 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)) 03:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:20 INFO - Running setup.py (path:/tmp/pip-Rgpn0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:21 INFO - Running setup.py (path:/tmp/pip-fHGXsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:21 INFO - Running setup.py (path:/tmp/pip-wGd2Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:21 INFO - Running setup.py (path:/tmp/pip-qY868D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:21 INFO - Running setup.py (path:/tmp/pip-b9fS07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:21 INFO - Running setup.py (path:/tmp/pip-1AkIhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:21 INFO - Running setup.py (path:/tmp/pip-ZZ9Mg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:21 INFO - Running setup.py (path:/tmp/pip-BYimaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:21 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)) 03:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:21 INFO - Running setup.py (path:/tmp/pip-R8NpYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:21 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)) 03:13:21 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)) 03:13:21 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)) 03:13:21 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)) 03:13:21 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)) 03:13:21 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)) 03:13:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:21 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 03:13:21 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 03:13:21 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 03:13:21 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 03:13:21 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 03:13:21 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 03:13:23 INFO - Downloading blessings-1.6.tar.gz 03:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:23 INFO - Installing collected packages: blessings 03:13:23 INFO - Running setup.py install for blessings 03:13:23 INFO - Successfully installed blessings 03:13:23 INFO - Cleaning up... 03:13:23 INFO - Return code: 0 03:13:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:23 INFO - Reading from file tmpfile_stdout 03:13:23 INFO - Current package versions: 03:13:23 INFO - argparse == 1.2.1 03:13:23 INFO - blessings == 1.6 03:13:23 INFO - blobuploader == 1.2.4 03:13:23 INFO - docopt == 0.6.1 03:13:23 INFO - functools32 == 3.2.3-2 03:13:23 INFO - jsonschema == 2.5.1 03:13:23 INFO - manifestparser == 1.1 03:13:23 INFO - mozInstall == 1.12 03:13:23 INFO - mozcrash == 0.17 03:13:23 INFO - mozdebug == 0.1 03:13:23 INFO - mozdevice == 0.48 03:13:23 INFO - mozfile == 1.2 03:13:23 INFO - mozhttpd == 0.7 03:13:23 INFO - mozinfo == 0.9 03:13:23 INFO - mozleak == 0.1 03:13:23 INFO - mozlog == 3.2 03:13:23 INFO - moznetwork == 0.27 03:13:23 INFO - mozprocess == 0.22 03:13:23 INFO - mozprofile == 0.28 03:13:23 INFO - mozrunner == 6.11 03:13:23 INFO - mozscreenshot == 0.1 03:13:23 INFO - mozsystemmonitor == 0.3 03:13:23 INFO - moztest == 0.7 03:13:23 INFO - mozversion == 1.4 03:13:23 INFO - psutil == 3.1.1 03:13:23 INFO - requests == 1.2.3 03:13:23 INFO - wsgiref == 0.1.2 03:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:23 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 03:13:23 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 03:13:23 INFO - Using env: {'DISPLAY': ':0', 03:13:23 INFO - 'HOME': '/home/cltbld', 03:13:23 INFO - 'LANG': 'en_US.UTF-8', 03:13:23 INFO - 'LANGUAGE': 'en_US:en', 03:13:23 INFO - 'LOGNAME': 'cltbld', 03:13:23 INFO - 'MAIL': '/var/mail/cltbld', 03:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:23 INFO - 'MOZ_NO_REMOTE': '1', 03:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:23 INFO - 'NO_EM_RESTART': '1', 03:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:23 INFO - 'PWD': '/builds/slave/test', 03:13:23 INFO - 'SHELL': '/bin/bash', 03:13:23 INFO - 'SHLVL': '1', 03:13:23 INFO - 'TERM': 'linux', 03:13:23 INFO - 'TMOUT': '86400', 03:13:23 INFO - 'USER': 'cltbld', 03:13:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:23 INFO - '_': '/tools/buildbot/bin/python'} 03:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 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)) 03:13:24 INFO - Cleaning up... 03:13:24 INFO - Return code: 0 03:13:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:24 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:24 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 03:13:24 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 03:13:24 INFO - Using env: {'DISPLAY': ':0', 03:13:24 INFO - 'HOME': '/home/cltbld', 03:13:24 INFO - 'LANG': 'en_US.UTF-8', 03:13:24 INFO - 'LANGUAGE': 'en_US:en', 03:13:24 INFO - 'LOGNAME': 'cltbld', 03:13:24 INFO - 'MAIL': '/var/mail/cltbld', 03:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:24 INFO - 'MOZ_NO_REMOTE': '1', 03:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:24 INFO - 'NO_EM_RESTART': '1', 03:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:24 INFO - 'PWD': '/builds/slave/test', 03:13:24 INFO - 'SHELL': '/bin/bash', 03:13:24 INFO - 'SHLVL': '1', 03:13:24 INFO - 'TERM': 'linux', 03:13:24 INFO - 'TMOUT': '86400', 03:13:24 INFO - 'USER': 'cltbld', 03:13:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:24 INFO - '_': '/tools/buildbot/bin/python'} 03:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:24 INFO - Cleaning up... 03:13:24 INFO - Return code: 0 03:13:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:24 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 0x7f3f292ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', '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 03:13:24 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 03:13:24 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 03:13:24 INFO - Using env: {'DISPLAY': ':0', 03:13:24 INFO - 'HOME': '/home/cltbld', 03:13:24 INFO - 'LANG': 'en_US.UTF-8', 03:13:24 INFO - 'LANGUAGE': 'en_US:en', 03:13:24 INFO - 'LOGNAME': 'cltbld', 03:13:24 INFO - 'MAIL': '/var/mail/cltbld', 03:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:24 INFO - 'MOZ_NO_REMOTE': '1', 03:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:24 INFO - 'NO_EM_RESTART': '1', 03:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:24 INFO - 'PWD': '/builds/slave/test', 03:13:24 INFO - 'SHELL': '/bin/bash', 03:13:24 INFO - 'SHLVL': '1', 03:13:24 INFO - 'TERM': 'linux', 03:13:24 INFO - 'TMOUT': '86400', 03:13:24 INFO - 'USER': 'cltbld', 03:13:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:24 INFO - '_': '/tools/buildbot/bin/python'} 03:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:24 INFO - Downloading/unpacking flake8 03:13:24 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 03:13:24 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 03:13:24 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 03:13:24 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 03:13:24 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 03:13:24 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 03:13:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:13:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:13:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:13:27 INFO - no previously-included directories found matching 'docs/_build' 03:13:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:13:27 INFO - Running setup.py install for pep8 03:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:13:27 INFO - no previously-included directories found matching 'docs/_build' 03:13:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:13:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:13:27 INFO - Cleaning up... 03:13:27 INFO - Return code: 0 03:13:27 INFO - Running post-action listener: _resource_record_post_action 03:13:27 INFO - Running post-action listener: _start_resource_monitoring 03:13:27 INFO - Starting resource monitoring. 03:13:27 INFO - ##### 03:13:27 INFO - ##### Finished create-virtualenv step (success) 03:13:27 INFO - ##### 03:13:27 INFO - ##### 03:13:27 INFO - ##### Running install step. 03:13:27 INFO - ##### 03:13:27 INFO - Running pre-action listener: _resource_record_pre_action 03:13:27 INFO - Running main action method: install 03:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:27 INFO - Reading from file tmpfile_stdout 03:13:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:27 INFO - Reading from file tmpfile_stdout 03:13:27 INFO - Output received: 03:13:27 INFO - Usage: mozinstall [options] installer 03:13:27 INFO - Options: 03:13:27 INFO - -h, --help show this help message and exit 03:13:27 INFO - -d DEST, --destination=DEST 03:13:27 INFO - Directory to install application into. [default: 03:13:27 INFO - "/builds/slave/test"] 03:13:27 INFO - --app=APP Application being installed. [default: firefox] 03:13:27 INFO - mkdir: /builds/slave/test/build/application 03:13:27 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'] 03:13:27 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 03:13:43 INFO - Reading from file tmpfile_stdout 03:13:43 INFO - Output received: 03:13:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:13:43 INFO - Running post-action listener: _resource_record_post_action 03:13:43 INFO - ##### 03:13:43 INFO - ##### Finished install step (success) 03:13:43 INFO - ##### 03:13:43 INFO - ##### 03:13:43 INFO - ##### Running run-tests step. 03:13:43 INFO - ##### 03:13:43 INFO - Running pre-action listener: _resource_record_pre_action 03:13:43 INFO - Running main action method: run_tests 03:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:43 INFO - Python 2.7.3 03:13:43 INFO - Return code: 0 03:13:43 INFO - grabbing minidump binary from tooltool 03:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:43 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 0x10481c0>, '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 0x10490c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:43 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 03:13:43 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 03:13:43 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 03:13:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:44 INFO - Return code: 0 03:13:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:13:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:13:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:13:44 INFO - Return code: 0 03:13:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:13:44 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:13:44 INFO - Using env: {'DISPLAY': ':0', 03:13:44 INFO - 'HOME': '/home/cltbld', 03:13:44 INFO - 'LANG': 'en_US.UTF-8', 03:13:44 INFO - 'LANGUAGE': 'en_US:en', 03:13:44 INFO - 'LOGNAME': 'cltbld', 03:13:44 INFO - 'MAIL': '/var/mail/cltbld', 03:13:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:44 INFO - 'MOZ_NO_REMOTE': '1', 03:13:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:44 INFO - 'NO_EM_RESTART': '1', 03:13:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:44 INFO - 'PWD': '/builds/slave/test', 03:13:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:44 INFO - 'SHELL': '/bin/bash', 03:13:44 INFO - 'SHLVL': '1', 03:13:44 INFO - 'TERM': 'linux', 03:13:44 INFO - 'TMOUT': '86400', 03:13:44 INFO - 'USER': 'cltbld', 03:13:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581', 03:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:44 INFO - '_': '/tools/buildbot/bin/python'} 03:13:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:13:45 INFO - mozversion application_buildid: 20160622024801 03:13:45 INFO - mozversion application_changeset: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f 03:13:45 INFO - mozversion application_display_name: Nightly 03:13:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:45 INFO - mozversion application_name: Firefox 03:13:45 INFO - mozversion application_remotingname: firefox 03:13:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:13:45 INFO - mozversion application_vendor: Mozilla 03:13:45 INFO - mozversion application_version: 50.0a1 03:13:45 INFO - mozversion platform_buildid: 20160622024801 03:13:45 INFO - mozversion platform_changeset: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f 03:13:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:13:45 INFO - mozversion platform_version: 50.0a1 03:13:45 INFO - using testdate: 1466590425 03:13:45 INFO - actual date: 1466590425 03:13:45 INFO - starting webserver on 'localhost:44516' 03:13:45 INFO - SUITE-START | Running 2 tests 03:13:45 INFO - TEST-START | dromaeo_css 03:13:45 INFO - operating with platform_type : linux_ 03:13:45 INFO - Initialising browser for dromaeo_css test... 03:13:45 INFO - TEST-INFO | started process 10591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4YwWTa/profile http://localhost:44516/getInfo.html) 03:13:49 INFO - PROCESS | 10591 | __metrics Screen width/height:1600/1200 03:13:49 INFO - PROCESS | 10591 | colorDepth:24 03:13:49 INFO - PROCESS | 10591 | Browser inner width/height: 1024/697 03:13:49 INFO - PROCESS | 10591 | __metrics 03:13:50 INFO - PROCESS | 10591 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:51 INFO - TEST-INFO | 10591: exit 0 03:13:51 INFO - Browser initialized. 03:13:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:13:51 INFO - TEST-INFO | started process 10672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4YwWTa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:03 INFO - PROCESS | 10672 | RSS: Main: 175341568 03:14:03 INFO - PROCESS | 10672 | 03:14:54 INFO - PROCESS | 10672 | 1466590494418 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] 03:17:07 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44516/tests/dromaeo/cssquery-ext.html) 03:17:08 INFO - PROCESS | 10672 | RSS: Main: 254758912 03:17:08 INFO - PROCESS | 10672 | 03:20:11 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-ext.html (next: http://localhost:44516/tests/dromaeo/cssquery-jquery.html) 03:20:11 INFO - PROCESS | 10672 | RSS: Main: 255922176 03:20:11 INFO - PROCESS | 10672 | 03:23:13 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44516/tests/dromaeo/cssquery-mootools.html) 03:23:14 INFO - PROCESS | 10672 | RSS: Main: 255176704 03:23:14 INFO - PROCESS | 10672 | 03:26:16 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44516/tests/dromaeo/cssquery-prototype.html) 03:26:17 INFO - PROCESS | 10672 | RSS: Main: 254918656 03:26:17 INFO - PROCESS | 10672 | 03:29:20 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44516/tests/dromaeo/cssquery-yui.html) 03:29:21 INFO - PROCESS | 10672 | RSS: Main: 234213376 03:29:21 INFO - PROCESS | 10672 | 03:32:23 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:44516/tests/dromaeo/cssquery-yui.html (next: http://localhost:44516/tests/dromaeo/cssquery-dojo.html) 03:32:24 INFO - PROCESS | 10672 | RSS: Main: 293425152 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | __start_tp_report 03:32:24 INFO - PROCESS | 10672 | _x_x_mozilla_page_load 03:32:24 INFO - PROCESS | 10672 | _x_x_mozilla_page_load_details 03:32:24 INFO - PROCESS | 10672 | |i|pagename|runs| 03:32:24 INFO - PROCESS | 10672 | |0;dojo.html;2612.20327800021;2621.9737802621967;2648.8808003639833;2655.4025344297547;2664.280644226059;4631.189541830183;4648.581627653511;4689.155951928656;4703.764811759415;4750.7862146203415;4723.740194289313;4774.952250477503;4784.688995215317;4786.664933454659;4802.327674125625;4168.166366726652;4323.1137616788565;4421.6904816662845;4434.800433980463;4543.954560454386;4438.977805110986;4473.038296766194;4485.798139083749;4503.076869241814;4540.046590216059;4272.850450234258;4311.07311927937;4348.239058164809;4376.6498680105515;4393.0994146199955;4360.345948107777;4370.497392799837;4424.181526417591;4424.446944131983;4434.06884554244;4403.075354175627;4412.4043254160915;4427.40230068943;4453.51011388747;4464.330350447426;4604.861854144381;4733.4793172751315;4862.951370486286;4863.465018847924;4873.244647079709;5146.433892271847;5178.430372659004;5183.585313174937;5211.140161873286;5212.582993360522;5036.445990940993;5177.948220517785;5184.507471790212;5224.895502089937;5230.607704422184;4807.903841923142;4852.56326930578;4853.708777473293;4898.755062246873;4921.9015619688125;5372.167314066326;5373.167159090347;5373.516383525502;5377.704226267593;5391.29913111293;4914;5018.573421259234;5156.123459011902;5168.043911876315;5170.1469257572835;5117.130087885069;5163.173892177234;5179.249008893689;5179.430262671103;5238.97380513095;5098.031374038921;5103.821366252163;5116.539511443988;5117.155669314596;5133.153029750124;4903.338049363361;4983.476734942851;5012.523810238022;5052.3937127544195;5076.390833100052;4345.3699213613845;4364;4402.119576084732;4407.757573333497;4414.1171765647;3773.8301776420126;3795.0512371907025;3807.809609519513;3838.9040273993373;3848.9807550962064;4229.661627069827;4272.4445822042935;4338.869833904988;4379.0585024219945;4390.078083602415;5129.384473863161;5145.099607568661;5176.50823171798;5176.637635365563;5218.765155568009;4359.12817436514;4392.758398288125;4394.714343567658;4424.513303536608;4470.485894122153;4483.21543729846;4596.7931443085145;4621.976890115595;4633;4641.327007583882;4825.855224343275;4850.466448690711;4852.102361063215;4886.291487734258;4901.3138160658245;5113.335266415343;5164.561012313995;5166.147585648326;5170.146925757208;5174.249733788655;4713.08094921487;4784.162771514902;4814.807407703793;4815.061063092663;4877.512248775094;5054.342935418372;5062.924056139234;5069.2902993581665;5072.82245121419;5118.283440318284;5149.356330458692;5151.6908985461;5154.690718556899;5167.560757335668;5168.767405466688;4820.421549414093;4843.321934929183;4949.232868905326;4975.502449754996;5001.399832020181;4978.925316120189;5000.824971125993;5010;5011.874703132451;5061.772220250171;4960.826371076995;4975.875603109951;4976.776045077908;5007.1487847065355;5025.748712564284;4903.215485522299;4987.526185012418;4996.200607902863;4997.675151115166;4999.725015124203;4908.852734417973;4924.8768780780765;4948.653594248368;4963.578095861748;4977.328060711902 03:32:24 INFO - PROCESS | 10672 | |1;ext.html;546.0866138407623;575.9654420734756;586.788756047823;588.4674369695424;592.1709606550831;27298.181054568344;39153.608463915385;40424.59575404245;40453.595464045386;40463;41016.79491602538;41366.7931660342;41480.58519414805;41504.16991660173;41552.16895662085;7540.095188577378;7852.921470785276;7994.480358776661;8002;10057.647982320621;9978.750531236705;10330.948345258263;10336.638217662383;10339.793204135913;10343;10332.431716255604;10377.221708371864;10383.221258405612;10384.896151038469;10386.169106471463;7674.117476490192;7885.172056933997;7887.132415434355;10287.845682314772;10449;10161.390316581028;10201.081902628799;10201.744956376077;10300.79398412035;10314.9484252579;37211.44182837233;37507.81246093779;37533.24933501315;37587.62412375869;37619.62380376188;3202.3115030268373;3617.5478065241846;3696.2607478504406;3708.072981754561;3714.3381386653273;29271;29300.41399172026;29466.70533294661;29550.113496595135;30322.090337289916;3541.663541963535;3556.217632120955;3561.8041007744564;3563.893083207508;3626.691731202851;186023;187235.06382468;187649;245829.7708511464;246486;52297;53006.469935300156;53017.73491132597;53128.46871531312;53156.468435315925;55985;56118.15822762662;56134.71932640311;56199;56224.43775562274;15113.47102851395;15642.68714625701;15653.217339132998;15665.843341566439;15669;10302.742431439274;11687.707807304885;11953.880461195451;11994.34031128279;12406.379681015913;15688.294026768823;15751.212439377985;15824;15869.603259918364;15907.204639767966;6311.747530098836;6322.810315690536;6496.350364963466;6502.44729198014;6507.689770131535;781.5896654256561;827.6854795177915;950.6007476859736;958.166395236149;974.0843607009389;27926.16221513358;28010.2997425066;28307.575386369223;28490.85754571255;28511.429771404455;958.9232861371073;969.6170012845027;1021.4250124564026;1026.2457094035879;1053.4785281285813;15068.171250581323;15073.472428464951;15103.773443398359;15122.621934451507;15153.848461515465;378055;379894;380945;381042;382550;48761.512384876405;48762.268565971535;48781.756091219315;48860.75569622129;48903.51096489061;1066.3388699006666;1101.311680199859;1156.976860462803;1168.293182624517;1181.5687274144875;26398.736012640395;28992.275193120342;29644.407111858072;29953.472565805132;30133.09600711982;42053.1589368217;42085;42544.361834571886;42550.36174457324;42619;300105;301445;301988;302246;302668;30983.69016309808;34958.82520587381;36245.81877090598;36462.63537364592;36479.81760091289;41540.58459415367;41566.58433415627;41785;42546.361804572334;42847.14305713931;35527;36009.0997725059;36530.8173459131;36598.8170059148;37258.441123383716;35426.82286588551;36020.819895901404;36041;36088.81955590205;36494;35330.76342328006;35870.46194307035;35911.64088359188;36152.63847361493;36271.818640906626;30078.398432031674;32360.190995225308;32568.674313256564;32721.509177362834;32864.67135328616;24791.00835966541;25051.87474062691;25188.74811251864;25544.23367298984;25565.616515752652 03:32:24 INFO - PROCESS | 10672 | |2;jquery.html;382.2965743032819;382.3232877806283;383.37509858929957;392.0923063108904;396.17793079360337;15301.311440985155;16763.329466821328;16909.746353804672;17118.82881171188;17134.48596542104;16068;16312.83687163128;16812.075335856523;16839.66320673586;16868;5005.724685142325;5173.534381905628;5185.222216667492;5201.2458193561915;5227.973860130713;3558.1460449492065;3851.2490064437447;5785.16115163301;6133.754649814002;6135;5955.34491205967;6176.567640265183;6178.8455288617915;6201.782937597185;6210.31686514483;6080.483158931496;6113.083037544404;6146.7233974471255;6150.753969841224;6155.19982402287;3330.300636866261;3557.714527334321;3579.8926032219074;3582.5521809773777;5101.923471147936;19876.70184947227;20478.590428191354;20692.068856901475;20771;20825.271115511037;1995.6607376745842;2039.2047101630376;2044.4684382060623;2057.753069631639;2087.499000239947;12940;12998.740025199442;13316.334183290797;13494.190348579019;13782.310884455737;1689.81412044675;1758.4636685810822;1838.3198216659787;1851.4075495841337;1854.5456363191104;60783.39216607866;64891.351086489005;65083;66706.66646666784;74098.88851667283;8748.606312715943;9296.395734277387;10254.230932680079;10326.122279606318;10400.531976061095;14141.29293535319;14274.14355138695;14355.712885742227;14362.497312594218;14393.92803035978;7409.444291678038;7452.217517160729;7526.134494533198;7572.81067973294;7650.158482566913;7055.118110236221;7074.75238366665;7118.430525557943;7237.421006319587;7265.745698900619;4189.413482112506;4366.825326986885;4382.386465894777;4397.626201772885;4500.504944456107;1607.075931339461;1661.335465813684;1715.125286104096;1805.073588073223;1881.5672395348872;839.7186942374251;865.948043117415;901.8151278987792;904.3262769236829;913.2465715784505;16445.342186312413;16879.38243487711;16948.152592370578;17067.40264090751;17255.482335529956;831.1646794971016;853.4623187391903;853.7737499562496;870.6212797433137;878.0824038879387;8832.160944710242;9540.713778586654;9733.2213422926;9751.609935602639;9868.950655246677;359450;362060;363188;378884;381376;71857;75084;77120;77234.61382693051;85707.5714621423;873.5719497446206;924.5007695844168;927.4481683398367;960.577345967772;967.1247520993512;15826.36694532252;16187.271572779018;16207.918960405123;16483.58791030234;16507.66984660324;28595.99914003;37524.812375937945;38197.61802382052;38414.423783643826;38427.462901483625;53233.733831330595;54856;55635.72182139063;55937.72031139981;56740;6358;6687.264400915798;6961.721531138698;7040.683169257293;7724.961375193088;11149.275297105662;12252.938735306267;12300.507979680713;12514.624561263177;12593.433295501542;10261.897381026094;10348.223883208639;10417.895821041693;10545.683629491128;10601.204909631655;10480.63317783874;10594.258401911793;10643.787124257316;10649.520771565143;10737.248392612442;10296.17630589566;10543.947280263856;10646.361218326925;10655.520501577292;10778.676639700821;7652.502587331805;7794.844103118019;7801.9609901950125;7879.172686867796;7997.7600671979935;10222.6422075227;10359.378437293786;10418.426986515511;10573.101286390744;10784.838227426439 03:32:24 INFO - PROCESS | 10672 | |3;mootools.html;1233.0320698251874;1302.1731200687564;1370.4723681382668;1379.8137251471048;1664.4840099569135;6408.327125651804;7556.584387858666;7798.532088074705;7801.804954876124;8040.396970227227;7720.845583088349;7834;7841.294283514482;7857.842843143148;7868.213178682129;1894.1003023563767;2155.5365596396773;2215.9556808863813;2228.3983324502374;2249.853759505627;2259.7288325400973;2276.726792784868;2277.6241920083166;2278;2281.6577513373045;2179.574982878339;2185.9781402186013;2234.7318321801326;2240.4622890506325;2244.3491387497606;1821.826926441986;2073.1292857000094;2091.048572899327;2166.3176099528596;2168.447046003275;2191.539776646906;2214.081156320125;2214.3910424633195;2215;2220.2673117871063;7836.059672839296;7889.566073865935;7894.131645518988;7909.960450197712;7917.445778795487;4367.344898265285;4483.551644835523;4486.685931984763;4488.236999710057;4490.259107247301;2885.797994140411;2919.3139612191117;3008.4735171345146;3016.2610160510594;3026.5157574787927;1007.969760907174;1023.4780262066325;1024.9692509224735;1031.113242611361;1031.4327120083924;10667.893321066767;10671.413072281022;10685.83971240432;10691.572337106583;10695.304805187638;4184.142250838631;4278.144371125725;4334.631556317749;4352.194843953878;4408.184485870124;8510.957445212858;8521.659133634585;8575.571221438902;8590.87113693295;8597.097304783032;4651.511591282934;4657.068586282757;4663.370444989951;4667.743274119888;4670.299455081765;3761.360568703327;4048.817803198804;4124.711270211056;4131.215069136854;4187.706860519735;3416.8462419191196;3468;3493.528373669573;3520.771149875301;3595.5146055282726;1014.91373233276;1053.4785281285813;1057.154276578734;1066.4880857188439;1079.838024296346;797.2585495489251;823.320760372695;844.9788755281168;852.5396286005612;855.7475544714324;5375.892482150413;5415.458454154632;5458.235846981426;5598.1322894951345;5708.65748055118;384.56544105160987;386.2236903823279;389.966852817508;401.1315501938271;402.9798510074485;3708.313961917054;3710;3716.4611131385795;3717.516722826015;3767.2842159990064;9312.487813170204;9526.142647161789;9526.90473095274;9587.808243835085;9680.951595242119;9410.858837117448;9438.244940404751;9448.669296574586;9455.05449455049;9512.048795120432;7170.139583249939;7215.783526494213;7241.565506069653;7251.673674684757;7251.746188883364;5384.596155288447;5451.400345962021;5511.944880551304;5576.498115169654;5612.635178713371;8348.582570871311;8683.652653893774;8687.652493900427;8932.240759535513;8988.415752976036;8670.739877803677;8984.820303594022;8996.415233009833;9057.36598438103;9073.954630226806;6079.483243924316;6134.294556125924;6342.460890824332;6903.861922761416;7093.1488221413765;7173.641317933978;7607.733729319447;7661.272179142972;7672.923270767445;7685.730999414994;6538;6691.297413771484;6729.226138994079;6819.215790184192;6848.246692863681;6627.237867645283;6737.427318677967;6748.527603067738;6792.660366981532;6793.66031698423;6223.564350495421;6375.075614036032;6410.134631824831;6436.452901503238;6464.870702586016;4745.83389581363;4806.279058141306;4853.320535125014;4874.805007799649;4909.4845041270155;4798.664093513421;4857.9028419432125;4885.2427873679635;4906.1659517881335;5036.143855544639 03:32:24 INFO - PROCESS | 10672 | |4;prototype.html;304.1559671910448;311.93761247750456;312.54368621812154;313.1716609567695;316.2284026974184;4869.9269510957365;4872.70763754175;4885.7801398937045;4903.362562866827;4924.1382758017335;4809.422869255685;4811.4707382187935;4822.927656085161;4834.299026641135;4860.513948605138;3636.690881275095;3692.280005398948;3751.8499260029566;3809.847606095753;3862.208247309295;3763.322601931651;3808.219315040424;3811.6950643948417;3822.369309064015;3833.290841194374;3616.330978768923;3787.185755062661;3794.5256842894637;3798.620137986193;3806.8286927088348;3635.600083990759;3783.45139954705;3788.8254641061358;3806.143617686026;3830.8467661293516;3354.5910717498464;3372.173817414749;3377.864885404581;3380.7295416366633;3385.86456541738;4705.1765940960195;4725.3384526166365;4732.266498692708;4735.715857048588;4737.407824021997;4222.8176110689055;4328.32910898808;4370.737755734666;4374.6500279977845;4384.934225986613;5057;5061.316722242487;5083.847484575469;5105.7024339047575;5114.2584325273;3699.6300369962787;3704.3887758519813;3707.5550933887835;3724.42271447926;3762.1347090169143;5170.508801663836;5309.442508536626;5326.2543243945875;5363.570914326844;5368.8389348319615;3741.158239396114;3748.3627783276906;3759.5300587426573;3786.848526058982;3792.50697409335;3849.8075096245634;3860.1121741999495;3862.942055869164;3866.9613303867163;3874.380099184117;4321.891952701208;4323.891902702395;4350.303951367766;4360.869173924787;4377.905523619095;4926.45808961014;5086.440491546001;5097.6941383517105;5100.158473851773;5108.489151084936;1313.6797518493852;1332.6806461603137;1342.7918672605763;1350.2506109109343;1356.5794603672696;846.5259454705384;866.9003064647646;875.5228400521731;876.2595606712318;892.205936716323;4344.913101737948;4388.736675799462;4406.493253275914;4431.711938724037;4479.619232365286;5182;5218.7912483500995;5221.6344855859725;5277.551408130275;5313.282706834605;4291.206126866539;4537.4328208973875;4556.339330797082;4561.521040290788;4566.771661416916;2771.2240572639694;2783.151138902654;2793.4413117376607;2807.199948014806;2810.819455828557;4933.86521100149;4965.602751779849;4971.080350135164;4997.775100120431;5011.749412529359;5099.69401835891;5334.91997620036;5375.489328513785;5393.4336894626285;5422.810201642924;4937.703737775745;4948.4309304429735;4950.232713929347;4965.900681986413;4980.900381992412;5310.654807437504;5312.893742125213;5320.893582128413;5342.145256759055;5345.118055520796;4885.462599114166;5161.438607360909;5162.225666150108;5164.96700659877;5248.763805628832;4915.754212289443;4934.605231581393;4947.82682606107;4951.14332125453;5017.774200160929;3666.3583872822683;3694.556653201633;3705.129294615709;3714.7399682022;3728.8694895678523;5166.863290076177;5212.244224587489;5213.530782229617;5252.842414727565;5327.680339179662;5008.424031236309;5056.317397151338;5060.089183946925;5071.949280507148;5073.92389114171;5118.155504341891;5118.923216151835;5120.667156634807;5143.434222235626;5149.845504634867;4877.292792545132;4886.511348865085;5086.61850361217;5087.720175390389;5096.643234973516;5013.523715247045;5077.77150028257;5105.438401775876;5119.74401279927;5120.948790512047;4969.403671559436;5015.094264179588;5020.924686129638;5026.84919452417;5033.697978121324 03:32:24 INFO - PROCESS | 10672 | |5;yui.html;708.2952462300009;713.5290708132633;722.4509372876612;738.4867517075631;771.4831063187663;12614.432350544224;12870.485180592777;13379.598612041642;14500.564983050499;14557.78163327551;15140.394384224617;15230.390784368612;15386.307616157272;15388.15365154916;15405.69188616227;621.8662987457695;792.0614072324314;800.9987515605493;802.5987006496752;803.5781214862186;778.6379333609871;817.1256755271861;824.0976131136426;824.1593574553951;825.2366560931115;841.5203334099566;843.359047124187;845.5898889038812;845.6279237135672;845.7209120990059;660.7588230295908;810.5906517208772;834.1366685480529;835.6490274084869;835.9164083591653;611.1321922869491;619.0621208868523;619.1888625900085;619.5198720991268;619.7273199792077;14047.157170569799;14203;14203.218822964733;14213.644658883508;14215;13394.263315517741;13924;13992.580222593237;14019.369128389248;14027.929860350734;12455.626331210078;12583.748325033539;12703.301318427482;12884.96920246378;13030.087893847434;4194;4301.892452688677;4330.675199360029;4341.761203133827;4397.1205758848355;70625.29374706239;71265.6436717813;71566.64216678884;73930.63034684845;74313.25686743118;10920.672379828618;11087.279326843729;11135.944320278346;11233.71915702114;11330.943345283385;20817.167313307298;20834.68747968782;20836.06237719276;20840.1663933444;20846.374608761762;6450.774222902176;6600.174978127734;6607.834804129935;6642.833929151713;6677.131972843499;3745.9812700936322;3901;3912.902177445587;3919.1769728357363;3936.8031598419966;2923.956140657892;3027.04648035868;3032.924176895551;3034.226272300549;3035.104644129987;520.9947900521022;522.1306524636514;527.6543863769238;527.881226723984;528.3211073770187;479.5276652497287;484.5106442493037;545.7407731327667;562.0308178585491;579.9072148456311;8010.959945200353;8044.396670249755;8426.241638252586;8492.411300106416;8641.740747777576;497.2764627467027;543.947461661678;563.86944176925;576.8673205162752;578.1934201788481;3707;4019.4975628046495;4142.979285103615;4217.493900731932;4218.135282267128;105112;107576;109346;109652;109726;92235.53882230546;93041;93460.53269733743;93869;94046;61095;79090.06824488072;79714.60142699249;80850;83735.16264837395;7461;7695.268949449794;7731.34283585879;7973.840523189388;8000.319972802377;48621;48823;49419.258711118644;49697.254541182636;49717.25424118713;48689.5131048685;69915.30084699088;70789;72423.63788181025;73737.26262737304;9382;9848.212143028684;9860.408375497493;9864.802703945737;10082.243831712798;10632.89367106319;10724.678259652223;10868.293560918515;10925.781484370427;11021;10190.286679932333;10229.43738094412;10232.744181395226;10462;10714.89285107139;9745.707628771148;9814.362066465657;10113.190944724258;10375;10465.9476702616;9855.45794981283;9982.251331150337;10041.146502547364;10292.176625869763;10437.895621043692;8461.45847259975;8576.228139467477;8827.962177245694;8898.243649289883;9035.593398296962;8703.695370661997;8737.956310218407;8759.562021898751;8871.374055321276;9018.86471702938 03:32:24 INFO - PROCESS | 10672 | __end_tp_report 03:32:24 INFO - PROCESS | 10672 | __start_cc_report 03:32:24 INFO - PROCESS | 10672 | _x_x_mozilla_cycle_collect,1122 03:32:24 INFO - PROCESS | 10672 | __end_cc_report 03:32:24 INFO - PROCESS | 10672 | __startTimestamp1466591544138__endTimestamp 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | ------- Summary: start ------- 03:32:24 INFO - PROCESS | 10672 | Number of tests: 6 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#0] dojo.html Cycles:165 Average:4742.51 Median:4877.51 stddev:512.24 (10.5%) stddev-sans-first:485.79 03:32:24 INFO - PROCESS | 10672 | Values: 2612.2 2622.0 2648.9 2655.4 2664.3 4631.2 4648.6 4689.2 4703.8 4750.8 4723.7 4775.0 4784.7 4786.7 4802.3 4168.2 4323.1 4421.7 4434.8 4544.0 4439.0 4473.0 4485.8 4503.1 4540.0 4272.9 4311.1 4348.2 4376.6 4393.1 4360.3 4370.5 4424.2 4424.4 4434.1 4403.1 4412.4 4427.4 4453.5 4464.3 4604.9 4733.5 4863.0 4863.5 4873.2 5146.4 5178.4 5183.6 5211.1 5212.6 5036.4 5177.9 5184.5 5224.9 5230.6 4807.9 4852.6 4853.7 4898.8 4921.9 5372.2 5373.2 5373.5 5377.7 5391.3 4914.0 5018.6 5156.1 5168.0 5170.1 5117.1 5163.2 5179.2 5179.4 5239.0 5098.0 5103.8 5116.5 5117.2 5133.2 4903.3 4983.5 5012.5 5052.4 5076.4 4345.4 4364.0 4402.1 4407.8 4414.1 3773.8 3795.1 3807.8 3838.9 3849.0 4229.7 4272.4 4338.9 4379.1 4390.1 5129.4 5145.1 5176.5 5176.6 5218.8 4359.1 4392.8 4394.7 4424.5 4470.5 4483.2 4596.8 4622.0 4633.0 4641.3 4825.9 4850.5 4852.1 4886.3 4901.3 5113.3 5164.6 5166.1 5170.1 5174.2 4713.1 4784.2 4814.8 4815.1 4877.5 5054.3 5062.9 5069.3 5072.8 5118.3 5149.4 5151.7 5154.7 5167.6 5168.8 4820.4 4843.3 4949.2 4975.5 5001.4 4978.9 5000.8 5010.0 5011.9 5061.8 4960.8 4975.9 4976.8 5007.1 5025.7 4903.2 4987.5 4996.2 4997.7 4999.7 4908.9 4924.9 4948.7 4963.6 4977.3 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#1] ext.html Cycles:180 Average:46178.65 Median:19717.18 stddev:80400.33 (407.8%) stddev-sans-first:80552.87 03:32:24 INFO - PROCESS | 10672 | Values: 546.1 576.0 586.8 588.5 592.2 27298.2 39153.6 40424.6 40453.6 40463.0 41016.8 41366.8 41480.6 41504.2 41552.2 7540.1 7852.9 7994.5 8002.0 10057.6 9978.8 10330.9 10336.6 10339.8 10343.0 10332.4 10377.2 10383.2 10384.9 10386.2 7674.1 7885.2 7887.1 10287.8 10449.0 10161.4 10201.1 10201.7 10300.8 10314.9 37211.4 37507.8 37533.2 37587.6 37619.6 3202.3 3617.5 3696.3 3708.1 3714.3 29271.0 29300.4 29466.7 29550.1 30322.1 3541.7 3556.2 3561.8 3563.9 3626.7 186023.0 187235.1 187649.0 245829.8 246486.0 52297.0 53006.5 53017.7 53128.5 53156.5 55985.0 56118.2 56134.7 56199.0 56224.4 15113.5 15642.7 15653.2 15665.8 15669.0 10302.7 11687.7 11953.9 11994.3 12406.4 15688.3 15751.2 15824.0 15869.6 15907.2 6311.7 6322.8 6496.4 6502.4 6507.7 781.6 827.7 950.6 958.2 974.1 27926.2 28010.3 28307.6 28490.9 28511.4 958.9 969.6 1021.4 1026.2 1053.5 15068.2 15073.5 15103.8 15122.6 15153.8 378055.0 379894.0 380945.0 381042.0 382550.0 48761.5 48762.3 48781.8 48860.8 48903.5 1066.3 1101.3 1157.0 1168.3 1181.6 26398.7 28992.3 29644.4 29953.5 30133.1 42053.2 42085.0 42544.4 42550.4 42619.0 300105.0 301445.0 301988.0 302246.0 302668.0 30983.7 34958.8 36245.8 36462.6 36479.8 41540.6 41566.6 41785.0 42546.4 42847.1 35527.0 36009.1 36530.8 36598.8 37258.4 35426.8 36020.8 36041.0 36088.8 36494.0 35330.8 35870.5 35911.6 36152.6 36271.8 30078.4 32360.2 32568.7 32721.5 32864.7 24791.0 25051.9 25188.7 25544.2 25565.6 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#2] jquery.html Cycles:180 Average:23921.75 Median:19289.96 stddev:61073.07 (316.6%) stddev-sans-first:61218.82 03:32:24 INFO - PROCESS | 10672 | Values: 382.3 382.3 383.4 392.1 396.2 15301.3 16763.3 16909.7 17118.8 17134.5 16068.0 16312.8 16812.1 16839.7 16868.0 5005.7 5173.5 5185.2 5201.2 5228.0 3558.1 3851.2 5785.2 6133.8 6135.0 5955.3 6176.6 6178.8 6201.8 6210.3 6080.5 6113.1 6146.7 6150.8 6155.2 3330.3 3557.7 3579.9 3582.6 5101.9 19876.7 20478.6 20692.1 20771.0 20825.3 1995.7 2039.2 2044.5 2057.8 2087.5 12940.0 12998.7 13316.3 13494.2 13782.3 1689.8 1758.5 1838.3 1851.4 1854.5 60783.4 64891.4 65083.0 66706.7 74098.9 8748.6 9296.4 10254.2 10326.1 10400.5 14141.3 14274.1 14355.7 14362.5 14393.9 7409.4 7452.2 7526.1 7572.8 7650.2 7055.1 7074.8 7118.4 7237.4 7265.7 4189.4 4366.8 4382.4 4397.6 4500.5 1607.1 1661.3 1715.1 1805.1 1881.6 839.7 865.9 901.8 904.3 913.2 16445.3 16879.4 16948.2 17067.4 17255.5 831.2 853.5 853.8 870.6 878.1 8832.2 9540.7 9733.2 9751.6 9869.0 359450.0 362060.0 363188.0 378884.0 381376.0 71857.0 75084.0 77120.0 77234.6 85707.6 873.6 924.5 927.4 960.6 967.1 15826.4 16187.3 16207.9 16483.6 16507.7 28596.0 37524.8 38197.6 38414.4 38427.5 53233.7 54856.0 55635.7 55937.7 56740.0 6358.0 6687.3 6961.7 7040.7 7725.0 11149.3 12252.9 12300.5 12514.6 12593.4 10261.9 10348.2 10417.9 10545.7 10601.2 10480.6 10594.3 10643.8 10649.5 10737.2 10296.2 10543.9 10646.4 10655.5 10778.7 7652.5 7794.8 7802.0 7879.2 7997.8 10222.6 10359.4 10418.4 10573.1 10784.8 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#3] mootools.html Cycles:180 Average:5120.34 Median:4880.02 stddev:2858.39 (58.6%) stddev-sans-first:2851.48 03:32:24 INFO - PROCESS | 10672 | Values: 1233.0 1302.2 1370.5 1379.8 1664.5 6408.3 7556.6 7798.5 7801.8 8040.4 7720.8 7834.0 7841.3 7857.8 7868.2 1894.1 2155.5 2216.0 2228.4 2249.9 2259.7 2276.7 2277.6 2278.0 2281.7 2179.6 2186.0 2234.7 2240.5 2244.3 1821.8 2073.1 2091.0 2166.3 2168.4 2191.5 2214.1 2214.4 2215.0 2220.3 7836.1 7889.6 7894.1 7910.0 7917.4 4367.3 4483.6 4486.7 4488.2 4490.3 2885.8 2919.3 3008.5 3016.3 3026.5 1008.0 1023.5 1025.0 1031.1 1031.4 10667.9 10671.4 10685.8 10691.6 10695.3 4184.1 4278.1 4334.6 4352.2 4408.2 8511.0 8521.7 8575.6 8590.9 8597.1 4651.5 4657.1 4663.4 4667.7 4670.3 3761.4 4048.8 4124.7 4131.2 4187.7 3416.8 3468.0 3493.5 3520.8 3595.5 1014.9 1053.5 1057.2 1066.5 1079.8 797.3 823.3 845.0 852.5 855.7 5375.9 5415.5 5458.2 5598.1 5708.7 384.6 386.2 390.0 401.1 403.0 3708.3 3710.0 3716.5 3717.5 3767.3 9312.5 9526.1 9526.9 9587.8 9681.0 9410.9 9438.2 9448.7 9455.1 9512.0 7170.1 7215.8 7241.6 7251.7 7251.7 5384.6 5451.4 5511.9 5576.5 5612.6 8348.6 8683.7 8687.7 8932.2 8988.4 8670.7 8984.8 8996.4 9057.4 9074.0 6079.5 6134.3 6342.5 6903.9 7093.1 7173.6 7607.7 7661.3 7672.9 7685.7 6538.0 6691.3 6729.2 6819.2 6848.2 6627.2 6737.4 6748.5 6792.7 6793.7 6223.6 6375.1 6410.1 6436.5 6464.9 4745.8 4806.3 4853.3 4874.8 4909.5 4798.7 4857.9 4885.2 4906.2 5036.1 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#4] prototype.html Cycles:180 Average:4243.27 Median:4871.32 stddev:1224.24 (25.1%) stddev-sans-first:1191.44 03:32:24 INFO - PROCESS | 10672 | Values: 304.2 311.9 312.5 313.2 316.2 4869.9 4872.7 4885.8 4903.4 4924.1 4809.4 4811.5 4822.9 4834.3 4860.5 3636.7 3692.3 3751.8 3809.8 3862.2 3763.3 3808.2 3811.7 3822.4 3833.3 3616.3 3787.2 3794.5 3798.6 3806.8 3635.6 3783.5 3788.8 3806.1 3830.8 3354.6 3372.2 3377.9 3380.7 3385.9 4705.2 4725.3 4732.3 4735.7 4737.4 4222.8 4328.3 4370.7 4374.7 4384.9 5057.0 5061.3 5083.8 5105.7 5114.3 3699.6 3704.4 3707.6 3724.4 3762.1 5170.5 5309.4 5326.3 5363.6 5368.8 3741.2 3748.4 3759.5 3786.8 3792.5 3849.8 3860.1 3862.9 3867.0 3874.4 4321.9 4323.9 4350.3 4360.9 4377.9 4926.5 5086.4 5097.7 5100.2 5108.5 1313.7 1332.7 1342.8 1350.3 1356.6 846.5 866.9 875.5 876.3 892.2 4344.9 4388.7 4406.5 4431.7 4479.6 5182.0 5218.8 5221.6 5277.6 5313.3 4291.2 4537.4 4556.3 4561.5 4566.8 2771.2 2783.2 2793.4 2807.2 2810.8 4933.9 4965.6 4971.1 4997.8 5011.7 5099.7 5334.9 5375.5 5393.4 5422.8 4937.7 4948.4 4950.2 4965.9 4980.9 5310.7 5312.9 5320.9 5342.1 5345.1 4885.5 5161.4 5162.2 5165.0 5248.8 4915.8 4934.6 4947.8 4951.1 5017.8 3666.4 3694.6 3705.1 3714.7 3728.9 5166.9 5212.2 5213.5 5252.8 5327.7 5008.4 5056.3 5060.1 5071.9 5073.9 5118.2 5118.9 5120.7 5143.4 5149.8 4877.3 4886.5 5086.6 5087.7 5096.6 5013.5 5077.8 5105.4 5119.7 5120.9 4969.4 5015.1 5020.9 5026.8 5033.7 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - PROCESS | 10672 | [#5] yui.html Cycles:180 Average:18939.21 Median:536.13 stddev:28069.74 (5235.6%) stddev-sans-first:28115.11 03:32:24 INFO - PROCESS | 10672 | Values: 708.3 713.5 722.5 738.5 771.5 12614.4 12870.5 13379.6 14500.6 14557.8 15140.4 15230.4 15386.3 15388.2 15405.7 621.9 792.1 801.0 802.6 803.6 778.6 817.1 824.1 824.2 825.2 841.5 843.4 845.6 845.6 845.7 660.8 810.6 834.1 835.6 835.9 611.1 619.1 619.2 619.5 619.7 14047.2 14203.0 14203.2 14213.6 14215.0 13394.3 13924.0 13992.6 14019.4 14027.9 12455.6 12583.7 12703.3 12885.0 13030.1 4194.0 4301.9 4330.7 4341.8 4397.1 70625.3 71265.6 71566.6 73930.6 74313.3 10920.7 11087.3 11135.9 11233.7 11330.9 20817.2 20834.7 20836.1 20840.2 20846.4 6450.8 6600.2 6607.8 6642.8 6677.1 3746.0 3901.0 3912.9 3919.2 3936.8 2924.0 3027.0 3032.9 3034.2 3035.1 521.0 522.1 527.7 527.9 528.3 479.5 484.5 545.7 562.0 579.9 8011.0 8044.4 8426.2 8492.4 8641.7 497.3 543.9 563.9 576.9 578.2 3707.0 4019.5 4143.0 4217.5 4218.1 105112.0 107576.0 109346.0 109652.0 109726.0 92235.5 93041.0 93460.5 93869.0 94046.0 61095.0 79090.1 79714.6 80850.0 83735.2 7461.0 7695.3 7731.3 7973.8 8000.3 48621.0 48823.0 49419.3 49697.3 49717.3 48689.5 69915.3 70789.0 72423.6 73737.3 9382.0 9848.2 9860.4 9864.8 10082.2 10632.9 10724.7 10868.3 10925.8 11021.0 10190.3 10229.4 10232.7 10462.0 10714.9 9745.7 9814.4 10113.2 10375.0 10465.9 9855.5 9982.3 10041.1 10292.2 10437.9 8461.5 8576.2 8828.0 8898.2 9035.6 8703.7 8738.0 8759.6 8871.4 9018.9 03:32:24 INFO - PROCESS | 10672 | -------- Summary: end -------- 03:32:24 INFO - PROCESS | 10672 | 03:32:24 INFO - TEST-INFO | 10672: exit 0 03:32:24 INFO - TEST-OK | dromaeo_css | took 1119791ms 03:32:24 INFO - TEST-START | kraken 03:32:24 INFO - operating with platform_type : linux_ 03:32:24 INFO - Initialising browser for kraken test... 03:32:24 INFO - TEST-INFO | started process 10855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OlyEx/profile http://localhost:44516/getInfo.html) 03:32:29 INFO - PROCESS | 10855 | __metrics Screen width/height:1600/1200 03:32:29 INFO - PROCESS | 10855 | colorDepth:24 03:32:29 INFO - PROCESS | 10855 | Browser inner width/height: 1024/697 03:32:29 INFO - PROCESS | 10855 | __metrics 03:32:30 INFO - PROCESS | 10855 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:32:31 INFO - TEST-INFO | 10855: exit 0 03:32:31 INFO - Browser initialized. 03:32:31 INFO - Running cycle 1/1 for kraken test... 03:32:31 INFO - TEST-INFO | started process 10934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OlyEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:43 INFO - PROCESS | 10934 | RSS: Main: 175329280 03:32:43 INFO - PROCESS | 10934 | 03:32:46 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44516/tests/kraken/driver.html?testName=audio-beat-detection) 03:32:47 INFO - PROCESS | 10934 | RSS: Main: 232972288 03:32:47 INFO - PROCESS | 10934 | 03:32:49 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44516/tests/kraken/driver.html?testName=audio-dft) 03:32:50 INFO - PROCESS | 10934 | RSS: Main: 221032448 03:32:50 INFO - PROCESS | 10934 | 03:32:53 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44516/tests/kraken/driver.html?testName=audio-fft) 03:32:54 INFO - PROCESS | 10934 | RSS: Main: 288485376 03:32:54 INFO - PROCESS | 10934 | 03:32:56 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44516/tests/kraken/driver.html?testName=audio-oscillator) 03:32:57 INFO - PROCESS | 10934 | RSS: Main: 199020544 03:32:57 INFO - PROCESS | 10934 | 03:32:59 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:32:59 INFO - PROCESS | 10934 | RSS: Main: 202948608 03:32:59 INFO - PROCESS | 10934 | 03:33:03 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44516/tests/kraken/driver.html?testName=imaging-darkroom) 03:33:03 INFO - PROCESS | 10934 | RSS: Main: 238649344 03:33:03 INFO - PROCESS | 10934 | 03:33:07 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44516/tests/kraken/driver.html?testName=imaging-desaturate) 03:33:07 INFO - PROCESS | 10934 | RSS: Main: 234860544 03:33:07 INFO - PROCESS | 10934 | 03:33:10 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44516/tests/kraken/driver.html?testName=json-parse-financial) 03:33:11 INFO - PROCESS | 10934 | RSS: Main: 238145536 03:33:11 INFO - PROCESS | 10934 | 03:33:13 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:33:13 INFO - PROCESS | 10934 | RSS: Main: 226422784 03:33:13 INFO - PROCESS | 10934 | 03:33:15 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:33:16 INFO - PROCESS | 10934 | RSS: Main: 232042496 03:33:16 INFO - PROCESS | 10934 | 03:33:18 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:19 INFO - PROCESS | 10934 | RSS: Main: 237211648 03:33:19 INFO - PROCESS | 10934 | 03:33:21 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:22 INFO - PROCESS | 10934 | RSS: Main: 239747072 03:33:22 INFO - PROCESS | 10934 | 03:33:25 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:33:25 INFO - PROCESS | 10934 | RSS: Main: 240676864 03:33:25 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | Cycle 1(1): loaded http://localhost:44516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44516/tests/kraken/driver.html?testName=ai-astar) 03:33:27 INFO - PROCESS | 10934 | RSS: Main: 283262976 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | __start_tp_report 03:33:27 INFO - PROCESS | 10934 | _x_x_mozilla_page_load 03:33:27 INFO - PROCESS | 10934 | _x_x_mozilla_page_load_details 03:33:27 INFO - PROCESS | 10934 | |i|pagename|runs| 03:33:27 INFO - PROCESS | 10934 | |0;ai-astar;113;109;112;115;112;114;112;112;113;112 03:33:27 INFO - PROCESS | 10934 | |1;audio-beat-detection;164;131;139;185;131;158;155;138;196;129 03:33:27 INFO - PROCESS | 10934 | |2;audio-dft;162;162;163;162;161;163;164;161;161;162 03:33:27 INFO - PROCESS | 10934 | |3;audio-fft;75;78;76;123;76;77;75;76;103;76 03:33:27 INFO - PROCESS | 10934 | |4;audio-oscillator;85;85;116;85;85;87;128;88;88;134 03:33:27 INFO - PROCESS | 10934 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;119 03:33:27 INFO - PROCESS | 10934 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 03:33:27 INFO - PROCESS | 10934 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;94;95 03:33:27 INFO - PROCESS | 10934 | |8;json-parse-financial;62;64;64;63;64;74;64;62;61;62 03:33:27 INFO - PROCESS | 10934 | |9;json-stringify-tinderbox;64;64;65;65;65;64;64;65;65;65 03:33:27 INFO - PROCESS | 10934 | |10;stanford-crypto-aes;82;83;82;88;82;87;90;91;130;92 03:33:27 INFO - PROCESS | 10934 | |11;stanford-crypto-ccm;135;132;129;131;144;130;132;132;173;141 03:33:27 INFO - PROCESS | 10934 | |12;stanford-crypto-pbkdf2;169;169;175;168;165;169;169;171;165;165 03:33:27 INFO - PROCESS | 10934 | |13;stanford-crypto-sha256-iterative;67;68;69;71;68;70;69;66;66;66 03:33:27 INFO - PROCESS | 10934 | __end_tp_report 03:33:27 INFO - PROCESS | 10934 | __start_cc_report 03:33:27 INFO - PROCESS | 10934 | _x_x_mozilla_cycle_collect,1933 03:33:27 INFO - PROCESS | 10934 | __end_cc_report 03:33:27 INFO - PROCESS | 10934 | __startTimestamp1466591607968__endTimestamp 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | ------- Summary: start ------- 03:33:27 INFO - PROCESS | 10934 | Number of tests: 14 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.58 (1.4%) stddev-sans-first:1.66 03:33:27 INFO - PROCESS | 10934 | Values: 113.0 109.0 112.0 115.0 112.0 114.0 112.0 112.0 113.0 112.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:156.50 stddev:23.54 (15.0%) stddev-sans-first:24.60 03:33:27 INFO - PROCESS | 10934 | Values: 164.0 131.0 139.0 185.0 131.0 158.0 155.0 138.0 196.0 129.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 03:33:27 INFO - PROCESS | 10934 | Values: 162.0 162.0 163.0 162.0 161.0 163.0 164.0 161.0 161.0 162.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.27 (21.4%) stddev-sans-first:16.96 03:33:27 INFO - PROCESS | 10934 | Values: 75.0 78.0 76.0 123.0 76.0 77.0 75.0 76.0 103.0 76.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:19.77 (23.3%) stddev-sans-first:20.39 03:33:27 INFO - PROCESS | 10934 | Values: 85.0 85.0 116.0 85.0 85.0 87.0 128.0 88.0 88.0 134.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:33:27 INFO - PROCESS | 10934 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 119.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 03:33:27 INFO - PROCESS | 10934 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:33:27 INFO - PROCESS | 10934 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:3.68 (5.8%) stddev-sans-first:3.83 03:33:27 INFO - PROCESS | 10934 | Values: 62.0 64.0 64.0 63.0 64.0 74.0 64.0 62.0 61.0 62.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 03:33:27 INFO - PROCESS | 10934 | Values: 64.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.50 stddev:14.35 (16.4%) stddev-sans-first:14.87 03:33:27 INFO - PROCESS | 10934 | Values: 82.0 83.0 82.0 88.0 82.0 87.0 90.0 91.0 130.0 92.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:133.50 stddev:13.25 (9.9%) stddev-sans-first:14.02 03:33:27 INFO - PROCESS | 10934 | Values: 135.0 132.0 129.0 131.0 144.0 130.0 132.0 132.0 173.0 141.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:3.10 (1.8%) stddev-sans-first:3.28 03:33:27 INFO - PROCESS | 10934 | Values: 169.0 169.0 175.0 168.0 165.0 169.0 169.0 171.0 165.0 165.0 03:33:27 INFO - PROCESS | 10934 | 03:33:27 INFO - PROCESS | 10934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.76 (2.6%) stddev-sans-first:1.83 03:33:27 INFO - PROCESS | 10934 | Values: 67.0 68.0 69.0 71.0 68.0 70.0 69.0 66.0 66.0 66.0 03:33:27 INFO - PROCESS | 10934 | -------- Summary: end -------- 03:33:27 INFO - PROCESS | 10934 | 03:33:29 INFO - TEST-INFO | 10934: exit 0 03:33:29 INFO - TEST-OK | kraken | took 64115ms 03:33:29 INFO - SUITE-END | took 1183s 03:33:29 INFO - Completed test suite (00:19:43) 03:33:29 INFO - javascript benchmark 03:33:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.20327800021, 2621.9737802621967, 2648.8808003639833, 2655.4025344297547, 2664.280644226059, 4631.189541830183, 4648.581627653511, 4689.155951928656, 4703.764811759415, 4750.7862146203415, 4723.740194289313, 4774.952250477503, 4784.688995215317, 4786.664933454659, 4802.327674125625, 4168.166366726652, 4323.1137616788565, 4421.6904816662845, 4434.800433980463, 4543.954560454386, 4438.977805110986, 4473.038296766194, 4485.798139083749, 4503.076869241814, 4540.046590216059, 4272.850450234258, 4311.07311927937, 4348.239058164809, 4376.6498680105515, 4393.0994146199955, 4360.345948107777, 4370.497392799837, 4424.181526417591, 4424.446944131983, 4434.06884554244, 4403.075354175627, 4412.4043254160915, 4427.40230068943, 4453.51011388747, 4464.330350447426, 4604.861854144381, 4733.4793172751315, 4862.951370486286, 4863.465018847924, 4873.244647079709, 5146.433892271847, 5178.430372659004, 5183.585313174937, 5211.140161873286, 5212.582993360522, 5036.445990940993, 5177.948220517785, 5184.507471790212, 5224.895502089937, 5230.607704422184, 4807.903841923142, 4852.56326930578, 4853.708777473293, 4898.755062246873, 4921.9015619688125, 5372.167314066326, 5373.167159090347, 5373.516383525502, 5377.704226267593, 5391.29913111293, 4914.0, 5018.573421259234, 5156.123459011902, 5168.043911876315, 5170.1469257572835, 5117.130087885069, 5163.173892177234, 5179.249008893689, 5179.430262671103, 5238.97380513095, 5098.031374038921, 5103.821366252163, 5116.539511443988, 5117.155669314596, 5133.153029750124, 4903.338049363361, 4983.476734942851, 5012.523810238022, 5052.3937127544195, 5076.390833100052, 4345.3699213613845, 4364.0, 4402.119576084732, 4407.757573333497, 4414.1171765647, 3773.8301776420126, 3795.0512371907025, 3807.809609519513, 3838.9040273993373, 3848.9807550962064, 4229.661627069827, 4272.4445822042935, 4338.869833904988, 4379.0585024219945, 4390.078083602415, 5129.384473863161, 5145.099607568661, 5176.50823171798, 5176.637635365563, 5218.765155568009, 4359.12817436514, 4392.758398288125, 4394.714343567658, 4424.513303536608, 4470.485894122153, 4483.21543729846, 4596.7931443085145, 4621.976890115595, 4633.0, 4641.327007583882, 4825.855224343275, 4850.466448690711, 4852.102361063215, 4886.291487734258, 4901.3138160658245, 5113.335266415343, 5164.561012313995, 5166.147585648326, 5170.146925757208, 5174.249733788655, 4713.08094921487, 4784.162771514902, 4814.807407703793, 4815.061063092663, 4877.512248775094, 5054.342935418372, 5062.924056139234, 5069.2902993581665, 5072.82245121419, 5118.283440318284, 5149.356330458692, 5151.6908985461, 5154.690718556899, 5167.560757335668, 5168.767405466688, 4820.421549414093, 4843.321934929183, 4949.232868905326, 4975.502449754996, 5001.399832020181, 4978.925316120189, 5000.824971125993, 5010.0, 5011.874703132451, 5061.772220250171, 4960.826371076995, 4975.875603109951, 4976.776045077908, 5007.1487847065355, 5025.748712564284, 4903.215485522299, 4987.526185012418, 4996.200607902863, 4997.675151115166, 4999.725015124203, 4908.852734417973, 4924.8768780780765, 4948.653594248368, 4963.578095861748, 4977.328060711902], "value": 4708.862108881429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0866138407623, 575.9654420734756, 586.788756047823, 588.4674369695424, 592.1709606550831, 27298.181054568344, 39153.608463915385, 40424.59575404245, 40453.595464045386, 40463.0, 41016.79491602538, 41366.7931660342, 41480.58519414805, 41504.16991660173, 41552.16895662085, 7540.095188577378, 7852.921470785276, 7994.480358776661, 8002.0, 10057.647982320621, 9978.750531236705, 10330.948345258263, 10336.638217662383, 10339.793204135913, 10343.0, 10332.431716255604, 10377.221708371864, 10383.221258405612, 10384.896151038469, 10386.169106471463, 7674.117476490192, 7885.172056933997, 7887.132415434355, 10287.845682314772, 10449.0, 10161.390316581028, 10201.081902628799, 10201.744956376077, 10300.79398412035, 10314.9484252579, 37211.44182837233, 37507.81246093779, 37533.24933501315, 37587.62412375869, 37619.62380376188, 3202.3115030268373, 3617.5478065241846, 3696.2607478504406, 3708.072981754561, 3714.3381386653273, 29271.0, 29300.41399172026, 29466.70533294661, 29550.113496595135, 30322.090337289916, 3541.663541963535, 3556.217632120955, 3561.8041007744564, 3563.893083207508, 3626.691731202851, 186023.0, 187235.06382468, 187649.0, 245829.7708511464, 246486.0, 52297.0, 53006.469935300156, 53017.73491132597, 53128.46871531312, 53156.468435315925, 55985.0, 56118.15822762662, 56134.71932640311, 56199.0, 56224.43775562274, 15113.47102851395, 15642.68714625701, 15653.217339132998, 15665.843341566439, 15669.0, 10302.742431439274, 11687.707807304885, 11953.880461195451, 11994.34031128279, 12406.379681015913, 15688.294026768823, 15751.212439377985, 15824.0, 15869.603259918364, 15907.204639767966, 6311.747530098836, 6322.810315690536, 6496.350364963466, 6502.44729198014, 6507.689770131535, 781.5896654256561, 827.6854795177915, 950.6007476859736, 958.166395236149, 974.0843607009389, 27926.16221513358, 28010.2997425066, 28307.575386369223, 28490.85754571255, 28511.429771404455, 958.9232861371073, 969.6170012845027, 1021.4250124564026, 1026.2457094035879, 1053.4785281285813, 15068.171250581323, 15073.472428464951, 15103.773443398359, 15122.621934451507, 15153.848461515465, 378055.0, 379894.0, 380945.0, 381042.0, 382550.0, 48761.512384876405, 48762.268565971535, 48781.756091219315, 48860.75569622129, 48903.51096489061, 1066.3388699006666, 1101.311680199859, 1156.976860462803, 1168.293182624517, 1181.5687274144875, 26398.736012640395, 28992.275193120342, 29644.407111858072, 29953.472565805132, 30133.09600711982, 42053.1589368217, 42085.0, 42544.361834571886, 42550.36174457324, 42619.0, 300105.0, 301445.0, 301988.0, 302246.0, 302668.0, 30983.69016309808, 34958.82520587381, 36245.81877090598, 36462.63537364592, 36479.81760091289, 41540.58459415367, 41566.58433415627, 41785.0, 42546.361804572334, 42847.14305713931, 35527.0, 36009.0997725059, 36530.8173459131, 36598.8170059148, 37258.441123383716, 35426.82286588551, 36020.819895901404, 36041.0, 36088.81955590205, 36494.0, 35330.76342328006, 35870.46194307035, 35911.64088359188, 36152.63847361493, 36271.818640906626, 30078.398432031674, 32360.190995225308, 32568.674313256564, 32721.509177362834, 32864.67135328616, 24791.00835966541, 25051.87474062691, 25188.74811251864, 25544.23367298984, 25565.616515752652], "value": 18128.57215893022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.2965743032819, 382.3232877806283, 383.37509858929957, 392.0923063108904, 396.17793079360337, 15301.311440985155, 16763.329466821328, 16909.746353804672, 17118.82881171188, 17134.48596542104, 16068.0, 16312.83687163128, 16812.075335856523, 16839.66320673586, 16868.0, 5005.724685142325, 5173.534381905628, 5185.222216667492, 5201.2458193561915, 5227.973860130713, 3558.1460449492065, 3851.2490064437447, 5785.16115163301, 6133.754649814002, 6135.0, 5955.34491205967, 6176.567640265183, 6178.8455288617915, 6201.782937597185, 6210.31686514483, 6080.483158931496, 6113.083037544404, 6146.7233974471255, 6150.753969841224, 6155.19982402287, 3330.300636866261, 3557.714527334321, 3579.8926032219074, 3582.5521809773777, 5101.923471147936, 19876.70184947227, 20478.590428191354, 20692.068856901475, 20771.0, 20825.271115511037, 1995.6607376745842, 2039.2047101630376, 2044.4684382060623, 2057.753069631639, 2087.499000239947, 12940.0, 12998.740025199442, 13316.334183290797, 13494.190348579019, 13782.310884455737, 1689.81412044675, 1758.4636685810822, 1838.3198216659787, 1851.4075495841337, 1854.5456363191104, 60783.39216607866, 64891.351086489005, 65083.0, 66706.66646666784, 74098.88851667283, 8748.606312715943, 9296.395734277387, 10254.230932680079, 10326.122279606318, 10400.531976061095, 14141.29293535319, 14274.14355138695, 14355.712885742227, 14362.497312594218, 14393.92803035978, 7409.444291678038, 7452.217517160729, 7526.134494533198, 7572.81067973294, 7650.158482566913, 7055.118110236221, 7074.75238366665, 7118.430525557943, 7237.421006319587, 7265.745698900619, 4189.413482112506, 4366.825326986885, 4382.386465894777, 4397.626201772885, 4500.504944456107, 1607.075931339461, 1661.335465813684, 1715.125286104096, 1805.073588073223, 1881.5672395348872, 839.7186942374251, 865.948043117415, 901.8151278987792, 904.3262769236829, 913.2465715784505, 16445.342186312413, 16879.38243487711, 16948.152592370578, 17067.40264090751, 17255.482335529956, 831.1646794971016, 853.4623187391903, 853.7737499562496, 870.6212797433137, 878.0824038879387, 8832.160944710242, 9540.713778586654, 9733.2213422926, 9751.609935602639, 9868.950655246677, 359450.0, 362060.0, 363188.0, 378884.0, 381376.0, 71857.0, 75084.0, 77120.0, 77234.61382693051, 85707.5714621423, 873.5719497446206, 924.5007695844168, 927.4481683398367, 960.577345967772, 967.1247520993512, 15826.36694532252, 16187.271572779018, 16207.918960405123, 16483.58791030234, 16507.66984660324, 28595.99914003, 37524.812375937945, 38197.61802382052, 38414.423783643826, 38427.462901483625, 53233.733831330595, 54856.0, 55635.72182139063, 55937.72031139981, 56740.0, 6358.0, 6687.264400915798, 6961.721531138698, 7040.683169257293, 7724.961375193088, 11149.275297105662, 12252.938735306267, 12300.507979680713, 12514.624561263177, 12593.433295501542, 10261.897381026094, 10348.223883208639, 10417.895821041693, 10545.683629491128, 10601.204909631655, 10480.63317783874, 10594.258401911793, 10643.787124257316, 10649.520771565143, 10737.248392612442, 10296.17630589566, 10543.947280263856, 10646.361218326925, 10655.520501577292, 10778.676639700821, 7652.502587331805, 7794.844103118019, 7801.9609901950125, 7879.172686867796, 7997.7600671979935, 10222.6422075227, 10359.378437293786, 10418.426986515511, 10573.101286390744, 10784.838227426439], "value": 8320.827131718657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.0320698251874, 1302.1731200687564, 1370.4723681382668, 1379.8137251471048, 1664.4840099569135, 6408.327125651804, 7556.584387858666, 7798.532088074705, 7801.804954876124, 8040.396970227227, 7720.845583088349, 7834.0, 7841.294283514482, 7857.842843143148, 7868.213178682129, 1894.1003023563767, 2155.5365596396773, 2215.9556808863813, 2228.3983324502374, 2249.853759505627, 2259.7288325400973, 2276.726792784868, 2277.6241920083166, 2278.0, 2281.6577513373045, 2179.574982878339, 2185.9781402186013, 2234.7318321801326, 2240.4622890506325, 2244.3491387497606, 1821.826926441986, 2073.1292857000094, 2091.048572899327, 2166.3176099528596, 2168.447046003275, 2191.539776646906, 2214.081156320125, 2214.3910424633195, 2215.0, 2220.2673117871063, 7836.059672839296, 7889.566073865935, 7894.131645518988, 7909.960450197712, 7917.445778795487, 4367.344898265285, 4483.551644835523, 4486.685931984763, 4488.236999710057, 4490.259107247301, 2885.797994140411, 2919.3139612191117, 3008.4735171345146, 3016.2610160510594, 3026.5157574787927, 1007.969760907174, 1023.4780262066325, 1024.9692509224735, 1031.113242611361, 1031.4327120083924, 10667.893321066767, 10671.413072281022, 10685.83971240432, 10691.572337106583, 10695.304805187638, 4184.142250838631, 4278.144371125725, 4334.631556317749, 4352.194843953878, 4408.184485870124, 8510.957445212858, 8521.659133634585, 8575.571221438902, 8590.87113693295, 8597.097304783032, 4651.511591282934, 4657.068586282757, 4663.370444989951, 4667.743274119888, 4670.299455081765, 3761.360568703327, 4048.817803198804, 4124.711270211056, 4131.215069136854, 4187.706860519735, 3416.8462419191196, 3468.0, 3493.528373669573, 3520.771149875301, 3595.5146055282726, 1014.91373233276, 1053.4785281285813, 1057.154276578734, 1066.4880857188439, 1079.838024296346, 797.2585495489251, 823.320760372695, 844.9788755281168, 852.5396286005612, 855.7475544714324, 5375.892482150413, 5415.458454154632, 5458.235846981426, 5598.1322894951345, 5708.65748055118, 384.56544105160987, 386.2236903823279, 389.966852817508, 401.1315501938271, 402.9798510074485, 3708.313961917054, 3710.0, 3716.4611131385795, 3717.516722826015, 3767.2842159990064, 9312.487813170204, 9526.142647161789, 9526.90473095274, 9587.808243835085, 9680.951595242119, 9410.858837117448, 9438.244940404751, 9448.669296574586, 9455.05449455049, 9512.048795120432, 7170.139583249939, 7215.783526494213, 7241.565506069653, 7251.673674684757, 7251.746188883364, 5384.596155288447, 5451.400345962021, 5511.944880551304, 5576.498115169654, 5612.635178713371, 8348.582570871311, 8683.652653893774, 8687.652493900427, 8932.240759535513, 8988.415752976036, 8670.739877803677, 8984.820303594022, 8996.415233009833, 9057.36598438103, 9073.954630226806, 6079.483243924316, 6134.294556125924, 6342.460890824332, 6903.861922761416, 7093.1488221413765, 7173.641317933978, 7607.733729319447, 7661.272179142972, 7672.923270767445, 7685.730999414994, 6538.0, 6691.297413771484, 6729.226138994079, 6819.215790184192, 6848.246692863681, 6627.237867645283, 6737.427318677967, 6748.527603067738, 6792.660366981532, 6793.66031698423, 6223.564350495421, 6375.075614036032, 6410.134631824831, 6436.452901503238, 6464.870702586016, 4745.83389581363, 4806.279058141306, 4853.320535125014, 4874.805007799649, 4909.4845041270155, 4798.664093513421, 4857.9028419432125, 4885.2427873679635, 4906.1659517881335, 5036.143855544639], "value": 4053.30586552217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.1559671910448, 311.93761247750456, 312.54368621812154, 313.1716609567695, 316.2284026974184, 4869.9269510957365, 4872.70763754175, 4885.7801398937045, 4903.362562866827, 4924.1382758017335, 4809.422869255685, 4811.4707382187935, 4822.927656085161, 4834.299026641135, 4860.513948605138, 3636.690881275095, 3692.280005398948, 3751.8499260029566, 3809.847606095753, 3862.208247309295, 3763.322601931651, 3808.219315040424, 3811.6950643948417, 3822.369309064015, 3833.290841194374, 3616.330978768923, 3787.185755062661, 3794.5256842894637, 3798.620137986193, 3806.8286927088348, 3635.600083990759, 3783.45139954705, 3788.8254641061358, 3806.143617686026, 3830.8467661293516, 3354.5910717498464, 3372.173817414749, 3377.864885404581, 3380.7295416366633, 3385.86456541738, 4705.1765940960195, 4725.3384526166365, 4732.266498692708, 4735.715857048588, 4737.407824021997, 4222.8176110689055, 4328.32910898808, 4370.737755734666, 4374.6500279977845, 4384.934225986613, 5057.0, 5061.316722242487, 5083.847484575469, 5105.7024339047575, 5114.2584325273, 3699.6300369962787, 3704.3887758519813, 3707.5550933887835, 3724.42271447926, 3762.1347090169143, 5170.508801663836, 5309.442508536626, 5326.2543243945875, 5363.570914326844, 5368.8389348319615, 3741.158239396114, 3748.3627783276906, 3759.5300587426573, 3786.848526058982, 3792.50697409335, 3849.8075096245634, 3860.1121741999495, 3862.942055869164, 3866.9613303867163, 3874.380099184117, 4321.891952701208, 4323.891902702395, 4350.303951367766, 4360.869173924787, 4377.905523619095, 4926.45808961014, 5086.440491546001, 5097.6941383517105, 5100.158473851773, 5108.489151084936, 1313.6797518493852, 1332.6806461603137, 1342.7918672605763, 1350.2506109109343, 1356.5794603672696, 846.5259454705384, 866.9003064647646, 875.5228400521731, 876.2595606712318, 892.205936716323, 4344.913101737948, 4388.736675799462, 4406.493253275914, 4431.711938724037, 4479.619232365286, 5182.0, 5218.7912483500995, 5221.6344855859725, 5277.551408130275, 5313.282706834605, 4291.206126866539, 4537.4328208973875, 4556.339330797082, 4561.521040290788, 4566.771661416916, 2771.2240572639694, 2783.151138902654, 2793.4413117376607, 2807.199948014806, 2810.819455828557, 4933.86521100149, 4965.602751779849, 4971.080350135164, 4997.775100120431, 5011.749412529359, 5099.69401835891, 5334.91997620036, 5375.489328513785, 5393.4336894626285, 5422.810201642924, 4937.703737775745, 4948.4309304429735, 4950.232713929347, 4965.900681986413, 4980.900381992412, 5310.654807437504, 5312.893742125213, 5320.893582128413, 5342.145256759055, 5345.118055520796, 4885.462599114166, 5161.438607360909, 5162.225666150108, 5164.96700659877, 5248.763805628832, 4915.754212289443, 4934.605231581393, 4947.82682606107, 4951.14332125453, 5017.774200160929, 3666.3583872822683, 3694.556653201633, 3705.129294615709, 3714.7399682022, 3728.8694895678523, 5166.863290076177, 5212.244224587489, 5213.530782229617, 5252.842414727565, 5327.680339179662, 5008.424031236309, 5056.317397151338, 5060.089183946925, 5071.949280507148, 5073.92389114171, 5118.155504341891, 5118.923216151835, 5120.667156634807, 5143.434222235626, 5149.845504634867, 4877.292792545132, 4886.511348865085, 5086.61850361217, 5087.720175390389, 5096.643234973516, 5013.523715247045, 5077.77150028257, 5105.438401775876, 5119.74401279927, 5120.948790512047, 4969.403671559436, 5015.094264179588, 5020.924686129638, 5026.84919452417, 5033.697978121324], "value": 3857.9308484365038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2952462300009, 713.5290708132633, 722.4509372876612, 738.4867517075631, 771.4831063187663, 12614.432350544224, 12870.485180592777, 13379.598612041642, 14500.564983050499, 14557.78163327551, 15140.394384224617, 15230.390784368612, 15386.307616157272, 15388.15365154916, 15405.69188616227, 621.8662987457695, 792.0614072324314, 800.9987515605493, 802.5987006496752, 803.5781214862186, 778.6379333609871, 817.1256755271861, 824.0976131136426, 824.1593574553951, 825.2366560931115, 841.5203334099566, 843.359047124187, 845.5898889038812, 845.6279237135672, 845.7209120990059, 660.7588230295908, 810.5906517208772, 834.1366685480529, 835.6490274084869, 835.9164083591653, 611.1321922869491, 619.0621208868523, 619.1888625900085, 619.5198720991268, 619.7273199792077, 14047.157170569799, 14203.0, 14203.218822964733, 14213.644658883508, 14215.0, 13394.263315517741, 13924.0, 13992.580222593237, 14019.369128389248, 14027.929860350734, 12455.626331210078, 12583.748325033539, 12703.301318427482, 12884.96920246378, 13030.087893847434, 4194.0, 4301.892452688677, 4330.675199360029, 4341.761203133827, 4397.1205758848355, 70625.29374706239, 71265.6436717813, 71566.64216678884, 73930.63034684845, 74313.25686743118, 10920.672379828618, 11087.279326843729, 11135.944320278346, 11233.71915702114, 11330.943345283385, 20817.167313307298, 20834.68747968782, 20836.06237719276, 20840.1663933444, 20846.374608761762, 6450.774222902176, 6600.174978127734, 6607.834804129935, 6642.833929151713, 6677.131972843499, 3745.9812700936322, 3901.0, 3912.902177445587, 3919.1769728357363, 3936.8031598419966, 2923.956140657892, 3027.04648035868, 3032.924176895551, 3034.226272300549, 3035.104644129987, 520.9947900521022, 522.1306524636514, 527.6543863769238, 527.881226723984, 528.3211073770187, 479.5276652497287, 484.5106442493037, 545.7407731327667, 562.0308178585491, 579.9072148456311, 8010.959945200353, 8044.396670249755, 8426.241638252586, 8492.411300106416, 8641.740747777576, 497.2764627467027, 543.947461661678, 563.86944176925, 576.8673205162752, 578.1934201788481, 3707.0, 4019.4975628046495, 4142.979285103615, 4217.493900731932, 4218.135282267128, 105112.0, 107576.0, 109346.0, 109652.0, 109726.0, 92235.53882230546, 93041.0, 93460.53269733743, 93869.0, 94046.0, 61095.0, 79090.06824488072, 79714.60142699249, 80850.0, 83735.16264837395, 7461.0, 7695.268949449794, 7731.34283585879, 7973.840523189388, 8000.319972802377, 48621.0, 48823.0, 49419.258711118644, 49697.254541182636, 49717.25424118713, 48689.5131048685, 69915.30084699088, 70789.0, 72423.63788181025, 73737.26262737304, 9382.0, 9848.212143028684, 9860.408375497493, 9864.802703945737, 10082.243831712798, 10632.89367106319, 10724.678259652223, 10868.293560918515, 10925.781484370427, 11021.0, 10190.286679932333, 10229.43738094412, 10232.744181395226, 10462.0, 10714.89285107139, 9745.707628771148, 9814.362066465657, 10113.190944724258, 10375.0, 10465.9476702616, 9855.45794981283, 9982.251331150337, 10041.146502547364, 10292.176625869763, 10437.895621043692, 8461.45847259975, 8576.228139467477, 8827.962177245694, 8898.243649289883, 9035.593398296962, 8703.695370661997, 8737.956310218407, 8759.562021898751, 8871.374055321276, 9018.86471702938], "value": 6683.295077583178, "unit": "score"}], "name": "dromaeo_css", "value": 6482.988852349622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 112.0, 115.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 139.0, 185.0, 131.0, 158.0, 155.0, 138.0, 196.0, 129.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 163.0, 164.0, 161.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 123.0, 76.0, 77.0, 75.0, 76.0, 103.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 85.0, 87.0, 128.0, 88.0, 88.0, 134.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 119.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 63.0, 64.0, 74.0, 64.0, 62.0, 61.0, 62.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 88.0, 82.0, 87.0, 90.0, 91.0, 130.0, 92.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 129.0, 131.0, 144.0, 130.0, 132.0, 132.0, 173.0, 141.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 175.0, 168.0, 165.0, 169.0, 169.0, 171.0, 165.0, 165.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 71.0, 68.0, 70.0, 69.0, 66.0, 66.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1560.4, "alertThreshold": 2.0}]} 03:33:29 INFO - Return code: 0 03:33:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:33:29 INFO - # TBPL SUCCESS # 03:33:29 INFO - Running post-action listener: _resource_record_post_action 03:33:29 INFO - ##### 03:33:29 INFO - ##### Finished run-tests step (success) 03:33:29 INFO - ##### 03:33:29 INFO - Running post-run listener: _resource_record_post_run 03:33:29 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534507520; Read time: 16; Write time: 462792 03:33:29 INFO - TinderboxPrint: CPU usage
13.1% 03:33:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:33:29 INFO - TinderboxPrint: I/O write bytes / time
534,507,520 / 462,792 03:33:29 INFO - TinderboxPrint: CPU idle
8,325.2 (86.9%) 03:33:29 INFO - TinderboxPrint: CPU user
1,212.9 (12.7%) 03:33:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:33:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 245792768; Read time: 0; Write time: 212864 03:33:29 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288714752; Read time: 16; Write time: 249928 03:33:29 INFO - Running post-run listener: _upload_blobber_files 03:33:29 INFO - Blob upload gear active. 03:33:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:33:29 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 03:33:29 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'] 03:33:29 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 03:33:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:33 INFO - (blobuploader) - INFO - Done attempting. 03:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:35 INFO - (blobuploader) - INFO - Done attempting. 03:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:36 INFO - (blobuploader) - INFO - Done attempting. 03:33:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:33:36 INFO - Return code: 0 03:33:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:33:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:33:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/feb1f0355f5797b02e068456da854869ad86c5660d263df7632096c968d344836eed229123ecc93a252661ed423cd1478f8e6cf75080d9a2e3aa9c2ee5a1d97d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/233b384996c8660c566f753f8687bbf8a22921b0cd49161a0ce2277217e38f74f6c128572f5832fd10835b0b5d8c99b4dfafd149ec4eb86c36123418b7f56c88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9604c95cb880ed7e6e172f019c0e815098ae4875fcf974c5b67e49e1b4f003998e40d31a8334bab64a823bb17514cbe33bac9b9692e45ddf90e948834ce9191f"} 03:33:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:33:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:33:36 INFO - Contents: 03:33:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/feb1f0355f5797b02e068456da854869ad86c5660d263df7632096c968d344836eed229123ecc93a252661ed423cd1478f8e6cf75080d9a2e3aa9c2ee5a1d97d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/233b384996c8660c566f753f8687bbf8a22921b0cd49161a0ce2277217e38f74f6c128572f5832fd10835b0b5d8c99b4dfafd149ec4eb86c36123418b7f56c88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9604c95cb880ed7e6e172f019c0e815098ae4875fcf974c5b67e49e1b4f003998e40d31a8334bab64a823bb17514cbe33bac9b9692e45ddf90e948834ce9191f"} 03:33:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:33:36 INFO - Copying logs to upload dir... 03:33:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:33:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.882147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-22 03:33:36.171912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:36.175518) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/feb1f0355f5797b02e068456da854869ad86c5660d263df7632096c968d344836eed229123ecc93a252661ed423cd1478f8e6cf75080d9a2e3aa9c2ee5a1d97d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/233b384996c8660c566f753f8687bbf8a22921b0cd49161a0ce2277217e38f74f6c128572f5832fd10835b0b5d8c99b4dfafd149ec4eb86c36123418b7f56c88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9604c95cb880ed7e6e172f019c0e815098ae4875fcf974c5b67e49e1b4f003998e40d31a8334bab64a823bb17514cbe33bac9b9692e45ddf90e948834ce9191f"} build_url:https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/feb1f0355f5797b02e068456da854869ad86c5660d263df7632096c968d344836eed229123ecc93a252661ed423cd1478f8e6cf75080d9a2e3aa9c2ee5a1d97d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/233b384996c8660c566f753f8687bbf8a22921b0cd49161a0ce2277217e38f74f6c128572f5832fd10835b0b5d8c99b4dfafd149ec4eb86c36123418b7f56c88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9604c95cb880ed7e6e172f019c0e815098ae4875fcf974c5b67e49e1b4f003998e40d31a8334bab64a823bb17514cbe33bac9b9692e45ddf90e948834ce9191f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:36.200659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:36.200968) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466588757.658749-1710025581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:36.285340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:33:36.285661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:33:36.285961) ========= ========= Total master_lag: 0.18 =========