builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1466241085.7 results: success (0) buildid: 20160617233003 builduid: 1c2b73f4bc20486abc510eb2e476775b revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.702513) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.702939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.703248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.750836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.751122) ========= 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=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 02:11:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-06-18 02:11:26 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.864465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.864799) ========= 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=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014871 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.914787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.915178) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 02:11:26,280 truncating revision to first 12 chars 2016-06-18 02:11:26,280 Setting DEBUG logging. 2016-06-18 02:11:26,280 attempt 1/10 2016-06-18 02:11:26,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 02:11:26,591 unpacking tar archive at: fx-team-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653940 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.595644) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.595958) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.596381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.596702) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.620589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-06-18 02:11:26.620892) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:11:27 INFO - MultiFileLogger online at 20160618 02:11:27 in /builds/slave/test 02:11:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:11:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:27 INFO - {'append_to_log': False, 02:11:27 INFO - 'base_work_dir': '/builds/slave/test', 02:11:27 INFO - 'blob_upload_branch': 'Fx-Team', 02:11:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:27 INFO - 'branch': 'Fx-Team', 02:11:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:27 INFO - 'config_files': ('talos/linux_config.py',), 02:11:27 INFO - 'default_actions': ('clobber', 02:11:27 INFO - 'read-buildbot-config', 02:11:27 INFO - 'download-and-extract', 02:11:27 INFO - 'populate-webroot', 02:11:27 INFO - 'create-virtualenv', 02:11:27 INFO - 'install', 02:11:27 INFO - 'run-tests'), 02:11:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:27 INFO - 'download_minidump_stackwalk': True, 02:11:27 INFO - 'download_symbols': 'ondemand', 02:11:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:27 INFO - 'installer_path': 'installer.exe', 02:11:27 INFO - 'log_level': 'info', 02:11:27 INFO - 'log_name': 'talos', 02:11:27 INFO - 'log_to_console': True, 02:11:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:11:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:11:27 INFO - 'opt_config_files': (), 02:11:27 INFO - 'pip_index': False, 02:11:27 INFO - 'sps_profile': False, 02:11:27 INFO - 'sps_profile_interval': 0, 02:11:27 INFO - 'suite': 'dromaeojs', 02:11:27 INFO - 'system_bits': '32', 02:11:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:27 INFO - 'title': 'talos-linux64-ix-063', 02:11:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:27 INFO - 'use_talos_json': True, 02:11:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:27 INFO - 'work_dir': 'build'} 02:11:27 INFO - ##### 02:11:27 INFO - ##### Running clobber step. 02:11:27 INFO - ##### 02:11:27 INFO - Running pre-action listener: _resource_record_pre_action 02:11:27 INFO - Running main action method: clobber 02:11:27 INFO - rmtree: /builds/slave/test/build 02:11:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:11:28 INFO - Running post-action listener: _resource_record_post_action 02:11:28 INFO - ##### 02:11:28 INFO - ##### Finished clobber step (success) 02:11:28 INFO - ##### 02:11:28 INFO - ##### 02:11:28 INFO - ##### Running read-buildbot-config step. 02:11:28 INFO - ##### 02:11:28 INFO - Running pre-action listener: _resource_record_pre_action 02:11:28 INFO - Running main action method: read_buildbot_config 02:11:28 INFO - Using buildbot properties: 02:11:28 INFO - { 02:11:28 INFO - "project": "", 02:11:28 INFO - "product": "firefox", 02:11:28 INFO - "script_repo_revision": "production", 02:11:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:11:28 INFO - "repository": "", 02:11:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:11:28 INFO - "buildid": "20160617233003", 02:11:28 INFO - "pgo_build": "True", 02:11:28 INFO - "basedir": "/builds/slave/test", 02:11:28 INFO - "buildnumber": 198, 02:11:28 INFO - "slavename": "talos-linux64-ix-063", 02:11:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:11:28 INFO - "platform": "ubuntu64_hw", 02:11:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:11:28 INFO - "branch": "fx-team", 02:11:28 INFO - "repo_path": "integration/fx-team", 02:11:28 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 02:11:28 INFO - "stage_platform": "linux64-pgo", 02:11:28 INFO - "builduid": "1c2b73f4bc20486abc510eb2e476775b", 02:11:28 INFO - "slavebuilddir": "test" 02:11:28 INFO - } 02:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:11:28 INFO - Running post-action listener: _resource_record_post_action 02:11:28 INFO - ##### 02:11:28 INFO - ##### Finished read-buildbot-config step (success) 02:11:28 INFO - ##### 02:11:28 INFO - ##### 02:11:28 INFO - ##### Running download-and-extract step. 02:11:28 INFO - ##### 02:11:28 INFO - Running pre-action listener: _resource_record_pre_action 02:11:28 INFO - Running main action method: download_and_extract 02:11:28 INFO - mkdir: /builds/slave/test/build/tests 02:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:28 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:36 INFO - Downloaded 1361 bytes. 02:11:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:36 INFO - Using the following test package requirements: 02:11:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:11:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:11:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'jsshell-linux-x86_64.zip'], 02:11:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:11:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:11:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:11:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:11:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:11:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:36 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:41 INFO - Downloaded 24221020 bytes. 02:11:41 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'] 02:11:41 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 02:11:43 INFO - Return code: 0 02:11:43 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 02:11: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')]} 02:11:43 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:49 INFO - Downloaded 24221020 bytes. 02:11:49 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'] 02:11:49 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 02:11:50 INFO - Return code: 0 02:11:50 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')]} 02:11:50 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:52 INFO - Downloaded 14405384 bytes. 02:11:52 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'] 02:11:52 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 02:11:52 INFO - Return code: 0 02:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:52 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:11:56 INFO - Downloaded 60128862 bytes. 02:11:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:56 INFO - mkdir: /builds/slave/test/properties 02:11:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:56 INFO - Contents: 02:11:56 INFO - build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:57 INFO - Running post-action listener: _resource_record_post_action 02:11:57 INFO - Running post-action listener: set_extra_try_arguments 02:11:57 INFO - ##### 02:11:57 INFO - ##### Finished download-and-extract step (success) 02:11:57 INFO - ##### 02:11:57 INFO - ##### 02:11:57 INFO - ##### Running populate-webroot step. 02:11:57 INFO - ##### 02:11:57 INFO - Running pre-action listener: _resource_record_pre_action 02:11:57 INFO - Running main action method: populate_webroot 02:11:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:57 INFO - '--tppagecycles', 02:11:57 INFO - '7'], 02:11:57 INFO - 'tests': ['tsvgm']}}, 02:11:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:11:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['damp', 'tps']}, 02:11:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'tests': ['damp', 'tps']}, 02:11:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['dromaeo_dom']}, 02:11:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['basic_compositor_video']}, 02:11:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:11:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['a11yr', 02:11:57 INFO - 'ts_paint', 02:11:57 INFO - 'tpaint', 02:11:57 INFO - 'sessionrestore', 02:11:57 INFO - 'sessionrestore_no_auto_restore', 02:11:57 INFO - 'tabpaint']}, 02:11:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['tsvgx', 02:11:57 INFO - 'tsvgr_opacity', 02:11:57 INFO - 'tart', 02:11:57 INFO - 'tscrollx', 02:11:57 INFO - 'cart']}, 02:11:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:57 INFO - 'tsvgr_opacity', 02:11:57 INFO - 'tart', 02:11:57 INFO - 'tscrollx', 02:11:57 INFO - 'cart']}, 02:11:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'talos_options': ['--disable-e10s'], 02:11:57 INFO - 'tests': ['tp5o']}, 02:11:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'tests': ['tp5o']}, 02:11:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'talos_options': ['--disable-e10s', 02:11:57 INFO - '--xperf_path', 02:11:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:57 INFO - 'tests': ['tp5n']}, 02:11:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:57 INFO - 'talos_options': ['--xperf_path', 02:11:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:57 INFO - 'tests': ['tp5n']}}, 02:11:57 INFO - 'talos.zip': {'path': '', 02:11:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:57 INFO - Running post-action listener: _resource_record_post_action 02:11:57 INFO - ##### 02:11:57 INFO - ##### Finished populate-webroot step (success) 02:11:57 INFO - ##### 02:11:57 INFO - ##### 02:11:57 INFO - ##### Running create-virtualenv step. 02:11:57 INFO - ##### 02:11:57 INFO - Running pre-action listener: _resource_record_pre_action 02:11:57 INFO - Running main action method: create_virtualenv 02:11:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:57 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 02:11:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:57 INFO - Using real prefix '/usr' 02:11:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:00 INFO - Installing pip.................done. 02:12:00 INFO - Return code: 0 02:12:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:00 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:00 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 02:12:00 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 02:12:00 INFO - Using env: {'DISPLAY': ':0', 02:12:00 INFO - 'HOME': '/home/cltbld', 02:12:00 INFO - 'LANG': 'en_US.UTF-8', 02:12:00 INFO - 'LANGUAGE': 'en_US:en', 02:12:00 INFO - 'LOGNAME': 'cltbld', 02:12:00 INFO - 'MAIL': '/var/mail/cltbld', 02:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:00 INFO - 'MOZ_NO_REMOTE': '1', 02:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:00 INFO - 'NO_EM_RESTART': '1', 02:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:00 INFO - 'PWD': '/builds/slave/test', 02:12:00 INFO - 'SHELL': '/bin/bash', 02:12:00 INFO - 'SHLVL': '1', 02:12:00 INFO - 'TERM': 'linux', 02:12:00 INFO - 'TMOUT': '86400', 02:12:00 INFO - 'USER': 'cltbld', 02:12:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:00 INFO - '_': '/tools/buildbot/bin/python'} 02:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:00 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 02:12:00 INFO - Cleaning up... 02:12:00 INFO - Return code: 0 02:12:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:00 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:00 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 02:12:00 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 02:12:00 INFO - Using env: {'DISPLAY': ':0', 02:12:00 INFO - 'HOME': '/home/cltbld', 02:12:00 INFO - 'LANG': 'en_US.UTF-8', 02:12:00 INFO - 'LANGUAGE': 'en_US:en', 02:12:00 INFO - 'LOGNAME': 'cltbld', 02:12:00 INFO - 'MAIL': '/var/mail/cltbld', 02:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:00 INFO - 'MOZ_NO_REMOTE': '1', 02:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:00 INFO - 'NO_EM_RESTART': '1', 02:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:00 INFO - 'PWD': '/builds/slave/test', 02:12:00 INFO - 'SHELL': '/bin/bash', 02:12:00 INFO - 'SHLVL': '1', 02:12:00 INFO - 'TERM': 'linux', 02:12:00 INFO - 'TMOUT': '86400', 02:12:00 INFO - 'USER': 'cltbld', 02:12:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:00 INFO - '_': '/tools/buildbot/bin/python'} 02:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:00 INFO - Downloading/unpacking psutil>=3.1.1 02:12:00 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 02:12:00 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 02:12:00 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 02:12:00 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 02:12:00 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 02:12:00 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 02:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:02 INFO - Installing collected packages: psutil 02:12:02 INFO - Running setup.py install for psutil 02:12:02 INFO - building 'psutil._psutil_linux' extension 02:12:02 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 02:12:02 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 02:12:02 INFO - building 'psutil._psutil_posix' extension 02:12:02 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 02:12:03 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 02:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:03 INFO - Successfully installed psutil 02:12:03 INFO - Cleaning up... 02:12:03 INFO - Return code: 0 02:12:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:03 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:03 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 02:12:03 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 02:12:03 INFO - Using env: {'DISPLAY': ':0', 02:12:03 INFO - 'HOME': '/home/cltbld', 02:12:03 INFO - 'LANG': 'en_US.UTF-8', 02:12:03 INFO - 'LANGUAGE': 'en_US:en', 02:12:03 INFO - 'LOGNAME': 'cltbld', 02:12:03 INFO - 'MAIL': '/var/mail/cltbld', 02:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:03 INFO - 'MOZ_NO_REMOTE': '1', 02:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:03 INFO - 'NO_EM_RESTART': '1', 02:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:03 INFO - 'PWD': '/builds/slave/test', 02:12:03 INFO - 'SHELL': '/bin/bash', 02:12:03 INFO - 'SHLVL': '1', 02:12:03 INFO - 'TERM': 'linux', 02:12:03 INFO - 'TMOUT': '86400', 02:12:03 INFO - 'USER': 'cltbld', 02:12:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:03 INFO - '_': '/tools/buildbot/bin/python'} 02:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:12:05 INFO - Installing collected packages: mozsystemmonitor 02:12:05 INFO - Running setup.py install for mozsystemmonitor 02:12:05 INFO - Successfully installed mozsystemmonitor 02:12:05 INFO - Cleaning up... 02:12:05 INFO - Return code: 0 02:12:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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', '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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:12: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 jsonschema==2.5.1 02:12:05 INFO - Using env: {'DISPLAY': ':0', 02:12:05 INFO - 'HOME': '/home/cltbld', 02:12:05 INFO - 'LANG': 'en_US.UTF-8', 02:12:05 INFO - 'LANGUAGE': 'en_US:en', 02:12:05 INFO - 'LOGNAME': 'cltbld', 02:12:05 INFO - 'MAIL': '/var/mail/cltbld', 02:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:05 INFO - 'MOZ_NO_REMOTE': '1', 02:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:05 INFO - 'NO_EM_RESTART': '1', 02:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:05 INFO - 'PWD': '/builds/slave/test', 02:12:05 INFO - 'SHELL': '/bin/bash', 02:12:05 INFO - 'SHLVL': '1', 02:12:05 INFO - 'TERM': 'linux', 02:12:05 INFO - 'TMOUT': '86400', 02:12:05 INFO - 'USER': 'cltbld', 02:12:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:05 INFO - '_': '/tools/buildbot/bin/python'} 02:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:05 INFO - Downloading/unpacking jsonschema==2.5.1 02:12:05 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 02:12:05 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 02:12:05 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 02:12:05 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 02:12:05 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 02:12:05 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 02:12:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:07 INFO - warning: no files found matching '*.txt' 02:12:07 INFO - no previously-included directories found matching 'build' 02:12:07 INFO - no previously-included directories found matching 'dist' 02:12:07 INFO - no previously-included directories found matching '.git*' 02:12:07 INFO - Installing collected packages: jsonschema, functools32 02:12:08 INFO - Running setup.py install for functools32 02:12:08 INFO - warning: no files found matching '*.txt' 02:12:08 INFO - no previously-included directories found matching 'build' 02:12:08 INFO - no previously-included directories found matching 'dist' 02:12:08 INFO - no previously-included directories found matching '.git*' 02:12:08 INFO - Successfully installed jsonschema functools32 02:12:08 INFO - Cleaning up... 02:12:08 INFO - Return code: 0 02:12:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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', '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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:12: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 blobuploader==1.2.4 02:12:08 INFO - Using env: {'DISPLAY': ':0', 02:12:08 INFO - 'HOME': '/home/cltbld', 02:12:08 INFO - 'LANG': 'en_US.UTF-8', 02:12:08 INFO - 'LANGUAGE': 'en_US:en', 02:12:08 INFO - 'LOGNAME': 'cltbld', 02:12:08 INFO - 'MAIL': '/var/mail/cltbld', 02:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:08 INFO - 'MOZ_NO_REMOTE': '1', 02:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:08 INFO - 'NO_EM_RESTART': '1', 02:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:08 INFO - 'PWD': '/builds/slave/test', 02:12:08 INFO - 'SHELL': '/bin/bash', 02:12:08 INFO - 'SHLVL': '1', 02:12:08 INFO - 'TERM': 'linux', 02:12:08 INFO - 'TMOUT': '86400', 02:12:08 INFO - 'USER': 'cltbld', 02:12:08 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:08 INFO - '_': '/tools/buildbot/bin/python'} 02:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:11 INFO - Downloading docopt-0.6.1.tar.gz 02:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:11 INFO - Running setup.py install for blobuploader 02:12:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:11 INFO - Running setup.py install for requests 02:12:11 INFO - Running setup.py install for docopt 02:12:11 INFO - Successfully installed blobuploader requests docopt 02:12:11 INFO - Cleaning up... 02:12:11 INFO - Return code: 0 02:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:11 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:11 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 02:12:11 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 02:12:11 INFO - Using env: {'DISPLAY': ':0', 02:12:11 INFO - 'HOME': '/home/cltbld', 02:12:11 INFO - 'LANG': 'en_US.UTF-8', 02:12:11 INFO - 'LANGUAGE': 'en_US:en', 02:12:11 INFO - 'LOGNAME': 'cltbld', 02:12:11 INFO - 'MAIL': '/var/mail/cltbld', 02:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:11 INFO - 'MOZ_NO_REMOTE': '1', 02:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:11 INFO - 'NO_EM_RESTART': '1', 02:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:11 INFO - 'PWD': '/builds/slave/test', 02:12:11 INFO - 'SHELL': '/bin/bash', 02:12:11 INFO - 'SHLVL': '1', 02:12:11 INFO - 'TERM': 'linux', 02:12:11 INFO - 'TMOUT': '86400', 02:12:11 INFO - 'USER': 'cltbld', 02:12:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:11 INFO - '_': '/tools/buildbot/bin/python'} 02:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:12 INFO - Running setup.py (path:/tmp/pip-cHp6kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:12 INFO - Running setup.py (path:/tmp/pip-xLVZAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:12 INFO - Running setup.py (path:/tmp/pip-Pwtmwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:12 INFO - Running setup.py (path:/tmp/pip-X65hcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:12 INFO - Running setup.py (path:/tmp/pip-E32cxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:12 INFO - Running setup.py (path:/tmp/pip-i3E0Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:12 INFO - Running setup.py (path:/tmp/pip-GfhbAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:12 INFO - Running setup.py (path:/tmp/pip-LPRUaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:12 INFO - Running setup.py (path:/tmp/pip-MiGOX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:12 INFO - Running setup.py (path:/tmp/pip-NR_KOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:12 INFO - Running setup.py (path:/tmp/pip-lHVYFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:12 INFO - Running setup.py (path:/tmp/pip-vajKDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:12 INFO - Running setup.py (path:/tmp/pip-cDAbYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:13 INFO - Running setup.py (path:/tmp/pip-XU8MxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:13 INFO - Running setup.py (path:/tmp/pip-EOjFod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:13 INFO - Running setup.py (path:/tmp/pip-YvnFPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:13 INFO - Running setup.py (path:/tmp/pip-YsLKTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:13 INFO - Running setup.py install for manifestparser 02:12:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:13 INFO - Running setup.py install for mozcrash 02:12:13 INFO - Running setup.py install for mozdebug 02:12:13 INFO - Running setup.py install for mozdevice 02:12:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:13 INFO - Running setup.py install for mozfile 02:12:13 INFO - Running setup.py install for mozhttpd 02:12:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:13 INFO - Running setup.py install for mozinfo 02:12:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for mozInstall 02:12:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for mozleak 02:12:14 INFO - Running setup.py install for mozlog 02:12:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for moznetwork 02:12:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for mozprocess 02:12:14 INFO - Running setup.py install for mozprofile 02:12:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for mozrunner 02:12:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:14 INFO - Running setup.py install for mozscreenshot 02:12:14 INFO - Running setup.py install for moztest 02:12:14 INFO - Running setup.py install for mozversion 02:12:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:15 INFO - Cleaning up... 02:12:15 INFO - Return code: 0 02:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:15 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:15 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 02:12:15 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 02:12:15 INFO - Using env: {'DISPLAY': ':0', 02:12:15 INFO - 'HOME': '/home/cltbld', 02:12:15 INFO - 'LANG': 'en_US.UTF-8', 02:12:15 INFO - 'LANGUAGE': 'en_US:en', 02:12:15 INFO - 'LOGNAME': 'cltbld', 02:12:15 INFO - 'MAIL': '/var/mail/cltbld', 02:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:15 INFO - 'MOZ_NO_REMOTE': '1', 02:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:15 INFO - 'NO_EM_RESTART': '1', 02:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:15 INFO - 'PWD': '/builds/slave/test', 02:12:15 INFO - 'SHELL': '/bin/bash', 02:12:15 INFO - 'SHLVL': '1', 02:12:15 INFO - 'TERM': 'linux', 02:12:15 INFO - 'TMOUT': '86400', 02:12:15 INFO - 'USER': 'cltbld', 02:12:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:15 INFO - '_': '/tools/buildbot/bin/python'} 02:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:15 INFO - Running setup.py (path:/tmp/pip-GAKdvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:15 INFO - Running setup.py (path:/tmp/pip-is0QZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:15 INFO - Running setup.py (path:/tmp/pip-bjsFcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:15 INFO - Running setup.py (path:/tmp/pip-jnS0e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:15 INFO - Running setup.py (path:/tmp/pip-m7np1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:15 INFO - Running setup.py (path:/tmp/pip-Oge0Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:15 INFO - Running setup.py (path:/tmp/pip-mwnwrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:15 INFO - Running setup.py (path:/tmp/pip-GRcXjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:15 INFO - Running setup.py (path:/tmp/pip-1a0yNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:15 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)) 02:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:15 INFO - Running setup.py (path:/tmp/pip-o5dPMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:16 INFO - Running setup.py (path:/tmp/pip-AonlyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:16 INFO - Running setup.py (path:/tmp/pip-lysm9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:16 INFO - Running setup.py (path:/tmp/pip-rqN4wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:16 INFO - Running setup.py (path:/tmp/pip-JmrUhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:16 INFO - Running setup.py (path:/tmp/pip-yLIZrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:16 INFO - Running setup.py (path:/tmp/pip-QzInGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:16 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)) 02:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:16 INFO - Running setup.py (path:/tmp/pip-YIyFDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:16 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)) 02:12:16 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)) 02:12:16 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)) 02:12:16 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)) 02:12:16 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)) 02:12:16 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)) 02:12:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:18 INFO - Downloading blessings-1.6.tar.gz 02:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:18 INFO - Installing collected packages: blessings 02:12:18 INFO - Running setup.py install for blessings 02:12:18 INFO - Successfully installed blessings 02:12:18 INFO - Cleaning up... 02:12:18 INFO - Return code: 0 02:12:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:18 INFO - Reading from file tmpfile_stdout 02:12:18 INFO - Current package versions: 02:12:18 INFO - argparse == 1.2.1 02:12:18 INFO - blessings == 1.6 02:12:18 INFO - blobuploader == 1.2.4 02:12:18 INFO - docopt == 0.6.1 02:12:18 INFO - functools32 == 3.2.3-2 02:12:18 INFO - jsonschema == 2.5.1 02:12:18 INFO - manifestparser == 1.1 02:12:18 INFO - mozInstall == 1.12 02:12:18 INFO - mozcrash == 0.17 02:12:18 INFO - mozdebug == 0.1 02:12:18 INFO - mozdevice == 0.48 02:12:18 INFO - mozfile == 1.2 02:12:18 INFO - mozhttpd == 0.7 02:12:18 INFO - mozinfo == 0.9 02:12:18 INFO - mozleak == 0.1 02:12:18 INFO - mozlog == 3.2 02:12:18 INFO - moznetwork == 0.27 02:12:18 INFO - mozprocess == 0.22 02:12:18 INFO - mozprofile == 0.28 02:12:18 INFO - mozrunner == 6.11 02:12:18 INFO - mozscreenshot == 0.1 02:12:18 INFO - mozsystemmonitor == 0.3 02:12:18 INFO - moztest == 0.7 02:12:18 INFO - mozversion == 1.4 02:12:18 INFO - psutil == 3.1.1 02:12:18 INFO - requests == 1.2.3 02:12:18 INFO - wsgiref == 0.1.2 02:12:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:18 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')]} 02:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:18 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')]} 02:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:18 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 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:18 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 02:12:18 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 02:12:18 INFO - Using env: {'DISPLAY': ':0', 02:12:18 INFO - 'HOME': '/home/cltbld', 02:12:18 INFO - 'LANG': 'en_US.UTF-8', 02:12:18 INFO - 'LANGUAGE': 'en_US:en', 02:12:18 INFO - 'LOGNAME': 'cltbld', 02:12:18 INFO - 'MAIL': '/var/mail/cltbld', 02:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:18 INFO - 'MOZ_NO_REMOTE': '1', 02:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:18 INFO - 'NO_EM_RESTART': '1', 02:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:18 INFO - 'PWD': '/builds/slave/test', 02:12:18 INFO - 'SHELL': '/bin/bash', 02:12:18 INFO - 'SHLVL': '1', 02:12:18 INFO - 'TERM': 'linux', 02:12:18 INFO - 'TMOUT': '86400', 02:12:18 INFO - 'USER': 'cltbld', 02:12:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:18 INFO - '_': '/tools/buildbot/bin/python'} 02:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 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)) 02:12:19 INFO - Cleaning up... 02:12:19 INFO - Return code: 0 02:12:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:12:19 INFO - Using env: {'DISPLAY': ':0', 02:12:19 INFO - 'HOME': '/home/cltbld', 02:12:19 INFO - 'LANG': 'en_US.UTF-8', 02:12:19 INFO - 'LANGUAGE': 'en_US:en', 02:12:19 INFO - 'LOGNAME': 'cltbld', 02:12:19 INFO - 'MAIL': '/var/mail/cltbld', 02:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:19 INFO - 'MOZ_NO_REMOTE': '1', 02:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:19 INFO - 'NO_EM_RESTART': '1', 02:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:19 INFO - 'PWD': '/builds/slave/test', 02:12:19 INFO - 'SHELL': '/bin/bash', 02:12:19 INFO - 'SHLVL': '1', 02:12:19 INFO - 'TERM': 'linux', 02:12:19 INFO - 'TMOUT': '86400', 02:12:19 INFO - 'USER': 'cltbld', 02:12:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:19 INFO - '_': '/tools/buildbot/bin/python'} 02:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:12:19 INFO - Cleaning up... 02:12:19 INFO - Return code: 0 02:12:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7476925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, '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': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', '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 02:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:12:19 INFO - Using env: {'DISPLAY': ':0', 02:12:19 INFO - 'HOME': '/home/cltbld', 02:12:19 INFO - 'LANG': 'en_US.UTF-8', 02:12:19 INFO - 'LANGUAGE': 'en_US:en', 02:12:19 INFO - 'LOGNAME': 'cltbld', 02:12:19 INFO - 'MAIL': '/var/mail/cltbld', 02:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:19 INFO - 'MOZ_NO_REMOTE': '1', 02:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:19 INFO - 'NO_EM_RESTART': '1', 02:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:19 INFO - 'PWD': '/builds/slave/test', 02:12:19 INFO - 'SHELL': '/bin/bash', 02:12:19 INFO - 'SHLVL': '1', 02:12:19 INFO - 'TERM': 'linux', 02:12:19 INFO - 'TMOUT': '86400', 02:12:19 INFO - 'USER': 'cltbld', 02:12:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:19 INFO - '_': '/tools/buildbot/bin/python'} 02:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:19 INFO - Downloading/unpacking flake8 02:12:19 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 02:12:19 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 02:12:19 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 02:12:19 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 02:12:19 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 02:12:19 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 02:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:22 INFO - no previously-included directories found matching 'docs/_build' 02:12:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:12:22 INFO - Running setup.py install for pep8 02:12:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:24 INFO - no previously-included directories found matching 'docs/_build' 02:12:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:12:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:12:24 INFO - Cleaning up... 02:12:33 INFO - Return code: 0 02:12:33 INFO - Running post-action listener: _resource_record_post_action 02:12:33 INFO - Running post-action listener: _start_resource_monitoring 02:12:33 INFO - Starting resource monitoring. 02:12:33 INFO - ##### 02:12:33 INFO - ##### Finished create-virtualenv step (success) 02:12:33 INFO - ##### 02:12:33 INFO - ##### 02:12:33 INFO - ##### Running install step. 02:12:33 INFO - ##### 02:12:33 INFO - Running pre-action listener: _resource_record_pre_action 02:12:33 INFO - Running main action method: install 02:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:33 INFO - Reading from file tmpfile_stdout 02:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:33 INFO - Reading from file tmpfile_stdout 02:12:33 INFO - Output received: 02:12:33 INFO - Usage: mozinstall [options] installer 02:12:33 INFO - Options: 02:12:33 INFO - -h, --help show this help message and exit 02:12:33 INFO - -d DEST, --destination=DEST 02:12:33 INFO - Directory to install application into. [default: 02:12:33 INFO - "/builds/slave/test"] 02:12:33 INFO - --app=APP Application being installed. [default: firefox] 02:12:33 INFO - mkdir: /builds/slave/test/build/application 02:12:33 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'] 02:12:33 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 02:12:52 INFO - Reading from file tmpfile_stdout 02:12:52 INFO - Output received: 02:12:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:12:52 INFO - Running post-action listener: _resource_record_post_action 02:12:52 INFO - ##### 02:12:52 INFO - ##### Finished install step (success) 02:12:52 INFO - ##### 02:12:52 INFO - ##### 02:12:52 INFO - ##### Running run-tests step. 02:12:52 INFO - ##### 02:12:52 INFO - Running pre-action listener: _resource_record_pre_action 02:12:52 INFO - Running main action method: run_tests 02:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:52 INFO - Python 2.7.3 02:12:52 INFO - Return code: 0 02:12:52 INFO - grabbing minidump binary from tooltool 02:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:52 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 0x27cb1c0>, '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 0x27cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12:52 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 02:12:52 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 02:12:52 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 02:12:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:52 INFO - Return code: 0 02:12:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:12:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:12:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:12:53 INFO - Return code: 0 02:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 02:12:53 INFO - Using env: {'DISPLAY': ':0', 02:12:53 INFO - 'HOME': '/home/cltbld', 02:12:53 INFO - 'LANG': 'en_US.UTF-8', 02:12:53 INFO - 'LANGUAGE': 'en_US:en', 02:12:53 INFO - 'LOGNAME': 'cltbld', 02:12:53 INFO - 'MAIL': '/var/mail/cltbld', 02:12:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:53 INFO - 'MOZ_NO_REMOTE': '1', 02:12:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:53 INFO - 'NO_EM_RESTART': '1', 02:12:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:53 INFO - 'PWD': '/builds/slave/test', 02:12:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:53 INFO - 'SHELL': '/bin/bash', 02:12:53 INFO - 'SHLVL': '1', 02:12:53 INFO - 'TERM': 'linux', 02:12:53 INFO - 'TMOUT': '86400', 02:12:53 INFO - 'USER': 'cltbld', 02:12:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328', 02:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:53 INFO - '_': '/tools/buildbot/bin/python'} 02:12:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:12:53 INFO - mozversion application_buildid: 20160617233003 02:12:53 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:12:53 INFO - mozversion application_display_name: Nightly 02:12:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:53 INFO - mozversion application_name: Firefox 02:12:53 INFO - mozversion application_remotingname: firefox 02:12:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:12:53 INFO - mozversion application_vendor: Mozilla 02:12:53 INFO - mozversion application_version: 50.0a1 02:12:53 INFO - mozversion platform_buildid: 20160617233003 02:12:53 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:12:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:12:53 INFO - mozversion platform_version: 50.0a1 02:12:53 INFO - using testdate: 1466241173 02:12:53 INFO - actual date: 1466241173 02:12:53 INFO - starting webserver on 'localhost:43373' 02:12:53 INFO - SUITE-START | Running 2 tests 02:12:53 INFO - TEST-START | dromaeo_css 02:12:53 INFO - operating with platform_type : linux_ 02:12:53 INFO - Initialising browser for dromaeo_css test... 02:12:53 INFO - TEST-INFO | started process 12431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcQz_6/profile http://localhost:43373/getInfo.html) 02:13:00 INFO - PROCESS | 12431 | __metrics Screen width/height:1600/1200 02:13:00 INFO - PROCESS | 12431 | colorDepth:24 02:13:00 INFO - PROCESS | 12431 | Browser inner width/height: 1024/697 02:13:00 INFO - PROCESS | 12431 | __metrics 02:13:02 INFO - PROCESS | 12431 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:03 INFO - PROCESS | 12431 | console.error: PushService: 02:13:03 INFO - PROCESS | 12431 | stateChangeProcessEnqueue: Error transitioning state 02:13:03 INFO - PROCESS | 12431 | UnknownError 02:13:03 INFO - TEST-INFO | 12431: exit 0 02:13:03 INFO - Browser initialized. 02:13:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:03 INFO - TEST-INFO | started process 12516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcQz_6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:15 INFO - PROCESS | 12516 | RSS: Main: 173641728 02:13:15 INFO - PROCESS | 12516 | 02:14:06 INFO - PROCESS | 12516 | 1466241246508 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] 02:16:16 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43373/tests/dromaeo/cssquery-ext.html) 02:16:17 INFO - PROCESS | 12516 | RSS: Main: 266211328 02:16:17 INFO - PROCESS | 12516 | 02:19:19 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-ext.html (next: http://localhost:43373/tests/dromaeo/cssquery-jquery.html) 02:19:20 INFO - PROCESS | 12516 | RSS: Main: 261931008 02:19:20 INFO - PROCESS | 12516 | 02:22:22 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43373/tests/dromaeo/cssquery-mootools.html) 02:22:22 INFO - PROCESS | 12516 | RSS: Main: 269557760 02:22:22 INFO - PROCESS | 12516 | 02:25:24 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43373/tests/dromaeo/cssquery-prototype.html) 02:25:25 INFO - PROCESS | 12516 | RSS: Main: 261009408 02:25:25 INFO - PROCESS | 12516 | 02:28:27 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43373/tests/dromaeo/cssquery-yui.html) 02:28:28 INFO - PROCESS | 12516 | RSS: Main: 241508352 02:28:28 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | Cycle 1(1): loaded http://localhost:43373/tests/dromaeo/cssquery-yui.html (next: http://localhost:43373/tests/dromaeo/cssquery-dojo.html) 02:31:31 INFO - PROCESS | 12516 | RSS: Main: 290000896 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | __start_tp_report 02:31:31 INFO - PROCESS | 12516 | _x_x_mozilla_page_load 02:31:31 INFO - PROCESS | 12516 | _x_x_mozilla_page_load_details 02:31:31 INFO - PROCESS | 12516 | |i|pagename|runs| 02:31:31 INFO - PROCESS | 12516 | |0;dojo.html;3102.627684677839;3122.2038380213044;3130.201798541372;3146.119086655737;3173.3653269346123;5333.4399888011685;5370.731463426828;5398.379186393566;5508.724563771811;5536.584756143286;5440.782368705247;5458.890822183554;5505.697186654733;5522.5581953443725;5578.721063946797;4925.7537123143875;4995.875103122433;5023.196288593826;5031.622628302874;5173.663711858736;5085.618578606601;5107.744612769366;5109.003744269869;5131.794728210867;5135.897282054357;4860.586850117745;4897.534734200228;4934.309196712463;4946.40643122824;5061.417936937262;4862.878428039292;4894.437139728905;4894.923116914273;4964.230544265644;5002.974985125051;4914.950850491521;4969;4976.676516026447;4982.82560110398;5028.723420211887;5340.172273297645;5382.138857782736;5435.864103397446;5439.102548079562;5462.5083742462975;5743.138529220609;5798.478136967693;5822.126680997884;5827.883442331172;5870.970645146747;5855.560832937546;5857.20927674767;5863.648181109147;5872.5889187756875;5875.1187321901625;5239.685618862881;5370.9731451342495;5455.754491047913;5457.890842183134;5529.4470552944385;6038.849028774316;6058.575899687068;6058.787942422082;6060.212172417558;6061;5569.248151499577;5800.274965629296;5812.6221795584;5818.5054270386645;5823.068309070613;5698.230738850285;5781.682007489629;5783.248177736868;5805.535557155417;5810.331811841608;5726.484616384545;5739.196512488255;5763.6541807491685;5764.106563482667;5764.221830052889;5646.520045796071;5740.052891272977;5789.478946894799;5791.044477661223;5796.478316951495;4375.453068366454;4395.164918665443;4404.493483249467;4432.800523976429;4433.578810013044;3897.415387691869;3918.647321741;3937.114149316438;3937.3306537888056;3965.8413663453716;5364.570834333244;5420.34955805298;5445.918311225335;5450.836474905759;5562.110062390079;5785.27684039495;5850.180974663551;5867.853303667357;5882.676452795137;5910.202122713378;5500.092484740053;5519.034169020486;5520.199571062173;5521.2270282160525;5525.198846167284;4602.976985115053;4675.836345727883;4702.106599746037;4717.764111794465;4795;6066.817995460143;6074;6076.787312444043;6083.908741368795;6115.174451448997;5885.970570147122;5891.823245302648;5896.705164741831;5898.764049437975;5899.056151015817;5915.171875937286;5933.347331793413;5951.22634057587;5952.315483719254;6085.604435711842;5748.741306641127;5751.798687045934;5753.683547404766;5757.309122905278;5759.280089988752;5797.304323481209;5830.47525722687;5859.121131830089;5863.1791549184;5868.882622347443;5558.91661625084;5561.833145005657;5579.16312553104;5626.2685850839125;5661.037623604079;5581.553475722014;5642.802501912413;5648.124540696199;5651.689157096399;5656.37779844225;5482.314710661168;5573.442655734394;5573.8606534835335;5584.190292407497;5589.105743081088;5595.8880822384135;5641.9435805641415;5653.745581448927;5736.311642602915;5747.396523364986;5558.749856256559;5561.054620714407;5564;5565.582581306499;5572.10846264612 02:31:31 INFO - PROCESS | 12516 | |1;ext.html;565.2538648983343;601.7893737191984;616.0728104203174;621.2669050520384;625.5621065254323;32509.349813003755;35779.284414311696;41191.79404102979;41866.37200441996;41889.16221675572;44338;44378.33432498507;44579.10841783162;44591.554084459145;44609;8795.296376289898;8945.329100317469;8949.25489529542;8949.463032218087;8950.104989501064;8753.912460875374;8843.380963332569;8859.335549833757;8863.556822158898;8874.556272186397;8895.911040889572;8911.821763564725;8934.285257179443;8934.597943092576;8941.50821704806;8782.780430489225;8824;8828.382013259074;8841.204291613754;8847.73456796294;8735.825283494358;8804.64781408743;8813.911860881373;8817.735467935972;8827.117288271185;37471.62528374709;37731;37919.24161516782;37972.43041354382;37975;3225.5322978168033;3401.8639254429795;3423.246885685145;3554.893353199408;3981.6814654827544;31906.840465797755;32094.197645058826;32150.03549893507;32605.836970814995;33472.49791253133;4084.2035803018425;4148.072971856959;4188.518320393133;4213.5786421357925;4335.544767799367;341066;341667;341746.29126854456;342103;342494;54878.725606372514;54919;55264.72367638136;55373.446265536826;55449.168262476094;36837.26325473529;37586;37651.62348376536;37700.62299376971;59522.70238648866;13942.86057139436;14033.85966140346;14063.507777227953;14090.647733806736;14095.436182552583;10354.53404596795;10432.426216558162;10452;10453.163746900229;10454.163666906628;19196.136173872208;19229.230830766894;19260.614787704446;19291.710624340645;19354.709679354823;6824.761133360308;6901.585904845625;7038.753643622551;7106.5736055836815;7172.13934327884;942.59468428575;1018.674024312213;1026.90757831794;1036.362636978268;1159.1769843411105;29568.55647165294;29796.40407191844;30031.849840750656;30266.84866575653;30526.38947221043;993.6373223773271;1088.8693356797235;1136.3466007045981;1155.3991924199538;1198.1553005131361;15878.444254451038;16122.435714749927;16426.096564689058;16598.834011659972;16718.749218761728;536617;554242;566320;567600;931846;55515.66905985654;55587.444125559035;55898;56070.43929560652;56084.71957640268;1241.2924632959307;1321.881030707241;1324.8211491448724;1332.793417020344;1343.509618989062;29512;30565.847170764893;30826.845865771425;32570.83714581412;33160;55008.449915500336;55105.1734223995;56436.15345769899;56607.43392566022;61452.69273653782;519364;523256;525615;526917;528570;36817.815910920275;41861.58138418577;42703.57296426996;43532;44529.10941781082;48407.757961209965;49121.50878491169;49204.753976231324;49562.75218623884;50099;40388.59611403848;41207.381889272285;41557.37663934983;42074.7896260529;42990.14019719651;40862.6662867256;40909;41132;41529.1694166121;41684;40440.79779601083;40669;40787.796061020694;41356.79321603373;41404;35551.64448355483;36328.81835590805;36822;37029;37094;27433.725662743916;27547;27707.722922770514;27814.3046423841;28018.439631207668 02:31:31 INFO - PROCESS | 12516 | |2;jquery.html;380.8781190019195;382.2717722738184;389.838217139887;402.71004876488934;406.8779366190146;17834.375796847115;19859.404217873467;20106.396808095782;20422.183112675513;20475.385738427853;17334.046627435488;17555;18067.096645167723;18172.636547269045;18235.452936411897;5518.503334699876;5662.433756624325;5781.971090144543;5788.47903688668;5800.100984347433;5676.262085928824;5699.059655156915;5709.086546152616;5729.369769325371;5731.369549349568;5550.91673624894;5667.489925906668;5699.68651724155;6896.896546551806;7371.378296774701;7282.8179295517775;7286.672099755524;7426.220246874054;7476.700931962715;7483.43874209431;6955.095837541087;7061.82345441368;7106.928930710678;7111.075560177143;7113.857722845514;23898.283051508482;25412.491750165078;26298.73701262982;26548.60177097345;26619.334516637045;2426.6410809946487;2482.2925466242036;2507.4734305795805;2530.2029860593852;2610.3474131467133;14486.927565362212;14856.125129348073;15307.540773776804;15462.922685386613;16029.35882564696;2006.8193862552293;2007.4880905369184;2054.157795303933;2056.794320567946;2056.9485762855898;71905.6404717973;74345.99999999946;75513;94121.52939235329;97497;17347.479575612753;17889.7316540252;18015.819841801414;18036.458906232834;18289.451316460527;31137.844310778753;31226.375472490425;31308.686913131034;31324.843375782973;31494.527582086288;8297.8340433191;8800.16398442147;8872.689455869013;8924.643014279485;9217.170454658979;7431.405487560982;7465.2534746526;7478.177400485943;7612.3148916597775;7625.389968802482;8802.647894084294;8820.911790882137;8831;8979.595918183566;9116.544172791333;3266.771326007157;3386.3396637655915;3498.475228715713;3526.594441639193;3586.3544561978574;866.7313132928812;910.7085732565648;953.7872136642922;986.2701600815345;1034.5758239121924;17643.647127057386;19602.411927642195;19801;19809.504762380766;19930.402087937095;984.9359791613522;985.84719368498;987.8567607696843;990.9752256193509;997.9401235925868;10546.683599492027;10973;11069.723256918642;11104.222704410775;11114.610988615521;450706;457371;484375;484528;484541;92273.53863230642;96117.51941240388;96503;96585;96907;944.8157609266127;946.7633091727068;960.4717405427127;969.7769513012047;970.9271804614823;16753.74869376985;16817.66364672724;17095.316187352368;17250.309987600856;17741.290348386436;29361.11916642504;30589.694103058686;34909.65090349064;35637.64362356343;41922;59148.40851591429;59476.107858383024;60070;60402.09396858963;60797.088043678494;7365.52124111931;7707.267809558083;7819.413543984338;8751.518666473405;9083.318751093562;9486.383385079947;11934.820977685167;11979.460924258256;12986.155899866479;13042.347882605642;11154.553817847196;11786.528538858349;11843.46704398287;11857.288562686266;11933.3436660981;10678.092362148993;11966.700832479257;12146.696332591757;12198.390080495763;12627.179233349803;11696.239744416585;11752.236104653512;11799;12213.511459541518;12468.251904885736;8833.602487888189;8898.911010889808;9036.548172591476;9036.954815225881;9161.86257206129;11220.326780393203;11472.82790758156;11711.063114950613;11729.413529323328;12242 02:31:31 INFO - PROCESS | 12516 | |3;mootools.html;1315.4343632238147;1429.6854691967767;1481.6814384907245;1592.2277695317769;1756.1833747307498;8367.874481882769;8840.425372350792;8853.380263381558;9089.27285817133;9093.454392736425;8805.779855503615;8976.326775491832;9025.909740902589;9026.142516460943;9035.683751068715;2049.9487512812225;2307.676925230469;2359.7050368703867;2376.097083108425;2390.2470721722602;2406.8194885383577;2410.783029527342;2414.7102347718296;2415.6738840256603;2416.178499310234;2341.7424083350816;2352.6118190498632;2368;2368.2658375903525;2370.8221883358733;1974.1708482437411;2250.144944920936;2314.0628045641542;2321.616933206019;2326.941826454335;2197.6703494475796;2222.5777102350503;2223.2552095048177;2224.877631730254;2248.1457046322294;9177.449353038839;9246.075392460767;9246.90753092474;9296.070392960717;9299.349045566812;5090;5220.29526013987;5232.319798426218;5244.842654720364;5244.8688782780355;3260.2175477885376;3306.9503957440656;3326.9833650831833;3412.4028295048515;3425.9657403425895;1061.2093989977438;1074.5164675895878;1086.9293495922739;1092.5083712329483;1097.1277834121893;12778.10553261272;12789.936050319782;12796;12822.80765788514;12844.229346239255;4756.240191129235;4805.951940480621;4888.951110488921;4898.706077635354;4907.705537667752;10478.266521343585;10510.579576816994;10537.89462105369;10587.364758114538;10593.205509586658;5363.570914326844;5371;5372.382176049804;5381.838544843661;5388.164834450667;4219.578042195817;4760.309755085563;4893.559579637849;4903.068417000758;4956.776945037482;3777.660010599059;3914.921701565953;3929.646331830149;3950.7827069511454;4015.8996025099023;1230.3479156047308;1253.160382543698;1260.8865202131851;1265.1523479268913;1269.9746005079846;773.659589780506;861.5476874640739;896.3994123936978;940.0082912527213;976.6239997600975;6233.844153896189;6234.750609975641;6275;6275.184226050585;6372.394622510854;454.8180727708943;455.744782921565;463.5225717510969;475.6313856761038;478.0749250200803;4249.7237679551345;4274.1451709658195;4349.760763157993;4362.258416069276;4362.738235705804;10966.780664386668;11298.774024519464;11364.374959377148;11393.544258229744;11424.428778561205;10608.20438467118;11014.44927753609;11202.327860328407;11278.323300601825;11306.547738090549;8379.329653627696;8455.239028487342;8551.486910785372;8565.95717021411;8573.485590864568;6182.969085154546;6403.96798016007;6425.132607097982;6497.480201583957;6562.409383155348;10318.845217321596;10321.122704570196;10492.737681558023;10520.10579100785;10577.471126443494;10498.265121441425;10711.625093121704;10727.892721072689;10736.570537178426;10779.946100269448;7386.630668466662;7840.176781437867;8012.919870801451;8115.715949941724;8271;8626.266767324847;8632.91367086321;8703.216710496086;8720.738377848675;8725.258353040063;7249.927500725136;7332.486725929134;7393.55638661682;7541.509801862861;7832.216778322122;7414.703411863465;7459.589722565311;7506.699732010877;7574.204708505527;7635.389168866366;6959.478039147186;7007.404370628554;7022.719091236293;7024.859502810017;7029.3673569379;4807.807687692453;4923.261510773269;4965.801367945386;4999.425066117443;5073.7716802743225;5101.566366858859;5108.642395032312;5146.76839542229;5227.790888364575;5260.026895024433 02:31:31 INFO - PROCESS | 12516 | |4;prototype.html;318.7943776264308;327.6756011548567;332.90640246789303;333.81806915231226;336.39113205098766;5118.259791670831;5199.272101905736;5242.397124330703;5325.520703136717;5342.252084708139;5170.3020092287625;5211.166213405856;5212.817551385702;5255.500727430888;5298.682079075248;4142.357934520139;4162.438070860426;4173.853915112972;4180.874573762792;4224.471941007374;3922.5096862892137;3934.921301573967;4084.7344922580087;4128.1330920506725;4146.295129827921;4104.671626269891;4127.711060225771;4146.419501269825;4150.8962275943195;4152.37714342848;4125.566815484376;4126.360414135814;4142.109446469024;4150.522689890641;4151.481064866892;3432.622411534729;3709.6661300482815;3714.7585406948733;3716.9070773230615;3727.14275716584;5137.7944882204665;5144.176931690949;5146.8198613048735;5152.948470515322;5166.276721259027;4590.885227869297;4671.369365135697;4675.649326300541;4693.671442998992;4694.436667599875;5349.304590403222;5380.192971054373;5483.122700367961;5489.615726899118;5496.7526461309335;3922.784246866421;3951.644352008333;3962.4546426893535;3965.1871366369824;3970.50368703912;5730.484256416901;5764.337101233328;5774.653520788766;5785.652860828406;5785.942140578582;4000.5199376074474;4088.8364465421646;4102.917941641151;4117.5882411758585;4121.52602450716;4096.26267271888;4098.4876890388705;4102.671786257092;4112.935862782187;4122.134351786099;4629.953700463019;4649.721016739007;4680.368150299666;4693.55411235932;4700.130475861908;5494.2582751328055;5494.450554944474;5587.776488940478;5594.440555944454;5601.943980560142;1314.9408276627576;1381.6062422209623;1392.735380277744;1398.741232871922;1403.382511694851;863.6459051788862;883.9823203535893;889.235257678396;893.5398269891011;897.9191872731485;4684.594621613503;4725.362076119749;4750.619950404029;4752.500987396274;4778.713277203379;4927.831754028216;4956.281339205795;4965.726885021359;4968.478309777493;4983.327250821165;4406.1187762447;4656.41794775653;4743.739094349844;4760.357351757469;4763.976180119077;2681.0482278791137;2682.731726827302;2690.4081102157493;2721.5781553859183;2727.2636388175083;5140.56305214061;5152;5171.560417364491;5175.508326708957;5185.662931909414;4724.834630787906;4986.675866068694;5039.042581909499;5049.495050494995;5069.898602028013;5066.721330326867;5085.703145697823;5104.642675012714;5119.795208191631;5122.564582010571;4927.60579153674;4962.206047032458;4963.627727920492;4975;4991.401031876198;4647.256438969748;4869.366982292421;4916.139675556835;4922.409310882717;4943.530364615356;5054.393472783143;5078.4667609900425;5078.755704852335;5079.873003174803;5086.364204474441;3663.1757854483594;3680.2455496622592;3682.5085840234747;3693.944590831086;3697.7226707997547;4627.352170696173;4857.805687772591;4996.300517927566;4999.825006124768;5008.223725322581;4791.688540244873;4841.709497430165;4905.264210368473;4906.552566992675;4906.582940450102;4838.7338696372035;4853.344798452164;4880.95119048805;4889.7799599018845;4899.779509922133;4564.680472366902;4720.952790472189;4788.904221915612;4809.052333804814;4830.9854930465;4879.902401952012;4887.36464259644;4896.853094407174;4919.877003074808;4959.429665588504;4735.905281894274;4751.40607424072;4802.591779698765;4806.375171227718;4814.566688998007 02:31:31 INFO - PROCESS | 12516 | |5;yui.html;613.8189234175918;650.8372906773305;653.9444147247484;694.1669996004792;711.4770643576967;14226.217558034305;15015.399384024626;15086.3211155498;15091.849081509195;15095.547133585997;14150.929245353758;14675.486357977474;14705.632359191026;15198.924005379986;15200.315985780639;657.0866495571136;761.2235519769831;773.2576726342718;779.5829231361223;781.6560713286165;767.7428061599371;769.5805785846727;770.0836005153877;771.0208035794537;772.4322622872185;808.8463191993502;816.147126253067;816.2123550773503;816.510093943632;816.6243527977108;677.9389854913056;697.2295613347254;697.6616341074575;780.6331024418571;813.6907974969533;595.8986972214691;597.9611325263887;598.5809933046885;598.7515181199797;599.688162155681;14548.854511454962;14574.854251457562;14585.343659535347;14605.78091328631;14622.26888655563;12781.808272875915;13090.504215046945;13123.343832808321;13363.198208107544;13597.04820662554;11055.613053543088;11411.315321080761;11523.539058437653;12071.155019148664;12081.395930203455;3714.609965953563;3735.831887565039;3758.1356288053626;3787.9621203787883;3917.0794863207407;74434.62782686106;75434;75652;75726.62136689336;75728.62135689287;9850.50747462624;10265.486725663686;10570.10154136907;10904.945475272732;10913.727156820984;18851.3402030931;18901.338453154072;18927.716084258747;18955.620887582172;18976.715349269773;7169.24722904098;7443.665035073434;7584.582847943416;7607.961960190274;7758.55179028128;4219.873403797891;4315.352697095461;4374.387585737999;4464.3973063635995;4583.839565615188;3390.28803951173;3505.088676944013;3507.701845343174;3510.192655689155;3515.261795023074;610.6946526736632;615.972281247345;628.1645411602558;629.2071989293523;633.1768700689086;634.6826586706646;651.2380514797698;678.5250324772679;684.5995092870727;706.5795851468368;8280.544570048705;8660.8700869487;8667.393282470166;8771.429857059271;8876.467411955304;530.1808705549935;545.5662748115178;571.8941995730803;642.6529673976;651.6025224612982;4040.4343391925154;4188.6230239278;4232.343986682069;4249.5113061997645;4256.403593807775;111826;113937.86062139439;114419.25099474196;115271;115453;99392.5030374858;100080;101016;101220.49389753152;101381;85799.84553675927;86761.56619216989;86919;87140.5642971781;87714.56142719374;8123.79690507742;8134.186581341818;8134.674613015413;8167.918320816716;8323.916760832315;36471.45292820663;45011;49938.50061499484;50535;51550.22674659958;52443.47556524386;59495.40504594899;74568;74611.62694186495;74949.25050749423;9753.02469753019;9793.314467987457;9797.559109840216;10028.448435335835;10057;10868.293560918515;10912.672619821418;10950.780984380428;10986.176036797113;11322.660320190407;8501.489910605384;10771.084457821173;11188.552457901918;11423.885761142283;11903.404829758305;11394.886051139714;11395.829062563902;11441.485133169193;11807.23252988553;11855.58505452305;11565;11619.825702614298;11765.941170294094;11985;12586.685332866751;9569.473678947725;9790.461524616214;9923.206143508358;10033.247506437192;10125.797484050425;9967.800643987224;10114.393136411838;10141.746456338651;10196.592136314464;10263.332883362558 02:31:31 INFO - PROCESS | 12516 | __end_tp_report 02:31:31 INFO - PROCESS | 12516 | __start_cc_report 02:31:31 INFO - PROCESS | 12516 | _x_x_mozilla_cycle_collect,816 02:31:31 INFO - PROCESS | 12516 | __end_cc_report 02:31:31 INFO - PROCESS | 12516 | __startTimestamp1466242291410__endTimestamp 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | ------- Summary: start ------- 02:31:31 INFO - PROCESS | 12516 | Number of tests: 6 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#0] dojo.html Cycles:165 Average:5396.63 Median:5572.11 stddev:625.48 (11.2%) stddev-sans-first:600.96 02:31:31 INFO - PROCESS | 12516 | Values: 3102.6 3122.2 3130.2 3146.1 3173.4 5333.4 5370.7 5398.4 5508.7 5536.6 5440.8 5458.9 5505.7 5522.6 5578.7 4925.8 4995.9 5023.2 5031.6 5173.7 5085.6 5107.7 5109.0 5131.8 5135.9 4860.6 4897.5 4934.3 4946.4 5061.4 4862.9 4894.4 4894.9 4964.2 5003.0 4915.0 4969.0 4976.7 4982.8 5028.7 5340.2 5382.1 5435.9 5439.1 5462.5 5743.1 5798.5 5822.1 5827.9 5871.0 5855.6 5857.2 5863.6 5872.6 5875.1 5239.7 5371.0 5455.8 5457.9 5529.4 6038.8 6058.6 6058.8 6060.2 6061.0 5569.2 5800.3 5812.6 5818.5 5823.1 5698.2 5781.7 5783.2 5805.5 5810.3 5726.5 5739.2 5763.7 5764.1 5764.2 5646.5 5740.1 5789.5 5791.0 5796.5 4375.5 4395.2 4404.5 4432.8 4433.6 3897.4 3918.6 3937.1 3937.3 3965.8 5364.6 5420.3 5445.9 5450.8 5562.1 5785.3 5850.2 5867.9 5882.7 5910.2 5500.1 5519.0 5520.2 5521.2 5525.2 4603.0 4675.8 4702.1 4717.8 4795.0 6066.8 6074.0 6076.8 6083.9 6115.2 5886.0 5891.8 5896.7 5898.8 5899.1 5915.2 5933.3 5951.2 5952.3 6085.6 5748.7 5751.8 5753.7 5757.3 5759.3 5797.3 5830.5 5859.1 5863.2 5868.9 5558.9 5561.8 5579.2 5626.3 5661.0 5581.6 5642.8 5648.1 5651.7 5656.4 5482.3 5573.4 5573.9 5584.2 5589.1 5595.9 5641.9 5653.7 5736.3 5747.4 5558.7 5561.1 5564.0 5565.6 5572.1 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#1] ext.html Cycles:180 Average:64579.64 Median:41380.40 stddev:139358.09 (336.8%) stddev-sans-first:139666.15 02:31:31 INFO - PROCESS | 12516 | Values: 565.3 601.8 616.1 621.3 625.6 32509.3 35779.3 41191.8 41866.4 41889.2 44338.0 44378.3 44579.1 44591.6 44609.0 8795.3 8945.3 8949.3 8949.5 8950.1 8753.9 8843.4 8859.3 8863.6 8874.6 8895.9 8911.8 8934.3 8934.6 8941.5 8782.8 8824.0 8828.4 8841.2 8847.7 8735.8 8804.6 8813.9 8817.7 8827.1 37471.6 37731.0 37919.2 37972.4 37975.0 3225.5 3401.9 3423.2 3554.9 3981.7 31906.8 32094.2 32150.0 32605.8 33472.5 4084.2 4148.1 4188.5 4213.6 4335.5 341066.0 341667.0 341746.3 342103.0 342494.0 54878.7 54919.0 55264.7 55373.4 55449.2 36837.3 37586.0 37651.6 37700.6 59522.7 13942.9 14033.9 14063.5 14090.6 14095.4 10354.5 10432.4 10452.0 10453.2 10454.2 19196.1 19229.2 19260.6 19291.7 19354.7 6824.8 6901.6 7038.8 7106.6 7172.1 942.6 1018.7 1026.9 1036.4 1159.2 29568.6 29796.4 30031.8 30266.8 30526.4 993.6 1088.9 1136.3 1155.4 1198.2 15878.4 16122.4 16426.1 16598.8 16718.7 536617.0 554242.0 566320.0 567600.0 931846.0 55515.7 55587.4 55898.0 56070.4 56084.7 1241.3 1321.9 1324.8 1332.8 1343.5 29512.0 30565.8 30826.8 32570.8 33160.0 55008.4 55105.2 56436.2 56607.4 61452.7 519364.0 523256.0 525615.0 526917.0 528570.0 36817.8 41861.6 42703.6 43532.0 44529.1 48407.8 49121.5 49204.8 49562.8 50099.0 40388.6 41207.4 41557.4 42074.8 42990.1 40862.7 40909.0 41132.0 41529.2 41684.0 40440.8 40669.0 40787.8 41356.8 41404.0 35551.6 36328.8 36822.0 37029.0 37094.0 27433.7 27547.0 27707.7 27814.3 28018.4 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#2] jquery.html Cycles:180 Average:29593.64 Median:386.05 stddev:77977.67 (20198.6%) stddev-sans-first:78165.57 02:31:31 INFO - PROCESS | 12516 | Values: 380.9 382.3 389.8 402.7 406.9 17834.4 19859.4 20106.4 20422.2 20475.4 17334.0 17555.0 18067.1 18172.6 18235.5 5518.5 5662.4 5782.0 5788.5 5800.1 5676.3 5699.1 5709.1 5729.4 5731.4 5550.9 5667.5 5699.7 6896.9 7371.4 7282.8 7286.7 7426.2 7476.7 7483.4 6955.1 7061.8 7106.9 7111.1 7113.9 23898.3 25412.5 26298.7 26548.6 26619.3 2426.6 2482.3 2507.5 2530.2 2610.3 14486.9 14856.1 15307.5 15462.9 16029.4 2006.8 2007.5 2054.2 2056.8 2056.9 71905.6 74346.0 75513.0 94121.5 97497.0 17347.5 17889.7 18015.8 18036.5 18289.5 31137.8 31226.4 31308.7 31324.8 31494.5 8297.8 8800.2 8872.7 8924.6 9217.2 7431.4 7465.3 7478.2 7612.3 7625.4 8802.6 8820.9 8831.0 8979.6 9116.5 3266.8 3386.3 3498.5 3526.6 3586.4 866.7 910.7 953.8 986.3 1034.6 17643.6 19602.4 19801.0 19809.5 19930.4 984.9 985.8 987.9 991.0 997.9 10546.7 10973.0 11069.7 11104.2 11114.6 450706.0 457371.0 484375.0 484528.0 484541.0 92273.5 96117.5 96503.0 96585.0 96907.0 944.8 946.8 960.5 969.8 970.9 16753.7 16817.7 17095.3 17250.3 17741.3 29361.1 30589.7 34909.7 35637.6 41922.0 59148.4 59476.1 60070.0 60402.1 60797.1 7365.5 7707.3 7819.4 8751.5 9083.3 9486.4 11934.8 11979.5 12986.2 13042.3 11154.6 11786.5 11843.5 11857.3 11933.3 10678.1 11966.7 12146.7 12198.4 12627.2 11696.2 11752.2 11799.0 12213.5 12468.3 8833.6 8898.9 9036.5 9037.0 9161.9 11220.3 11472.8 11711.1 11729.4 12242.0 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#3] mootools.html Cycles:180 Average:5898.88 Median:4758.27 stddev:3444.84 (72.4%) stddev-sans-first:3437.28 02:31:31 INFO - PROCESS | 12516 | Values: 1315.4 1429.7 1481.7 1592.2 1756.2 8367.9 8840.4 8853.4 9089.3 9093.5 8805.8 8976.3 9025.9 9026.1 9035.7 2049.9 2307.7 2359.7 2376.1 2390.2 2406.8 2410.8 2414.7 2415.7 2416.2 2341.7 2352.6 2368.0 2368.3 2370.8 1974.2 2250.1 2314.1 2321.6 2326.9 2197.7 2222.6 2223.3 2224.9 2248.1 9177.4 9246.1 9246.9 9296.1 9299.3 5090.0 5220.3 5232.3 5244.8 5244.9 3260.2 3307.0 3327.0 3412.4 3426.0 1061.2 1074.5 1086.9 1092.5 1097.1 12778.1 12789.9 12796.0 12822.8 12844.2 4756.2 4806.0 4889.0 4898.7 4907.7 10478.3 10510.6 10537.9 10587.4 10593.2 5363.6 5371.0 5372.4 5381.8 5388.2 4219.6 4760.3 4893.6 4903.1 4956.8 3777.7 3914.9 3929.6 3950.8 4015.9 1230.3 1253.2 1260.9 1265.2 1270.0 773.7 861.5 896.4 940.0 976.6 6233.8 6234.8 6275.0 6275.2 6372.4 454.8 455.7 463.5 475.6 478.1 4249.7 4274.1 4349.8 4362.3 4362.7 10966.8 11298.8 11364.4 11393.5 11424.4 10608.2 11014.4 11202.3 11278.3 11306.5 8379.3 8455.2 8551.5 8566.0 8573.5 6183.0 6404.0 6425.1 6497.5 6562.4 10318.8 10321.1 10492.7 10520.1 10577.5 10498.3 10711.6 10727.9 10736.6 10779.9 7386.6 7840.2 8012.9 8115.7 8271.0 8626.3 8632.9 8703.2 8720.7 8725.3 7249.9 7332.5 7393.6 7541.5 7832.2 7414.7 7459.6 7506.7 7574.2 7635.4 6959.5 7007.4 7022.7 7024.9 7029.4 4807.8 4923.3 4965.8 4999.4 5073.8 5101.6 5108.6 5146.8 5227.8 5260.0 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#4] prototype.html Cycles:180 Average:4349.51 Median:4807.71 stddev:1219.38 (25.4%) stddev-sans-first:1184.68 02:31:31 INFO - PROCESS | 12516 | Values: 318.8 327.7 332.9 333.8 336.4 5118.3 5199.3 5242.4 5325.5 5342.3 5170.3 5211.2 5212.8 5255.5 5298.7 4142.4 4162.4 4173.9 4180.9 4224.5 3922.5 3934.9 4084.7 4128.1 4146.3 4104.7 4127.7 4146.4 4150.9 4152.4 4125.6 4126.4 4142.1 4150.5 4151.5 3432.6 3709.7 3714.8 3716.9 3727.1 5137.8 5144.2 5146.8 5152.9 5166.3 4590.9 4671.4 4675.6 4693.7 4694.4 5349.3 5380.2 5483.1 5489.6 5496.8 3922.8 3951.6 3962.5 3965.2 3970.5 5730.5 5764.3 5774.7 5785.7 5785.9 4000.5 4088.8 4102.9 4117.6 4121.5 4096.3 4098.5 4102.7 4112.9 4122.1 4630.0 4649.7 4680.4 4693.6 4700.1 5494.3 5494.5 5587.8 5594.4 5601.9 1314.9 1381.6 1392.7 1398.7 1403.4 863.6 884.0 889.2 893.5 897.9 4684.6 4725.4 4750.6 4752.5 4778.7 4927.8 4956.3 4965.7 4968.5 4983.3 4406.1 4656.4 4743.7 4760.4 4764.0 2681.0 2682.7 2690.4 2721.6 2727.3 5140.6 5152.0 5171.6 5175.5 5185.7 4724.8 4986.7 5039.0 5049.5 5069.9 5066.7 5085.7 5104.6 5119.8 5122.6 4927.6 4962.2 4963.6 4975.0 4991.4 4647.3 4869.4 4916.1 4922.4 4943.5 5054.4 5078.5 5078.8 5079.9 5086.4 3663.2 3680.2 3682.5 3693.9 3697.7 4627.4 4857.8 4996.3 4999.8 5008.2 4791.7 4841.7 4905.3 4906.6 4906.6 4838.7 4853.3 4881.0 4889.8 4899.8 4564.7 4721.0 4788.9 4809.1 4831.0 4879.9 4887.4 4896.9 4919.9 4959.4 4735.9 4751.4 4802.6 4806.4 4814.6 02:31:31 INFO - PROCESS | 12516 | 02:31:31 INFO - PROCESS | 12516 | [#5] yui.html Cycles:180 Average:19751.84 Median:24797.42 stddev:29747.20 (120.0%) stddev-sans-first:29795.94 02:31:31 INFO - PROCESS | 12516 | Values: 613.8 650.8 653.9 694.2 711.5 14226.2 15015.4 15086.3 15091.8 15095.5 14150.9 14675.5 14705.6 15198.9 15200.3 657.1 761.2 773.3 779.6 781.7 767.7 769.6 770.1 771.0 772.4 808.8 816.1 816.2 816.5 816.6 677.9 697.2 697.7 780.6 813.7 595.9 598.0 598.6 598.8 599.7 14548.9 14574.9 14585.3 14605.8 14622.3 12781.8 13090.5 13123.3 13363.2 13597.0 11055.6 11411.3 11523.5 12071.2 12081.4 3714.6 3735.8 3758.1 3788.0 3917.1 74434.6 75434.0 75652.0 75726.6 75728.6 9850.5 10265.5 10570.1 10904.9 10913.7 18851.3 18901.3 18927.7 18955.6 18976.7 7169.2 7443.7 7584.6 7608.0 7758.6 4219.9 4315.4 4374.4 4464.4 4583.8 3390.3 3505.1 3507.7 3510.2 3515.3 610.7 616.0 628.2 629.2 633.2 634.7 651.2 678.5 684.6 706.6 8280.5 8660.9 8667.4 8771.4 8876.5 530.2 545.6 571.9 642.7 651.6 4040.4 4188.6 4232.3 4249.5 4256.4 111826.0 113937.9 114419.3 115271.0 115453.0 99392.5 100080.0 101016.0 101220.5 101381.0 85799.8 86761.6 86919.0 87140.6 87714.6 8123.8 8134.2 8134.7 8167.9 8323.9 36471.5 45011.0 49938.5 50535.0 51550.2 52443.5 59495.4 74568.0 74611.6 74949.3 9753.0 9793.3 9797.6 10028.4 10057.0 10868.3 10912.7 10950.8 10986.2 11322.7 8501.5 10771.1 11188.6 11423.9 11903.4 11394.9 11395.8 11441.5 11807.2 11855.6 11565.0 11619.8 11765.9 11985.0 12586.7 9569.5 9790.5 9923.2 10033.2 10125.8 9967.8 10114.4 10141.7 10196.6 10263.3 02:31:31 INFO - PROCESS | 12516 | -------- Summary: end -------- 02:31:31 INFO - PROCESS | 12516 | 02:31:32 INFO - TEST-INFO | 12516: exit 0 02:31:32 INFO - TEST-OK | dromaeo_css | took 1118655ms 02:31:32 INFO - TEST-START | kraken 02:31:32 INFO - operating with platform_type : linux_ 02:31:32 INFO - Initialising browser for kraken test... 02:31:32 INFO - TEST-INFO | started process 12700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQVLo1/profile http://localhost:43373/getInfo.html) 02:31:38 INFO - PROCESS | 12700 | __metrics Screen width/height:1600/1200 02:31:38 INFO - PROCESS | 12700 | colorDepth:24 02:31:38 INFO - PROCESS | 12700 | Browser inner width/height: 1024/697 02:31:38 INFO - PROCESS | 12700 | __metrics 02:31:40 INFO - PROCESS | 12700 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:41 INFO - PROCESS | 12700 | console.error: PushService: 02:31:41 INFO - PROCESS | 12700 | stateChangeProcessEnqueue: Error transitioning state 02:31:41 INFO - PROCESS | 12700 | UnknownError 02:31:41 INFO - TEST-INFO | 12700: exit 0 02:31:41 INFO - Browser initialized. 02:31:41 INFO - Running cycle 1/1 for kraken test... 02:31:41 INFO - TEST-INFO | started process 12786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQVLo1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:53 INFO - PROCESS | 12786 | RSS: Main: 174202880 02:31:53 INFO - PROCESS | 12786 | 02:31:56 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43373/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:57 INFO - PROCESS | 12786 | RSS: Main: 232808448 02:31:57 INFO - PROCESS | 12786 | 02:31:59 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43373/tests/kraken/driver.html?testName=audio-dft) 02:32:00 INFO - PROCESS | 12786 | RSS: Main: 220213248 02:32:00 INFO - PROCESS | 12786 | 02:32:03 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43373/tests/kraken/driver.html?testName=audio-fft) 02:32:04 INFO - PROCESS | 12786 | RSS: Main: 287457280 02:32:04 INFO - PROCESS | 12786 | 02:32:06 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43373/tests/kraken/driver.html?testName=audio-oscillator) 02:32:06 INFO - PROCESS | 12786 | RSS: Main: 197996544 02:32:06 INFO - PROCESS | 12786 | 02:32:09 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:09 INFO - PROCESS | 12786 | RSS: Main: 202547200 02:32:09 INFO - PROCESS | 12786 | 02:32:12 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43373/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:13 INFO - PROCESS | 12786 | RSS: Main: 237944832 02:32:13 INFO - PROCESS | 12786 | 02:32:16 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43373/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:17 INFO - PROCESS | 12786 | RSS: Main: 233086976 02:32:17 INFO - PROCESS | 12786 | 02:32:20 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43373/tests/kraken/driver.html?testName=json-parse-financial) 02:32:20 INFO - PROCESS | 12786 | RSS: Main: 236093440 02:32:20 INFO - PROCESS | 12786 | 02:32:22 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:22 INFO - PROCESS | 12786 | RSS: Main: 224706560 02:32:22 INFO - PROCESS | 12786 | 02:32:24 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:25 INFO - PROCESS | 12786 | RSS: Main: 229089280 02:32:25 INFO - PROCESS | 12786 | 02:32:27 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:32:28 INFO - PROCESS | 12786 | RSS: Main: 235384832 02:32:28 INFO - PROCESS | 12786 | 02:32:30 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:31 INFO - PROCESS | 12786 | RSS: Main: 240054272 02:32:31 INFO - PROCESS | 12786 | 02:32:33 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:34 INFO - PROCESS | 12786 | RSS: Main: 241418240 02:32:34 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | Cycle 1(1): loaded http://localhost:43373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43373/tests/kraken/driver.html?testName=ai-astar) 02:32:36 INFO - PROCESS | 12786 | RSS: Main: 283848704 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | __start_tp_report 02:32:36 INFO - PROCESS | 12786 | _x_x_mozilla_page_load 02:32:36 INFO - PROCESS | 12786 | _x_x_mozilla_page_load_details 02:32:36 INFO - PROCESS | 12786 | |i|pagename|runs| 02:32:36 INFO - PROCESS | 12786 | |0;ai-astar;111;105;110;108;110;110;109;109;109;109 02:32:36 INFO - PROCESS | 12786 | |1;audio-beat-detection;154;126;134;178;130;153;154;125;191;126 02:32:36 INFO - PROCESS | 12786 | |2;audio-dft;161;161;162;161;161;164;162;161;160;159 02:32:36 INFO - PROCESS | 12786 | |3;audio-fft;73;74;75;115;75;76;75;76;110;75 02:32:36 INFO - PROCESS | 12786 | |4;audio-oscillator;85;85;116;85;86;85;128;86;86;133 02:32:36 INFO - PROCESS | 12786 | |5;imaging-gaussian-blur;117;117;117;117;117;116;118;116;116;117 02:32:36 INFO - PROCESS | 12786 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;146;146 02:32:36 INFO - PROCESS | 12786 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 02:32:36 INFO - PROCESS | 12786 | |8;json-parse-financial;56;56;55;57;57;58;56;55;55;54 02:32:36 INFO - PROCESS | 12786 | |9;json-stringify-tinderbox;62;62;61;61;60;61;61;61;60;61 02:32:36 INFO - PROCESS | 12786 | |10;stanford-crypto-aes;80;79;85;79;80;80;80;86;114;88 02:32:36 INFO - PROCESS | 12786 | |11;stanford-crypto-ccm;124;133;125;127;119;119;130;119;153;125 02:32:36 INFO - PROCESS | 12786 | |12;stanford-crypto-pbkdf2;166;159;159;159;157;160;161;164;164;156 02:32:36 INFO - PROCESS | 12786 | |13;stanford-crypto-sha256-iterative;63;63;66;61;63;70;62;61;62;61 02:32:36 INFO - PROCESS | 12786 | __end_tp_report 02:32:36 INFO - PROCESS | 12786 | __start_cc_report 02:32:36 INFO - PROCESS | 12786 | _x_x_mozilla_cycle_collect,1604 02:32:36 INFO - PROCESS | 12786 | __end_cc_report 02:32:36 INFO - PROCESS | 12786 | __startTimestamp1466242356396__endTimestamp 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | ------- Summary: start ------- 02:32:36 INFO - PROCESS | 12786 | Number of tests: 14 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.63 (1.5%) stddev-sans-first:1.56 02:32:36 INFO - PROCESS | 12786 | Values: 111.0 105.0 110.0 108.0 110.0 110.0 109.0 109.0 109.0 109.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.50 stddev:23.23 (15.1%) stddev-sans-first:24.50 02:32:36 INFO - PROCESS | 12786 | Values: 154.0 126.0 134.0 178.0 130.0 153.0 154.0 125.0 191.0 126.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 02:32:36 INFO - PROCESS | 12786 | Values: 161.0 161.0 162.0 161.0 161.0 164.0 162.0 161.0 160.0 159.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.93 (21.2%) stddev-sans-first:16.53 02:32:36 INFO - PROCESS | 12786 | Values: 73.0 74.0 75.0 115.0 75.0 76.0 75.0 76.0 110.0 75.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:19.87 (23.4%) stddev-sans-first:20.56 02:32:36 INFO - PROCESS | 12786 | Values: 85.0 85.0 116.0 85.0 86.0 85.0 128.0 86.0 86.0 133.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:32:36 INFO - PROCESS | 12786 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 118.0 116.0 116.0 117.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:32:36 INFO - PROCESS | 12786 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 02:32:36 INFO - PROCESS | 12786 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 02:32:36 INFO - PROCESS | 12786 | Values: 56.0 56.0 55.0 57.0 57.0 58.0 56.0 55.0 55.0 54.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 02:32:36 INFO - PROCESS | 12786 | Values: 62.0 62.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:80.00 stddev:10.66 (13.3%) stddev-sans-first:11.15 02:32:36 INFO - PROCESS | 12786 | Values: 80.0 79.0 85.0 79.0 80.0 80.0 80.0 86.0 114.0 88.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.00 stddev:10.16 (8.1%) stddev-sans-first:10.70 02:32:36 INFO - PROCESS | 12786 | Values: 124.0 133.0 125.0 127.0 119.0 119.0 130.0 119.0 153.0 125.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:3.24 (2.0%) stddev-sans-first:2.76 02:32:36 INFO - PROCESS | 12786 | Values: 166.0 159.0 159.0 159.0 157.0 160.0 161.0 164.0 164.0 156.0 02:32:36 INFO - PROCESS | 12786 | 02:32:36 INFO - PROCESS | 12786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.82 (4.5%) stddev-sans-first:2.99 02:32:36 INFO - PROCESS | 12786 | Values: 63.0 63.0 66.0 61.0 63.0 70.0 62.0 61.0 62.0 61.0 02:32:36 INFO - PROCESS | 12786 | -------- Summary: end -------- 02:32:36 INFO - PROCESS | 12786 | 02:32:38 INFO - TEST-INFO | 12786: exit 0 02:32:38 INFO - TEST-OK | kraken | took 66201ms 02:32:38 INFO - SUITE-END | took 1184s 02:32:38 INFO - Completed test suite (00:19:44) 02:32:38 INFO - javascript benchmark 02:32:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.627684677839, 3122.2038380213044, 3130.201798541372, 3146.119086655737, 3173.3653269346123, 5333.4399888011685, 5370.731463426828, 5398.379186393566, 5508.724563771811, 5536.584756143286, 5440.782368705247, 5458.890822183554, 5505.697186654733, 5522.5581953443725, 5578.721063946797, 4925.7537123143875, 4995.875103122433, 5023.196288593826, 5031.622628302874, 5173.663711858736, 5085.618578606601, 5107.744612769366, 5109.003744269869, 5131.794728210867, 5135.897282054357, 4860.586850117745, 4897.534734200228, 4934.309196712463, 4946.40643122824, 5061.417936937262, 4862.878428039292, 4894.437139728905, 4894.923116914273, 4964.230544265644, 5002.974985125051, 4914.950850491521, 4969.0, 4976.676516026447, 4982.82560110398, 5028.723420211887, 5340.172273297645, 5382.138857782736, 5435.864103397446, 5439.102548079562, 5462.5083742462975, 5743.138529220609, 5798.478136967693, 5822.126680997884, 5827.883442331172, 5870.970645146747, 5855.560832937546, 5857.20927674767, 5863.648181109147, 5872.5889187756875, 5875.1187321901625, 5239.685618862881, 5370.9731451342495, 5455.754491047913, 5457.890842183134, 5529.4470552944385, 6038.849028774316, 6058.575899687068, 6058.787942422082, 6060.212172417558, 6061.0, 5569.248151499577, 5800.274965629296, 5812.6221795584, 5818.5054270386645, 5823.068309070613, 5698.230738850285, 5781.682007489629, 5783.248177736868, 5805.535557155417, 5810.331811841608, 5726.484616384545, 5739.196512488255, 5763.6541807491685, 5764.106563482667, 5764.221830052889, 5646.520045796071, 5740.052891272977, 5789.478946894799, 5791.044477661223, 5796.478316951495, 4375.453068366454, 4395.164918665443, 4404.493483249467, 4432.800523976429, 4433.578810013044, 3897.415387691869, 3918.647321741, 3937.114149316438, 3937.3306537888056, 3965.8413663453716, 5364.570834333244, 5420.34955805298, 5445.918311225335, 5450.836474905759, 5562.110062390079, 5785.27684039495, 5850.180974663551, 5867.853303667357, 5882.676452795137, 5910.202122713378, 5500.092484740053, 5519.034169020486, 5520.199571062173, 5521.2270282160525, 5525.198846167284, 4602.976985115053, 4675.836345727883, 4702.106599746037, 4717.764111794465, 4795.0, 6066.817995460143, 6074.0, 6076.787312444043, 6083.908741368795, 6115.174451448997, 5885.970570147122, 5891.823245302648, 5896.705164741831, 5898.764049437975, 5899.056151015817, 5915.171875937286, 5933.347331793413, 5951.22634057587, 5952.315483719254, 6085.604435711842, 5748.741306641127, 5751.798687045934, 5753.683547404766, 5757.309122905278, 5759.280089988752, 5797.304323481209, 5830.47525722687, 5859.121131830089, 5863.1791549184, 5868.882622347443, 5558.91661625084, 5561.833145005657, 5579.16312553104, 5626.2685850839125, 5661.037623604079, 5581.553475722014, 5642.802501912413, 5648.124540696199, 5651.689157096399, 5656.37779844225, 5482.314710661168, 5573.442655734394, 5573.8606534835335, 5584.190292407497, 5589.105743081088, 5595.8880822384135, 5641.9435805641415, 5653.745581448927, 5736.311642602915, 5747.396523364986, 5558.749856256559, 5561.054620714407, 5564.0, 5565.582581306499, 5572.10846264612], "value": 5353.555012331025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2538648983343, 601.7893737191984, 616.0728104203174, 621.2669050520384, 625.5621065254323, 32509.349813003755, 35779.284414311696, 41191.79404102979, 41866.37200441996, 41889.16221675572, 44338.0, 44378.33432498507, 44579.10841783162, 44591.554084459145, 44609.0, 8795.296376289898, 8945.329100317469, 8949.25489529542, 8949.463032218087, 8950.104989501064, 8753.912460875374, 8843.380963332569, 8859.335549833757, 8863.556822158898, 8874.556272186397, 8895.911040889572, 8911.821763564725, 8934.285257179443, 8934.597943092576, 8941.50821704806, 8782.780430489225, 8824.0, 8828.382013259074, 8841.204291613754, 8847.73456796294, 8735.825283494358, 8804.64781408743, 8813.911860881373, 8817.735467935972, 8827.117288271185, 37471.62528374709, 37731.0, 37919.24161516782, 37972.43041354382, 37975.0, 3225.5322978168033, 3401.8639254429795, 3423.246885685145, 3554.893353199408, 3981.6814654827544, 31906.840465797755, 32094.197645058826, 32150.03549893507, 32605.836970814995, 33472.49791253133, 4084.2035803018425, 4148.072971856959, 4188.518320393133, 4213.5786421357925, 4335.544767799367, 341066.0, 341667.0, 341746.29126854456, 342103.0, 342494.0, 54878.725606372514, 54919.0, 55264.72367638136, 55373.446265536826, 55449.168262476094, 36837.26325473529, 37586.0, 37651.62348376536, 37700.62299376971, 59522.70238648866, 13942.86057139436, 14033.85966140346, 14063.507777227953, 14090.647733806736, 14095.436182552583, 10354.53404596795, 10432.426216558162, 10452.0, 10453.163746900229, 10454.163666906628, 19196.136173872208, 19229.230830766894, 19260.614787704446, 19291.710624340645, 19354.709679354823, 6824.761133360308, 6901.585904845625, 7038.753643622551, 7106.5736055836815, 7172.13934327884, 942.59468428575, 1018.674024312213, 1026.90757831794, 1036.362636978268, 1159.1769843411105, 29568.55647165294, 29796.40407191844, 30031.849840750656, 30266.84866575653, 30526.38947221043, 993.6373223773271, 1088.8693356797235, 1136.3466007045981, 1155.3991924199538, 1198.1553005131361, 15878.444254451038, 16122.435714749927, 16426.096564689058, 16598.834011659972, 16718.749218761728, 536617.0, 554242.0, 566320.0, 567600.0, 931846.0, 55515.66905985654, 55587.444125559035, 55898.0, 56070.43929560652, 56084.71957640268, 1241.2924632959307, 1321.881030707241, 1324.8211491448724, 1332.793417020344, 1343.509618989062, 29512.0, 30565.847170764893, 30826.845865771425, 32570.83714581412, 33160.0, 55008.449915500336, 55105.1734223995, 56436.15345769899, 56607.43392566022, 61452.69273653782, 519364.0, 523256.0, 525615.0, 526917.0, 528570.0, 36817.815910920275, 41861.58138418577, 42703.57296426996, 43532.0, 44529.10941781082, 48407.757961209965, 49121.50878491169, 49204.753976231324, 49562.75218623884, 50099.0, 40388.59611403848, 41207.381889272285, 41557.37663934983, 42074.7896260529, 42990.14019719651, 40862.6662867256, 40909.0, 41132.0, 41529.1694166121, 41684.0, 40440.79779601083, 40669.0, 40787.796061020694, 41356.79321603373, 41404.0, 35551.64448355483, 36328.81835590805, 36822.0, 37029.0, 37094.0, 27433.725662743916, 27547.0, 27707.722922770514, 27814.3046423841, 28018.439631207668], "value": 19909.277126365123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.8781190019195, 382.2717722738184, 389.838217139887, 402.71004876488934, 406.8779366190146, 17834.375796847115, 19859.404217873467, 20106.396808095782, 20422.183112675513, 20475.385738427853, 17334.046627435488, 17555.0, 18067.096645167723, 18172.636547269045, 18235.452936411897, 5518.503334699876, 5662.433756624325, 5781.971090144543, 5788.47903688668, 5800.100984347433, 5676.262085928824, 5699.059655156915, 5709.086546152616, 5729.369769325371, 5731.369549349568, 5550.91673624894, 5667.489925906668, 5699.68651724155, 6896.896546551806, 7371.378296774701, 7282.8179295517775, 7286.672099755524, 7426.220246874054, 7476.700931962715, 7483.43874209431, 6955.095837541087, 7061.82345441368, 7106.928930710678, 7111.075560177143, 7113.857722845514, 23898.283051508482, 25412.491750165078, 26298.73701262982, 26548.60177097345, 26619.334516637045, 2426.6410809946487, 2482.2925466242036, 2507.4734305795805, 2530.2029860593852, 2610.3474131467133, 14486.927565362212, 14856.125129348073, 15307.540773776804, 15462.922685386613, 16029.35882564696, 2006.8193862552293, 2007.4880905369184, 2054.157795303933, 2056.794320567946, 2056.9485762855898, 71905.6404717973, 74345.99999999946, 75513.0, 94121.52939235329, 97497.0, 17347.479575612753, 17889.7316540252, 18015.819841801414, 18036.458906232834, 18289.451316460527, 31137.844310778753, 31226.375472490425, 31308.686913131034, 31324.843375782973, 31494.527582086288, 8297.8340433191, 8800.16398442147, 8872.689455869013, 8924.643014279485, 9217.170454658979, 7431.405487560982, 7465.2534746526, 7478.177400485943, 7612.3148916597775, 7625.389968802482, 8802.647894084294, 8820.911790882137, 8831.0, 8979.595918183566, 9116.544172791333, 3266.771326007157, 3386.3396637655915, 3498.475228715713, 3526.594441639193, 3586.3544561978574, 866.7313132928812, 910.7085732565648, 953.7872136642922, 986.2701600815345, 1034.5758239121924, 17643.647127057386, 19602.411927642195, 19801.0, 19809.504762380766, 19930.402087937095, 984.9359791613522, 985.84719368498, 987.8567607696843, 990.9752256193509, 997.9401235925868, 10546.683599492027, 10973.0, 11069.723256918642, 11104.222704410775, 11114.610988615521, 450706.0, 457371.0, 484375.0, 484528.0, 484541.0, 92273.53863230642, 96117.51941240388, 96503.0, 96585.0, 96907.0, 944.8157609266127, 946.7633091727068, 960.4717405427127, 969.7769513012047, 970.9271804614823, 16753.74869376985, 16817.66364672724, 17095.316187352368, 17250.309987600856, 17741.290348386436, 29361.11916642504, 30589.694103058686, 34909.65090349064, 35637.64362356343, 41922.0, 59148.40851591429, 59476.107858383024, 60070.0, 60402.09396858963, 60797.088043678494, 7365.52124111931, 7707.267809558083, 7819.413543984338, 8751.518666473405, 9083.318751093562, 9486.383385079947, 11934.820977685167, 11979.460924258256, 12986.155899866479, 13042.347882605642, 11154.553817847196, 11786.528538858349, 11843.46704398287, 11857.288562686266, 11933.3436660981, 10678.092362148993, 11966.700832479257, 12146.696332591757, 12198.390080495763, 12627.179233349803, 11696.239744416585, 11752.236104653512, 11799.0, 12213.511459541518, 12468.251904885736, 8833.602487888189, 8898.911010889808, 9036.548172591476, 9036.954815225881, 9161.86257206129, 11220.326780393203, 11472.82790758156, 11711.063114950613, 11729.413529323328, 12242.0], "value": 10106.557260361364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.4343632238147, 1429.6854691967767, 1481.6814384907245, 1592.2277695317769, 1756.1833747307498, 8367.874481882769, 8840.425372350792, 8853.380263381558, 9089.27285817133, 9093.454392736425, 8805.779855503615, 8976.326775491832, 9025.909740902589, 9026.142516460943, 9035.683751068715, 2049.9487512812225, 2307.676925230469, 2359.7050368703867, 2376.097083108425, 2390.2470721722602, 2406.8194885383577, 2410.783029527342, 2414.7102347718296, 2415.6738840256603, 2416.178499310234, 2341.7424083350816, 2352.6118190498632, 2368.0, 2368.2658375903525, 2370.8221883358733, 1974.1708482437411, 2250.144944920936, 2314.0628045641542, 2321.616933206019, 2326.941826454335, 2197.6703494475796, 2222.5777102350503, 2223.2552095048177, 2224.877631730254, 2248.1457046322294, 9177.449353038839, 9246.075392460767, 9246.90753092474, 9296.070392960717, 9299.349045566812, 5090.0, 5220.29526013987, 5232.319798426218, 5244.842654720364, 5244.8688782780355, 3260.2175477885376, 3306.9503957440656, 3326.9833650831833, 3412.4028295048515, 3425.9657403425895, 1061.2093989977438, 1074.5164675895878, 1086.9293495922739, 1092.5083712329483, 1097.1277834121893, 12778.10553261272, 12789.936050319782, 12796.0, 12822.80765788514, 12844.229346239255, 4756.240191129235, 4805.951940480621, 4888.951110488921, 4898.706077635354, 4907.705537667752, 10478.266521343585, 10510.579576816994, 10537.89462105369, 10587.364758114538, 10593.205509586658, 5363.570914326844, 5371.0, 5372.382176049804, 5381.838544843661, 5388.164834450667, 4219.578042195817, 4760.309755085563, 4893.559579637849, 4903.068417000758, 4956.776945037482, 3777.660010599059, 3914.921701565953, 3929.646331830149, 3950.7827069511454, 4015.8996025099023, 1230.3479156047308, 1253.160382543698, 1260.8865202131851, 1265.1523479268913, 1269.9746005079846, 773.659589780506, 861.5476874640739, 896.3994123936978, 940.0082912527213, 976.6239997600975, 6233.844153896189, 6234.750609975641, 6275.0, 6275.184226050585, 6372.394622510854, 454.8180727708943, 455.744782921565, 463.5225717510969, 475.6313856761038, 478.0749250200803, 4249.7237679551345, 4274.1451709658195, 4349.760763157993, 4362.258416069276, 4362.738235705804, 10966.780664386668, 11298.774024519464, 11364.374959377148, 11393.544258229744, 11424.428778561205, 10608.20438467118, 11014.44927753609, 11202.327860328407, 11278.323300601825, 11306.547738090549, 8379.329653627696, 8455.239028487342, 8551.486910785372, 8565.95717021411, 8573.485590864568, 6182.969085154546, 6403.96798016007, 6425.132607097982, 6497.480201583957, 6562.409383155348, 10318.845217321596, 10321.122704570196, 10492.737681558023, 10520.10579100785, 10577.471126443494, 10498.265121441425, 10711.625093121704, 10727.892721072689, 10736.570537178426, 10779.946100269448, 7386.630668466662, 7840.176781437867, 8012.919870801451, 8115.715949941724, 8271.0, 8626.266767324847, 8632.91367086321, 8703.216710496086, 8720.738377848675, 8725.258353040063, 7249.927500725136, 7332.486725929134, 7393.55638661682, 7541.509801862861, 7832.216778322122, 7414.703411863465, 7459.589722565311, 7506.699732010877, 7574.204708505527, 7635.389168866366, 6959.478039147186, 7007.404370628554, 7022.719091236293, 7024.859502810017, 7029.3673569379, 4807.807687692453, 4923.261510773269, 4965.801367945386, 4999.425066117443, 5073.7716802743225, 5101.566366858859, 5108.642395032312, 5146.76839542229, 5227.790888364575, 5260.026895024433], "value": 4590.158284280691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.7943776264308, 327.6756011548567, 332.90640246789303, 333.81806915231226, 336.39113205098766, 5118.259791670831, 5199.272101905736, 5242.397124330703, 5325.520703136717, 5342.252084708139, 5170.3020092287625, 5211.166213405856, 5212.817551385702, 5255.500727430888, 5298.682079075248, 4142.357934520139, 4162.438070860426, 4173.853915112972, 4180.874573762792, 4224.471941007374, 3922.5096862892137, 3934.921301573967, 4084.7344922580087, 4128.1330920506725, 4146.295129827921, 4104.671626269891, 4127.711060225771, 4146.419501269825, 4150.8962275943195, 4152.37714342848, 4125.566815484376, 4126.360414135814, 4142.109446469024, 4150.522689890641, 4151.481064866892, 3432.622411534729, 3709.6661300482815, 3714.7585406948733, 3716.9070773230615, 3727.14275716584, 5137.7944882204665, 5144.176931690949, 5146.8198613048735, 5152.948470515322, 5166.276721259027, 4590.885227869297, 4671.369365135697, 4675.649326300541, 4693.671442998992, 4694.436667599875, 5349.304590403222, 5380.192971054373, 5483.122700367961, 5489.615726899118, 5496.7526461309335, 3922.784246866421, 3951.644352008333, 3962.4546426893535, 3965.1871366369824, 3970.50368703912, 5730.484256416901, 5764.337101233328, 5774.653520788766, 5785.652860828406, 5785.942140578582, 4000.5199376074474, 4088.8364465421646, 4102.917941641151, 4117.5882411758585, 4121.52602450716, 4096.26267271888, 4098.4876890388705, 4102.671786257092, 4112.935862782187, 4122.134351786099, 4629.953700463019, 4649.721016739007, 4680.368150299666, 4693.55411235932, 4700.130475861908, 5494.2582751328055, 5494.450554944474, 5587.776488940478, 5594.440555944454, 5601.943980560142, 1314.9408276627576, 1381.6062422209623, 1392.735380277744, 1398.741232871922, 1403.382511694851, 863.6459051788862, 883.9823203535893, 889.235257678396, 893.5398269891011, 897.9191872731485, 4684.594621613503, 4725.362076119749, 4750.619950404029, 4752.500987396274, 4778.713277203379, 4927.831754028216, 4956.281339205795, 4965.726885021359, 4968.478309777493, 4983.327250821165, 4406.1187762447, 4656.41794775653, 4743.739094349844, 4760.357351757469, 4763.976180119077, 2681.0482278791137, 2682.731726827302, 2690.4081102157493, 2721.5781553859183, 2727.2636388175083, 5140.56305214061, 5152.0, 5171.560417364491, 5175.508326708957, 5185.662931909414, 4724.834630787906, 4986.675866068694, 5039.042581909499, 5049.495050494995, 5069.898602028013, 5066.721330326867, 5085.703145697823, 5104.642675012714, 5119.795208191631, 5122.564582010571, 4927.60579153674, 4962.206047032458, 4963.627727920492, 4975.0, 4991.401031876198, 4647.256438969748, 4869.366982292421, 4916.139675556835, 4922.409310882717, 4943.530364615356, 5054.393472783143, 5078.4667609900425, 5078.755704852335, 5079.873003174803, 5086.364204474441, 3663.1757854483594, 3680.2455496622592, 3682.5085840234747, 3693.944590831086, 3697.7226707997547, 4627.352170696173, 4857.805687772591, 4996.300517927566, 4999.825006124768, 5008.223725322581, 4791.688540244873, 4841.709497430165, 4905.264210368473, 4906.552566992675, 4906.582940450102, 4838.7338696372035, 4853.344798452164, 4880.95119048805, 4889.7799599018845, 4899.779509922133, 4564.680472366902, 4720.952790472189, 4788.904221915612, 4809.052333804814, 4830.9854930465, 4879.902401952012, 4887.36464259644, 4896.853094407174, 4919.877003074808, 4959.429665588504, 4735.905281894274, 4751.40607424072, 4802.591779698765, 4806.375171227718, 4814.566688998007], "value": 3965.1809737052245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.8189234175918, 650.8372906773305, 653.9444147247484, 694.1669996004792, 711.4770643576967, 14226.217558034305, 15015.399384024626, 15086.3211155498, 15091.849081509195, 15095.547133585997, 14150.929245353758, 14675.486357977474, 14705.632359191026, 15198.924005379986, 15200.315985780639, 657.0866495571136, 761.2235519769831, 773.2576726342718, 779.5829231361223, 781.6560713286165, 767.7428061599371, 769.5805785846727, 770.0836005153877, 771.0208035794537, 772.4322622872185, 808.8463191993502, 816.147126253067, 816.2123550773503, 816.510093943632, 816.6243527977108, 677.9389854913056, 697.2295613347254, 697.6616341074575, 780.6331024418571, 813.6907974969533, 595.8986972214691, 597.9611325263887, 598.5809933046885, 598.7515181199797, 599.688162155681, 14548.854511454962, 14574.854251457562, 14585.343659535347, 14605.78091328631, 14622.26888655563, 12781.808272875915, 13090.504215046945, 13123.343832808321, 13363.198208107544, 13597.04820662554, 11055.613053543088, 11411.315321080761, 11523.539058437653, 12071.155019148664, 12081.395930203455, 3714.609965953563, 3735.831887565039, 3758.1356288053626, 3787.9621203787883, 3917.0794863207407, 74434.62782686106, 75434.0, 75652.0, 75726.62136689336, 75728.62135689287, 9850.50747462624, 10265.486725663686, 10570.10154136907, 10904.945475272732, 10913.727156820984, 18851.3402030931, 18901.338453154072, 18927.716084258747, 18955.620887582172, 18976.715349269773, 7169.24722904098, 7443.665035073434, 7584.582847943416, 7607.961960190274, 7758.55179028128, 4219.873403797891, 4315.352697095461, 4374.387585737999, 4464.3973063635995, 4583.839565615188, 3390.28803951173, 3505.088676944013, 3507.701845343174, 3510.192655689155, 3515.261795023074, 610.6946526736632, 615.972281247345, 628.1645411602558, 629.2071989293523, 633.1768700689086, 634.6826586706646, 651.2380514797698, 678.5250324772679, 684.5995092870727, 706.5795851468368, 8280.544570048705, 8660.8700869487, 8667.393282470166, 8771.429857059271, 8876.467411955304, 530.1808705549935, 545.5662748115178, 571.8941995730803, 642.6529673976, 651.6025224612982, 4040.4343391925154, 4188.6230239278, 4232.343986682069, 4249.5113061997645, 4256.403593807775, 111826.0, 113937.86062139439, 114419.25099474196, 115271.0, 115453.0, 99392.5030374858, 100080.0, 101016.0, 101220.49389753152, 101381.0, 85799.84553675927, 86761.56619216989, 86919.0, 87140.5642971781, 87714.56142719374, 8123.79690507742, 8134.186581341818, 8134.674613015413, 8167.918320816716, 8323.916760832315, 36471.45292820663, 45011.0, 49938.50061499484, 50535.0, 51550.22674659958, 52443.47556524386, 59495.40504594899, 74568.0, 74611.62694186495, 74949.25050749423, 9753.02469753019, 9793.314467987457, 9797.559109840216, 10028.448435335835, 10057.0, 10868.293560918515, 10912.672619821418, 10950.780984380428, 10986.176036797113, 11322.660320190407, 8501.489910605384, 10771.084457821173, 11188.552457901918, 11423.885761142283, 11903.404829758305, 11394.886051139714, 11395.829062563902, 11441.485133169193, 11807.23252988553, 11855.58505452305, 11565.0, 11619.825702614298, 11765.941170294094, 11985.0, 12586.685332866751, 9569.473678947725, 9790.461524616214, 9923.206143508358, 10033.247506437192, 10125.797484050425, 9967.800643987224, 10114.393136411838, 10141.746456338651, 10196.592136314464, 10263.332883362558], "value": 6908.51169208282, "unit": "score"}], "name": "dromaeo_css", "value": 7166.45279657014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 108.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 134.0, 178.0, 130.0, 153.0, 154.0, 125.0, 191.0, 126.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 164.0, 162.0, 161.0, 160.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 115.0, 75.0, 76.0, 75.0, 76.0, 110.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 86.0, 85.0, 128.0, 86.0, 86.0, 133.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 57.0, 58.0, 56.0, 55.0, 55.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 85.0, 79.0, 80.0, 80.0, 80.0, 86.0, 114.0, 88.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 125.0, 127.0, 119.0, 119.0, 130.0, 119.0, 153.0, 125.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 159.0, 159.0, 157.0, 160.0, 161.0, 164.0, 164.0, 156.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 61.0, 63.0, 70.0, 62.0, 61.0, 62.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1508.4, "alertThreshold": 2.0}]} 02:32:38 INFO - Return code: 0 02:32:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:32:38 INFO - # TBPL SUCCESS # 02:32:38 INFO - Running post-action listener: _resource_record_post_action 02:32:38 INFO - ##### 02:32:38 INFO - ##### Finished run-tests step (success) 02:32:38 INFO - ##### 02:32:38 INFO - Running post-run listener: _resource_record_post_run 02:32:38 INFO - Total resource usage - Wall time: 1204s; CPU: 14.0%; Read bytes: 12288; Write bytes: 401829888; Read time: 1464; Write time: 3184280 02:32:38 INFO - TinderboxPrint: CPU usage
13.7% 02:32:38 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 1,464 02:32:38 INFO - TinderboxPrint: I/O write bytes / time
401,829,888 / 3,184,280 02:32:38 INFO - TinderboxPrint: CPU idle
8,288.8 (86.3%) 02:32:38 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 02:32:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:32:38 INFO - install - Wall time: 19s; CPU: 21.0%; Read bytes: 0; Write bytes: 101703680; Read time: 0; Write time: 1120860 02:32:38 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 12288; Write bytes: 289021952; Read time: 1464; Write time: 1902692 02:32:39 INFO - Running post-run listener: _upload_blobber_files 02:32:39 INFO - Blob upload gear active. 02:32:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:32:39 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 02:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:32:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:32:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:40 INFO - (blobuploader) - INFO - Done attempting. 02:32:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:32:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:43 INFO - (blobuploader) - INFO - Done attempting. 02:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:44 INFO - (blobuploader) - INFO - Done attempting. 02:32:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:32:44 INFO - Return code: 0 02:32:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:32:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:32:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef591bb587163cc1cdc2e4b763d83988f34a9a9a6bae34fdce928827be60d55cfdac1876d20dd36d92ac328e6b4c905734704a0f5ba47c035d2dfec32594422d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84f9c15d28ce19d59ba8ab96f7368c0e94b51588d62ae8b829082f14efb82244ce4f125a426157dc00493ded3582596b1b177a58c87e815c3431fc00af2527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd61e212188d4db172ad3cf65ca56117fe458cea3365c374fe8ef218dec164b6c7549ce745724880032b96d575d818751a3e94b0c644349f51c5c426fc8ce29e"} 02:32:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:32:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:32:44 INFO - Contents: 02:32:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef591bb587163cc1cdc2e4b763d83988f34a9a9a6bae34fdce928827be60d55cfdac1876d20dd36d92ac328e6b4c905734704a0f5ba47c035d2dfec32594422d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84f9c15d28ce19d59ba8ab96f7368c0e94b51588d62ae8b829082f14efb82244ce4f125a426157dc00493ded3582596b1b177a58c87e815c3431fc00af2527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd61e212188d4db172ad3cf65ca56117fe458cea3365c374fe8ef218dec164b6c7549ce745724880032b96d575d818751a3e94b0c644349f51c5c426fc8ce29e"} 02:32:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:32:44 INFO - Copying logs to upload dir... 02:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:32:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.532947 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-06-18 02:32:44.162707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:44.165944) ========= 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=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef591bb587163cc1cdc2e4b763d83988f34a9a9a6bae34fdce928827be60d55cfdac1876d20dd36d92ac328e6b4c905734704a0f5ba47c035d2dfec32594422d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84f9c15d28ce19d59ba8ab96f7368c0e94b51588d62ae8b829082f14efb82244ce4f125a426157dc00493ded3582596b1b177a58c87e815c3431fc00af2527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd61e212188d4db172ad3cf65ca56117fe458cea3365c374fe8ef218dec164b6c7549ce745724880032b96d575d818751a3e94b0c644349f51c5c426fc8ce29e"} build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/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/sha512/ef591bb587163cc1cdc2e4b763d83988f34a9a9a6bae34fdce928827be60d55cfdac1876d20dd36d92ac328e6b4c905734704a0f5ba47c035d2dfec32594422d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84f9c15d28ce19d59ba8ab96f7368c0e94b51588d62ae8b829082f14efb82244ce4f125a426157dc00493ded3582596b1b177a58c87e815c3431fc00af2527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd61e212188d4db172ad3cf65ca56117fe458cea3365c374fe8ef218dec164b6c7549ce745724880032b96d575d818751a3e94b0c644349f51c5c426fc8ce29e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:44.194424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:44.195099) ========= 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=33d5923976266a1c518c4bf7000001ab-1466238304.721002-266585328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004344 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:44.279016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:32:44.279731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:32:44.280302) ========= ========= Total master_lag: 0.18 =========