builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1466662525.39 results: success (0) buildid: 20160622203037 builduid: 3bd9b7c0bcc44ce08e5c2d2c485b41c1 revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.388887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.389440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.389763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.410407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.410729) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 23:15:25-- 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% 221M=0s 2016-06-22 23:15:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.549724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.550030) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018677 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.607585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:25.608183) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --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 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 23:15:25,769 truncating revision to first 12 chars 2016-06-22 23:15:25,769 Setting DEBUG logging. 2016-06-22 23:15:25,769 attempt 1/10 2016-06-22 23:15:25,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3724c3955693?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 23:15:26,124 unpacking tar archive at: fx-team-3724c3955693/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698053 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:26.363552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:26.363823) ========= script_repo_revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:26.364174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:26.364447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 23:15:26.373693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 11 secs) (at 2016-06-22 23:15:26.373962) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:15:26 INFO - MultiFileLogger online at 20160622 23:15:26 in /builds/slave/test 23:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:15:26 INFO - {'append_to_log': False, 23:15:26 INFO - 'base_work_dir': '/builds/slave/test', 23:15:26 INFO - 'blob_upload_branch': 'Fx-Team', 23:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:15:26 INFO - 'branch': 'Fx-Team', 23:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:15:26 INFO - 'config_files': ('talos/linux_config.py',), 23:15:26 INFO - 'default_actions': ('clobber', 23:15:26 INFO - 'read-buildbot-config', 23:15:26 INFO - 'download-and-extract', 23:15:26 INFO - 'populate-webroot', 23:15:26 INFO - 'create-virtualenv', 23:15:26 INFO - 'install', 23:15:26 INFO - 'run-tests'), 23:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:15:26 INFO - 'download_minidump_stackwalk': True, 23:15:26 INFO - 'download_symbols': 'ondemand', 23:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:15:26 INFO - 'installer_path': 'installer.exe', 23:15:26 INFO - 'log_level': 'info', 23:15:26 INFO - 'log_name': 'talos', 23:15:26 INFO - 'log_to_console': True, 23:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:15:26 INFO - 'opt_config_files': (), 23:15:26 INFO - 'pip_index': False, 23:15:26 INFO - 'sps_profile': False, 23:15:26 INFO - 'sps_profile_interval': 0, 23:15:26 INFO - 'suite': 'dromaeojs-e10s', 23:15:26 INFO - 'system_bits': '32', 23:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:15:26 INFO - 'title': 'talos-linux64-ix-064', 23:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:15:26 INFO - 'use_talos_json': True, 23:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:15:26 INFO - 'work_dir': 'build'} 23:15:26 INFO - ##### 23:15:26 INFO - ##### Running clobber step. 23:15:26 INFO - ##### 23:15:26 INFO - Running pre-action listener: _resource_record_pre_action 23:15:26 INFO - Running main action method: clobber 23:15:26 INFO - rmtree: /builds/slave/test/build 23:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:15:27 INFO - Running post-action listener: _resource_record_post_action 23:15:27 INFO - ##### 23:15:27 INFO - ##### Finished clobber step (success) 23:15:27 INFO - ##### 23:15:27 INFO - ##### 23:15:27 INFO - ##### Running read-buildbot-config step. 23:15:27 INFO - ##### 23:15:27 INFO - Running pre-action listener: _resource_record_pre_action 23:15:27 INFO - Running main action method: read_buildbot_config 23:15:27 INFO - Using buildbot properties: 23:15:27 INFO - { 23:15:27 INFO - "project": "", 23:15:27 INFO - "product": "firefox", 23:15:27 INFO - "script_repo_revision": "production", 23:15:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:15:27 INFO - "repository": "", 23:15:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:15:27 INFO - "buildid": "20160622203037", 23:15:27 INFO - "pgo_build": "True", 23:15:27 INFO - "basedir": "/builds/slave/test", 23:15:27 INFO - "buildnumber": 495, 23:15:27 INFO - "slavename": "talos-linux64-ix-064", 23:15:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:15:27 INFO - "platform": "ubuntu64_hw", 23:15:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:15:27 INFO - "branch": "fx-team", 23:15:27 INFO - "repo_path": "integration/fx-team", 23:15:27 INFO - "revision": "3724c395569322ea7f9fbf4a76d8b0734e9b8cda", 23:15:27 INFO - "stage_platform": "linux64-pgo", 23:15:27 INFO - "builduid": "3bd9b7c0bcc44ce08e5c2d2c485b41c1", 23:15:27 INFO - "slavebuilddir": "test" 23:15:27 INFO - } 23:15:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:15:27 INFO - Running post-action listener: _resource_record_post_action 23:15:27 INFO - ##### 23:15:27 INFO - ##### Finished read-buildbot-config step (success) 23:15:27 INFO - ##### 23:15:27 INFO - ##### 23:15:27 INFO - ##### Running download-and-extract step. 23:15:27 INFO - ##### 23:15:27 INFO - Running pre-action listener: _resource_record_pre_action 23:15:27 INFO - Running main action method: download_and_extract 23:15:27 INFO - mkdir: /builds/slave/test/build/tests 23:15:27 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')]} 23:15:27 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:29 INFO - Downloaded 1361 bytes. 23:15:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:15:29 INFO - Using the following test package requirements: 23:15:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:15:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:15:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'jsshell-linux-x86_64.zip'], 23:15:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:15:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:15:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:15:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:15:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:15:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:29 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:30 INFO - Downloaded 24269895 bytes. 23:15:30 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'] 23:15:30 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 23:15:32 INFO - Return code: 0 23:15:32 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 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:32 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:41 INFO - Downloaded 24269895 bytes. 23:15: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'] 23:15: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 23:15:43 INFO - Return code: 0 23:15: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')]} 23:15:43 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:44 INFO - Downloaded 14405384 bytes. 23:15:44 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'] 23:15:44 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 23:15:44 INFO - Return code: 0 23:15:44 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')]} 23:15:44 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/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 23:15:45 INFO - Downloaded 60156108 bytes. 23:15:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:15:45 INFO - mkdir: /builds/slave/test/properties 23:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 23:15:45 INFO - Contents: 23:15:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:15:46 INFO - Running post-action listener: _resource_record_post_action 23:15:46 INFO - Running post-action listener: set_extra_try_arguments 23:15:46 INFO - ##### 23:15:46 INFO - ##### Finished download-and-extract step (success) 23:15:46 INFO - ##### 23:15:46 INFO - ##### 23:15:46 INFO - ##### Running populate-webroot step. 23:15:46 INFO - ##### 23:15:46 INFO - Running pre-action listener: _resource_record_pre_action 23:15:46 INFO - Running main action method: populate_webroot 23:15:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:15:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:15:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:15:46 INFO - '--tppagecycles', 23:15:46 INFO - '7'], 23:15:46 INFO - 'tests': ['tsvgm']}}, 23:15:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:15:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:15:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:15:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:15:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['damp', 'tps']}, 23:15:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'tests': ['damp', 'tps']}, 23:15:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['dromaeo_dom']}, 23:15:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:15:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['basic_compositor_video']}, 23:15:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:15:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'other-e10s': {'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['a11yr', 23:15:46 INFO - 'ts_paint', 23:15:46 INFO - 'tpaint', 23:15:46 INFO - 'sessionrestore', 23:15:46 INFO - 'sessionrestore_no_auto_restore', 23:15:46 INFO - 'tabpaint']}, 23:15:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['tsvgx', 23:15:46 INFO - 'tsvgr_opacity', 23:15:46 INFO - 'tart', 23:15:46 INFO - 'tscrollx', 23:15:46 INFO - 'cart']}, 23:15:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:15:46 INFO - 'tsvgr_opacity', 23:15:46 INFO - 'tart', 23:15:46 INFO - 'tscrollx', 23:15:46 INFO - 'cart']}, 23:15:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'talos_options': ['--disable-e10s'], 23:15:46 INFO - 'tests': ['tp5o']}, 23:15:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'tests': ['tp5o']}, 23:15:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'talos_options': ['--disable-e10s', 23:15:46 INFO - '--xperf_path', 23:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:46 INFO - 'tests': ['tp5n']}, 23:15:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:46 INFO - 'talos_options': ['--xperf_path', 23:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:46 INFO - 'tests': ['tp5n']}}, 23:15:46 INFO - 'talos.zip': {'path': '', 23:15:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:15:46 INFO - Running post-action listener: _resource_record_post_action 23:15:46 INFO - ##### 23:15:46 INFO - ##### Finished populate-webroot step (success) 23:15:46 INFO - ##### 23:15:46 INFO - ##### 23:15:46 INFO - ##### Running create-virtualenv step. 23:15:46 INFO - ##### 23:15:46 INFO - Running pre-action listener: _resource_record_pre_action 23:15:46 INFO - Running main action method: create_virtualenv 23:15:46 INFO - Creating virtualenv /builds/slave/test/build/venv 23:15:46 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 23:15:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:15:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:15:46 INFO - Using real prefix '/usr' 23:15:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:15:47 INFO - Installing distribute.............................................................................................................................................................................................done. 23:15:49 INFO - Installing pip.................done. 23:15:49 INFO - Return code: 0 23:15:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:15:49 INFO - Using env: {'DISPLAY': ':0', 23:15:49 INFO - 'HOME': '/home/cltbld', 23:15:49 INFO - 'LANG': 'en_US.UTF-8', 23:15:49 INFO - 'LANGUAGE': 'en_US:en', 23:15:49 INFO - 'LOGNAME': 'cltbld', 23:15:49 INFO - 'MAIL': '/var/mail/cltbld', 23:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:49 INFO - 'MOZ_NO_REMOTE': '1', 23:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:49 INFO - 'NO_EM_RESTART': '1', 23:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:49 INFO - 'PWD': '/builds/slave/test', 23:15:49 INFO - 'SHELL': '/bin/bash', 23:15:49 INFO - 'SHLVL': '1', 23:15:49 INFO - 'TERM': 'linux', 23:15:49 INFO - 'TMOUT': '86400', 23:15:49 INFO - 'USER': 'cltbld', 23:15:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:49 INFO - '_': '/tools/buildbot/bin/python'} 23:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:49 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 23:15:49 INFO - Cleaning up... 23:15:49 INFO - Return code: 0 23:15:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:15:49 INFO - Using env: {'DISPLAY': ':0', 23:15:49 INFO - 'HOME': '/home/cltbld', 23:15:49 INFO - 'LANG': 'en_US.UTF-8', 23:15:49 INFO - 'LANGUAGE': 'en_US:en', 23:15:49 INFO - 'LOGNAME': 'cltbld', 23:15:49 INFO - 'MAIL': '/var/mail/cltbld', 23:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:49 INFO - 'MOZ_NO_REMOTE': '1', 23:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:49 INFO - 'NO_EM_RESTART': '1', 23:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:49 INFO - 'PWD': '/builds/slave/test', 23:15:49 INFO - 'SHELL': '/bin/bash', 23:15:49 INFO - 'SHLVL': '1', 23:15:49 INFO - 'TERM': 'linux', 23:15:49 INFO - 'TMOUT': '86400', 23:15:49 INFO - 'USER': 'cltbld', 23:15:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:49 INFO - '_': '/tools/buildbot/bin/python'} 23:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:49 INFO - Downloading/unpacking psutil>=3.1.1 23:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:51 INFO - Installing collected packages: psutil 23:15:51 INFO - Running setup.py install for psutil 23:15:51 INFO - building 'psutil._psutil_linux' extension 23:15:51 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 23:15:51 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 23:15:51 INFO - building 'psutil._psutil_posix' extension 23:15:51 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 23:15:52 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 23:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:52 INFO - Successfully installed psutil 23:15:52 INFO - Cleaning up... 23:15:52 INFO - Return code: 0 23:15:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:15: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')]} 23:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15: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')]} 23:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:52 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:15:52 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 23:15:52 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 23:15:52 INFO - Using env: {'DISPLAY': ':0', 23:15:52 INFO - 'HOME': '/home/cltbld', 23:15:52 INFO - 'LANG': 'en_US.UTF-8', 23:15:52 INFO - 'LANGUAGE': 'en_US:en', 23:15:52 INFO - 'LOGNAME': 'cltbld', 23:15:52 INFO - 'MAIL': '/var/mail/cltbld', 23:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:52 INFO - 'MOZ_NO_REMOTE': '1', 23:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:52 INFO - 'NO_EM_RESTART': '1', 23:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:52 INFO - 'PWD': '/builds/slave/test', 23:15:52 INFO - 'SHELL': '/bin/bash', 23:15:52 INFO - 'SHLVL': '1', 23:15:52 INFO - 'TERM': 'linux', 23:15:52 INFO - 'TMOUT': '86400', 23:15:52 INFO - 'USER': 'cltbld', 23:15:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:52 INFO - '_': '/tools/buildbot/bin/python'} 23:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:15:52 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 23:15:52 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 23:15:52 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 23:15:52 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 23:15:52 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 23:15:52 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 23:15:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:15:54 INFO - Installing collected packages: mozsystemmonitor 23:15:54 INFO - Running setup.py install for mozsystemmonitor 23:15:54 INFO - Successfully installed mozsystemmonitor 23:15:54 INFO - Cleaning up... 23:15:54 INFO - Return code: 0 23:15:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:54 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:15:54 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 23:15:54 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 23:15:54 INFO - Using env: {'DISPLAY': ':0', 23:15:54 INFO - 'HOME': '/home/cltbld', 23:15:54 INFO - 'LANG': 'en_US.UTF-8', 23:15:54 INFO - 'LANGUAGE': 'en_US:en', 23:15:54 INFO - 'LOGNAME': 'cltbld', 23:15:54 INFO - 'MAIL': '/var/mail/cltbld', 23:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:54 INFO - 'MOZ_NO_REMOTE': '1', 23:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:54 INFO - 'NO_EM_RESTART': '1', 23:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:54 INFO - 'PWD': '/builds/slave/test', 23:15:54 INFO - 'SHELL': '/bin/bash', 23:15:54 INFO - 'SHLVL': '1', 23:15:54 INFO - 'TERM': 'linux', 23:15:54 INFO - 'TMOUT': '86400', 23:15:54 INFO - 'USER': 'cltbld', 23:15:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:54 INFO - '_': '/tools/buildbot/bin/python'} 23:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:54 INFO - Downloading/unpacking jsonschema==2.5.1 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:56 INFO - warning: no files found matching '*.txt' 23:15:56 INFO - no previously-included directories found matching 'build' 23:15:56 INFO - no previously-included directories found matching 'dist' 23:15:56 INFO - no previously-included directories found matching '.git*' 23:15:56 INFO - Installing collected packages: jsonschema, functools32 23:15:56 INFO - Running setup.py install for functools32 23:15:57 INFO - warning: no files found matching '*.txt' 23:15:57 INFO - no previously-included directories found matching 'build' 23:15:57 INFO - no previously-included directories found matching 'dist' 23:15:57 INFO - no previously-included directories found matching '.git*' 23:15:57 INFO - Successfully installed jsonschema functools32 23:15:57 INFO - Cleaning up... 23:15:57 INFO - Return code: 0 23:15:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:57 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:15:57 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 23:15:57 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 23:15:57 INFO - Using env: {'DISPLAY': ':0', 23:15:57 INFO - 'HOME': '/home/cltbld', 23:15:57 INFO - 'LANG': 'en_US.UTF-8', 23:15:57 INFO - 'LANGUAGE': 'en_US:en', 23:15:57 INFO - 'LOGNAME': 'cltbld', 23:15:57 INFO - 'MAIL': '/var/mail/cltbld', 23:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:57 INFO - 'MOZ_NO_REMOTE': '1', 23:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:57 INFO - 'NO_EM_RESTART': '1', 23:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:57 INFO - 'PWD': '/builds/slave/test', 23:15:57 INFO - 'SHELL': '/bin/bash', 23:15:57 INFO - 'SHLVL': '1', 23:15:57 INFO - 'TERM': 'linux', 23:15:57 INFO - 'TMOUT': '86400', 23:15:57 INFO - 'USER': 'cltbld', 23:15:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:57 INFO - '_': '/tools/buildbot/bin/python'} 23:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:57 INFO - Downloading/unpacking blobuploader==1.2.4 23:15:57 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 23:15:57 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 23:15:57 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 23:15:57 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 23:15:57 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 23:15:57 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 23:15:59 INFO - Downloading blobuploader-1.2.4.tar.gz 23:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:15:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:15:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:00 INFO - Downloading docopt-0.6.1.tar.gz 23:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:00 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:00 INFO - Running setup.py install for blobuploader 23:16:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:00 INFO - Running setup.py install for requests 23:16:00 INFO - Running setup.py install for docopt 23:16:00 INFO - Successfully installed blobuploader requests docopt 23:16:00 INFO - Cleaning up... 23:16:00 INFO - Return code: 0 23:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:00 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:16:00 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 23:16:00 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 23:16:00 INFO - Using env: {'DISPLAY': ':0', 23:16:00 INFO - 'HOME': '/home/cltbld', 23:16:00 INFO - 'LANG': 'en_US.UTF-8', 23:16:00 INFO - 'LANGUAGE': 'en_US:en', 23:16:00 INFO - 'LOGNAME': 'cltbld', 23:16:00 INFO - 'MAIL': '/var/mail/cltbld', 23:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:00 INFO - 'MOZ_NO_REMOTE': '1', 23:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:00 INFO - 'NO_EM_RESTART': '1', 23:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:00 INFO - 'PWD': '/builds/slave/test', 23:16:00 INFO - 'SHELL': '/bin/bash', 23:16:00 INFO - 'SHLVL': '1', 23:16:00 INFO - 'TERM': 'linux', 23:16:00 INFO - 'TMOUT': '86400', 23:16:00 INFO - 'USER': 'cltbld', 23:16:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:00 INFO - '_': '/tools/buildbot/bin/python'} 23:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:00 INFO - Running setup.py (path:/tmp/pip-gcnLy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:01 INFO - Running setup.py (path:/tmp/pip-gy55YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:01 INFO - Running setup.py (path:/tmp/pip-7DP4fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:01 INFO - Running setup.py (path:/tmp/pip-Go_yuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:01 INFO - Running setup.py (path:/tmp/pip-_S0DSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:01 INFO - Running setup.py (path:/tmp/pip-gKWiZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:01 INFO - Running setup.py (path:/tmp/pip-1ZTM0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:01 INFO - Running setup.py (path:/tmp/pip-I8APCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:01 INFO - Running setup.py (path:/tmp/pip-00FjB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:01 INFO - Running setup.py (path:/tmp/pip-1jZYH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:01 INFO - Running setup.py (path:/tmp/pip-QqL9OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:01 INFO - Running setup.py (path:/tmp/pip-zPJbuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:01 INFO - Running setup.py (path:/tmp/pip-dONRIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:01 INFO - Running setup.py (path:/tmp/pip-ZvWf9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:02 INFO - Running setup.py (path:/tmp/pip-yIwWrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:02 INFO - Running setup.py (path:/tmp/pip-7zd9TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:02 INFO - Running setup.py (path:/tmp/pip-p3GQEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:02 INFO - Running setup.py install for manifestparser 23:16:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:02 INFO - Running setup.py install for mozcrash 23:16:02 INFO - Running setup.py install for mozdebug 23:16:02 INFO - Running setup.py install for mozdevice 23:16:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:02 INFO - Running setup.py install for mozfile 23:16:02 INFO - Running setup.py install for mozhttpd 23:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:02 INFO - Running setup.py install for mozinfo 23:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:02 INFO - Running setup.py install for mozInstall 23:16:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Running setup.py install for mozleak 23:16:03 INFO - Running setup.py install for mozlog 23:16:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Running setup.py install for moznetwork 23:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Running setup.py install for mozprocess 23:16:03 INFO - Running setup.py install for mozprofile 23:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Running setup.py install for mozrunner 23:16:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:03 INFO - Running setup.py install for mozscreenshot 23:16:03 INFO - Running setup.py install for moztest 23:16:03 INFO - Running setup.py install for mozversion 23:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:04 INFO - Cleaning up... 23:16:04 INFO - Return code: 0 23:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:04 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')]} 23:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:04 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')]} 23:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:04 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:16:04 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 23:16:04 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 23:16:04 INFO - Using env: {'DISPLAY': ':0', 23:16:04 INFO - 'HOME': '/home/cltbld', 23:16:04 INFO - 'LANG': 'en_US.UTF-8', 23:16:04 INFO - 'LANGUAGE': 'en_US:en', 23:16:04 INFO - 'LOGNAME': 'cltbld', 23:16:04 INFO - 'MAIL': '/var/mail/cltbld', 23:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:04 INFO - 'MOZ_NO_REMOTE': '1', 23:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:04 INFO - 'NO_EM_RESTART': '1', 23:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:04 INFO - 'PWD': '/builds/slave/test', 23:16:04 INFO - 'SHELL': '/bin/bash', 23:16:04 INFO - 'SHLVL': '1', 23:16:04 INFO - 'TERM': 'linux', 23:16:04 INFO - 'TMOUT': '86400', 23:16:04 INFO - 'USER': 'cltbld', 23:16:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:04 INFO - '_': '/tools/buildbot/bin/python'} 23:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:04 INFO - Running setup.py (path:/tmp/pip-DqBq9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:04 INFO - Running setup.py (path:/tmp/pip-S2rQJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:04 INFO - Running setup.py (path:/tmp/pip-BUxur7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:04 INFO - Running setup.py (path:/tmp/pip-AH6UMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:04 INFO - Running setup.py (path:/tmp/pip-xt13t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:04 INFO - Running setup.py (path:/tmp/pip-vo0GaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:04 INFO - Running setup.py (path:/tmp/pip-sv5b5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:04 INFO - Running setup.py (path:/tmp/pip-9wr72w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:04 INFO - Running setup.py (path:/tmp/pip-WOznvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:04 INFO - Running setup.py (path:/tmp/pip-qLRyEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:04 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)) 23:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:04 INFO - Running setup.py (path:/tmp/pip-DQgxgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:05 INFO - Running setup.py (path:/tmp/pip-HoZf_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:05 INFO - Running setup.py (path:/tmp/pip-uDiXfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:05 INFO - Running setup.py (path:/tmp/pip-DpXA7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:05 INFO - Running setup.py (path:/tmp/pip-PgfAOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:05 INFO - Running setup.py (path:/tmp/pip-fXd9je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:05 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)) 23:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:05 INFO - Running setup.py (path:/tmp/pip-PrKfI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:05 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)) 23:16:05 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)) 23:16:05 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)) 23:16:05 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)) 23:16:05 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)) 23:16:05 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)) 23:16:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:07 INFO - Downloading blessings-1.6.tar.gz 23:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:16:07 INFO - Installing collected packages: blessings 23:16:07 INFO - Running setup.py install for blessings 23:16:07 INFO - Successfully installed blessings 23:16:07 INFO - Cleaning up... 23:16:07 INFO - Return code: 0 23:16:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:07 INFO - Reading from file tmpfile_stdout 23:16:07 INFO - Current package versions: 23:16:07 INFO - argparse == 1.2.1 23:16:07 INFO - blessings == 1.6 23:16:07 INFO - blobuploader == 1.2.4 23:16:07 INFO - docopt == 0.6.1 23:16:07 INFO - functools32 == 3.2.3-2 23:16:07 INFO - jsonschema == 2.5.1 23:16:07 INFO - manifestparser == 1.1 23:16:07 INFO - mozInstall == 1.12 23:16:07 INFO - mozcrash == 0.17 23:16:07 INFO - mozdebug == 0.1 23:16:07 INFO - mozdevice == 0.48 23:16:07 INFO - mozfile == 1.2 23:16:07 INFO - mozhttpd == 0.7 23:16:07 INFO - mozinfo == 0.9 23:16:07 INFO - mozleak == 0.1 23:16:07 INFO - mozlog == 3.2 23:16:07 INFO - moznetwork == 0.27 23:16:07 INFO - mozprocess == 0.22 23:16:07 INFO - mozprofile == 0.28 23:16:07 INFO - mozrunner == 6.11 23:16:07 INFO - mozscreenshot == 0.1 23:16:07 INFO - mozsystemmonitor == 0.3 23:16:07 INFO - moztest == 0.7 23:16:07 INFO - mozversion == 1.4 23:16:07 INFO - psutil == 3.1.1 23:16:07 INFO - requests == 1.2.3 23:16:07 INFO - wsgiref == 0.1.2 23:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:07 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')]} 23:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:07 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')]} 23:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:07 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 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:16:07 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 23:16:07 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 23:16:07 INFO - Using env: {'DISPLAY': ':0', 23:16:07 INFO - 'HOME': '/home/cltbld', 23:16:07 INFO - 'LANG': 'en_US.UTF-8', 23:16:07 INFO - 'LANGUAGE': 'en_US:en', 23:16:07 INFO - 'LOGNAME': 'cltbld', 23:16:07 INFO - 'MAIL': '/var/mail/cltbld', 23:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:07 INFO - 'MOZ_NO_REMOTE': '1', 23:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:07 INFO - 'NO_EM_RESTART': '1', 23:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:07 INFO - 'PWD': '/builds/slave/test', 23:16:07 INFO - 'SHELL': '/bin/bash', 23:16:07 INFO - 'SHLVL': '1', 23:16:07 INFO - 'TERM': 'linux', 23:16:07 INFO - 'TMOUT': '86400', 23:16:07 INFO - 'USER': 'cltbld', 23:16:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:07 INFO - '_': '/tools/buildbot/bin/python'} 23:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 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)) 23:16:08 INFO - Cleaning up... 23:16:08 INFO - Return code: 0 23:16:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:16: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', 'jsonschema'] in /builds/slave/test/build 23:16: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 jsonschema 23:16:08 INFO - Using env: {'DISPLAY': ':0', 23:16:08 INFO - 'HOME': '/home/cltbld', 23:16:08 INFO - 'LANG': 'en_US.UTF-8', 23:16:08 INFO - 'LANGUAGE': 'en_US:en', 23:16:08 INFO - 'LOGNAME': 'cltbld', 23:16:08 INFO - 'MAIL': '/var/mail/cltbld', 23:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:08 INFO - 'MOZ_NO_REMOTE': '1', 23:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:08 INFO - 'NO_EM_RESTART': '1', 23:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:08 INFO - 'PWD': '/builds/slave/test', 23:16:08 INFO - 'SHELL': '/bin/bash', 23:16:08 INFO - 'SHLVL': '1', 23:16:08 INFO - 'TERM': 'linux', 23:16:08 INFO - 'TMOUT': '86400', 23:16:08 INFO - 'USER': 'cltbld', 23:16:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:08 INFO - '_': '/tools/buildbot/bin/python'} 23:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:16:08 INFO - Cleaning up... 23:16:08 INFO - Return code: 0 23:16:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa164b42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', '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 23:16: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', 'flake8'] in /builds/slave/test/build 23:16: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 flake8 23:16:08 INFO - Using env: {'DISPLAY': ':0', 23:16:08 INFO - 'HOME': '/home/cltbld', 23:16:08 INFO - 'LANG': 'en_US.UTF-8', 23:16:08 INFO - 'LANGUAGE': 'en_US:en', 23:16:08 INFO - 'LOGNAME': 'cltbld', 23:16:08 INFO - 'MAIL': '/var/mail/cltbld', 23:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:08 INFO - 'MOZ_NO_REMOTE': '1', 23:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:08 INFO - 'NO_EM_RESTART': '1', 23:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:08 INFO - 'PWD': '/builds/slave/test', 23:16:08 INFO - 'SHELL': '/bin/bash', 23:16:08 INFO - 'SHLVL': '1', 23:16:08 INFO - 'TERM': 'linux', 23:16:08 INFO - 'TMOUT': '86400', 23:16:08 INFO - 'USER': 'cltbld', 23:16:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:08 INFO - '_': '/tools/buildbot/bin/python'} 23:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:08 INFO - Downloading/unpacking flake8 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:16:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:16:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:16:11 INFO - no previously-included directories found matching 'docs/_build' 23:16:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:16:11 INFO - Running setup.py install for pep8 23:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:16:11 INFO - no previously-included directories found matching 'docs/_build' 23:16:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:16:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:16:11 INFO - Cleaning up... 23:16:11 INFO - Return code: 0 23:16:11 INFO - Running post-action listener: _resource_record_post_action 23:16:11 INFO - Running post-action listener: _start_resource_monitoring 23:16:11 INFO - Starting resource monitoring. 23:16:11 INFO - ##### 23:16:11 INFO - ##### Finished create-virtualenv step (success) 23:16:11 INFO - ##### 23:16:11 INFO - ##### 23:16:11 INFO - ##### Running install step. 23:16:11 INFO - ##### 23:16:11 INFO - Running pre-action listener: _resource_record_pre_action 23:16:11 INFO - Running main action method: install 23:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:11 INFO - Reading from file tmpfile_stdout 23:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 23:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:16:11 INFO - Reading from file tmpfile_stdout 23:16:11 INFO - Output received: 23:16:11 INFO - Usage: mozinstall [options] installer 23:16:11 INFO - Options: 23:16:11 INFO - -h, --help show this help message and exit 23:16:11 INFO - -d DEST, --destination=DEST 23:16:11 INFO - Directory to install application into. [default: 23:16:11 INFO - "/builds/slave/test"] 23:16:11 INFO - --app=APP Application being installed. [default: firefox] 23:16:11 INFO - mkdir: /builds/slave/test/build/application 23:16:11 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'] 23:16:11 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 23:16:28 INFO - Reading from file tmpfile_stdout 23:16:28 INFO - Output received: 23:16:28 INFO - /builds/slave/test/build/application/firefox/firefox 23:16:28 INFO - Running post-action listener: _resource_record_post_action 23:16:28 INFO - ##### 23:16:28 INFO - ##### Finished install step (success) 23:16:28 INFO - ##### 23:16:28 INFO - ##### 23:16:28 INFO - ##### Running run-tests step. 23:16:28 INFO - ##### 23:16:28 INFO - Running pre-action listener: _resource_record_pre_action 23:16:28 INFO - Running main action method: run_tests 23:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:16:28 INFO - Python 2.7.3 23:16:28 INFO - Return code: 0 23:16:28 INFO - grabbing minidump binary from tooltool 23:16: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')]} 23:16:28 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 0x1ca01c0>, '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 0x1ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:16:28 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 23:16:28 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 23:16:28 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 23:16:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:16:28 INFO - Return code: 0 23:16:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:16:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:16:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:16:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:16:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:16:29 INFO - Return code: 0 23:16:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:16:29 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:16:29 INFO - Using env: {'DISPLAY': ':0', 23:16:29 INFO - 'HOME': '/home/cltbld', 23:16:29 INFO - 'LANG': 'en_US.UTF-8', 23:16:29 INFO - 'LANGUAGE': 'en_US:en', 23:16:29 INFO - 'LOGNAME': 'cltbld', 23:16:29 INFO - 'MAIL': '/var/mail/cltbld', 23:16:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:16:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:29 INFO - 'MOZ_NO_REMOTE': '1', 23:16:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:29 INFO - 'NO_EM_RESTART': '1', 23:16:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:29 INFO - 'PWD': '/builds/slave/test', 23:16:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:16:29 INFO - 'SHELL': '/bin/bash', 23:16:29 INFO - 'SHLVL': '1', 23:16:29 INFO - 'TERM': 'linux', 23:16:29 INFO - 'TMOUT': '86400', 23:16:29 INFO - 'USER': 'cltbld', 23:16:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399', 23:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:29 INFO - '_': '/tools/buildbot/bin/python'} 23:16:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:16:29 INFO - mozversion application_buildid: 20160622203037 23:16:29 INFO - mozversion application_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 23:16:29 INFO - mozversion application_display_name: Nightly 23:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:16:29 INFO - mozversion application_name: Firefox 23:16:29 INFO - mozversion application_remotingname: firefox 23:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:16:29 INFO - mozversion application_vendor: Mozilla 23:16:29 INFO - mozversion application_version: 50.0a1 23:16:29 INFO - mozversion platform_buildid: 20160622203037 23:16:29 INFO - mozversion platform_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 23:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:16:29 INFO - mozversion platform_version: 50.0a1 23:16:29 INFO - using testdate: 1466662589 23:16:29 INFO - actual date: 1466662589 23:16:29 INFO - starting webserver on 'localhost:57863' 23:16:29 INFO - SUITE-START | Running 2 tests 23:16:29 INFO - TEST-START | dromaeo_css 23:16:29 INFO - operating with platform_type : linux_ 23:16:29 INFO - Initialising browser for dromaeo_css test... 23:16:29 INFO - TEST-INFO | started process 6287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKgXoI/profile http://localhost:57863/getInfo.html) 23:16:35 INFO - PROCESS | 6287 | __metrics Screen width/height:1600/1200 23:16:35 INFO - PROCESS | 6287 | colorDepth:24 23:16:35 INFO - PROCESS | 6287 | Browser inner width/height: 1024/697 23:16:35 INFO - PROCESS | 6287 | __metrics 23:16:35 ERROR - PROCESS | 6287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:16:36 INFO - TEST-INFO | 6287: exit 0 23:16:36 INFO - Browser initialized. 23:16:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:16:36 INFO - TEST-INFO | started process 6408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKgXoI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:48 INFO - PROCESS | 6408 | RSS: Main: 184770560 23:16:48 INFO - PROCESS | 6408 | 23:17:38 INFO - PROCESS | 6408 | 1466662658447 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] 23:19:46 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57863/tests/dromaeo/cssquery-ext.html) 23:19:47 INFO - PROCESS | 6408 | RSS: Main: 190029824 23:19:47 INFO - PROCESS | 6408 | 23:22:49 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-ext.html (next: http://localhost:57863/tests/dromaeo/cssquery-jquery.html) 23:22:50 INFO - PROCESS | 6408 | RSS: Main: 187760640 23:22:50 INFO - PROCESS | 6408 | 23:25:52 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57863/tests/dromaeo/cssquery-mootools.html) 23:25:52 INFO - PROCESS | 6408 | RSS: Main: 188919808 23:25:52 INFO - PROCESS | 6408 | 23:28:54 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57863/tests/dromaeo/cssquery-prototype.html) 23:28:54 INFO - PROCESS | 6408 | RSS: Main: 186769408 23:28:54 INFO - PROCESS | 6408 | 23:31:57 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57863/tests/dromaeo/cssquery-yui.html) 23:31:58 INFO - PROCESS | 6408 | RSS: Main: 188432384 23:31:58 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | Cycle 1(1): loaded http://localhost:57863/tests/dromaeo/cssquery-yui.html (next: http://localhost:57863/tests/dromaeo/cssquery-dojo.html) 23:35:00 INFO - PROCESS | 6408 | RSS: Main: 189616128 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | __start_tp_report 23:35:00 INFO - PROCESS | 6408 | _x_x_mozilla_page_load 23:35:00 INFO - PROCESS | 6408 | _x_x_mozilla_page_load_details 23:35:00 INFO - PROCESS | 6408 | |i|pagename|runs| 23:35:00 INFO - PROCESS | 6408 | |0;dojo.html;3120.8439578021093;3128.186671465419;3155.0692545699017;3170.3342298117395;3174.825384603846;5318;5352.4915133062395;5375.16684913838;5415.891682166354;5418.997485465186;5329.946700532993;5361.7587208575615;5374.328208973879;5438.592105592086;5504.119340905456;4874;4916.115099282128;5009.44896061433;5075.822346217865;5116.976604679079;736.6395462678508;5010.824621138261;5047.26814611881;5077.619178561604;5078.238264260353;4960.057589058068;4986.576141027999;4998.500149985009;5014.222795466709;5069.315642388267;4874.268859671042;5010.949890501121;5016.648834581581;5037.622178336639;5077.136886729265;4935.9753201234125;4944.678595891256;4958.826441074581;4965.255211718235;4971.950280497185;5417.26866872971;5469.917951230735;5505.614606977513;5521.585881058937;5544.833654990357;5740.54075673945;5795.768169273224;5891.558133140032;5909.6158749681135;5918.289805223358;5867.031939729939;5892.734826932799;5894.646321220741;5894.823155305305;5963.970180149115;5499.917501237444;5505.642133261325;5505.862353441156;5507.476789704971;5517.751701173457;5785.074388097884;5810.970945145247;5829.7376618052285;5833.649981001154;6049.062395328643;5611.466910643482;5625.353084395347;5650.830475085754;5653.943460565341;5669.036263835158;5728.885422291531;5743.684097374601;5745.85635359111;5747.798827041033;5752.769889204469;5680.801171959044;5699.344575373802;5747.195392645033;5750.367459579443;5821.941780582225;5676.801311954062;5689.971550142222;5725.685087320154;5771.769129234867;5930.080837470199;4415.227335216325;4428.31361139024;4437.445319335083;4438.467383913951;4465.24090904547;3946.427767973685;3963.960360396359;3965.3655415134017;3991.9201615967518;4006.9982504373907;5631.352394474688;5654.123610840326;5697.6296540724725;5705.686187259741;5750.856228594319;5858.677772722541;5878.617889837147;5883.499902508249;5888.175655408247;5921.73352199152;5510.889782204334;5619.466150715675;5636.915446268309;5698.059820129715;5709.115087161496;4927.236278376858;4931.038447502774;4931.827386041471;4934.4572097069295;4968.354113965233;6201.0388389799655;6202.72087756052;6209.844753881189;6223.502119830403;6226.844328891723;5684.204211410323;5829.5336373090895;5859.414058594107;5892.528597712087;5945.40545945402;6137.907931380943;6140.5701600887505;6148.907766383419;6176.81469555914;6181.412765787243;5746.7701291949525;5791.0734282514595;5807.361190269152;5809.36097029318;5819.76720931158;5678;5724;5770.3652598215;5778.27771528559;5780.161876527795;5611.80358687444;5635.605507614428;5639.210510528447;5643.887122257614;5665.263515742927;5563.888722225452;5621.409751976147;5667.574931880043;5687.459691329317;5687.971560142173;5387.326584176978;5494.642848214853;5550.7779688812;5569.443055694398;5598.1602759586385;5583.469570390806;5657.688827114548;5684.403137670485;5728.570357223141;5746.425357464387;5429.402765695691;5535.806246781343;5550.222968784293;5564.55483561306;5571.136473846398 23:35:00 INFO - PROCESS | 6408 | |1;ext.html;572.4590262202217;608.8660494691168;620.1380081686459;632.0929466215979;633.6578247746218;42966;43381;43960;44279.77860110699;46720.76639616797;44612.776936115275;44980.3252951206;45010.32484512735;45028.3245751314;45129.54870451295;8734.301255899545;8825.95587022064;8868.290536757044;8887.866681999774;8901.287896968228;8688.304935605136;8753.606087726035;8816.074312197223;8833.116688331147;8837.072107428723;8824;8869.02440731519;8872.733817985438;8889.73330800077;8893.110688931087;8733.214010739064;8737;8737.038925718165;8747.125287471266;8783.912160878373;8733;8804.163604457566;8809.515476648781;8862.734117976472;8903.599338029739;42305.78847105776;42538.36192457116;42575.36136957948;42708.572914271084;42846.357304640456;3391.6269210386836;3489.6859282664427;3524.2775231077567;3542.734294927865;3548.3967725486727;31024;32540.511892321632;33634.49548256778;34428.65571344279;34601.48097778535;4345.869623911288;4353.738775673438;4402.141582391435;4502.144592527409;4546.431696037996;338865;338918;340831;343585;344691.9999999975;33894.830525847705;34846.303073938376;34901.476477852346;59225;60117.39882601205;36698.082547935985;36742.632573674455;36843.447348289796;36929.815350923076;36967.260654786754;14401;14422;14553.927230363992;14576.271186440636;14582.343794529272;11413.771724565462;11433.656990290305;11442.37066961325;11455.770884582429;11470.942645286887;8249.092599814016;8256.174382561696;8291.792705182419;8383.496990180609;8404.117567655308;3203.2472368993267;3211.5985501812274;3222.6616205298574;3228.1445416964525;3238.514222866589;936.5457752989795;1034.5448002878709;1039.6984874386344;1043.5929987304958;1104.364990130662;31604.367912641617;31727.84136079305;32324.83837580797;32463.837680811444;32620.83689581537;1072.447689439939;1081.8052750504828;1127.537709539085;1196.5991392883482;1236.7773800715956;16939;17348.392806251974;17372.218250178772;17416.564585885455;17469.1605631572;525668;528789;531795;533811;535583;59237;59755.70122149361;59952.70023649854;59997.40002599918;60030.69984650049;1303.3548393545066;1327.9867201328057;1358.3934653494987;1364.0792465086026;1368.3773882883265;29816.552751708306;31521.842390788817;31626.51204638645;31630;32071.839640801645;49569;50357.74821125871;50445.74777126091;50578.24132638087;50710.746446267534;436883;445733;446114;446120;448711;28208.85895570509;28430.43139137247;28635;28652.713472865005;28660.57009144823;48734.75632621814;49457.50542494529;49860.75069624629;49982.25026624531;50777.49222507728;41739.582604174786;42353.78823105865;42506.36240456458;42729.572704272556;43259.35110973401;40682.193033007105;40777.388339174344;41242;41540.37689434722;42203.36694949517;35974.100647484025;40391.1921761569;40502.392464112476;41295;42222.366664499445;35717.82141089278;37688.81155594205;38048.80975595215;38389.232215356096;38712.80643596876;28137.577936330563;28304.43391132207;28426.85786571054;28497.715022849505;28588.857055714587 23:35:00 INFO - PROCESS | 6408 | |2;jquery.html;376.80782800771595;385.6124594782244;390.9257241124187;393.6791514915346;407.95512493625694;17182.398616048442;19722.30971915983;19793.505162370948;19827.405177844652;20188.29340973066;17835;18256.908715456437;18490.44528664142;18791.906040469814;18894.527636809053;5643.548516118711;5754.913676294859;5837.678927658977;5870.295564532262;5873.148393482942;5625.071863142576;5706.828795136132;5762.654240745548;5794.68129252891;5815.185873977646;5638;5687.971560142214;5699.344575373843;5713;5736.311642602873;5612.5229355504625;5759.452851979097;5772.797952071657;5774.6535207887455;5801.854953626172;4949.307097006386;5026.497350264981;5042.092423363793;5049.192129259338;5160.045391602565;22661;22873.085076596915;23202.883985580134;23226.3032109037;23432.7656723434;2363.0429675981254;2471.6663250461315;2483.3170878008514;2546.490701859617;2951.940961180764;14616.26918654063;14796.482123125747;14931.328090235857;15018.399264029425;15055.322510487054;1935.1098494692458;1979.455649696345;2008.7991200879942;2024.3724445421967;2077.418322869599;70849.64575177143;75339.24660753377;75535.24464755337;79701;87421.99999999936;10421.426821524889;10822.242443028912;10876.945615271872;10979.780404391868;11104.777904441866;15002.474913377979;15054.623634409227;15065.924670376578;15098;15114.168720720247;7598.658060387296;7810.921890781133;7833.5691536966015;7877.212278772077;7895.171007044178;7466.664000120008;7570.205128461543;7620.504667196615;7671.923280767121;7679.116901556393;4554.453465584151;4614.630829533629;4656.604188644003;4704.129735998851;4714.693544919569;1920.981879603812;1936.3803582853352;1969.940901772949;2033.4611327998093;2039.7858224886172;934.2619330728648;969.1035791892472;973.6300205921846;975.4098770244042;1022.2690776094979;18793.530161746065;19049.80950190508;19610.901945490466;19892.50268743264;19924.800751992585;981.7251169672503;1022.7749895023084;1033.9172866170688;1045.628801775374;1054.926155169146;10532.36805791655;11045.944770276257;11058.170637202242;11097.944510277397;11180.273282236629;471962;476340;484669;487661;496530;97141.51429242949;98324.50837745765;98496;98712;98808;978.0854900667898;998.4159266828841;1011.6307547745167;1011.9747006324753;1014.8021135878433;17360.305587776853;17415;17667.469975900745;17961.281548737905;18083.54791130232;41636;42624.36063458989;43237.567624323354;43943.66757701886;44302.55697442984;59294;60845;61455.69272153611;61634.691826540584;62689.68655156695;8423.115572865006;8605.268552173135;8668.696595619123;8716.041235463967;8845.734627961172;12417.565385211474;12964.546240881524;13279.535216267384;13666.726665466835;13922.025458217828;11267.887321126684;11355.886441135483;12084.214526055779;12098.637040888787;12134.817977730165;12001.759964800829;12079.39603019863;12137.514499419924;12219.51121955112;12395.75208495807;11972.64082077539;12357.75284494287;12365.75268494643;12367.69080772988;12398.690032748893;7502.512336698097;7650.923490765021;7716.5755883426955;7896;8489.320854331516;11279.266847654877;11728.237664551776;11735.706607334885;12065.638030859089;12168.93915530452 23:35:00 INFO - PROCESS | 6408 | |3;mootools.html;1398.9720205595886;1447.8479759625238;1519.5669234268237;1659.5768079139818;1693.7967443906718;7575.0909890813045;7928.6432110555015;8335.208155225251;9029.277657787377;9041.593128309225;8332.041815191254;8520.488770673765;8708.825823483527;8737.344699147574;8755.255803256714;2296.5866144094057;2334.8365614407;2340.134150364359;2343.379004563792;2346.765323467657;2335.649652552114;2347.730011048726;2356.1164563288767;2381.071382160959;2387.0213212582844;2336.4626135988733;2337.2287145242112;2352.164981431593;2378.3459548624096;2393.533261014103;2280.0879648140713;2284.885755712216;2293.334932869466;2297.1959814064944;2300.769923007703;2158.708574342475;2170.913163473459;2175.8803265820534;2177.891105444737;2195.3304242206123;8499.065102838744;8500.617472213766;8511.489310641382;8513.74458766238;8570.142985701443;5163.32876726027;5314.840554783363;5319.867003324948;5339.172428273624;5339.199120131972;3237.902862914116;3239;3396.4226081566194;3410.778299410555;3418.384690755663;1179.6000916581115;1194.3192380343207;1200.2078628105407;1210.6065528703118;1219.1892391559602;11972.161948663597;12202.633920982385;12262.754744905053;12314.81527777084;12322.938385308105;4551.249043907718;4589.977050114728;4642.442906851199;4720.0559888022535;4724.4094488188975;10352.948235258926;10408.219383546264;10411.271211015157;10416.010479004482;10486.947565262124;5339.225812257201;5344.866378340573;5346.7861285548925;5359.464053594609;5360.276362691065;4372;4628.930566041512;4746.881327966828;4813.205821039489;4828;3871.9612803872164;3927.626875446828;3938.1139243669945;4115.52671442782;4119.258533464005;1194.331174542259;1203.2479700187382;1212.3877441891789;1229.5266322465916;1241.875812418751;876.6449587916904;877.4472082588056;894.1505569708803;899.3524662243175;919.1268295119663;5547.1679248113105;5617.185508101303;5806.187133801272;5853.586101074132;5992.43071908168;439.49019137799996;439.86364227089064;442.2238970606565;454.23008001437245;471.5217792221342;3802.4106263529197;3898.122922342507;4007.8797636070963;4048.4332193492933;4131.814068366931;10335.22485813567;10808.189385796097;10875.673729788119;10882.564697412015;10940.288881222696;10378.792424151627;10708.30396024256;10813.945930270298;10863.402512861869;11145.442727863574;7945.995569481314;7955.880661789962;8045.436819422584;8069.435139540175;8115.634796434175;6050.6369617823075;6123.418275263843;6143;6143.539234557516;6195.482106883842;10165.13596344319;10232;10243.692689219335;10334.689959301233;10436;10056.49717514136;10058.245631577514;10365.689029329133;10396.376217426978;10413.271071024956;6952.409045231212;7430.628468576441;7646.847063058819;7699.538027718355;7787.727429539939;8372.372072094495;8467.872981905153;8471.068182500043;8558.657653693783;8564.357673174412;6911.136107986502;7265.636718164176;7339.9266007341375;7373.520721153108;7595.278448547379;7393.9260607393235;7650.9234907652435;7698.114716807639;7708.190639982721;7717.768466946;6748.93251067483;6778.152730908637;6817.147856517935;6820.454363650995;6831.11195544576;5093.617978651542;5298.364196296469;5439.4288599696465;5439.456054394529;5481.314835645544;5242.76407561653;5259.63182577216;5273.073444238485;5354;5450.672959622435 23:35:00 INFO - PROCESS | 6408 | |4;prototype.html;305.12125079770243;314.79381005441417;320.82515029309025;322.56131660941116;327.7738360531233;5475.534579560732;5512.503874651281;5644.266245388099;5717.885642287151;5737.2541569596;5530.419305972875;5544.22380866679;5568.415316391782;5572.5263352614975;5585.748641311141;4385.276429389163;4386;4393.406890069848;4394.362817391477;4409.29451287794;4054.5337286212166;4222.556631553689;4228.5560016198315;4412.911741765179;4422.402975598301;4215.978920105395;4219.3881887126345;4221.514525829522;4226.1336426032585;4244.702870799046;4271.423357846697;4276.893077673083;4280.357946308063;4288.099499105192;4312.762798046107;3618.9276214475826;3720.4605332226947;3729.5524537055458;3731.776093434403;3731.925361492782;5436.755346009439;5449.182622606601;5449.754761035763;5456.263404440389;5490.309748223342;4886.169351210303;4935.555799977983;4939.654224204307;4950.282209079699;4981.5055483354845;5677.772889084473;5792.913106303409;5817.331006934214;5820.738066786962;5842.707864606795;4042.6765858731233;4066.857659981916;4088.0801819590356;4102.5076990761;4103.4050062740735;5757.337906140806;5959.493443057346;6016.157737916695;6060.878782424371;6123.142760013558;4134.689898257643;4141.52372477169;4148.688848336386;4154.646855017358;4157.750534967911;4203.330884888057;4210.978945105255;4215.430916826251;4215.725977811432;4221.6833737469815;4846.878828029327;4864.562189402971;4887.853364399074;4903.681260718042;4904;5680.488756011896;5748.568857335633;5851.824445266649;5885.558583106199;5904.822855314347;1438.978415323771;1450.4415799916897;1458.8832893368506;1459.7956286119952;1460.627539977299;883.2404132446092;917.9306108383792;920.9263258939269;929.2473096791621;934.4206591912922;4944.901101978012;4969.527894849984;5059.418166910852;5107.770150343244;5166.689998600096;5338.733063346817;5345.3540497454005;5345.866353341197;5380.838574842761;5389.137737961985;4965.851024469272;5072.974635126875;5109.284700141983;5320.44135365781;5716.628419152742;3127.593412856314;3167.2421805897948;3188.5536024956523;3188.6173659160586;3236.271838836243;6111.297200821962;6169.791708311653;6260.40526150015;6263.404976527223;6266.373362663697;6139.693015349215;6148;6148.508119350441;6171.907421388682;6172.827162839047;6111.388861113942;6112.847178820476;6303.2751233607805;6326.557141000086;6338.809835704937;5841.678707671119;6014.368491308524;6046.395360464095;6060.272767267956;6064.514838812796;5897.5576831736935;5924;5944.49471794885;5959.344472108151;5962.495751784174;5993.700314984146;6230.252369715663;6258.3741625838875;6286.9312216924145;6309.779157729457;4223.598758117974;4228.471441069866;4229.725067870579;4238;4285.80713867883;5772.682502462237;5907.675077870586;6066.393360663898;6084.513238940785;6106.45041946227;5816.302043754777;5829.3296270927685;5845.620034697731;5853.653659658217;5871.266091738533;5875.383084776037;5879.353271140257;5887.411258874078;5890.440408161217;5909.852253693692;5513.669179849222;5645.830625081254;5689.146628005832;5700.600957933071;5744.793593345445;5857.824265271878;5908.438698323653;5951.285845698544;5953.583249172516;5974.610155937659;5459.918101228564;5697.572682048946;5709.7145142741865;5786.884262314814;5844.736986835687 23:35:00 INFO - PROCESS | 6408 | |5;yui.html;749.7825630567136;790.3210554867094;794.8608993426157;802.4062193976459;804.6298702596807;14803.555893323191;16314;16344;16397.26212320447;16405.589860253483;13391.531296404628;13421.261830599313;13471.595852124428;13531.188128712283;15380.230988450561;783.7061102086717;799.0930294116191;800.8598495263335;801.0387534958045;804.6137853830136;654.3587284461231;758.256908229935;769.7228997560874;779.0690125300268;785.4541093939714;821.6918655504186;823.2549542663899;828.2504333578122;828.8798124271977;830.667732906836;815.979600509989;819.1644522586928;822.7655118291258;824.3364091906013;826.4132465949183;594.9286085669704;597.5996082624652;598.8113744170572;604.0727483313093;606.1180981671657;14334.569962901129;14340.211288379134;14413.927930360385;14422.06256593318;14433.134011959317;14207.36066876993;14314;14352.856471435256;14355.282235888268;14424.206668633222;12443.315617641027;12582.685432864251;12584;12652.367381630882;12669.176503527242;3857.4792403025513;3881.961180388188;3913.6673382762215;3929.7445666031617;4062.289099407592;85519.57240213822;87157.12842871553;87479.56260218722;87501.12498874993;87728.56135719344;11181.44092795357;11215.831762523569;11576.42117894102;11680.474378652982;11859.525618975316;19426;21083.578328433345;21217.469563261042;21317.25389611356;21518.784812151993;8326.875096873551;8688.13118688126;8843.778905527284;8885.644574216958;8972.41679290844;4668.299755036772;4786.1863483207935;4821.879453013633;4854.587360074363;4985.925211121836;3581;3674.761140525911;3701.7038636908983;3712.1090938174643;3713.1459764254373;630.3885231325606;649.691396586627;652.641047423915;657.2310396835713;686.5640318397853;610.6305685060563;669.7220653428773;725.8040329111216;732.4982387064878;749.4004796163048;9427.717168484956;9646.662366817127;9730.172935300438;9811.656592019244;10370.740731481623;636.5639536917226;695.6104581434413;708.6173466328125;712.5226098514008;722.227216877946;4643.674942753974;4844.75776211188;4853.830115945995;4882.658213925062;4883.706977581356;112937;116302.41848790702;117161;118263.40868295776;121762.39118804349;98519.50740246254;100460.49769751105;100667.49666251622;102247;104358.47820760848;82990.58504707558;85868;86636.99999999873;87405.44100916114;89206.10793891978;9219.400738951947;9409.576569054272;9425.387349822515;9500.762480937756;9564.33049686543;50319.74840125776;50358.24462633137;50803.74598126986;51470.22794658158;51639.225411619605;68137.23786207747;73951;75978.6201068991;76384;77527.44945100954;12299.323537205539;12434.440450179945;12742.745145097231;12776.61670149897;13030.869691303345;15427.151506667242;15737.527874163794;15802.130882801557;15824.762628560351;15868.60328491797;13610.523631672844;13816.447342106203;14118.2940852959;14551;15366.539003829903;13834.911721079163;14827;14978.575851393189;15062.16767280986;15112.697746045238;13680.93159534196;13986.370613322628;14067.437302507786;14089.436422543393;14263.928680356532;11630.76738465209;11915.702107447383;12235.877641223475;12301.876981230072;12316.445759940645;11070.28043177191;11201.159913006393;11521.308721476738;11529.365884876412;11893.583724569598 23:35:00 INFO - PROCESS | 6408 | __end_tp_report 23:35:00 INFO - PROCESS | 6408 | __start_cc_report 23:35:00 INFO - PROCESS | 6408 | _x_x_mozilla_cycle_collect,342 23:35:00 INFO - PROCESS | 6408 | __end_cc_report 23:35:00 INFO - PROCESS | 6408 | __startTimestamp1466663700972__endTimestamp 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | ------- Summary: start ------- 23:35:00 INFO - PROCESS | 6408 | Number of tests: 6 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#0] dojo.html Cycles:165 Average:5391.15 Median:5631.35 stddev:716.73 (12.7%) stddev-sans-first:696.44 23:35:00 INFO - PROCESS | 6408 | Values: 3120.8 3128.2 3155.1 3170.3 3174.8 5318.0 5352.5 5375.2 5415.9 5419.0 5329.9 5361.8 5374.3 5438.6 5504.1 4874.0 4916.1 5009.4 5075.8 5117.0 736.6 5010.8 5047.3 5077.6 5078.2 4960.1 4986.6 4998.5 5014.2 5069.3 4874.3 5010.9 5016.6 5037.6 5077.1 4936.0 4944.7 4958.8 4965.3 4972.0 5417.3 5469.9 5505.6 5521.6 5544.8 5740.5 5795.8 5891.6 5909.6 5918.3 5867.0 5892.7 5894.6 5894.8 5964.0 5499.9 5505.6 5505.9 5507.5 5517.8 5785.1 5811.0 5829.7 5833.6 6049.1 5611.5 5625.4 5650.8 5653.9 5669.0 5728.9 5743.7 5745.9 5747.8 5752.8 5680.8 5699.3 5747.2 5750.4 5821.9 5676.8 5690.0 5725.7 5771.8 5930.1 4415.2 4428.3 4437.4 4438.5 4465.2 3946.4 3964.0 3965.4 3991.9 4007.0 5631.4 5654.1 5697.6 5705.7 5750.9 5858.7 5878.6 5883.5 5888.2 5921.7 5510.9 5619.5 5636.9 5698.1 5709.1 4927.2 4931.0 4931.8 4934.5 4968.4 6201.0 6202.7 6209.8 6223.5 6226.8 5684.2 5829.5 5859.4 5892.5 5945.4 6137.9 6140.6 6148.9 6176.8 6181.4 5746.8 5791.1 5807.4 5809.4 5819.8 5678.0 5724.0 5770.4 5778.3 5780.2 5611.8 5635.6 5639.2 5643.9 5665.3 5563.9 5621.4 5667.6 5687.5 5688.0 5387.3 5494.6 5550.8 5569.4 5598.2 5583.5 5657.7 5684.4 5728.6 5746.4 5429.4 5535.8 5550.2 5564.6 5571.1 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#1] ext.html Cycles:180 Average:58791.97 Median:41971.47 stddev:118453.89 (282.2%) stddev-sans-first:118705.53 23:35:00 INFO - PROCESS | 6408 | Values: 572.5 608.9 620.1 632.1 633.7 42966.0 43381.0 43960.0 44279.8 46720.8 44612.8 44980.3 45010.3 45028.3 45129.5 8734.3 8826.0 8868.3 8887.9 8901.3 8688.3 8753.6 8816.1 8833.1 8837.1 8824.0 8869.0 8872.7 8889.7 8893.1 8733.2 8737.0 8737.0 8747.1 8783.9 8733.0 8804.2 8809.5 8862.7 8903.6 42305.8 42538.4 42575.4 42708.6 42846.4 3391.6 3489.7 3524.3 3542.7 3548.4 31024.0 32540.5 33634.5 34428.7 34601.5 4345.9 4353.7 4402.1 4502.1 4546.4 338865.0 338918.0 340831.0 343585.0 344692.0 33894.8 34846.3 34901.5 59225.0 60117.4 36698.1 36742.6 36843.4 36929.8 36967.3 14401.0 14422.0 14553.9 14576.3 14582.3 11413.8 11433.7 11442.4 11455.8 11470.9 8249.1 8256.2 8291.8 8383.5 8404.1 3203.2 3211.6 3222.7 3228.1 3238.5 936.5 1034.5 1039.7 1043.6 1104.4 31604.4 31727.8 32324.8 32463.8 32620.8 1072.4 1081.8 1127.5 1196.6 1236.8 16939.0 17348.4 17372.2 17416.6 17469.2 525668.0 528789.0 531795.0 533811.0 535583.0 59237.0 59755.7 59952.7 59997.4 60030.7 1303.4 1328.0 1358.4 1364.1 1368.4 29816.6 31521.8 31626.5 31630.0 32071.8 49569.0 50357.7 50445.7 50578.2 50710.7 436883.0 445733.0 446114.0 446120.0 448711.0 28208.9 28430.4 28635.0 28652.7 28660.6 48734.8 49457.5 49860.8 49982.3 50777.5 41739.6 42353.8 42506.4 42729.6 43259.4 40682.2 40777.4 41242.0 41540.4 42203.4 35974.1 40391.2 40502.4 41295.0 42222.4 35717.8 37688.8 38048.8 38389.2 38712.8 28137.6 28304.4 28426.9 28497.7 28588.9 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#2] jquery.html Cycles:180 Average:29151.37 Median:2514.90 stddev:79869.10 (3175.8%) stddev-sans-first:80063.93 23:35:00 INFO - PROCESS | 6408 | Values: 376.8 385.6 390.9 393.7 408.0 17182.4 19722.3 19793.5 19827.4 20188.3 17835.0 18256.9 18490.4 18791.9 18894.5 5643.5 5754.9 5837.7 5870.3 5873.1 5625.1 5706.8 5762.7 5794.7 5815.2 5638.0 5688.0 5699.3 5713.0 5736.3 5612.5 5759.5 5772.8 5774.7 5801.9 4949.3 5026.5 5042.1 5049.2 5160.0 22661.0 22873.1 23202.9 23226.3 23432.8 2363.0 2471.7 2483.3 2546.5 2951.9 14616.3 14796.5 14931.3 15018.4 15055.3 1935.1 1979.5 2008.8 2024.4 2077.4 70849.6 75339.2 75535.2 79701.0 87422.0 10421.4 10822.2 10876.9 10979.8 11104.8 15002.5 15054.6 15065.9 15098.0 15114.2 7598.7 7810.9 7833.6 7877.2 7895.2 7466.7 7570.2 7620.5 7671.9 7679.1 4554.5 4614.6 4656.6 4704.1 4714.7 1921.0 1936.4 1969.9 2033.5 2039.8 934.3 969.1 973.6 975.4 1022.3 18793.5 19049.8 19610.9 19892.5 19924.8 981.7 1022.8 1033.9 1045.6 1054.9 10532.4 11045.9 11058.2 11097.9 11180.3 471962.0 476340.0 484669.0 487661.0 496530.0 97141.5 98324.5 98496.0 98712.0 98808.0 978.1 998.4 1011.6 1012.0 1014.8 17360.3 17415.0 17667.5 17961.3 18083.5 41636.0 42624.4 43237.6 43943.7 44302.6 59294.0 60845.0 61455.7 61634.7 62689.7 8423.1 8605.3 8668.7 8716.0 8845.7 12417.6 12964.5 13279.5 13666.7 13922.0 11267.9 11355.9 12084.2 12098.6 12134.8 12001.8 12079.4 12137.5 12219.5 12395.8 11972.6 12357.8 12365.8 12367.7 12398.7 7502.5 7650.9 7716.6 7896.0 8489.3 11279.3 11728.2 11735.7 12065.6 12168.9 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#3] mootools.html Cycles:180 Average:5740.17 Median:4570.61 stddev:3286.20 (71.9%) stddev-sans-first:3279.23 23:35:00 INFO - PROCESS | 6408 | Values: 1399.0 1447.8 1519.6 1659.6 1693.8 7575.1 7928.6 8335.2 9029.3 9041.6 8332.0 8520.5 8708.8 8737.3 8755.3 2296.6 2334.8 2340.1 2343.4 2346.8 2335.6 2347.7 2356.1 2381.1 2387.0 2336.5 2337.2 2352.2 2378.3 2393.5 2280.1 2284.9 2293.3 2297.2 2300.8 2158.7 2170.9 2175.9 2177.9 2195.3 8499.1 8500.6 8511.5 8513.7 8570.1 5163.3 5314.8 5319.9 5339.2 5339.2 3237.9 3239.0 3396.4 3410.8 3418.4 1179.6 1194.3 1200.2 1210.6 1219.2 11972.2 12202.6 12262.8 12314.8 12322.9 4551.2 4590.0 4642.4 4720.1 4724.4 10352.9 10408.2 10411.3 10416.0 10486.9 5339.2 5344.9 5346.8 5359.5 5360.3 4372.0 4628.9 4746.9 4813.2 4828.0 3872.0 3927.6 3938.1 4115.5 4119.3 1194.3 1203.2 1212.4 1229.5 1241.9 876.6 877.4 894.2 899.4 919.1 5547.2 5617.2 5806.2 5853.6 5992.4 439.5 439.9 442.2 454.2 471.5 3802.4 3898.1 4007.9 4048.4 4131.8 10335.2 10808.2 10875.7 10882.6 10940.3 10378.8 10708.3 10813.9 10863.4 11145.4 7946.0 7955.9 8045.4 8069.4 8115.6 6050.6 6123.4 6143.0 6143.5 6195.5 10165.1 10232.0 10243.7 10334.7 10436.0 10056.5 10058.2 10365.7 10396.4 10413.3 6952.4 7430.6 7646.8 7699.5 7787.7 8372.4 8467.9 8471.1 8558.7 8564.4 6911.1 7265.6 7339.9 7373.5 7595.3 7393.9 7650.9 7698.1 7708.2 7717.8 6748.9 6778.2 6817.1 6820.5 6831.1 5093.6 5298.4 5439.4 5439.5 5481.3 5242.8 5259.6 5273.1 5354.0 5450.7 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#4] prototype.html Cycles:180 Average:4858.25 Median:5501.41 stddev:1454.72 (26.4%) stddev-sans-first:1418.09 23:35:00 INFO - PROCESS | 6408 | Values: 305.1 314.8 320.8 322.6 327.8 5475.5 5512.5 5644.3 5717.9 5737.3 5530.4 5544.2 5568.4 5572.5 5585.7 4385.3 4386.0 4393.4 4394.4 4409.3 4054.5 4222.6 4228.6 4412.9 4422.4 4216.0 4219.4 4221.5 4226.1 4244.7 4271.4 4276.9 4280.4 4288.1 4312.8 3618.9 3720.5 3729.6 3731.8 3731.9 5436.8 5449.2 5449.8 5456.3 5490.3 4886.2 4935.6 4939.7 4950.3 4981.5 5677.8 5792.9 5817.3 5820.7 5842.7 4042.7 4066.9 4088.1 4102.5 4103.4 5757.3 5959.5 6016.2 6060.9 6123.1 4134.7 4141.5 4148.7 4154.6 4157.8 4203.3 4211.0 4215.4 4215.7 4221.7 4846.9 4864.6 4887.9 4903.7 4904.0 5680.5 5748.6 5851.8 5885.6 5904.8 1439.0 1450.4 1458.9 1459.8 1460.6 883.2 917.9 920.9 929.2 934.4 4944.9 4969.5 5059.4 5107.8 5166.7 5338.7 5345.4 5345.9 5380.8 5389.1 4965.9 5073.0 5109.3 5320.4 5716.6 3127.6 3167.2 3188.6 3188.6 3236.3 6111.3 6169.8 6260.4 6263.4 6266.4 6139.7 6148.0 6148.5 6171.9 6172.8 6111.4 6112.8 6303.3 6326.6 6338.8 5841.7 6014.4 6046.4 6060.3 6064.5 5897.6 5924.0 5944.5 5959.3 5962.5 5993.7 6230.3 6258.4 6286.9 6309.8 4223.6 4228.5 4229.7 4238.0 4285.8 5772.7 5907.7 6066.4 6084.5 6106.5 5816.3 5829.3 5845.6 5853.7 5871.3 5875.4 5879.4 5887.4 5890.4 5909.9 5513.7 5645.8 5689.1 5700.6 5744.8 5857.8 5908.4 5951.3 5953.6 5974.6 5459.9 5697.6 5709.7 5786.9 5844.7 23:35:00 INFO - PROCESS | 6408 | 23:35:00 INFO - PROCESS | 6408 | [#5] yui.html Cycles:180 Average:21327.63 Median:4655.99 stddev:30852.12 (662.6%) stddev-sans-first:30899.98 23:35:00 INFO - PROCESS | 6408 | Values: 749.8 790.3 794.9 802.4 804.6 14803.6 16314.0 16344.0 16397.3 16405.6 13391.5 13421.3 13471.6 13531.2 15380.2 783.7 799.1 800.9 801.0 804.6 654.4 758.3 769.7 779.1 785.5 821.7 823.3 828.3 828.9 830.7 816.0 819.2 822.8 824.3 826.4 594.9 597.6 598.8 604.1 606.1 14334.6 14340.2 14413.9 14422.1 14433.1 14207.4 14314.0 14352.9 14355.3 14424.2 12443.3 12582.7 12584.0 12652.4 12669.2 3857.5 3882.0 3913.7 3929.7 4062.3 85519.6 87157.1 87479.6 87501.1 87728.6 11181.4 11215.8 11576.4 11680.5 11859.5 19426.0 21083.6 21217.5 21317.3 21518.8 8326.9 8688.1 8843.8 8885.6 8972.4 4668.3 4786.2 4821.9 4854.6 4985.9 3581.0 3674.8 3701.7 3712.1 3713.1 630.4 649.7 652.6 657.2 686.6 610.6 669.7 725.8 732.5 749.4 9427.7 9646.7 9730.2 9811.7 10370.7 636.6 695.6 708.6 712.5 722.2 4643.7 4844.8 4853.8 4882.7 4883.7 112937.0 116302.4 117161.0 118263.4 121762.4 98519.5 100460.5 100667.5 102247.0 104358.5 82990.6 85868.0 86637.0 87405.4 89206.1 9219.4 9409.6 9425.4 9500.8 9564.3 50319.7 50358.2 50803.7 51470.2 51639.2 68137.2 73951.0 75978.6 76384.0 77527.4 12299.3 12434.4 12742.7 12776.6 13030.9 15427.2 15737.5 15802.1 15824.8 15868.6 13610.5 13816.4 14118.3 14551.0 15366.5 13834.9 14827.0 14978.6 15062.2 15112.7 13680.9 13986.4 14067.4 14089.4 14263.9 11630.8 11915.7 12235.9 12301.9 12316.4 11070.3 11201.2 11521.3 11529.4 11893.6 23:35:00 INFO - PROCESS | 6408 | -------- Summary: end -------- 23:35:00 INFO - PROCESS | 6408 | 23:35:01 INFO - TEST-INFO | 6408: exit 0 23:35:01 INFO - TEST-OK | dromaeo_css | took 1111830ms 23:35:01 INFO - TEST-START | kraken 23:35:01 INFO - operating with platform_type : linux_ 23:35:01 INFO - Initialising browser for kraken test... 23:35:01 INFO - TEST-INFO | started process 6649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyfF8dR/profile http://localhost:57863/getInfo.html) 23:35:06 INFO - PROCESS | 6649 | __metrics Screen width/height:1600/1200 23:35:06 INFO - PROCESS | 6649 | colorDepth:24 23:35:06 INFO - PROCESS | 6649 | Browser inner width/height: 1024/697 23:35:06 INFO - PROCESS | 6649 | __metrics 23:35:07 ERROR - PROCESS | 6649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:35:08 INFO - TEST-INFO | 6649: exit 0 23:35:08 INFO - Browser initialized. 23:35:08 INFO - Running cycle 1/1 for kraken test... 23:35:08 INFO - TEST-INFO | started process 6767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyfF8dR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:20 INFO - PROCESS | 6767 | RSS: Main: 184524800 23:35:20 INFO - PROCESS | 6767 | 23:35:23 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57863/tests/kraken/driver.html?testName=audio-beat-detection) 23:35:23 INFO - PROCESS | 6767 | RSS: Main: 190504960 23:35:23 INFO - PROCESS | 6767 | 23:35:26 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57863/tests/kraken/driver.html?testName=audio-dft) 23:35:27 INFO - PROCESS | 6767 | RSS: Main: 190193664 23:35:27 INFO - PROCESS | 6767 | 23:35:30 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57863/tests/kraken/driver.html?testName=audio-fft) 23:35:30 INFO - PROCESS | 6767 | RSS: Main: 184758272 23:35:30 INFO - PROCESS | 6767 | 23:35:32 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57863/tests/kraken/driver.html?testName=audio-oscillator) 23:35:33 INFO - PROCESS | 6767 | RSS: Main: 185622528 23:35:33 INFO - PROCESS | 6767 | 23:35:35 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:35:36 INFO - PROCESS | 6767 | RSS: Main: 186273792 23:35:36 INFO - PROCESS | 6767 | 23:35:39 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57863/tests/kraken/driver.html?testName=imaging-darkroom) 23:35:40 INFO - PROCESS | 6767 | RSS: Main: 186499072 23:35:40 INFO - PROCESS | 6767 | 23:35:43 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57863/tests/kraken/driver.html?testName=imaging-desaturate) 23:35:44 INFO - PROCESS | 6767 | RSS: Main: 183738368 23:35:44 INFO - PROCESS | 6767 | 23:35:46 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57863/tests/kraken/driver.html?testName=json-parse-financial) 23:35:47 INFO - PROCESS | 6767 | RSS: Main: 185090048 23:35:47 INFO - PROCESS | 6767 | 23:35:49 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:35:49 INFO - PROCESS | 6767 | RSS: Main: 185393152 23:35:49 INFO - PROCESS | 6767 | 23:35:51 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:35:52 INFO - PROCESS | 6767 | RSS: Main: 185085952 23:35:52 INFO - PROCESS | 6767 | 23:35:54 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:35:54 INFO - PROCESS | 6767 | RSS: Main: 185618432 23:35:54 INFO - PROCESS | 6767 | 23:35:57 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:35:58 INFO - PROCESS | 6767 | RSS: Main: 186265600 23:35:58 INFO - PROCESS | 6767 | 23:36:00 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:01 INFO - PROCESS | 6767 | RSS: Main: 185798656 23:36:01 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | Cycle 1(1): loaded http://localhost:57863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57863/tests/kraken/driver.html?testName=ai-astar) 23:36:03 INFO - PROCESS | 6767 | RSS: Main: 187006976 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | __start_tp_report 23:36:03 INFO - PROCESS | 6767 | _x_x_mozilla_page_load 23:36:03 INFO - PROCESS | 6767 | _x_x_mozilla_page_load_details 23:36:03 INFO - PROCESS | 6767 | |i|pagename|runs| 23:36:03 INFO - PROCESS | 6767 | |0;ai-astar;103;111;104;112;111;111;112;109;111;113 23:36:03 INFO - PROCESS | 6767 | |1;audio-beat-detection;150;127;156;174;126;155;161;125;184;125 23:36:03 INFO - PROCESS | 6767 | |2;audio-dft;163;161;163;160;166;169;164;163;163;163 23:36:03 INFO - PROCESS | 6767 | |3;audio-fft;76;74;76;159;75;75;73;75;161;74 23:36:03 INFO - PROCESS | 6767 | |4;audio-oscillator;85;85;158;85;86;84;142;84;86;156 23:36:03 INFO - PROCESS | 6767 | |5;imaging-gaussian-blur;117;118;118;118;119;118;118;118;118;120 23:36:03 INFO - PROCESS | 6767 | |6;imaging-darkroom;146;150;147;147;147;147;149;147;148;148 23:36:03 INFO - PROCESS | 6767 | |7;imaging-desaturate;96;98;95;96;96;95;96;96;97;96 23:36:03 INFO - PROCESS | 6767 | |8;json-parse-financial;56;56;55;57;57;58;55;55;58;55 23:36:03 INFO - PROCESS | 6767 | |9;json-stringify-tinderbox;62;62;61;61;61;60;60;61;61;61 23:36:03 INFO - PROCESS | 6767 | |10;stanford-crypto-aes;86;80;80;86;81;85;82;80;90;80 23:36:03 INFO - PROCESS | 6767 | |11;stanford-crypto-ccm;121;122;132;136;141;128;123;134;132;138 23:36:03 INFO - PROCESS | 6767 | |12;stanford-crypto-pbkdf2;162;159;162;162;164;167;161;164;162;159 23:36:03 INFO - PROCESS | 6767 | |13;stanford-crypto-sha256-iterative;64;62;64;68;62;62;64;63;63;68 23:36:03 INFO - PROCESS | 6767 | __end_tp_report 23:36:03 INFO - PROCESS | 6767 | __start_cc_report 23:36:03 INFO - PROCESS | 6767 | _x_x_mozilla_cycle_collect,887 23:36:03 INFO - PROCESS | 6767 | __end_cc_report 23:36:03 INFO - PROCESS | 6767 | __startTimestamp1466663763465__endTimestamp 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | ------- Summary: start ------- 23:36:03 INFO - PROCESS | 6767 | Number of tests: 14 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:2.65 23:36:03 INFO - PROCESS | 6767 | Values: 103.0 111.0 104.0 112.0 111.0 111.0 112.0 109.0 111.0 113.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.50 stddev:21.71 (14.0%) stddev-sans-first:23.01 23:36:03 INFO - PROCESS | 6767 | Values: 150.0 127.0 156.0 174.0 126.0 155.0 161.0 125.0 184.0 125.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.65 23:36:03 INFO - PROCESS | 6767 | Values: 163.0 161.0 163.0 160.0 166.0 169.0 164.0 163.0 163.0 163.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.00 stddev:35.96 (47.9%) stddev-sans-first:37.68 23:36:03 INFO - PROCESS | 6767 | Values: 76.0 74.0 76.0 159.0 75.0 75.0 73.0 75.0 161.0 74.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:85.00 stddev:32.63 (38.4%) stddev-sans-first:33.79 23:36:03 INFO - PROCESS | 6767 | Values: 85.0 85.0 158.0 85.0 86.0 84.0 142.0 84.0 86.0 156.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 23:36:03 INFO - PROCESS | 6767 | Values: 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 120.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.09 23:36:03 INFO - PROCESS | 6767 | Values: 146.0 150.0 147.0 147.0 147.0 147.0 149.0 147.0 148.0 148.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 23:36:03 INFO - PROCESS | 6767 | Values: 96.0 98.0 95.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.23 (2.2%) stddev-sans-first:1.30 23:36:03 INFO - PROCESS | 6767 | Values: 56.0 56.0 55.0 57.0 57.0 58.0 55.0 55.0 58.0 55.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 23:36:03 INFO - PROCESS | 6767 | Values: 62.0 62.0 61.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:3.53 (4.2%) stddev-sans-first:3.57 23:36:03 INFO - PROCESS | 6767 | Values: 86.0 80.0 80.0 86.0 81.0 85.0 82.0 80.0 90.0 80.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:133.00 stddev:6.98 (5.2%) stddev-sans-first:6.46 23:36:03 INFO - PROCESS | 6767 | Values: 121.0 122.0 132.0 136.0 141.0 128.0 123.0 134.0 132.0 138.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 23:36:03 INFO - PROCESS | 6767 | Values: 162.0 159.0 162.0 162.0 164.0 167.0 161.0 164.0 162.0 159.0 23:36:03 INFO - PROCESS | 6767 | 23:36:03 INFO - PROCESS | 6767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.26 (3.5%) stddev-sans-first:2.40 23:36:03 INFO - PROCESS | 6767 | Values: 64.0 62.0 64.0 68.0 62.0 62.0 64.0 63.0 63.0 68.0 23:36:03 INFO - PROCESS | 6767 | -------- Summary: end -------- 23:36:03 INFO - PROCESS | 6767 | 23:36:04 INFO - TEST-INFO | 6767: exit 0 23:36:04 INFO - TEST-OK | kraken | took 62608ms 23:36:04 INFO - SUITE-END | took 1174s 23:36:04 INFO - Completed test suite (00:19:34) 23:36:04 INFO - javascript benchmark 23:36:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.947640289551, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.8439578021093, 3128.186671465419, 3155.0692545699017, 3170.3342298117395, 3174.825384603846, 5318.0, 5352.4915133062395, 5375.16684913838, 5415.891682166354, 5418.997485465186, 5329.946700532993, 5361.7587208575615, 5374.328208973879, 5438.592105592086, 5504.119340905456, 4874.0, 4916.115099282128, 5009.44896061433, 5075.822346217865, 5116.976604679079, 736.6395462678508, 5010.824621138261, 5047.26814611881, 5077.619178561604, 5078.238264260353, 4960.057589058068, 4986.576141027999, 4998.500149985009, 5014.222795466709, 5069.315642388267, 4874.268859671042, 5010.949890501121, 5016.648834581581, 5037.622178336639, 5077.136886729265, 4935.9753201234125, 4944.678595891256, 4958.826441074581, 4965.255211718235, 4971.950280497185, 5417.26866872971, 5469.917951230735, 5505.614606977513, 5521.585881058937, 5544.833654990357, 5740.54075673945, 5795.768169273224, 5891.558133140032, 5909.6158749681135, 5918.289805223358, 5867.031939729939, 5892.734826932799, 5894.646321220741, 5894.823155305305, 5963.970180149115, 5499.917501237444, 5505.642133261325, 5505.862353441156, 5507.476789704971, 5517.751701173457, 5785.074388097884, 5810.970945145247, 5829.7376618052285, 5833.649981001154, 6049.062395328643, 5611.466910643482, 5625.353084395347, 5650.830475085754, 5653.943460565341, 5669.036263835158, 5728.885422291531, 5743.684097374601, 5745.85635359111, 5747.798827041033, 5752.769889204469, 5680.801171959044, 5699.344575373802, 5747.195392645033, 5750.367459579443, 5821.941780582225, 5676.801311954062, 5689.971550142222, 5725.685087320154, 5771.769129234867, 5930.080837470199, 4415.227335216325, 4428.31361139024, 4437.445319335083, 4438.467383913951, 4465.24090904547, 3946.427767973685, 3963.960360396359, 3965.3655415134017, 3991.9201615967518, 4006.9982504373907, 5631.352394474688, 5654.123610840326, 5697.6296540724725, 5705.686187259741, 5750.856228594319, 5858.677772722541, 5878.617889837147, 5883.499902508249, 5888.175655408247, 5921.73352199152, 5510.889782204334, 5619.466150715675, 5636.915446268309, 5698.059820129715, 5709.115087161496, 4927.236278376858, 4931.038447502774, 4931.827386041471, 4934.4572097069295, 4968.354113965233, 6201.0388389799655, 6202.72087756052, 6209.844753881189, 6223.502119830403, 6226.844328891723, 5684.204211410323, 5829.5336373090895, 5859.414058594107, 5892.528597712087, 5945.40545945402, 6137.907931380943, 6140.5701600887505, 6148.907766383419, 6176.81469555914, 6181.412765787243, 5746.7701291949525, 5791.0734282514595, 5807.361190269152, 5809.36097029318, 5819.76720931158, 5678.0, 5724.0, 5770.3652598215, 5778.27771528559, 5780.161876527795, 5611.80358687444, 5635.605507614428, 5639.210510528447, 5643.887122257614, 5665.263515742927, 5563.888722225452, 5621.409751976147, 5667.574931880043, 5687.459691329317, 5687.971560142173, 5387.326584176978, 5494.642848214853, 5550.7779688812, 5569.443055694398, 5598.1602759586385, 5583.469570390806, 5657.688827114548, 5684.403137670485, 5728.570357223141, 5746.425357464387, 5429.402765695691, 5535.806246781343, 5550.222968784293, 5564.55483561306, 5571.136473846398], "value": 5345.032874312114, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4590262202217, 608.8660494691168, 620.1380081686459, 632.0929466215979, 633.6578247746218, 42966.0, 43381.0, 43960.0, 44279.77860110699, 46720.76639616797, 44612.776936115275, 44980.3252951206, 45010.32484512735, 45028.3245751314, 45129.54870451295, 8734.301255899545, 8825.95587022064, 8868.290536757044, 8887.866681999774, 8901.287896968228, 8688.304935605136, 8753.606087726035, 8816.074312197223, 8833.116688331147, 8837.072107428723, 8824.0, 8869.02440731519, 8872.733817985438, 8889.73330800077, 8893.110688931087, 8733.214010739064, 8737.0, 8737.038925718165, 8747.125287471266, 8783.912160878373, 8733.0, 8804.163604457566, 8809.515476648781, 8862.734117976472, 8903.599338029739, 42305.78847105776, 42538.36192457116, 42575.36136957948, 42708.572914271084, 42846.357304640456, 3391.6269210386836, 3489.6859282664427, 3524.2775231077567, 3542.734294927865, 3548.3967725486727, 31024.0, 32540.511892321632, 33634.49548256778, 34428.65571344279, 34601.48097778535, 4345.869623911288, 4353.738775673438, 4402.141582391435, 4502.144592527409, 4546.431696037996, 338865.0, 338918.0, 340831.0, 343585.0, 344691.9999999975, 33894.830525847705, 34846.303073938376, 34901.476477852346, 59225.0, 60117.39882601205, 36698.082547935985, 36742.632573674455, 36843.447348289796, 36929.815350923076, 36967.260654786754, 14401.0, 14422.0, 14553.927230363992, 14576.271186440636, 14582.343794529272, 11413.771724565462, 11433.656990290305, 11442.37066961325, 11455.770884582429, 11470.942645286887, 8249.092599814016, 8256.174382561696, 8291.792705182419, 8383.496990180609, 8404.117567655308, 3203.2472368993267, 3211.5985501812274, 3222.6616205298574, 3228.1445416964525, 3238.514222866589, 936.5457752989795, 1034.5448002878709, 1039.6984874386344, 1043.5929987304958, 1104.364990130662, 31604.367912641617, 31727.84136079305, 32324.83837580797, 32463.837680811444, 32620.83689581537, 1072.447689439939, 1081.8052750504828, 1127.537709539085, 1196.5991392883482, 1236.7773800715956, 16939.0, 17348.392806251974, 17372.218250178772, 17416.564585885455, 17469.1605631572, 525668.0, 528789.0, 531795.0, 533811.0, 535583.0, 59237.0, 59755.70122149361, 59952.70023649854, 59997.40002599918, 60030.69984650049, 1303.3548393545066, 1327.9867201328057, 1358.3934653494987, 1364.0792465086026, 1368.3773882883265, 29816.552751708306, 31521.842390788817, 31626.51204638645, 31630.0, 32071.839640801645, 49569.0, 50357.74821125871, 50445.74777126091, 50578.24132638087, 50710.746446267534, 436883.0, 445733.0, 446114.0, 446120.0, 448711.0, 28208.85895570509, 28430.43139137247, 28635.0, 28652.713472865005, 28660.57009144823, 48734.75632621814, 49457.50542494529, 49860.75069624629, 49982.25026624531, 50777.49222507728, 41739.582604174786, 42353.78823105865, 42506.36240456458, 42729.572704272556, 43259.35110973401, 40682.193033007105, 40777.388339174344, 41242.0, 41540.37689434722, 42203.36694949517, 35974.100647484025, 40391.1921761569, 40502.392464112476, 41295.0, 42222.366664499445, 35717.82141089278, 37688.81155594205, 38048.80975595215, 38389.232215356096, 38712.80643596876, 28137.577936330563, 28304.43391132207, 28426.85786571054, 28497.715022849505, 28588.857055714587], "value": 18806.437050791854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.80782800771595, 385.6124594782244, 390.9257241124187, 393.6791514915346, 407.95512493625694, 17182.398616048442, 19722.30971915983, 19793.505162370948, 19827.405177844652, 20188.29340973066, 17835.0, 18256.908715456437, 18490.44528664142, 18791.906040469814, 18894.527636809053, 5643.548516118711, 5754.913676294859, 5837.678927658977, 5870.295564532262, 5873.148393482942, 5625.071863142576, 5706.828795136132, 5762.654240745548, 5794.68129252891, 5815.185873977646, 5638.0, 5687.971560142214, 5699.344575373843, 5713.0, 5736.311642602873, 5612.5229355504625, 5759.452851979097, 5772.797952071657, 5774.6535207887455, 5801.854953626172, 4949.307097006386, 5026.497350264981, 5042.092423363793, 5049.192129259338, 5160.045391602565, 22661.0, 22873.085076596915, 23202.883985580134, 23226.3032109037, 23432.7656723434, 2363.0429675981254, 2471.6663250461315, 2483.3170878008514, 2546.490701859617, 2951.940961180764, 14616.26918654063, 14796.482123125747, 14931.328090235857, 15018.399264029425, 15055.322510487054, 1935.1098494692458, 1979.455649696345, 2008.7991200879942, 2024.3724445421967, 2077.418322869599, 70849.64575177143, 75339.24660753377, 75535.24464755337, 79701.0, 87421.99999999936, 10421.426821524889, 10822.242443028912, 10876.945615271872, 10979.780404391868, 11104.777904441866, 15002.474913377979, 15054.623634409227, 15065.924670376578, 15098.0, 15114.168720720247, 7598.658060387296, 7810.921890781133, 7833.5691536966015, 7877.212278772077, 7895.171007044178, 7466.664000120008, 7570.205128461543, 7620.504667196615, 7671.923280767121, 7679.116901556393, 4554.453465584151, 4614.630829533629, 4656.604188644003, 4704.129735998851, 4714.693544919569, 1920.981879603812, 1936.3803582853352, 1969.940901772949, 2033.4611327998093, 2039.7858224886172, 934.2619330728648, 969.1035791892472, 973.6300205921846, 975.4098770244042, 1022.2690776094979, 18793.530161746065, 19049.80950190508, 19610.901945490466, 19892.50268743264, 19924.800751992585, 981.7251169672503, 1022.7749895023084, 1033.9172866170688, 1045.628801775374, 1054.926155169146, 10532.36805791655, 11045.944770276257, 11058.170637202242, 11097.944510277397, 11180.273282236629, 471962.0, 476340.0, 484669.0, 487661.0, 496530.0, 97141.51429242949, 98324.50837745765, 98496.0, 98712.0, 98808.0, 978.0854900667898, 998.4159266828841, 1011.6307547745167, 1011.9747006324753, 1014.8021135878433, 17360.305587776853, 17415.0, 17667.469975900745, 17961.281548737905, 18083.54791130232, 41636.0, 42624.36063458989, 43237.567624323354, 43943.66757701886, 44302.55697442984, 59294.0, 60845.0, 61455.69272153611, 61634.691826540584, 62689.68655156695, 8423.115572865006, 8605.268552173135, 8668.696595619123, 8716.041235463967, 8845.734627961172, 12417.565385211474, 12964.546240881524, 13279.535216267384, 13666.726665466835, 13922.025458217828, 11267.887321126684, 11355.886441135483, 12084.214526055779, 12098.637040888787, 12134.817977730165, 12001.759964800829, 12079.39603019863, 12137.514499419924, 12219.51121955112, 12395.75208495807, 11972.64082077539, 12357.75284494287, 12365.75268494643, 12367.69080772988, 12398.690032748893, 7502.512336698097, 7650.923490765021, 7716.5755883426955, 7896.0, 8489.320854331516, 11279.266847654877, 11728.237664551776, 11735.706607334885, 12065.638030859089, 12168.93915530452], "value": 9335.827848636858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.9720205595886, 1447.8479759625238, 1519.5669234268237, 1659.5768079139818, 1693.7967443906718, 7575.0909890813045, 7928.6432110555015, 8335.208155225251, 9029.277657787377, 9041.593128309225, 8332.041815191254, 8520.488770673765, 8708.825823483527, 8737.344699147574, 8755.255803256714, 2296.5866144094057, 2334.8365614407, 2340.134150364359, 2343.379004563792, 2346.765323467657, 2335.649652552114, 2347.730011048726, 2356.1164563288767, 2381.071382160959, 2387.0213212582844, 2336.4626135988733, 2337.2287145242112, 2352.164981431593, 2378.3459548624096, 2393.533261014103, 2280.0879648140713, 2284.885755712216, 2293.334932869466, 2297.1959814064944, 2300.769923007703, 2158.708574342475, 2170.913163473459, 2175.8803265820534, 2177.891105444737, 2195.3304242206123, 8499.065102838744, 8500.617472213766, 8511.489310641382, 8513.74458766238, 8570.142985701443, 5163.32876726027, 5314.840554783363, 5319.867003324948, 5339.172428273624, 5339.199120131972, 3237.902862914116, 3239.0, 3396.4226081566194, 3410.778299410555, 3418.384690755663, 1179.6000916581115, 1194.3192380343207, 1200.2078628105407, 1210.6065528703118, 1219.1892391559602, 11972.161948663597, 12202.633920982385, 12262.754744905053, 12314.81527777084, 12322.938385308105, 4551.249043907718, 4589.977050114728, 4642.442906851199, 4720.0559888022535, 4724.4094488188975, 10352.948235258926, 10408.219383546264, 10411.271211015157, 10416.010479004482, 10486.947565262124, 5339.225812257201, 5344.866378340573, 5346.7861285548925, 5359.464053594609, 5360.276362691065, 4372.0, 4628.930566041512, 4746.881327966828, 4813.205821039489, 4828.0, 3871.9612803872164, 3927.626875446828, 3938.1139243669945, 4115.52671442782, 4119.258533464005, 1194.331174542259, 1203.2479700187382, 1212.3877441891789, 1229.5266322465916, 1241.875812418751, 876.6449587916904, 877.4472082588056, 894.1505569708803, 899.3524662243175, 919.1268295119663, 5547.1679248113105, 5617.185508101303, 5806.187133801272, 5853.586101074132, 5992.43071908168, 439.49019137799996, 439.86364227089064, 442.2238970606565, 454.23008001437245, 471.5217792221342, 3802.4106263529197, 3898.122922342507, 4007.8797636070963, 4048.4332193492933, 4131.814068366931, 10335.22485813567, 10808.189385796097, 10875.673729788119, 10882.564697412015, 10940.288881222696, 10378.792424151627, 10708.30396024256, 10813.945930270298, 10863.402512861869, 11145.442727863574, 7945.995569481314, 7955.880661789962, 8045.436819422584, 8069.435139540175, 8115.634796434175, 6050.6369617823075, 6123.418275263843, 6143.0, 6143.539234557516, 6195.482106883842, 10165.13596344319, 10232.0, 10243.692689219335, 10334.689959301233, 10436.0, 10056.49717514136, 10058.245631577514, 10365.689029329133, 10396.376217426978, 10413.271071024956, 6952.409045231212, 7430.628468576441, 7646.847063058819, 7699.538027718355, 7787.727429539939, 8372.372072094495, 8467.872981905153, 8471.068182500043, 8558.657653693783, 8564.357673174412, 6911.136107986502, 7265.636718164176, 7339.9266007341375, 7373.520721153108, 7595.278448547379, 7393.9260607393235, 7650.9234907652435, 7698.114716807639, 7708.190639982721, 7717.768466946, 6748.93251067483, 6778.152730908637, 6817.147856517935, 6820.454363650995, 6831.11195544576, 5093.617978651542, 5298.364196296469, 5439.4288599696465, 5439.456054394529, 5481.314835645544, 5242.76407561653, 5259.63182577216, 5273.073444238485, 5354.0, 5450.672959622435], "value": 4511.245600798537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.12125079770243, 314.79381005441417, 320.82515029309025, 322.56131660941116, 327.7738360531233, 5475.534579560732, 5512.503874651281, 5644.266245388099, 5717.885642287151, 5737.2541569596, 5530.419305972875, 5544.22380866679, 5568.415316391782, 5572.5263352614975, 5585.748641311141, 4385.276429389163, 4386.0, 4393.406890069848, 4394.362817391477, 4409.29451287794, 4054.5337286212166, 4222.556631553689, 4228.5560016198315, 4412.911741765179, 4422.402975598301, 4215.978920105395, 4219.3881887126345, 4221.514525829522, 4226.1336426032585, 4244.702870799046, 4271.423357846697, 4276.893077673083, 4280.357946308063, 4288.099499105192, 4312.762798046107, 3618.9276214475826, 3720.4605332226947, 3729.5524537055458, 3731.776093434403, 3731.925361492782, 5436.755346009439, 5449.182622606601, 5449.754761035763, 5456.263404440389, 5490.309748223342, 4886.169351210303, 4935.555799977983, 4939.654224204307, 4950.282209079699, 4981.5055483354845, 5677.772889084473, 5792.913106303409, 5817.331006934214, 5820.738066786962, 5842.707864606795, 4042.6765858731233, 4066.857659981916, 4088.0801819590356, 4102.5076990761, 4103.4050062740735, 5757.337906140806, 5959.493443057346, 6016.157737916695, 6060.878782424371, 6123.142760013558, 4134.689898257643, 4141.52372477169, 4148.688848336386, 4154.646855017358, 4157.750534967911, 4203.330884888057, 4210.978945105255, 4215.430916826251, 4215.725977811432, 4221.6833737469815, 4846.878828029327, 4864.562189402971, 4887.853364399074, 4903.681260718042, 4904.0, 5680.488756011896, 5748.568857335633, 5851.824445266649, 5885.558583106199, 5904.822855314347, 1438.978415323771, 1450.4415799916897, 1458.8832893368506, 1459.7956286119952, 1460.627539977299, 883.2404132446092, 917.9306108383792, 920.9263258939269, 929.2473096791621, 934.4206591912922, 4944.901101978012, 4969.527894849984, 5059.418166910852, 5107.770150343244, 5166.689998600096, 5338.733063346817, 5345.3540497454005, 5345.866353341197, 5380.838574842761, 5389.137737961985, 4965.851024469272, 5072.974635126875, 5109.284700141983, 5320.44135365781, 5716.628419152742, 3127.593412856314, 3167.2421805897948, 3188.5536024956523, 3188.6173659160586, 3236.271838836243, 6111.297200821962, 6169.791708311653, 6260.40526150015, 6263.404976527223, 6266.373362663697, 6139.693015349215, 6148.0, 6148.508119350441, 6171.907421388682, 6172.827162839047, 6111.388861113942, 6112.847178820476, 6303.2751233607805, 6326.557141000086, 6338.809835704937, 5841.678707671119, 6014.368491308524, 6046.395360464095, 6060.272767267956, 6064.514838812796, 5897.5576831736935, 5924.0, 5944.49471794885, 5959.344472108151, 5962.495751784174, 5993.700314984146, 6230.252369715663, 6258.3741625838875, 6286.9312216924145, 6309.779157729457, 4223.598758117974, 4228.471441069866, 4229.725067870579, 4238.0, 4285.80713867883, 5772.682502462237, 5907.675077870586, 6066.393360663898, 6084.513238940785, 6106.45041946227, 5816.302043754777, 5829.3296270927685, 5845.620034697731, 5853.653659658217, 5871.266091738533, 5875.383084776037, 5879.353271140257, 5887.411258874078, 5890.440408161217, 5909.852253693692, 5513.669179849222, 5645.830625081254, 5689.146628005832, 5700.600957933071, 5744.793593345445, 5857.824265271878, 5908.438698323653, 5951.285845698544, 5953.583249172516, 5974.610155937659, 5459.918101228564, 5697.572682048946, 5709.7145142741865, 5786.884262314814, 5844.736986835687], "value": 4382.102626335749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.7825630567136, 790.3210554867094, 794.8608993426157, 802.4062193976459, 804.6298702596807, 14803.555893323191, 16314.0, 16344.0, 16397.26212320447, 16405.589860253483, 13391.531296404628, 13421.261830599313, 13471.595852124428, 13531.188128712283, 15380.230988450561, 783.7061102086717, 799.0930294116191, 800.8598495263335, 801.0387534958045, 804.6137853830136, 654.3587284461231, 758.256908229935, 769.7228997560874, 779.0690125300268, 785.4541093939714, 821.6918655504186, 823.2549542663899, 828.2504333578122, 828.8798124271977, 830.667732906836, 815.979600509989, 819.1644522586928, 822.7655118291258, 824.3364091906013, 826.4132465949183, 594.9286085669704, 597.5996082624652, 598.8113744170572, 604.0727483313093, 606.1180981671657, 14334.569962901129, 14340.211288379134, 14413.927930360385, 14422.06256593318, 14433.134011959317, 14207.36066876993, 14314.0, 14352.856471435256, 14355.282235888268, 14424.206668633222, 12443.315617641027, 12582.685432864251, 12584.0, 12652.367381630882, 12669.176503527242, 3857.4792403025513, 3881.961180388188, 3913.6673382762215, 3929.7445666031617, 4062.289099407592, 85519.57240213822, 87157.12842871553, 87479.56260218722, 87501.12498874993, 87728.56135719344, 11181.44092795357, 11215.831762523569, 11576.42117894102, 11680.474378652982, 11859.525618975316, 19426.0, 21083.578328433345, 21217.469563261042, 21317.25389611356, 21518.784812151993, 8326.875096873551, 8688.13118688126, 8843.778905527284, 8885.644574216958, 8972.41679290844, 4668.299755036772, 4786.1863483207935, 4821.879453013633, 4854.587360074363, 4985.925211121836, 3581.0, 3674.761140525911, 3701.7038636908983, 3712.1090938174643, 3713.1459764254373, 630.3885231325606, 649.691396586627, 652.641047423915, 657.2310396835713, 686.5640318397853, 610.6305685060563, 669.7220653428773, 725.8040329111216, 732.4982387064878, 749.4004796163048, 9427.717168484956, 9646.662366817127, 9730.172935300438, 9811.656592019244, 10370.740731481623, 636.5639536917226, 695.6104581434413, 708.6173466328125, 712.5226098514008, 722.227216877946, 4643.674942753974, 4844.75776211188, 4853.830115945995, 4882.658213925062, 4883.706977581356, 112937.0, 116302.41848790702, 117161.0, 118263.40868295776, 121762.39118804349, 98519.50740246254, 100460.49769751105, 100667.49666251622, 102247.0, 104358.47820760848, 82990.58504707558, 85868.0, 86636.99999999873, 87405.44100916114, 89206.10793891978, 9219.400738951947, 9409.576569054272, 9425.387349822515, 9500.762480937756, 9564.33049686543, 50319.74840125776, 50358.24462633137, 50803.74598126986, 51470.22794658158, 51639.225411619605, 68137.23786207747, 73951.0, 75978.6201068991, 76384.0, 77527.44945100954, 12299.323537205539, 12434.440450179945, 12742.745145097231, 12776.61670149897, 13030.869691303345, 15427.151506667242, 15737.527874163794, 15802.130882801557, 15824.762628560351, 15868.60328491797, 13610.523631672844, 13816.447342106203, 14118.2940852959, 14551.0, 15366.539003829903, 13834.911721079163, 14827.0, 14978.575851393189, 15062.16767280986, 15112.697746045238, 13680.93159534196, 13986.370613322628, 14067.437302507786, 14089.436422543393, 14263.928680356532, 11630.76738465209, 11915.702107447383, 12235.877641223475, 12301.876981230072, 12316.445759940645, 11070.28043177191, 11201.159913006393, 11521.308721476738, 11529.365884876412, 11893.583724569598], "value": 7647.069695085577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 104.0, 112.0, 111.0, 111.0, 112.0, 109.0, 111.0, 113.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 156.0, 174.0, 126.0, 155.0, 161.0, 125.0, 184.0, 125.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 160.0, 166.0, 169.0, 164.0, 163.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 159.0, 75.0, 75.0, 73.0, 75.0, 161.0, 74.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 158.0, 85.0, 86.0, 84.0, 142.0, 84.0, 86.0, 156.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 120.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.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, 55.0, 55.0, 58.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 80.0, 86.0, 81.0, 85.0, 82.0, 80.0, 90.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 132.0, 136.0, 141.0, 128.0, 123.0, 134.0, 132.0, 138.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 162.0, 164.0, 167.0, 161.0, 164.0, 162.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 68.0, 62.0, 62.0, 64.0, 63.0, 63.0, 68.0], "value": 64.0, "unit": "score"}]}]} 23:36:04 INFO - Return code: 0 23:36:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:04 ERROR - # TBPL SUCCESS # 23:36:04 INFO - Running post-action listener: _resource_record_post_action 23:36:04 INFO - ##### 23:36:04 INFO - ##### Finished run-tests step (success) 23:36:04 INFO - ##### 23:36:04 INFO - Running post-run listener: _resource_record_post_run 23:36:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 536576; Write bytes: 299020288; Read time: 180; Write time: 195532 23:36:04 INFO - TinderboxPrint: CPU usage
13.5% 23:36:04 INFO - TinderboxPrint: I/O read bytes / time
536,576 / 180 23:36:04 INFO - TinderboxPrint: I/O write bytes / time
299,020,288 / 195,532 23:36:04 INFO - TinderboxPrint: CPU idle
8,233.2 (86.5%) 23:36:04 INFO - TinderboxPrint: CPU user
1,224.6 (12.9%) 23:36:04 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6447104; Read time: 0; Write time: 832 23:36:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 536576; Write bytes: 288944128; Read time: 180; Write time: 189588 23:36:05 INFO - Running post-run listener: _upload_blobber_files 23:36:05 INFO - Blob upload gear active. 23:36:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:05 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 23:36:05 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'] 23:36:05 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 23:36:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:06 INFO - (blobuploader) - INFO - Done attempting. 23:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:34 INFO - (blobuploader) - INFO - Done attempting. 23:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:35 INFO - (blobuploader) - INFO - Done attempting. 23:36:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:35 INFO - Return code: 0 23:36:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232d9c28c0289b26c20e1df2d44fb9642d61c2a755d6b943aa045456992e70d74e7e64a9fd71c4a6d6998f9b3b4ac028a79afc9e604ca80d482899ce69dcb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa598918908f39f758defa6ada93fc7af42e757de271f7104ca66cdc0b80dd4ad12df310edaafbff21b7e4b2166254c005c48e1d4a0e2bbeca7c7cacbe230b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9f71242ffd669ef80f9f5765c98ae312cc35efe2870b0dfaf028b0389ff1de73c186765d1b760aff287830ce2a265b1f89887a3dc45899b866f9a2f8861bc91"} 23:36:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:35 INFO - Contents: 23:36:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232d9c28c0289b26c20e1df2d44fb9642d61c2a755d6b943aa045456992e70d74e7e64a9fd71c4a6d6998f9b3b4ac028a79afc9e604ca80d482899ce69dcb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa598918908f39f758defa6ada93fc7af42e757de271f7104ca66cdc0b80dd4ad12df310edaafbff21b7e4b2166254c005c48e1d4a0e2bbeca7c7cacbe230b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9f71242ffd669ef80f9f5765c98ae312cc35efe2870b0dfaf028b0389ff1de73c186765d1b760aff287830ce2a265b1f89887a3dc45899b866f9a2f8861bc91"} 23:36:35 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:35 INFO - Copying logs to upload dir... 23:36:35 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.650680 ========= master_lag: 422.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 11 secs) (at 2016-06-22 23:43:37.741519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 23:43:37.745044) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232d9c28c0289b26c20e1df2d44fb9642d61c2a755d6b943aa045456992e70d74e7e64a9fd71c4a6d6998f9b3b4ac028a79afc9e604ca80d482899ce69dcb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa598918908f39f758defa6ada93fc7af42e757de271f7104ca66cdc0b80dd4ad12df310edaafbff21b7e4b2166254c005c48e1d4a0e2bbeca7c7cacbe230b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9f71242ffd669ef80f9f5765c98ae312cc35efe2870b0dfaf028b0389ff1de73c186765d1b760aff287830ce2a265b1f89887a3dc45899b866f9a2f8861bc91"} build_url:https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232d9c28c0289b26c20e1df2d44fb9642d61c2a755d6b943aa045456992e70d74e7e64a9fd71c4a6d6998f9b3b4ac028a79afc9e604ca80d482899ce69dcb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa598918908f39f758defa6ada93fc7af42e757de271f7104ca66cdc0b80dd4ad12df310edaafbff21b7e4b2166254c005c48e1d4a0e2bbeca7c7cacbe230b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9f71242ffd669ef80f9f5765c98ae312cc35efe2870b0dfaf028b0389ff1de73c186765d1b760aff287830ce2a265b1f89887a3dc45899b866f9a2f8861bc91"}' ========= master_lag: 0.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 23:43:38.116277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 mins, 5 secs) (at 2016-06-22 23:43:38.119737) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466661703.999654-1841759399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 185.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 mins, 5 secs) (at 2016-06-22 23:46:43.481013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 23:46:43.481352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 23:46:44.163580) ========= ========= Total master_lag: 608.55 =========