builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1465475979.59 results: success (0) buildid: 20160609030247 builduid: d600bdbc5a39477ba57a97cdd26595d9 revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.593081) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.593637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.593921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.616911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.617301) ========= 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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 05:39:40-- 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-09 05:39:40 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.705328) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.705639) ========= 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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.757836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:39.758248) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 05:39:40,455 truncating revision to first 12 chars 2016-06-09 05:39:40,455 Setting DEBUG logging. 2016-06-09 05:39:40,455 attempt 1/10 2016-06-09 05:39:40,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb493102af8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 05:39:40,790 unpacking tar archive at: mozilla-central-cb493102af8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:40.448887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:40.449233) ========= script_repo_revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:40.449675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:40.449966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:39:40.465852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2016-06-09 05:39:40.466121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:41 INFO - MultiFileLogger online at 20160609 05:39:41 in /builds/slave/test 05:39:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:41 INFO - {'append_to_log': False, 05:39:41 INFO - 'base_work_dir': '/builds/slave/test', 05:39:41 INFO - 'blob_upload_branch': 'Firefox', 05:39:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:41 INFO - 'branch': 'Firefox', 05:39:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:41 INFO - 'config_files': ('talos/linux_config.py',), 05:39:41 INFO - 'default_actions': ('clobber', 05:39:41 INFO - 'read-buildbot-config', 05:39:41 INFO - 'download-and-extract', 05:39:41 INFO - 'populate-webroot', 05:39:41 INFO - 'create-virtualenv', 05:39:41 INFO - 'install', 05:39:41 INFO - 'run-tests'), 05:39:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:41 INFO - 'download_minidump_stackwalk': True, 05:39:41 INFO - 'download_symbols': 'ondemand', 05:39:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:41 INFO - 'installer_path': 'installer.exe', 05:39:41 INFO - 'log_level': 'info', 05:39:41 INFO - 'log_name': 'talos', 05:39:41 INFO - 'log_to_console': True, 05:39:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:41 INFO - 'opt_config_files': (), 05:39:41 INFO - 'pip_index': False, 05:39:41 INFO - 'sps_profile': False, 05:39:41 INFO - 'sps_profile_interval': 0, 05:39:41 INFO - 'suite': 'dromaeojs-e10s', 05:39:41 INFO - 'system_bits': '32', 05:39:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:41 INFO - 'title': 'talos-linux64-ix-058', 05:39:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:41 INFO - 'use_talos_json': True, 05:39:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:41 INFO - 'work_dir': 'build'} 05:39:41 INFO - ##### 05:39:41 INFO - ##### Running clobber step. 05:39:41 INFO - ##### 05:39:41 INFO - Running pre-action listener: _resource_record_pre_action 05:39:41 INFO - Running main action method: clobber 05:39:41 INFO - rmtree: /builds/slave/test/build 05:39:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:42 INFO - Running post-action listener: _resource_record_post_action 05:39:42 INFO - ##### 05:39:42 INFO - ##### Finished clobber step (success) 05:39:42 INFO - ##### 05:39:42 INFO - ##### 05:39:42 INFO - ##### Running read-buildbot-config step. 05:39:42 INFO - ##### 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: read_buildbot_config 05:39:42 INFO - Using buildbot properties: 05:39:42 INFO - { 05:39:42 INFO - "project": "", 05:39:42 INFO - "product": "firefox", 05:39:42 INFO - "script_repo_revision": "production", 05:39:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:42 INFO - "repository": "", 05:39:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:42 INFO - "buildid": "20160609030247", 05:39:42 INFO - "stage_platform": "linux64-pgo", 05:39:42 INFO - "basedir": "/builds/slave/test", 05:39:42 INFO - "nightly_build": "True", 05:39:42 INFO - "buildnumber": 747, 05:39:42 INFO - "slavename": "talos-linux64-ix-058", 05:39:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:39:42 INFO - "platform": "ubuntu64_hw", 05:39:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:42 INFO - "branch": "mozilla-central", 05:39:42 INFO - "repo_path": "mozilla-central", 05:39:42 INFO - "revision": "cb493102af8a50946ac601a86cc3d076703faa57", 05:39:42 INFO - "pgo_build": "True", 05:39:42 INFO - "builduid": "d600bdbc5a39477ba57a97cdd26595d9", 05:39:42 INFO - "slavebuilddir": "test" 05:39:42 INFO - } 05:39:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:39:42 INFO - Running post-action listener: _resource_record_post_action 05:39:42 INFO - ##### 05:39:42 INFO - ##### Finished read-buildbot-config step (success) 05:39:42 INFO - ##### 05:39:42 INFO - ##### 05:39:42 INFO - ##### Running download-and-extract step. 05:39:42 INFO - ##### 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: download_and_extract 05:39:42 INFO - mkdir: /builds/slave/test/build/tests 05:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:42 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:47 INFO - Downloaded 1361 bytes. 05:39:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:47 INFO - Using the following test package requirements: 05:39:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'jsshell-linux-x86_64.zip'], 05:39:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:47 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')]} 05:39:47 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:54 INFO - Downloaded 24451981 bytes. 05:39:54 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'] 05:39:54 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 05:39:55 INFO - Return code: 0 05:39:55 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 05:39:55 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')]} 05:39:55 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:40:01 INFO - Downloaded 24451981 bytes. 05:40:01 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'] 05:40:01 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 05:40:02 INFO - Return code: 0 05:40:02 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')]} 05:40:02 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:40:03 INFO - Downloaded 10833377 bytes. 05:40:03 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'] 05:40:03 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 05:40:04 INFO - Return code: 0 05:40: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')]} 05:40:04 INFO - https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 05:40:36 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 05:40:36 INFO - retry: attempt #1 caught exception: The read operation timed out 05:40:36 INFO - retry: Failed, sleeping 30 seconds before retrying 05:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GFmnN55tSVKrqwZFrZl5qA/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 #2 05:41:08 INFO - Downloaded 59350640 bytes. 05:41:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:08 INFO - mkdir: /builds/slave/test/properties 05:41:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:08 INFO - Contents: 05:41:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:08 INFO - Running post-action listener: _resource_record_post_action 05:41:08 INFO - Running post-action listener: set_extra_try_arguments 05:41:08 INFO - ##### 05:41:08 INFO - ##### Finished download-and-extract step (success) 05:41:08 INFO - ##### 05:41:08 INFO - ##### 05:41:08 INFO - ##### Running populate-webroot step. 05:41:08 INFO - ##### 05:41:08 INFO - Running pre-action listener: _resource_record_pre_action 05:41:08 INFO - Running main action method: populate_webroot 05:41:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:08 INFO - '--tppagecycles', 05:41:08 INFO - '7'], 05:41:08 INFO - 'tests': ['tsvgm']}}, 05:41:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['damp', 'tps']}, 05:41:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'tests': ['damp', 'tps']}, 05:41:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['dromaeo_dom']}, 05:41:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['a11yr', 05:41:08 INFO - 'ts_paint', 05:41:08 INFO - 'tpaint', 05:41:08 INFO - 'sessionrestore', 05:41:08 INFO - 'sessionrestore_no_auto_restore', 05:41:08 INFO - 'tabpaint']}, 05:41:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['tsvgx', 05:41:08 INFO - 'tsvgr_opacity', 05:41:08 INFO - 'tart', 05:41:08 INFO - 'tscrollx', 05:41:08 INFO - 'cart']}, 05:41:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:08 INFO - 'tsvgr_opacity', 05:41:08 INFO - 'tart', 05:41:08 INFO - 'tscrollx', 05:41:08 INFO - 'cart']}, 05:41:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'talos_options': ['--disable-e10s'], 05:41:08 INFO - 'tests': ['tp5o']}, 05:41:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'tests': ['tp5o']}, 05:41:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'talos_options': ['--disable-e10s', 05:41:08 INFO - '--xperf_path', 05:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:08 INFO - 'tests': ['tp5n']}, 05:41:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:08 INFO - 'talos_options': ['--xperf_path', 05:41:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:08 INFO - 'tests': ['tp5n']}}, 05:41:08 INFO - 'talos.zip': {'path': '', 05:41:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:08 INFO - Running post-action listener: _resource_record_post_action 05:41:08 INFO - ##### 05:41:08 INFO - ##### Finished populate-webroot step (success) 05:41:08 INFO - ##### 05:41:08 INFO - ##### 05:41:08 INFO - ##### Running create-virtualenv step. 05:41:08 INFO - ##### 05:41:08 INFO - Running pre-action listener: _resource_record_pre_action 05:41:08 INFO - Running main action method: create_virtualenv 05:41:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:08 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 05:41:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:08 INFO - Using real prefix '/usr' 05:41:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:11 INFO - Installing pip.................done. 05:41:11 INFO - Return code: 0 05:41:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:11 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 05:41:11 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 05:41:11 INFO - Using env: {'DISPLAY': ':0', 05:41:11 INFO - 'HOME': '/home/cltbld', 05:41:11 INFO - 'LANG': 'en_US.UTF-8', 05:41:11 INFO - 'LANGUAGE': 'en_US:en', 05:41:11 INFO - 'LOGNAME': 'cltbld', 05:41:11 INFO - 'MAIL': '/var/mail/cltbld', 05:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:11 INFO - 'MOZ_NO_REMOTE': '1', 05:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:11 INFO - 'NO_EM_RESTART': '1', 05:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:11 INFO - 'PWD': '/builds/slave/test', 05:41:11 INFO - 'SHELL': '/bin/bash', 05:41:11 INFO - 'SHLVL': '1', 05:41:11 INFO - 'TERM': 'linux', 05:41:11 INFO - 'TMOUT': '86400', 05:41:11 INFO - 'USER': 'cltbld', 05:41:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:11 INFO - '_': '/tools/buildbot/bin/python'} 05:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:11 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 05:41:11 INFO - Cleaning up... 05:41:11 INFO - Return code: 0 05:41:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:11 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 05:41:11 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 05:41:11 INFO - Using env: {'DISPLAY': ':0', 05:41:11 INFO - 'HOME': '/home/cltbld', 05:41:11 INFO - 'LANG': 'en_US.UTF-8', 05:41:11 INFO - 'LANGUAGE': 'en_US:en', 05:41:11 INFO - 'LOGNAME': 'cltbld', 05:41:11 INFO - 'MAIL': '/var/mail/cltbld', 05:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:11 INFO - 'MOZ_NO_REMOTE': '1', 05:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:11 INFO - 'NO_EM_RESTART': '1', 05:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:11 INFO - 'PWD': '/builds/slave/test', 05:41:11 INFO - 'SHELL': '/bin/bash', 05:41:11 INFO - 'SHLVL': '1', 05:41:11 INFO - 'TERM': 'linux', 05:41:11 INFO - 'TMOUT': '86400', 05:41:11 INFO - 'USER': 'cltbld', 05:41:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:11 INFO - '_': '/tools/buildbot/bin/python'} 05:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:11 INFO - Downloading/unpacking psutil>=3.1.1 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:13 INFO - Installing collected packages: psutil 05:41:13 INFO - Running setup.py install for psutil 05:41:13 INFO - building 'psutil._psutil_linux' extension 05:41:13 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 05:41:14 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 05:41:14 INFO - building 'psutil._psutil_posix' extension 05:41:14 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 05:41:14 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 05:41:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:14 INFO - Successfully installed psutil 05:41:14 INFO - Cleaning up... 05:41:14 INFO - Return code: 0 05:41:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:14 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')]} 05:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:14 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')]} 05:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:14 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:14 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 05:41:14 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 05:41:14 INFO - Using env: {'DISPLAY': ':0', 05:41:14 INFO - 'HOME': '/home/cltbld', 05:41:14 INFO - 'LANG': 'en_US.UTF-8', 05:41:14 INFO - 'LANGUAGE': 'en_US:en', 05:41:14 INFO - 'LOGNAME': 'cltbld', 05:41:14 INFO - 'MAIL': '/var/mail/cltbld', 05:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:14 INFO - 'MOZ_NO_REMOTE': '1', 05:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:14 INFO - 'NO_EM_RESTART': '1', 05:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:14 INFO - 'PWD': '/builds/slave/test', 05:41:14 INFO - 'SHELL': '/bin/bash', 05:41:14 INFO - 'SHLVL': '1', 05:41:14 INFO - 'TERM': 'linux', 05:41:14 INFO - 'TMOUT': '86400', 05:41:14 INFO - 'USER': 'cltbld', 05:41:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:14 INFO - '_': '/tools/buildbot/bin/python'} 05:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:16 INFO - Installing collected packages: mozsystemmonitor 05:41:16 INFO - Running setup.py install for mozsystemmonitor 05:41:16 INFO - Successfully installed mozsystemmonitor 05:41:16 INFO - Cleaning up... 05:41:16 INFO - Return code: 0 05:41:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:16 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 05:41:16 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 05:41:16 INFO - Using env: {'DISPLAY': ':0', 05:41:16 INFO - 'HOME': '/home/cltbld', 05:41:16 INFO - 'LANG': 'en_US.UTF-8', 05:41:16 INFO - 'LANGUAGE': 'en_US:en', 05:41:16 INFO - 'LOGNAME': 'cltbld', 05:41:16 INFO - 'MAIL': '/var/mail/cltbld', 05:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:16 INFO - 'MOZ_NO_REMOTE': '1', 05:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:16 INFO - 'NO_EM_RESTART': '1', 05:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:16 INFO - 'PWD': '/builds/slave/test', 05:41:16 INFO - 'SHELL': '/bin/bash', 05:41:16 INFO - 'SHLVL': '1', 05:41:16 INFO - 'TERM': 'linux', 05:41:16 INFO - 'TMOUT': '86400', 05:41:16 INFO - 'USER': 'cltbld', 05:41:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:16 INFO - '_': '/tools/buildbot/bin/python'} 05:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:19 INFO - warning: no files found matching '*.txt' 05:41:19 INFO - no previously-included directories found matching 'build' 05:41:19 INFO - no previously-included directories found matching 'dist' 05:41:19 INFO - no previously-included directories found matching '.git*' 05:41:19 INFO - Installing collected packages: jsonschema, functools32 05:41:19 INFO - Running setup.py install for functools32 05:41:19 INFO - warning: no files found matching '*.txt' 05:41:19 INFO - no previously-included directories found matching 'build' 05:41:19 INFO - no previously-included directories found matching 'dist' 05:41:19 INFO - no previously-included directories found matching '.git*' 05:41:19 INFO - Successfully installed jsonschema functools32 05:41:19 INFO - Cleaning up... 05:41:19 INFO - Return code: 0 05:41:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:41:19 INFO - Using env: {'DISPLAY': ':0', 05:41:19 INFO - 'HOME': '/home/cltbld', 05:41:19 INFO - 'LANG': 'en_US.UTF-8', 05:41:19 INFO - 'LANGUAGE': 'en_US:en', 05:41:19 INFO - 'LOGNAME': 'cltbld', 05:41:19 INFO - 'MAIL': '/var/mail/cltbld', 05:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:19 INFO - 'MOZ_NO_REMOTE': '1', 05:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:19 INFO - 'NO_EM_RESTART': '1', 05:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:19 INFO - 'PWD': '/builds/slave/test', 05:41:19 INFO - 'SHELL': '/bin/bash', 05:41:19 INFO - 'SHLVL': '1', 05:41:19 INFO - 'TERM': 'linux', 05:41:19 INFO - 'TMOUT': '86400', 05:41:19 INFO - 'USER': 'cltbld', 05:41:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:19 INFO - '_': '/tools/buildbot/bin/python'} 05:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:22 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 05:41:22 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 05:41:22 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 05:41:22 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 05:41:22 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 05:41:22 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 05:41:22 INFO - Downloading docopt-0.6.1.tar.gz 05:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:22 INFO - Running setup.py install for blobuploader 05:41:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:22 INFO - Running setup.py install for requests 05:41:22 INFO - Running setup.py install for docopt 05:41:22 INFO - Successfully installed blobuploader requests docopt 05:41:22 INFO - Cleaning up... 05:41:22 INFO - Return code: 0 05:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:22 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:22 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 05:41:22 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 05:41:22 INFO - Using env: {'DISPLAY': ':0', 05:41:22 INFO - 'HOME': '/home/cltbld', 05:41:22 INFO - 'LANG': 'en_US.UTF-8', 05:41:22 INFO - 'LANGUAGE': 'en_US:en', 05:41:22 INFO - 'LOGNAME': 'cltbld', 05:41:22 INFO - 'MAIL': '/var/mail/cltbld', 05:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:22 INFO - 'MOZ_NO_REMOTE': '1', 05:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:22 INFO - 'NO_EM_RESTART': '1', 05:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:22 INFO - 'PWD': '/builds/slave/test', 05:41:22 INFO - 'SHELL': '/bin/bash', 05:41:22 INFO - 'SHLVL': '1', 05:41:22 INFO - 'TERM': 'linux', 05:41:22 INFO - 'TMOUT': '86400', 05:41:22 INFO - 'USER': 'cltbld', 05:41:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:22 INFO - '_': '/tools/buildbot/bin/python'} 05:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:23 INFO - Running setup.py (path:/tmp/pip-pobeuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:23 INFO - Running setup.py (path:/tmp/pip-2r9oDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:23 INFO - Running setup.py (path:/tmp/pip-djyOrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:23 INFO - Running setup.py (path:/tmp/pip-l7IBAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:23 INFO - Running setup.py (path:/tmp/pip-60IG0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:23 INFO - Running setup.py (path:/tmp/pip-gInl6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:23 INFO - Running setup.py (path:/tmp/pip-Kk5Plf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:23 INFO - Running setup.py (path:/tmp/pip-h7a4cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:23 INFO - Running setup.py (path:/tmp/pip-0EGvi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:23 INFO - Running setup.py (path:/tmp/pip-luu_3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:23 INFO - Running setup.py (path:/tmp/pip-7ztEfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:23 INFO - Running setup.py (path:/tmp/pip-HJL4tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:24 INFO - Running setup.py (path:/tmp/pip-Adwd1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:24 INFO - Running setup.py (path:/tmp/pip-_mDIES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:24 INFO - Running setup.py (path:/tmp/pip-yD2SQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:24 INFO - Running setup.py (path:/tmp/pip-C3qoFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:24 INFO - Running setup.py (path:/tmp/pip-guonmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:24 INFO - Running setup.py install for manifestparser 05:41:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:24 INFO - Running setup.py install for mozcrash 05:41:24 INFO - Running setup.py install for mozdebug 05:41:24 INFO - Running setup.py install for mozdevice 05:41:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:24 INFO - Running setup.py install for mozfile 05:41:24 INFO - Running setup.py install for mozhttpd 05:41:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozinfo 05:41:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozInstall 05:41:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozleak 05:41:25 INFO - Running setup.py install for mozlog 05:41:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for moznetwork 05:41:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozprocess 05:41:25 INFO - Running setup.py install for mozprofile 05:41:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozrunner 05:41:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:25 INFO - Running setup.py install for mozscreenshot 05:41:25 INFO - Running setup.py install for moztest 05:41:26 INFO - Running setup.py install for mozversion 05:41:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:26 INFO - Cleaning up... 05:41:26 INFO - Return code: 0 05:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:26 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 05:41:26 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 05:41:26 INFO - Using env: {'DISPLAY': ':0', 05:41:26 INFO - 'HOME': '/home/cltbld', 05:41:26 INFO - 'LANG': 'en_US.UTF-8', 05:41:26 INFO - 'LANGUAGE': 'en_US:en', 05:41:26 INFO - 'LOGNAME': 'cltbld', 05:41:26 INFO - 'MAIL': '/var/mail/cltbld', 05:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:26 INFO - 'MOZ_NO_REMOTE': '1', 05:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:26 INFO - 'NO_EM_RESTART': '1', 05:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:26 INFO - 'PWD': '/builds/slave/test', 05:41:26 INFO - 'SHELL': '/bin/bash', 05:41:26 INFO - 'SHLVL': '1', 05:41:26 INFO - 'TERM': 'linux', 05:41:26 INFO - 'TMOUT': '86400', 05:41:26 INFO - 'USER': 'cltbld', 05:41:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:26 INFO - '_': '/tools/buildbot/bin/python'} 05:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:26 INFO - Running setup.py (path:/tmp/pip-TDJnNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:26 INFO - Running setup.py (path:/tmp/pip-ewsFUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:26 INFO - Running setup.py (path:/tmp/pip-tGT9dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:26 INFO - Running setup.py (path:/tmp/pip-xTtXSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:26 INFO - Running setup.py (path:/tmp/pip-RDICNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:26 INFO - Running setup.py (path:/tmp/pip-on_p5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:26 INFO - Running setup.py (path:/tmp/pip-Xw9_OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:26 INFO - Running setup.py (path:/tmp/pip-zcSw0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:26 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)) 05:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:27 INFO - Running setup.py (path:/tmp/pip-GM1xhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:27 INFO - Running setup.py (path:/tmp/pip-Klv_xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:27 INFO - Running setup.py (path:/tmp/pip-EyoEx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:27 INFO - Running setup.py (path:/tmp/pip-hMyZjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:27 INFO - Running setup.py (path:/tmp/pip-KuSVMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:27 INFO - Running setup.py (path:/tmp/pip-yU8w2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:27 INFO - Running setup.py (path:/tmp/pip-1UHlYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:27 INFO - Running setup.py (path:/tmp/pip-z7UJgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:27 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)) 05:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:27 INFO - Running setup.py (path:/tmp/pip-ZAXPVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:27 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)) 05:41:27 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)) 05:41:27 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)) 05:41:27 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)) 05:41:27 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)) 05:41:27 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)) 05:41:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:27 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 05:41:27 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 05:41:27 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 05:41:27 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 05:41:27 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 05:41:27 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 05:41:29 INFO - Downloading blessings-1.6.tar.gz 05:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:29 INFO - Installing collected packages: blessings 05:41:29 INFO - Running setup.py install for blessings 05:41:29 INFO - Successfully installed blessings 05:41:29 INFO - Cleaning up... 05:41:29 INFO - Return code: 0 05:41:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:30 INFO - Reading from file tmpfile_stdout 05:41:30 INFO - Current package versions: 05:41:30 INFO - argparse == 1.2.1 05:41:30 INFO - blessings == 1.6 05:41:30 INFO - blobuploader == 1.2.4 05:41:30 INFO - docopt == 0.6.1 05:41:30 INFO - functools32 == 3.2.3-2 05:41:30 INFO - jsonschema == 2.5.1 05:41:30 INFO - manifestparser == 1.1 05:41:30 INFO - mozInstall == 1.12 05:41:30 INFO - mozcrash == 0.17 05:41:30 INFO - mozdebug == 0.1 05:41:30 INFO - mozdevice == 0.48 05:41:30 INFO - mozfile == 1.2 05:41:30 INFO - mozhttpd == 0.7 05:41:30 INFO - mozinfo == 0.9 05:41:30 INFO - mozleak == 0.1 05:41:30 INFO - mozlog == 3.2 05:41:30 INFO - moznetwork == 0.27 05:41:30 INFO - mozprocess == 0.22 05:41:30 INFO - mozprofile == 0.28 05:41:30 INFO - mozrunner == 6.11 05:41:30 INFO - mozscreenshot == 0.1 05:41:30 INFO - mozsystemmonitor == 0.3 05:41:30 INFO - moztest == 0.7 05:41:30 INFO - mozversion == 1.4 05:41:30 INFO - psutil == 3.1.1 05:41:30 INFO - requests == 1.2.3 05:41:30 INFO - wsgiref == 0.1.2 05:41:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:30 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')]} 05:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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')]} 05:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:30 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 05:41:30 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 05:41:30 INFO - Using env: {'DISPLAY': ':0', 05:41:30 INFO - 'HOME': '/home/cltbld', 05:41:30 INFO - 'LANG': 'en_US.UTF-8', 05:41:30 INFO - 'LANGUAGE': 'en_US:en', 05:41:30 INFO - 'LOGNAME': 'cltbld', 05:41:30 INFO - 'MAIL': '/var/mail/cltbld', 05:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:30 INFO - 'MOZ_NO_REMOTE': '1', 05:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:30 INFO - 'NO_EM_RESTART': '1', 05:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:30 INFO - 'PWD': '/builds/slave/test', 05:41:30 INFO - 'SHELL': '/bin/bash', 05:41:30 INFO - 'SHLVL': '1', 05:41:30 INFO - 'TERM': 'linux', 05:41:30 INFO - 'TMOUT': '86400', 05:41:30 INFO - 'USER': 'cltbld', 05:41:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:30 INFO - '_': '/tools/buildbot/bin/python'} 05:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 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)) 05:41:30 INFO - Cleaning up... 05:41:30 INFO - Return code: 0 05:41:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:30 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')]} 05:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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')]} 05:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:30 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 05:41:30 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 05:41:30 INFO - Using env: {'DISPLAY': ':0', 05:41:30 INFO - 'HOME': '/home/cltbld', 05:41:30 INFO - 'LANG': 'en_US.UTF-8', 05:41:30 INFO - 'LANGUAGE': 'en_US:en', 05:41:30 INFO - 'LOGNAME': 'cltbld', 05:41:30 INFO - 'MAIL': '/var/mail/cltbld', 05:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:30 INFO - 'MOZ_NO_REMOTE': '1', 05:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:30 INFO - 'NO_EM_RESTART': '1', 05:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:30 INFO - 'PWD': '/builds/slave/test', 05:41:30 INFO - 'SHELL': '/bin/bash', 05:41:30 INFO - 'SHLVL': '1', 05:41:30 INFO - 'TERM': 'linux', 05:41:30 INFO - 'TMOUT': '86400', 05:41:30 INFO - 'USER': 'cltbld', 05:41:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:30 INFO - '_': '/tools/buildbot/bin/python'} 05:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:30 INFO - Cleaning up... 05:41:30 INFO - Return code: 0 05:41:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:41:30 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')]} 05:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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')]} 05:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:30 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 0x7f12b851ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, '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': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', '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 05:41:30 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 05:41:30 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 05:41:30 INFO - Using env: {'DISPLAY': ':0', 05:41:30 INFO - 'HOME': '/home/cltbld', 05:41:30 INFO - 'LANG': 'en_US.UTF-8', 05:41:30 INFO - 'LANGUAGE': 'en_US:en', 05:41:30 INFO - 'LOGNAME': 'cltbld', 05:41:30 INFO - 'MAIL': '/var/mail/cltbld', 05:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:30 INFO - 'MOZ_NO_REMOTE': '1', 05:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:30 INFO - 'NO_EM_RESTART': '1', 05:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:30 INFO - 'PWD': '/builds/slave/test', 05:41:30 INFO - 'SHELL': '/bin/bash', 05:41:30 INFO - 'SHLVL': '1', 05:41:30 INFO - 'TERM': 'linux', 05:41:30 INFO - 'TMOUT': '86400', 05:41:30 INFO - 'USER': 'cltbld', 05:41:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:30 INFO - '_': '/tools/buildbot/bin/python'} 05:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:30 INFO - Downloading/unpacking flake8 05:41:30 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 05:41:30 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 05:41:30 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 05:41:30 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 05:41:30 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 05:41:30 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 05:41:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:41:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:41:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:41:33 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 05:41:33 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 05:41:33 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 05:41:33 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 05:41:33 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 05:41:33 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 05:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:41:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:33 INFO - no previously-included directories found matching 'docs/_build' 05:41:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:41:33 INFO - Running setup.py install for pep8 05:41:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:33 INFO - no previously-included directories found matching 'docs/_build' 05:41:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:41:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:41:33 INFO - Cleaning up... 05:41:33 INFO - Return code: 0 05:41:33 INFO - Running post-action listener: _resource_record_post_action 05:41:33 INFO - Running post-action listener: _start_resource_monitoring 05:41:33 INFO - Starting resource monitoring. 05:41:33 INFO - ##### 05:41:33 INFO - ##### Finished create-virtualenv step (success) 05:41:33 INFO - ##### 05:41:33 INFO - ##### 05:41:33 INFO - ##### Running install step. 05:41:33 INFO - ##### 05:41:33 INFO - Running pre-action listener: _resource_record_pre_action 05:41:33 INFO - Running main action method: install 05:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:33 INFO - Reading from file tmpfile_stdout 05:41:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:34 INFO - Reading from file tmpfile_stdout 05:41:34 INFO - Output received: 05:41:34 INFO - Usage: mozinstall [options] installer 05:41:34 INFO - Options: 05:41:34 INFO - -h, --help show this help message and exit 05:41:34 INFO - -d DEST, --destination=DEST 05:41:34 INFO - Directory to install application into. [default: 05:41:34 INFO - "/builds/slave/test"] 05:41:34 INFO - --app=APP Application being installed. [default: firefox] 05:41:34 INFO - mkdir: /builds/slave/test/build/application 05:41:34 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'] 05:41:34 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 05:41:50 INFO - Reading from file tmpfile_stdout 05:41:50 INFO - Output received: 05:41:50 INFO - /builds/slave/test/build/application/firefox/firefox 05:41:50 INFO - Running post-action listener: _resource_record_post_action 05:41:50 INFO - ##### 05:41:50 INFO - ##### Finished install step (success) 05:41:50 INFO - ##### 05:41:50 INFO - ##### 05:41:50 INFO - ##### Running run-tests step. 05:41:50 INFO - ##### 05:41:50 INFO - Running pre-action listener: _resource_record_pre_action 05:41:50 INFO - Running main action method: run_tests 05:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:50 INFO - Python 2.7.3 05:41:50 INFO - Return code: 0 05:41:50 INFO - grabbing minidump binary from tooltool 05:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:50 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 0x2442050>, '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 0x23ae170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:50 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 05:41:50 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 05:41:50 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 05:41:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:50 INFO - Return code: 0 05:41:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:41:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:41:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:41:51 INFO - Return code: 0 05:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 05:41:51 INFO - Using env: {'DISPLAY': ':0', 05:41:51 INFO - 'HOME': '/home/cltbld', 05:41:51 INFO - 'LANG': 'en_US.UTF-8', 05:41:51 INFO - 'LANGUAGE': 'en_US:en', 05:41:51 INFO - 'LOGNAME': 'cltbld', 05:41:51 INFO - 'MAIL': '/var/mail/cltbld', 05:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:51 INFO - 'MOZ_NO_REMOTE': '1', 05:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:51 INFO - 'NO_EM_RESTART': '1', 05:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:51 INFO - 'PWD': '/builds/slave/test', 05:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:51 INFO - 'SHELL': '/bin/bash', 05:41:51 INFO - 'SHLVL': '1', 05:41:51 INFO - 'TERM': 'linux', 05:41:51 INFO - 'TMOUT': '86400', 05:41:51 INFO - 'USER': 'cltbld', 05:41:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507', 05:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:51 INFO - '_': '/tools/buildbot/bin/python'} 05:41:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:41:52 INFO - mozversion application_buildid: 20160609030247 05:41:52 INFO - mozversion application_changeset: cb493102af8a50946ac601a86cc3d076703faa57 05:41:52 INFO - mozversion application_display_name: Nightly 05:41:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:52 INFO - mozversion application_name: Firefox 05:41:52 INFO - mozversion application_remotingname: firefox 05:41:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:41:52 INFO - mozversion application_vendor: Mozilla 05:41:52 INFO - mozversion application_version: 50.0a1 05:41:52 INFO - mozversion platform_buildid: 20160609030247 05:41:52 INFO - mozversion platform_changeset: cb493102af8a50946ac601a86cc3d076703faa57 05:41:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:41:52 INFO - mozversion platform_version: 50.0a1 05:41:52 INFO - using testdate: 1465476112 05:41:52 INFO - actual date: 1465476112 05:41:52 INFO - starting webserver on 'localhost:39870' 05:41:52 INFO - SUITE-START | Running 2 tests 05:41:52 INFO - TEST-START | dromaeo_css 05:41:52 INFO - operating with platform_type : linux_ 05:41:52 INFO - Initialising browser for dromaeo_css test... 05:41:52 INFO - TEST-INFO | started process 12841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8G2gG/profile http://localhost:39870/getInfo.html) 05:41:56 INFO - PROCESS | 12841 | __metrics Screen width/height:1600/1200 05:41:56 INFO - PROCESS | 12841 | colorDepth:24 05:41:56 INFO - PROCESS | 12841 | Browser inner width/height: 1024/697 05:41:56 INFO - PROCESS | 12841 | __metrics 05:41:57 ERROR - PROCESS | 12841 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:41:58 INFO - TEST-INFO | 12841: exit 0 05:41:58 INFO - Browser initialized. 05:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:58 INFO - TEST-INFO | started process 12960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8G2gG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:10 INFO - PROCESS | 12960 | RSS: Main: 184623104 05:42:10 INFO - PROCESS | 12960 | 05:43:00 INFO - PROCESS | 12960 | 1465476180012 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] 05:45:07 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39870/tests/dromaeo/cssquery-ext.html) 05:45:08 INFO - PROCESS | 12960 | RSS: Main: 187449344 05:45:08 INFO - PROCESS | 12960 | 05:48:10 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-ext.html (next: http://localhost:39870/tests/dromaeo/cssquery-jquery.html) 05:48:11 INFO - PROCESS | 12960 | RSS: Main: 187133952 05:48:11 INFO - PROCESS | 12960 | 05:51:13 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39870/tests/dromaeo/cssquery-mootools.html) 05:51:13 INFO - PROCESS | 12960 | RSS: Main: 188162048 05:51:13 INFO - PROCESS | 12960 | 05:54:15 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39870/tests/dromaeo/cssquery-prototype.html) 05:54:16 INFO - PROCESS | 12960 | RSS: Main: 186204160 05:54:16 INFO - PROCESS | 12960 | 05:57:18 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39870/tests/dromaeo/cssquery-yui.html) 05:57:19 INFO - PROCESS | 12960 | RSS: Main: 188416000 05:57:19 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39870/tests/dromaeo/cssquery-yui.html (next: http://localhost:39870/tests/dromaeo/cssquery-dojo.html) 06:00:22 INFO - PROCESS | 12960 | RSS: Main: 189427712 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | __start_tp_report 06:00:22 INFO - PROCESS | 12960 | _x_x_mozilla_page_load 06:00:22 INFO - PROCESS | 12960 | _x_x_mozilla_page_load_details 06:00:22 INFO - PROCESS | 12960 | |i|pagename|runs| 06:00:22 INFO - PROCESS | 12960 | |0;dojo.html;3074.6771588983156;3095.2107212660767;3104.596402467679;3104.6584875663675;3158.3841150975563;5341.1988201769755;5424.050791111559;5441.537469315108;5500.28496295482;5539.113741801312;5387.568994480442;5452.945470545294;5530.225768392418;5545.556355491561;5557.944420555793;4962;4997.1005219060735;5079;5118.769655365518;5173.172292433212;535.1714386709084;4878.195097808857;4963.280324352967;4994.87512812179;5072.797088116471;4961.156603377434;5000.849974500771;5029.2958985742025;5036.722980236085;5043.546080852722;5032.974835125838;5047.217681259411;5050;5051.419086805027;5061.645684802065;4901.411830580318;4928.605711543104;4964.230544265644;4982.028504441635;4985.675931064469;5439.864003399907;5480.286953220228;5487.780488780444;5525.060739674265;5551.583631227674;5692.430756924316;5759.078547432391;5903.232579764646;5910.143029260733;5910.645361278337;5799.82600521985;5862.824115276549;5904.143899134644;5911.586188966774;5957.046872500379;5467.753951072212;5480.287562616874;5481.260029895953;5487.807926722546;5489.807856725035;5847.736851841677;5980.820575382745;5985.281766188085;6008.399160083956;6009.939900601025;5846;5851.590388672752;5857.619254748428;5865.912011319833;5894.911576326359;5936.317323507766;5937.079752638348;5948.375420580864;5952.196453478725;5954.047352423591;5717.142428635655;5806.912896306559;5827.737751801179;5874.647521148745;5912.615679980788;5806.303243610793;5815.273090863642;5845.970770146122;5890.352061273256;5900.20347253124;4437.7781110944325;4478.395416618715;4504.729716217037;4514.480834704051;4517.051419202005;3926.155876486512;3933.862314819025;3936.291467535814;3960.683145348423;3988.4814974053766;5614.07367784311;5666.886662266732;5671.376148623648;5684.63049901755;5685.943140568624;6000.249968753906;6002.939970600238;6015.849603759941;6018.6990650467305;6042.728077236447;5437.4562543745305;5481.917771233435;5489.478499542537;5555.111182210827;5685.829425117253;5110.28456016158;5110.540051395318;5157.045946499909;5181.093308670967;5212.687238765686;6101.877962440726;6111.908321375183;6115.1744514490865;6116.755329786848;6126.632402055891;5787.334456537384;5906.616069955439;5968.045112782021;5977.103434484862;5980.970095149671;6068.939310607014;6125.724342404514;6126.733522497775;6129.404074626685;6134.222293196984;5752.252207213036;5815.098659707752;5865.266841644794;5889.646621202742;5909.438603332676;5824.242848429677;5860.648361098348;5905.498032667099;5980.491658209101;5988.640681558946;5785.39253378406;5806.274215723035;5806.303243610793;5817;5856.648601083949;5734.598578099493;5758.1362795579325;5760.366359700513;5780.3930587289415;5796.449337312949;5470.097433923517;5583.106702927512;5583.134614134816;5642.379338272704;5676.943230567642;5720.771169153188;5798;5803.564732644984;5827.94172058274;5850.853728656818;5656.208130861765;5698.743556540048;5703.800366987136;5708.315002199763;5710.143478478261 06:00:22 INFO - PROCESS | 12960 | |1;ext.html;574.4341823304047;627.3444250757957;628.1331762168207;643.7650257655955;647.5596594315863;41548.16903661925;43132;43220.56779432205;43242.78378608106;46992.76503617486;45195.77402112985;45266.77366613162;45614.543854561445;45679.54320456794;45693;8832.470051796896;8990.505522196276;9046.77383065422;9055.501947392891;9070.727878163665;8782.780430489225;8867.600957956907;8871.600777965006;8881.689140880071;8919.910800891972;8901.643934242622;8928.19646231839;8947.418417802855;8972.192502674758;8998.415103018315;8850.114988501131;8912.73261802147;8916.509591972439;8924.776880577972;8946.060663630355;8801.339899507499;8865.55672216393;8895.555222238861;8902.198802107841;8936.374453788238;42098.36852447216;42332;42362.576374236174;42491.1501769966;42750.14499710019;3515.402381595135;3539.557555305587;3571.7321200910037;3601.2617413430185;3632.6730594246646;29904.700952990628;30319.696803031908;32205.35589288201;32955;33317.83341083279;4161.75029498228;4192.706510544263;4227.682923780729;4315.568443155691;4460.553944605546;343255;343313;344294;345012;347591.2620436907;34169.65830341714;57492;57859;57876.13185802216;58102.70948645314;34736.652633473845;36344.45483317752;36490.452643210374;36549.08627284339;36689.633103668624;12859.099863009687;12870.678233044062;13082.542111026069;13130.34348282582;13167.736645267041;11131.220814542905;11158.1631377647;11158.553657853596;11185.66443006711;11208.775824483628;8156.306713929263;8184.099749027602;8190.795230119175;8282.088970213272;8294.294984926228;3178.682131786803;3194.5847039884666;3204.198950262434;3218.4850423932057;3241.2545114623767;968.0899954043177;986.8470387090013;1013.7769690668041;1085.267444474992;1162.110985096402;31833.681663183073;33055.50416743751;33117.503237451456;33179.50230746541;33602.32795344129;1034.927555071153;1067.9946600266949;1102.917281203897;1139.0545846947014;1176.1414167657658;16898.239579218964;17397.913010434866;17474.563135921704;17528.474145775646;17578.857374270632;600221;600364;603216;605182;610029;57895.13157302644;59753.701231493564;60003.69998149981;60240.698796506615;60316;1319.663485811112;1326.363345594101;1329.528017553774;1332.600219934016;1333.9599812005656;30602.92889748848;32208.19479513031;32347.514787277738;32456.83771581127;33169.50245746267;51593;52048;52409.213861791344;52443.47556524386;52693.736531317096;521361;521470;521474;521577;523482;28193;28937.7106228935;29211.561826573045;29225.56161657534;29311.50852177589;47290.52709472999;48302.33537234674;48952;50083;52338;41772.1645567093;42531.574684253996;42552.361714573686;43258.35112473378;43604;41533.37699934443;41682.58317416787;41815.7909210452;43138.35292470553;43454.56545434505;36947.63052369442;40704.1859162821;40736.388954165115;41592.1681566373;42510.787446062575;35226.82386588153;37818.287037037386;38067.42898856464;38153.236935261695;38216;28712.712872871005;28748;28872.278193045342;29003.27491812637;29008.564871527367 06:00:22 INFO - PROCESS | 12960 | |2;jquery.html;390.8495229336705;391.98432062717495;392.81341362852646;393.9074317535377;412.07078039022;13896.652583685413;17621.7356739649;18396.908015459903;19414.90292548537;19433.514162145955;18098.366557170502;18127.093645317746;18160.273589056455;18459.630807383845;18541.629167416642;5632.098864181721;5673.1917700738195;5738.741756620962;5865.32548756892;5880.823575292727;5731.885362292773;5734.168545560891;5742.081266997281;5744.942550574503;5814.592978491507;5604.103343465046;5704.401037891003;5780.393058728836;5792.826215213529;5801.332846722617;5497.47773961473;5740.311162660487;5747.2528571285675;5775.509081728058;5780.132980052984;5144.588432925357;5169;5170.844874653766;5174.456682048369;5181.611379146579;21626.567468650697;21898.671519927215;21990.340289791333;22093.558128837332;22332.106715731352;2095.748510178773;2347.80043696286;2510.447701505684;2526.759957804006;2531.7594828491265;10175.745606359826;10383.79232415355;12138.939305303506;14222.34184660168;14446.133232006114;1930.5173706573357;1986.7317912081828;2013.7080123382027;2043.6117137743781;2050.005747212601;83494.16505834986;84798.57600711957;85943.14056859477;86047;87190.56404717999;10299.588016479407;10606.310589811792;10636.521356538975;10672.733181670365;11625.476853541611;12786.61640150797;13480.865191348157;14828.110313381232;14865.331060102322;15004.549863504113;7095.751648692271;7429.405647548183;7513.774586762406;7593.772186834404;7772.300492955661;7197.316254955771;7281.781546553506;7318.743843965436;7478.3643390311345;7495.362894154058;4502.3471596618965;4529.5243999380245;4531.909361812745;4601.884952876205;4692.906141877143;1946.6496030714325;1973.7730161031377;1995.4013795861183;2008.4075197816678;2034.0541648133394;881.4887365328094;951.7335146159087;997.7206382212992;1006.2201793610011;1041.8228901086834;17636.735448968277;18432.723509147374;18533.629327413644;18610.5926098302;18622.53443663919;935.4013431403907;956.0917128727598;990.7077412163429;993.4039576254189;1000.949952502372;10166.898331016595;10380.377177369382;10417.270791044706;10471.790564188826;10473.47632618366;468170;484070;490530;493526;495130;70625;72687;95801;101910.49044754729;103056.48471757594;963.4556475591269;977.4379731654327;987.5704068729982;993.5082134343546;1002.904724051214;16385;16419.917900410423;16552.66894662124;16624.25190866438;16820.57948551296;34469.48295775515;38023;39752.60247397489;43643;45960.54039459563;59026.70486647539;59093.40906591051;59673.40326596852;60301.69849150726;60449.69775151096;7251.383632391306;7637.159912409519;8248.958755206186;8487.533185674847;8610.612522436631;11702.473388697359;13399.732005360032;13467.797983030458;13518.729625407634;13519.256440895846;11514.94242528782;11649.718530961418;11854.94072529632;11982.10134239918;12129.75740485203;11263.831042534532;11561.479733412185;11606;12007.099467539794;12096.334701591144;11599.594014209462;11611.767764644828;11700.70748231267;11834.349110798988;12080;7721.53290874732;7723.9227607723205;7745.419093568117;7975.920240797518;8016.038075430985;11716.94141529321;11934.4032798358;11962.401879906143;11978.341191234565;12081.75836483283 06:00:22 INFO - PROCESS | 12960 | |3;mootools.html;1448.0081144416076;1468.7356275870343;1563.6638122803602;1706.940257091002;1708.1117818734267;7647.770566883002;8754.474731516113;8863.822723545525;9333.719988400351;9335.206507446866;8924.91075089249;8932.374733768622;9009.324300677443;9018.233450156744;9100.99889012208;2283.977160228397;2305.4812667149927;2327.1156960355042;2327.5112226432384;2328.429534763985;2238.563480121377;2283.3264187064774;2310.653401989698;2313.8495997760174;2319.3042087373806;2307.284741730061;2310.376198426424;2311.7919387255142;2348.1664009276715;2351.670766092748;2280.0879648140794;2286.9085236590518;2295.5753185660537;2298.1267118494948;2302.953940921189;2284.3717977556307;2295.024614538831;2298.9425264368524;2300.896459659319;2303.1593468384085;9082.364234503588;9100.180983711498;9108.8633670495;9114.179723824887;9163.266938644892;5179.637425380225;5340.679559226459;5365.302510673627;5378.731063446851;5382.3541175059245;3304.6364899860996;3434.0679482103824;3494.405950988338;3503.1592417819793;3517.8241087945757;1120.753434244473;1123.4045955643521;1127.9323240605509;1132.47905963257;1172.9648110556698;13094.738105237842;13157.539486118036;13194.340282985908;13224.537141200011;13238.602841914759;4612.331211974312;4692.389989301369;4794.161021821237;4796.880077998008;4811.639127065484;10864.185186111074;10871.29336593119;10871.782564348669;10946.616868409568;10955.123590112771;5187.481251874782;5242.947570524322;5243.68537887728;5248.895022099537;5411.810586629449;4275.551067137968;4791.712497250176;4829.806807727722;4975.5522003019905;4987.925181122286;3798.525184351956;3910.882673519799;3933.1347103637154;3961.801909904493;4011.9799401002806;1193.5046955513365;1204.2292932523192;1221.3099598726692;1223.2966044524435;1244.7946088895412;835.6740871060291;928.9303302252223;930.3255140023429;938.4181807279394;938.671464987249;5909.8227053188475;5929.495992840571;5976.103584462278;6015.759369625166;6313.873722525615;927.1099744245465;976.1214906584131;996.8704068471052;1013.4443629029405;1038.9584416623402;3872.457855900176;3953.8418463261146;3956.1098752780395;3965.821538030738;3985.8405663773124;11157;11475.139364547693;11658.6502404928;11691.415429228504;11692.181547291779;11517.942410287895;11526.88473115258;11643.825342619868;11669.35818529972;11736.823947640793;8398.412111152284;8558.400911936105;8707.6516939323;8739.737807865775;8749.825003500022;5658.292713410824;5790.913136302875;5822.446867547576;5878.441548052928;5955.076963070731;10678.786424271626;10727.302725322828;10755.946220268848;10763.623273185402;10782.622608208674;10845.891541084804;10917.781644367227;10946.835797463204;11046.944765276123;11140.108791296514;7097.396721278749;7476.177620461636;7665.42509311815;7695.730649427243;7827.647755851114;8983.416077954913;9022.413543119676;9072.90927090747;9082.545872706207;9136.132067453582;7645.388368930361;7877.960610197141;8127.065387480516;8135.30849877767;8147.063087744985;7952.681892724227;8083.272505474535;8127.79680507992;8189.95905020495;8221.383396245425;7103.715851366094;7290.270972902667;7405;7454.515456495311;7466.066741657293;5050.949490505048;5211.765470553758;5247.2129180623215;5254.632175747661;5307.65500242483;5007.974960125176;5094.490550945025;5116.667416617908;5192.299039629602;5220.791168353223 06:00:22 INFO - PROCESS | 12960 | |4;prototype.html;326.3684769970107;332.48630865313095;332.61915107202253;335.1069400048871;338.2592123250084;5580.581456390767;5597.580181486394;5605.327360716709;5627.943720562798;5714.742836572354;5403.89220209857;5467.562594992401;5483;5512.972435137829;5583.5761880720465;4086.4074709167226;4216.873493795191;4320.740755554677;4323.589259020388;4328.9783551082355;4323.610875021247;4338.635443683184;4343.956560434387;4361.890952726191;4371.431713877191;4298.591633794785;4345.174416860802;4348.695591308609;4354.804033818486;4358.65130789536;4272.722273052257;4279.978600107011;4334.241507736165;4338.893582136567;4351.847685331029;3804.5814960354614;3804.828782704757;3827.5024246847734;3837.9808100959594;3861;5438.456154384569;5447.210154527571;5461.972690136564;5464.672119672792;5467.535259502907;4875.8781030474165;5040.495950404967;5051.267566202917;5055.721935293557;5066.847994560169;5877.52979761618;5880.70596470179;5884.941150588482;5960.791372301992;5987.161797348374;4238.957610423887;4268.509121451011;4269.786510674485;4275;4296.613304802551;6000.159977603139;6028;6059.848503787441;6089.269287685506;6092.878142437171;4298.441202643637;4302.7848607569495;4311.48262208537;4315.8273669053515;4319.028218650778;4387.3857659927635;4396.780160991938;4400.405945197422;4415.66882483815;4419.668524860648;4907.1167189905445;4910.729909854921;5003.099442100457;5021.271915572294;5040.79836806531;5831.679257640785;5878.382769809194;5922.466977972003;5929.762809487658;5951.4941229995065;1511.508759653117;1513.3870782333172;1523.8171419429739;1539.5304432148077;1541.167769404509;931.6599441203912;953.7710949372239;985.4875464758429;999.7850462150527;999.9100080992746;5607.383187849333;5637.68992705397;5644.971775141098;5679.375268720438;5723.656580605177;5983.730732117066;5998.820035398945;6089.695515224221;6096.969515152396;6101.749141425997;5463.31708536433;5695.345035320908;5783.0915797787475;5793.710314484259;5821.621594596338;3230.2570408806105;3240.7893486923276;3256.70689637929;3266.852991615383;3302.7944800147775;6076.422739839708;6166.198394208814;6234.37656234382;6242.845073661387;6268.811935641938;6096.464050850496;6204.81385558434;6236.75052997875;6240.937590624036;6243.96878015607;5897.292324921037;6243.469305109026;6254.562180647402;6283.465905398001;6284.811455656338;6013.0758157390965;6100.694965251809;6101.7559297627595;6126.693665316628;6146.78486252979;6009.36901625323;6026.789062382795;6033.793241351835;6049.969750151221;6057.848553786191;6044;6214.197882613991;6257.12286314113;6289.308176100534;6304.936950630618;4260.190563792869;4270.594293542109;4304.440422745023;4321.827126914888;4341.848035318749;5929.687421905546;6116;6129.2032035835055;6152.031349968146;6250.843728906631;5863.17915491823;5872.618279811799;5875.764969401176;5886.52907767369;5952.077427998667;5911.231539899785;5923.378045305353;5974.805038992132;5980.581359304807;6003.8198854034445;5583.385827559046;5877.706114694333;5878.2064421304285;5883.235179426647;5900.7049647518315;5987.371326010881;6021.518278537619;6034.879302414015;6048.667323297261;6059.666718330534;5579.860503487445;5858.47273745348;5896.204012458264;5909.85225369352;5922.585419020799 06:00:22 INFO - PROCESS | 12960 | |5;yui.html;718.7340683946941;762.4091329219854;771.3520642660164;806.2018601584433;826.9952008309903;13924.094933829294;14540.272986350667;14618.488352907638;14757.40970361187;14847.628809279773;13633.659158521043;13696.794548081762;13783.931080344584;13799.31003449826;13844.238566878817;650.6519012328405;750.9136449308345;753.0436345840793;768.1742127213269;769.3037800790294;767.5049593012503;772.5326177662517;777.4247057177676;780.0288640642408;781.8240895798457;824.1964085017121;824.4393812207696;827.2389401750404;827.7765003449065;828.9336853051741;818.4843548564396;819.5861090149496;822.2024636102971;825.471698113202;825.6697321071589;599.6492052149498;603.3092109534558;603.809799913026;604.4650484321363;604.8064619321818;14739.59973802487;14901.627459313495;14905.329260183318;14922;14928.552143435714;14713.896457765602;15159.772603410958;15160.070632600808;15195.848041519554;15440.691186176326;12016.895040552043;12172.756544869142;12250.877491225063;12333.69165770854;12880.484780608764;3893.1240470894104;3924.823382947774;4028.6978476614076;4089.591040895916;4090.734102283342;73941.63029184873;75678;75895.24104758937;76281;76576;11387.259828111146;11483.77032459346;11701.824472632918;11709.004734597655;12139.939300303442;21357.572848543252;21456.678149827763;21575.892120539298;21684.783152168275;21708.89145554262;7635;7790.649420776079;7970.362371010306;7994.760157195294;8125.837483250302;4584.518625544337;4585.633149348044;4608.3778689876435;4660.161170989187;4681.063787242565;3526.4181410067563;3655.5247817784048;3657.561092668897;3658.158623516606;3663.908402289964;572.6134858970179;587.632729544035;595.8986972214734;599.5892813422732;599.8830228105478;715.7745310227261;730.9305615966581;731.7329174851141;738.4203400330822;757.6287619066618;10286.228532860065;10413.698287714036;10444.895551044392;10647.361158330525;10708.1433485321;688.2566827825935;702.0145841057965;733.2191216354565;757.4357103957586;757.443279189795;4801.375821143229;4840.370751802243;4921.557059864629;5098.5411312982005;5115;116402.41798790952;116705.41647291709;119808;120305;121454.39272803579;88036;96799;97643;97797.5110124459;102487.40334247942;84194.57902710569;85293;86941.56529217314;89125.55437222772;89265.55367223252;9859.211263099078;9913.206943444651;10047.949760251444;10387.428691422045;10400.531976061247;47753;51146.48853511566;51864;52487;52637.7368113157;69196;77745.61127194327;77756.61121694582;78487.60756196182;78663.21336786788;13006.024548158737;13071.477140914638;13121.671958201121;13639.659008524866;13703.725925481634;14410.639734006314;14579.416823327372;14775.335109920294;15009.2495375233;15167.24163791784;12115.273083614658;13094.410751516396;13628.31858407056;13677.31613419345;13724.65688357799;12524.436400362189;12602.11785175029;12671.239725616493;12966.481340746264;14380.28098595087;13347.933260333637;13638.590842274747;13908.791368129689;13944.302784860514;14171.503997360043;10630.149588033093;10853.565857365933;10948.890511094787;11113.888861111285;11302.773944521228;11505.597304094317;12227.694307642025;12398.876011239772;12476.43856026499;12544.560940367044 06:00:22 INFO - PROCESS | 12960 | __end_tp_report 06:00:22 INFO - PROCESS | 12960 | __start_cc_report 06:00:22 INFO - PROCESS | 12960 | _x_x_mozilla_cycle_collect,349 06:00:22 INFO - PROCESS | 12960 | __end_cc_report 06:00:22 INFO - PROCESS | 12960 | __startTimestamp1465477222418__endTimestamp 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | ------- Summary: start ------- 06:00:22 INFO - PROCESS | 12960 | Number of tests: 6 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#0] dojo.html Cycles:165 Average:5447.34 Median:5698.74 stddev:744.95 (13.1%) stddev-sans-first:723.61 06:00:22 INFO - PROCESS | 12960 | Values: 3074.7 3095.2 3104.6 3104.7 3158.4 5341.2 5424.1 5441.5 5500.3 5539.1 5387.6 5452.9 5530.2 5545.6 5557.9 4962.0 4997.1 5079.0 5118.8 5173.2 535.2 4878.2 4963.3 4994.9 5072.8 4961.2 5000.8 5029.3 5036.7 5043.5 5033.0 5047.2 5050.0 5051.4 5061.6 4901.4 4928.6 4964.2 4982.0 4985.7 5439.9 5480.3 5487.8 5525.1 5551.6 5692.4 5759.1 5903.2 5910.1 5910.6 5799.8 5862.8 5904.1 5911.6 5957.0 5467.8 5480.3 5481.3 5487.8 5489.8 5847.7 5980.8 5985.3 6008.4 6009.9 5846.0 5851.6 5857.6 5865.9 5894.9 5936.3 5937.1 5948.4 5952.2 5954.0 5717.1 5806.9 5827.7 5874.6 5912.6 5806.3 5815.3 5846.0 5890.4 5900.2 4437.8 4478.4 4504.7 4514.5 4517.1 3926.2 3933.9 3936.3 3960.7 3988.5 5614.1 5666.9 5671.4 5684.6 5685.9 6000.2 6002.9 6015.8 6018.7 6042.7 5437.5 5481.9 5489.5 5555.1 5685.8 5110.3 5110.5 5157.0 5181.1 5212.7 6101.9 6111.9 6115.2 6116.8 6126.6 5787.3 5906.6 5968.0 5977.1 5981.0 6068.9 6125.7 6126.7 6129.4 6134.2 5752.3 5815.1 5865.3 5889.6 5909.4 5824.2 5860.6 5905.5 5980.5 5988.6 5785.4 5806.3 5806.3 5817.0 5856.6 5734.6 5758.1 5760.4 5780.4 5796.4 5470.1 5583.1 5583.1 5642.4 5676.9 5720.8 5798.0 5803.6 5827.9 5850.9 5656.2 5698.7 5703.8 5708.3 5710.1 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#1] ext.html Cycles:180 Average:63325.91 Median:23163.03 stddev:133986.50 (578.4%) stddev-sans-first:134279.53 06:00:22 INFO - PROCESS | 12960 | Values: 574.4 627.3 628.1 643.8 647.6 41548.2 43132.0 43220.6 43242.8 46992.8 45195.8 45266.8 45614.5 45679.5 45693.0 8832.5 8990.5 9046.8 9055.5 9070.7 8782.8 8867.6 8871.6 8881.7 8919.9 8901.6 8928.2 8947.4 8972.2 8998.4 8850.1 8912.7 8916.5 8924.8 8946.1 8801.3 8865.6 8895.6 8902.2 8936.4 42098.4 42332.0 42362.6 42491.2 42750.1 3515.4 3539.6 3571.7 3601.3 3632.7 29904.7 30319.7 32205.4 32955.0 33317.8 4161.8 4192.7 4227.7 4315.6 4460.6 343255.0 343313.0 344294.0 345012.0 347591.3 34169.7 57492.0 57859.0 57876.1 58102.7 34736.7 36344.5 36490.5 36549.1 36689.6 12859.1 12870.7 13082.5 13130.3 13167.7 11131.2 11158.2 11158.6 11185.7 11208.8 8156.3 8184.1 8190.8 8282.1 8294.3 3178.7 3194.6 3204.2 3218.5 3241.3 968.1 986.8 1013.8 1085.3 1162.1 31833.7 33055.5 33117.5 33179.5 33602.3 1034.9 1068.0 1102.9 1139.1 1176.1 16898.2 17397.9 17474.6 17528.5 17578.9 600221.0 600364.0 603216.0 605182.0 610029.0 57895.1 59753.7 60003.7 60240.7 60316.0 1319.7 1326.4 1329.5 1332.6 1334.0 30602.9 32208.2 32347.5 32456.8 33169.5 51593.0 52048.0 52409.2 52443.5 52693.7 521361.0 521470.0 521474.0 521577.0 523482.0 28193.0 28937.7 29211.6 29225.6 29311.5 47290.5 48302.3 48952.0 50083.0 52338.0 41772.2 42531.6 42552.4 43258.4 43604.0 41533.4 41682.6 41815.8 43138.4 43454.6 36947.6 40704.2 40736.4 41592.2 42510.8 35226.8 37818.3 38067.4 38153.2 38216.0 28712.7 28748.0 28872.3 29003.3 29008.6 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#2] jquery.html Cycles:180 Average:28742.74 Median:18500.62 stddev:80316.15 (434.1%) stddev-sans-first:80513.25 06:00:22 INFO - PROCESS | 12960 | Values: 390.8 392.0 392.8 393.9 412.1 13896.7 17621.7 18396.9 19414.9 19433.5 18098.4 18127.1 18160.3 18459.6 18541.6 5632.1 5673.2 5738.7 5865.3 5880.8 5731.9 5734.2 5742.1 5744.9 5814.6 5604.1 5704.4 5780.4 5792.8 5801.3 5497.5 5740.3 5747.3 5775.5 5780.1 5144.6 5169.0 5170.8 5174.5 5181.6 21626.6 21898.7 21990.3 22093.6 22332.1 2095.7 2347.8 2510.4 2526.8 2531.8 10175.7 10383.8 12138.9 14222.3 14446.1 1930.5 1986.7 2013.7 2043.6 2050.0 83494.2 84798.6 85943.1 86047.0 87190.6 10299.6 10606.3 10636.5 10672.7 11625.5 12786.6 13480.9 14828.1 14865.3 15004.5 7095.8 7429.4 7513.8 7593.8 7772.3 7197.3 7281.8 7318.7 7478.4 7495.4 4502.3 4529.5 4531.9 4601.9 4692.9 1946.6 1973.8 1995.4 2008.4 2034.1 881.5 951.7 997.7 1006.2 1041.8 17636.7 18432.7 18533.6 18610.6 18622.5 935.4 956.1 990.7 993.4 1000.9 10166.9 10380.4 10417.3 10471.8 10473.5 468170.0 484070.0 490530.0 493526.0 495130.0 70625.0 72687.0 95801.0 101910.5 103056.5 963.5 977.4 987.6 993.5 1002.9 16385.0 16419.9 16552.7 16624.3 16820.6 34469.5 38023.0 39752.6 43643.0 45960.5 59026.7 59093.4 59673.4 60301.7 60449.7 7251.4 7637.2 8249.0 8487.5 8610.6 11702.5 13399.7 13467.8 13518.7 13519.3 11514.9 11649.7 11854.9 11982.1 12129.8 11263.8 11561.5 11606.0 12007.1 12096.3 11599.6 11611.8 11700.7 11834.3 12080.0 7721.5 7723.9 7745.4 7975.9 8016.0 11716.9 11934.4 11962.4 11978.3 12081.8 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#3] mootools.html Cycles:180 Average:5986.84 Median:4792.94 stddev:3533.78 (73.7%) stddev-sans-first:3527.23 06:00:22 INFO - PROCESS | 12960 | Values: 1448.0 1468.7 1563.7 1706.9 1708.1 7647.8 8754.5 8863.8 9333.7 9335.2 8924.9 8932.4 9009.3 9018.2 9101.0 2284.0 2305.5 2327.1 2327.5 2328.4 2238.6 2283.3 2310.7 2313.8 2319.3 2307.3 2310.4 2311.8 2348.2 2351.7 2280.1 2286.9 2295.6 2298.1 2303.0 2284.4 2295.0 2298.9 2300.9 2303.2 9082.4 9100.2 9108.9 9114.2 9163.3 5179.6 5340.7 5365.3 5378.7 5382.4 3304.6 3434.1 3494.4 3503.2 3517.8 1120.8 1123.4 1127.9 1132.5 1173.0 13094.7 13157.5 13194.3 13224.5 13238.6 4612.3 4692.4 4794.2 4796.9 4811.6 10864.2 10871.3 10871.8 10946.6 10955.1 5187.5 5242.9 5243.7 5248.9 5411.8 4275.6 4791.7 4829.8 4975.6 4987.9 3798.5 3910.9 3933.1 3961.8 4012.0 1193.5 1204.2 1221.3 1223.3 1244.8 835.7 928.9 930.3 938.4 938.7 5909.8 5929.5 5976.1 6015.8 6313.9 927.1 976.1 996.9 1013.4 1039.0 3872.5 3953.8 3956.1 3965.8 3985.8 11157.0 11475.1 11658.7 11691.4 11692.2 11517.9 11526.9 11643.8 11669.4 11736.8 8398.4 8558.4 8707.7 8739.7 8749.8 5658.3 5790.9 5822.4 5878.4 5955.1 10678.8 10727.3 10755.9 10763.6 10782.6 10845.9 10917.8 10946.8 11046.9 11140.1 7097.4 7476.2 7665.4 7695.7 7827.6 8983.4 9022.4 9072.9 9082.5 9136.1 7645.4 7878.0 8127.1 8135.3 8147.1 7952.7 8083.3 8127.8 8190.0 8221.4 7103.7 7290.3 7405.0 7454.5 7466.1 5050.9 5211.8 5247.2 5254.6 5307.7 5008.0 5094.5 5116.7 5192.3 5220.8 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#4] prototype.html Cycles:180 Average:4970.31 Median:5687.36 stddev:1470.78 (25.9%) stddev-sans-first:1433.00 06:00:22 INFO - PROCESS | 12960 | Values: 326.4 332.5 332.6 335.1 338.3 5580.6 5597.6 5605.3 5627.9 5714.7 5403.9 5467.6 5483.0 5513.0 5583.6 4086.4 4216.9 4320.7 4323.6 4329.0 4323.6 4338.6 4344.0 4361.9 4371.4 4298.6 4345.2 4348.7 4354.8 4358.7 4272.7 4280.0 4334.2 4338.9 4351.8 3804.6 3804.8 3827.5 3838.0 3861.0 5438.5 5447.2 5462.0 5464.7 5467.5 4875.9 5040.5 5051.3 5055.7 5066.8 5877.5 5880.7 5884.9 5960.8 5987.2 4239.0 4268.5 4269.8 4275.0 4296.6 6000.2 6028.0 6059.8 6089.3 6092.9 4298.4 4302.8 4311.5 4315.8 4319.0 4387.4 4396.8 4400.4 4415.7 4419.7 4907.1 4910.7 5003.1 5021.3 5040.8 5831.7 5878.4 5922.5 5929.8 5951.5 1511.5 1513.4 1523.8 1539.5 1541.2 931.7 953.8 985.5 999.8 999.9 5607.4 5637.7 5645.0 5679.4 5723.7 5983.7 5998.8 6089.7 6097.0 6101.7 5463.3 5695.3 5783.1 5793.7 5821.6 3230.3 3240.8 3256.7 3266.9 3302.8 6076.4 6166.2 6234.4 6242.8 6268.8 6096.5 6204.8 6236.8 6240.9 6244.0 5897.3 6243.5 6254.6 6283.5 6284.8 6013.1 6100.7 6101.8 6126.7 6146.8 6009.4 6026.8 6033.8 6050.0 6057.8 6044.0 6214.2 6257.1 6289.3 6304.9 4260.2 4270.6 4304.4 4321.8 4341.8 5929.7 6116.0 6129.2 6152.0 6250.8 5863.2 5872.6 5875.8 5886.5 5952.1 5911.2 5923.4 5974.8 5980.6 6003.8 5583.4 5877.7 5878.2 5883.2 5900.7 5987.4 6021.5 6034.9 6048.7 6059.7 5579.9 5858.5 5896.2 5909.9 5922.6 06:00:22 INFO - PROCESS | 12960 | 06:00:22 INFO - PROCESS | 12960 | [#5] yui.html Cycles:180 Average:20924.00 Median:3976.76 stddev:30202.99 (759.5%) stddev-sans-first:30249.61 06:00:22 INFO - PROCESS | 12960 | Values: 718.7 762.4 771.4 806.2 827.0 13924.1 14540.3 14618.5 14757.4 14847.6 13633.7 13696.8 13783.9 13799.3 13844.2 650.7 750.9 753.0 768.2 769.3 767.5 772.5 777.4 780.0 781.8 824.2 824.4 827.2 827.8 828.9 818.5 819.6 822.2 825.5 825.7 599.6 603.3 603.8 604.5 604.8 14739.6 14901.6 14905.3 14922.0 14928.6 14713.9 15159.8 15160.1 15195.8 15440.7 12016.9 12172.8 12250.9 12333.7 12880.5 3893.1 3924.8 4028.7 4089.6 4090.7 73941.6 75678.0 75895.2 76281.0 76576.0 11387.3 11483.8 11701.8 11709.0 12139.9 21357.6 21456.7 21575.9 21684.8 21708.9 7635.0 7790.6 7970.4 7994.8 8125.8 4584.5 4585.6 4608.4 4660.2 4681.1 3526.4 3655.5 3657.6 3658.2 3663.9 572.6 587.6 595.9 599.6 599.9 715.8 730.9 731.7 738.4 757.6 10286.2 10413.7 10444.9 10647.4 10708.1 688.3 702.0 733.2 757.4 757.4 4801.4 4840.4 4921.6 5098.5 5115.0 116402.4 116705.4 119808.0 120305.0 121454.4 88036.0 96799.0 97643.0 97797.5 102487.4 84194.6 85293.0 86941.6 89125.6 89265.6 9859.2 9913.2 10047.9 10387.4 10400.5 47753.0 51146.5 51864.0 52487.0 52637.7 69196.0 77745.6 77756.6 78487.6 78663.2 13006.0 13071.5 13121.7 13639.7 13703.7 14410.6 14579.4 14775.3 15009.2 15167.2 12115.3 13094.4 13628.3 13677.3 13724.7 12524.4 12602.1 12671.2 12966.5 14380.3 13347.9 13638.6 13908.8 13944.3 14171.5 10630.1 10853.6 10948.9 11113.9 11302.8 11505.6 12227.7 12398.9 12476.4 12544.6 06:00:22 INFO - PROCESS | 12960 | -------- Summary: end -------- 06:00:22 INFO - PROCESS | 12960 | 06:00:23 INFO - TEST-INFO | 12960: exit 0 06:00:23 INFO - TEST-OK | dromaeo_css | took 1111120ms 06:00:23 INFO - TEST-START | kraken 06:00:23 INFO - operating with platform_type : linux_ 06:00:23 INFO - Initialising browser for kraken test... 06:00:23 INFO - TEST-INFO | started process 13199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiagwIB/profile http://localhost:39870/getInfo.html) 06:00:27 INFO - PROCESS | 13199 | __metrics Screen width/height:1600/1200 06:00:27 INFO - PROCESS | 13199 | colorDepth:24 06:00:27 INFO - PROCESS | 13199 | Browser inner width/height: 1024/697 06:00:27 INFO - PROCESS | 13199 | __metrics 06:00:28 ERROR - PROCESS | 13199 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:00:29 INFO - TEST-INFO | 13199: exit 0 06:00:29 INFO - Browser initialized. 06:00:29 INFO - Running cycle 1/1 for kraken test... 06:00:29 INFO - TEST-INFO | started process 13317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiagwIB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:41 INFO - PROCESS | 13317 | RSS: Main: 184524800 06:00:41 INFO - PROCESS | 13317 | 06:00:43 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39870/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:44 INFO - PROCESS | 13317 | RSS: Main: 189464576 06:00:44 INFO - PROCESS | 13317 | 06:00:47 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39870/tests/kraken/driver.html?testName=audio-dft) 06:00:48 INFO - PROCESS | 13317 | RSS: Main: 189202432 06:00:48 INFO - PROCESS | 13317 | 06:00:51 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39870/tests/kraken/driver.html?testName=audio-fft) 06:00:51 INFO - PROCESS | 13317 | RSS: Main: 184070144 06:00:51 INFO - PROCESS | 13317 | 06:00:53 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39870/tests/kraken/driver.html?testName=audio-oscillator) 06:00:54 INFO - PROCESS | 13317 | RSS: Main: 185200640 06:00:54 INFO - PROCESS | 13317 | 06:00:56 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:57 INFO - PROCESS | 13317 | RSS: Main: 185311232 06:00:57 INFO - PROCESS | 13317 | 06:01:00 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39870/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:00 INFO - PROCESS | 13317 | RSS: Main: 185675776 06:01:00 INFO - PROCESS | 13317 | 06:01:04 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39870/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:04 INFO - PROCESS | 13317 | RSS: Main: 185847808 06:01:04 INFO - PROCESS | 13317 | 06:01:07 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39870/tests/kraken/driver.html?testName=json-parse-financial) 06:01:08 INFO - PROCESS | 13317 | RSS: Main: 185659392 06:01:08 INFO - PROCESS | 13317 | 06:01:10 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:10 INFO - PROCESS | 13317 | RSS: Main: 185745408 06:01:10 INFO - PROCESS | 13317 | 06:01:12 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:13 INFO - PROCESS | 13317 | RSS: Main: 185937920 06:01:13 INFO - PROCESS | 13317 | 06:01:15 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:15 INFO - PROCESS | 13317 | RSS: Main: 185995264 06:01:15 INFO - PROCESS | 13317 | 06:01:18 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:19 INFO - PROCESS | 13317 | RSS: Main: 186318848 06:01:19 INFO - PROCESS | 13317 | 06:01:21 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:22 INFO - PROCESS | 13317 | RSS: Main: 186089472 06:01:22 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:39870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39870/tests/kraken/driver.html?testName=ai-astar) 06:01:24 INFO - PROCESS | 13317 | RSS: Main: 186482688 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | __start_tp_report 06:01:24 INFO - PROCESS | 13317 | _x_x_mozilla_page_load 06:01:24 INFO - PROCESS | 13317 | _x_x_mozilla_page_load_details 06:01:24 INFO - PROCESS | 13317 | |i|pagename|runs| 06:01:24 INFO - PROCESS | 13317 | |0;ai-astar;114;109;111;111;113;112;111;113;114;112 06:01:24 INFO - PROCESS | 13317 | |1;audio-beat-detection;162;129;162;179;129;154;159;133;192;128 06:01:24 INFO - PROCESS | 13317 | |2;audio-dft;164;165;161;162;168;169;162;163;163;163 06:01:24 INFO - PROCESS | 13317 | |3;audio-fft;76;76;75;158;78;76;77;75;158;76 06:01:24 INFO - PROCESS | 13317 | |4;audio-oscillator;85;85;146;85;85;86;138;85;85;154 06:01:24 INFO - PROCESS | 13317 | |5;imaging-gaussian-blur;118;117;117;117;118;118;117;119;117;117 06:01:24 INFO - PROCESS | 13317 | |6;imaging-darkroom;148;147;148;147;150;147;148;147;147;147 06:01:24 INFO - PROCESS | 13317 | |7;imaging-desaturate;95;96;95;94;96;95;95;95;95;95 06:01:24 INFO - PROCESS | 13317 | |8;json-parse-financial;57;62;61;57;58;56;61;56;57;56 06:01:24 INFO - PROCESS | 13317 | |9;json-stringify-tinderbox;61;62;63;62;63;62;70;61;62;63 06:01:24 INFO - PROCESS | 13317 | |10;stanford-crypto-aes;85;80;84;79;87;81;87;81;116;80 06:01:24 INFO - PROCESS | 13317 | |11;stanford-crypto-ccm;125;125;136;129;133;123;132;137;134;132 06:01:24 INFO - PROCESS | 13317 | |12;stanford-crypto-pbkdf2;169;169;164;164;165;159;161;160;166;162 06:01:24 INFO - PROCESS | 13317 | |13;stanford-crypto-sha256-iterative;66;64;64;63;65;64;63;62;64;64 06:01:24 INFO - PROCESS | 13317 | __end_tp_report 06:01:24 INFO - PROCESS | 13317 | __start_cc_report 06:01:24 INFO - PROCESS | 13317 | _x_x_mozilla_cycle_collect,872 06:01:24 INFO - PROCESS | 13317 | __end_cc_report 06:01:24 INFO - PROCESS | 13317 | __startTimestamp1465477284500__endTimestamp 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | ------- Summary: start ------- 06:01:24 INFO - PROCESS | 13317 | Number of tests: 14 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:1.56 (1.4%) stddev-sans-first:1.48 06:01:24 INFO - PROCESS | 13317 | Values: 114.0 109.0 111.0 111.0 113.0 112.0 111.0 113.0 114.0 112.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:160.50 stddev:22.54 (14.0%) stddev-sans-first:23.65 06:01:24 INFO - PROCESS | 13317 | Values: 162.0 129.0 162.0 179.0 129.0 154.0 159.0 133.0 192.0 128.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.62 (1.6%) stddev-sans-first:2.78 06:01:24 INFO - PROCESS | 13317 | Values: 164.0 165.0 161.0 162.0 168.0 169.0 162.0 163.0 163.0 163.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:34.53 (45.4%) stddev-sans-first:36.11 06:01:24 INFO - PROCESS | 13317 | Values: 76.0 76.0 75.0 158.0 78.0 76.0 77.0 75.0 158.0 76.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.64 (34.9%) stddev-sans-first:30.68 06:01:24 INFO - PROCESS | 13317 | Values: 85.0 85.0 146.0 85.0 85.0 86.0 138.0 85.0 85.0 154.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:01:24 INFO - PROCESS | 13317 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 117.0 117.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:01:24 INFO - PROCESS | 13317 | Values: 148.0 147.0 148.0 147.0 150.0 147.0 148.0 147.0 147.0 147.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:01:24 INFO - PROCESS | 13317 | Values: 95.0 96.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:2.33 (4.1%) stddev-sans-first:2.44 06:01:24 INFO - PROCESS | 13317 | Values: 57.0 62.0 61.0 57.0 58.0 56.0 61.0 56.0 57.0 56.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:2.60 (4.2%) stddev-sans-first:2.67 06:01:24 INFO - PROCESS | 13317 | Values: 61.0 62.0 63.0 62.0 63.0 62.0 70.0 61.0 62.0 63.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:82.50 stddev:10.94 (13.3%) stddev-sans-first:11.60 06:01:24 INFO - PROCESS | 13317 | Values: 85.0 80.0 84.0 79.0 87.0 81.0 87.0 81.0 116.0 80.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:132.50 stddev:4.88 (3.7%) stddev-sans-first:4.74 06:01:24 INFO - PROCESS | 13317 | Values: 125.0 125.0 136.0 129.0 133.0 123.0 132.0 137.0 134.0 132.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:3.48 (2.1%) stddev-sans-first:3.16 06:01:24 INFO - PROCESS | 13317 | Values: 169.0 169.0 164.0 164.0 165.0 159.0 161.0 160.0 166.0 162.0 06:01:24 INFO - PROCESS | 13317 | 06:01:24 INFO - PROCESS | 13317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.10 (1.7%) stddev-sans-first:0.87 06:01:24 INFO - PROCESS | 13317 | Values: 66.0 64.0 64.0 63.0 65.0 64.0 63.0 62.0 64.0 64.0 06:01:24 INFO - PROCESS | 13317 | -------- Summary: end -------- 06:01:24 INFO - PROCESS | 13317 | 06:01:25 INFO - TEST-INFO | 13317: exit 0 06:01:25 INFO - TEST-OK | kraken | took 62334ms 06:01:25 INFO - SUITE-END | took 1173s 06:01:25 INFO - Completed test suite (00:19:33) 06:01:25 INFO - javascript benchmark 06:01:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7286.452745411417, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.6771588983156, 3095.2107212660767, 3104.596402467679, 3104.6584875663675, 3158.3841150975563, 5341.1988201769755, 5424.050791111559, 5441.537469315108, 5500.28496295482, 5539.113741801312, 5387.568994480442, 5452.945470545294, 5530.225768392418, 5545.556355491561, 5557.944420555793, 4962.0, 4997.1005219060735, 5079.0, 5118.769655365518, 5173.172292433212, 535.1714386709084, 4878.195097808857, 4963.280324352967, 4994.87512812179, 5072.797088116471, 4961.156603377434, 5000.849974500771, 5029.2958985742025, 5036.722980236085, 5043.546080852722, 5032.974835125838, 5047.217681259411, 5050.0, 5051.419086805027, 5061.645684802065, 4901.411830580318, 4928.605711543104, 4964.230544265644, 4982.028504441635, 4985.675931064469, 5439.864003399907, 5480.286953220228, 5487.780488780444, 5525.060739674265, 5551.583631227674, 5692.430756924316, 5759.078547432391, 5903.232579764646, 5910.143029260733, 5910.645361278337, 5799.82600521985, 5862.824115276549, 5904.143899134644, 5911.586188966774, 5957.046872500379, 5467.753951072212, 5480.287562616874, 5481.260029895953, 5487.807926722546, 5489.807856725035, 5847.736851841677, 5980.820575382745, 5985.281766188085, 6008.399160083956, 6009.939900601025, 5846.0, 5851.590388672752, 5857.619254748428, 5865.912011319833, 5894.911576326359, 5936.317323507766, 5937.079752638348, 5948.375420580864, 5952.196453478725, 5954.047352423591, 5717.142428635655, 5806.912896306559, 5827.737751801179, 5874.647521148745, 5912.615679980788, 5806.303243610793, 5815.273090863642, 5845.970770146122, 5890.352061273256, 5900.20347253124, 4437.7781110944325, 4478.395416618715, 4504.729716217037, 4514.480834704051, 4517.051419202005, 3926.155876486512, 3933.862314819025, 3936.291467535814, 3960.683145348423, 3988.4814974053766, 5614.07367784311, 5666.886662266732, 5671.376148623648, 5684.63049901755, 5685.943140568624, 6000.249968753906, 6002.939970600238, 6015.849603759941, 6018.6990650467305, 6042.728077236447, 5437.4562543745305, 5481.917771233435, 5489.478499542537, 5555.111182210827, 5685.829425117253, 5110.28456016158, 5110.540051395318, 5157.045946499909, 5181.093308670967, 5212.687238765686, 6101.877962440726, 6111.908321375183, 6115.1744514490865, 6116.755329786848, 6126.632402055891, 5787.334456537384, 5906.616069955439, 5968.045112782021, 5977.103434484862, 5980.970095149671, 6068.939310607014, 6125.724342404514, 6126.733522497775, 6129.404074626685, 6134.222293196984, 5752.252207213036, 5815.098659707752, 5865.266841644794, 5889.646621202742, 5909.438603332676, 5824.242848429677, 5860.648361098348, 5905.498032667099, 5980.491658209101, 5988.640681558946, 5785.39253378406, 5806.274215723035, 5806.303243610793, 5817.0, 5856.648601083949, 5734.598578099493, 5758.1362795579325, 5760.366359700513, 5780.3930587289415, 5796.449337312949, 5470.097433923517, 5583.106702927512, 5583.134614134816, 5642.379338272704, 5676.943230567642, 5720.771169153188, 5798.0, 5803.564732644984, 5827.94172058274, 5850.853728656818, 5656.208130861765, 5698.743556540048, 5703.800366987136, 5708.315002199763, 5710.143478478261], "value": 5397.037056405741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4341823304047, 627.3444250757957, 628.1331762168207, 643.7650257655955, 647.5596594315863, 41548.16903661925, 43132.0, 43220.56779432205, 43242.78378608106, 46992.76503617486, 45195.77402112985, 45266.77366613162, 45614.543854561445, 45679.54320456794, 45693.0, 8832.470051796896, 8990.505522196276, 9046.77383065422, 9055.501947392891, 9070.727878163665, 8782.780430489225, 8867.600957956907, 8871.600777965006, 8881.689140880071, 8919.910800891972, 8901.643934242622, 8928.19646231839, 8947.418417802855, 8972.192502674758, 8998.415103018315, 8850.114988501131, 8912.73261802147, 8916.509591972439, 8924.776880577972, 8946.060663630355, 8801.339899507499, 8865.55672216393, 8895.555222238861, 8902.198802107841, 8936.374453788238, 42098.36852447216, 42332.0, 42362.576374236174, 42491.1501769966, 42750.14499710019, 3515.402381595135, 3539.557555305587, 3571.7321200910037, 3601.2617413430185, 3632.6730594246646, 29904.700952990628, 30319.696803031908, 32205.35589288201, 32955.0, 33317.83341083279, 4161.75029498228, 4192.706510544263, 4227.682923780729, 4315.568443155691, 4460.553944605546, 343255.0, 343313.0, 344294.0, 345012.0, 347591.2620436907, 34169.65830341714, 57492.0, 57859.0, 57876.13185802216, 58102.70948645314, 34736.652633473845, 36344.45483317752, 36490.452643210374, 36549.08627284339, 36689.633103668624, 12859.099863009687, 12870.678233044062, 13082.542111026069, 13130.34348282582, 13167.736645267041, 11131.220814542905, 11158.1631377647, 11158.553657853596, 11185.66443006711, 11208.775824483628, 8156.306713929263, 8184.099749027602, 8190.795230119175, 8282.088970213272, 8294.294984926228, 3178.682131786803, 3194.5847039884666, 3204.198950262434, 3218.4850423932057, 3241.2545114623767, 968.0899954043177, 986.8470387090013, 1013.7769690668041, 1085.267444474992, 1162.110985096402, 31833.681663183073, 33055.50416743751, 33117.503237451456, 33179.50230746541, 33602.32795344129, 1034.927555071153, 1067.9946600266949, 1102.917281203897, 1139.0545846947014, 1176.1414167657658, 16898.239579218964, 17397.913010434866, 17474.563135921704, 17528.474145775646, 17578.857374270632, 600221.0, 600364.0, 603216.0, 605182.0, 610029.0, 57895.13157302644, 59753.701231493564, 60003.69998149981, 60240.698796506615, 60316.0, 1319.663485811112, 1326.363345594101, 1329.528017553774, 1332.600219934016, 1333.9599812005656, 30602.92889748848, 32208.19479513031, 32347.514787277738, 32456.83771581127, 33169.50245746267, 51593.0, 52048.0, 52409.213861791344, 52443.47556524386, 52693.736531317096, 521361.0, 521470.0, 521474.0, 521577.0, 523482.0, 28193.0, 28937.7106228935, 29211.561826573045, 29225.56161657534, 29311.50852177589, 47290.52709472999, 48302.33537234674, 48952.0, 50083.0, 52338.0, 41772.1645567093, 42531.574684253996, 42552.361714573686, 43258.35112473378, 43604.0, 41533.37699934443, 41682.58317416787, 41815.7909210452, 43138.35292470553, 43454.56545434505, 36947.63052369442, 40704.1859162821, 40736.388954165115, 41592.1681566373, 42510.787446062575, 35226.82386588153, 37818.287037037386, 38067.42898856464, 38153.236935261695, 38216.0, 28712.712872871005, 28748.0, 28872.278193045342, 29003.27491812637, 29008.564871527367], "value": 19031.52313146449, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.8495229336705, 391.98432062717495, 392.81341362852646, 393.9074317535377, 412.07078039022, 13896.652583685413, 17621.7356739649, 18396.908015459903, 19414.90292548537, 19433.514162145955, 18098.366557170502, 18127.093645317746, 18160.273589056455, 18459.630807383845, 18541.629167416642, 5632.098864181721, 5673.1917700738195, 5738.741756620962, 5865.32548756892, 5880.823575292727, 5731.885362292773, 5734.168545560891, 5742.081266997281, 5744.942550574503, 5814.592978491507, 5604.103343465046, 5704.401037891003, 5780.393058728836, 5792.826215213529, 5801.332846722617, 5497.47773961473, 5740.311162660487, 5747.2528571285675, 5775.509081728058, 5780.132980052984, 5144.588432925357, 5169.0, 5170.844874653766, 5174.456682048369, 5181.611379146579, 21626.567468650697, 21898.671519927215, 21990.340289791333, 22093.558128837332, 22332.106715731352, 2095.748510178773, 2347.80043696286, 2510.447701505684, 2526.759957804006, 2531.7594828491265, 10175.745606359826, 10383.79232415355, 12138.939305303506, 14222.34184660168, 14446.133232006114, 1930.5173706573357, 1986.7317912081828, 2013.7080123382027, 2043.6117137743781, 2050.005747212601, 83494.16505834986, 84798.57600711957, 85943.14056859477, 86047.0, 87190.56404717999, 10299.588016479407, 10606.310589811792, 10636.521356538975, 10672.733181670365, 11625.476853541611, 12786.61640150797, 13480.865191348157, 14828.110313381232, 14865.331060102322, 15004.549863504113, 7095.751648692271, 7429.405647548183, 7513.774586762406, 7593.772186834404, 7772.300492955661, 7197.316254955771, 7281.781546553506, 7318.743843965436, 7478.3643390311345, 7495.362894154058, 4502.3471596618965, 4529.5243999380245, 4531.909361812745, 4601.884952876205, 4692.906141877143, 1946.6496030714325, 1973.7730161031377, 1995.4013795861183, 2008.4075197816678, 2034.0541648133394, 881.4887365328094, 951.7335146159087, 997.7206382212992, 1006.2201793610011, 1041.8228901086834, 17636.735448968277, 18432.723509147374, 18533.629327413644, 18610.5926098302, 18622.53443663919, 935.4013431403907, 956.0917128727598, 990.7077412163429, 993.4039576254189, 1000.949952502372, 10166.898331016595, 10380.377177369382, 10417.270791044706, 10471.790564188826, 10473.47632618366, 468170.0, 484070.0, 490530.0, 493526.0, 495130.0, 70625.0, 72687.0, 95801.0, 101910.49044754729, 103056.48471757594, 963.4556475591269, 977.4379731654327, 987.5704068729982, 993.5082134343546, 1002.904724051214, 16385.0, 16419.917900410423, 16552.66894662124, 16624.25190866438, 16820.57948551296, 34469.48295775515, 38023.0, 39752.60247397489, 43643.0, 45960.54039459563, 59026.70486647539, 59093.40906591051, 59673.40326596852, 60301.69849150726, 60449.69775151096, 7251.383632391306, 7637.159912409519, 8248.958755206186, 8487.533185674847, 8610.612522436631, 11702.473388697359, 13399.732005360032, 13467.797983030458, 13518.729625407634, 13519.256440895846, 11514.94242528782, 11649.718530961418, 11854.94072529632, 11982.10134239918, 12129.75740485203, 11263.831042534532, 11561.479733412185, 11606.0, 12007.099467539794, 12096.334701591144, 11599.594014209462, 11611.767764644828, 11700.70748231267, 11834.349110798988, 12080.0, 7721.53290874732, 7723.9227607723205, 7745.419093568117, 7975.920240797518, 8016.038075430985, 11716.94141529321, 11934.4032798358, 11962.401879906143, 11978.341191234565, 12081.75836483283], "value": 9076.785102344706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.0081144416076, 1468.7356275870343, 1563.6638122803602, 1706.940257091002, 1708.1117818734267, 7647.770566883002, 8754.474731516113, 8863.822723545525, 9333.719988400351, 9335.206507446866, 8924.91075089249, 8932.374733768622, 9009.324300677443, 9018.233450156744, 9100.99889012208, 2283.977160228397, 2305.4812667149927, 2327.1156960355042, 2327.5112226432384, 2328.429534763985, 2238.563480121377, 2283.3264187064774, 2310.653401989698, 2313.8495997760174, 2319.3042087373806, 2307.284741730061, 2310.376198426424, 2311.7919387255142, 2348.1664009276715, 2351.670766092748, 2280.0879648140794, 2286.9085236590518, 2295.5753185660537, 2298.1267118494948, 2302.953940921189, 2284.3717977556307, 2295.024614538831, 2298.9425264368524, 2300.896459659319, 2303.1593468384085, 9082.364234503588, 9100.180983711498, 9108.8633670495, 9114.179723824887, 9163.266938644892, 5179.637425380225, 5340.679559226459, 5365.302510673627, 5378.731063446851, 5382.3541175059245, 3304.6364899860996, 3434.0679482103824, 3494.405950988338, 3503.1592417819793, 3517.8241087945757, 1120.753434244473, 1123.4045955643521, 1127.9323240605509, 1132.47905963257, 1172.9648110556698, 13094.738105237842, 13157.539486118036, 13194.340282985908, 13224.537141200011, 13238.602841914759, 4612.331211974312, 4692.389989301369, 4794.161021821237, 4796.880077998008, 4811.639127065484, 10864.185186111074, 10871.29336593119, 10871.782564348669, 10946.616868409568, 10955.123590112771, 5187.481251874782, 5242.947570524322, 5243.68537887728, 5248.895022099537, 5411.810586629449, 4275.551067137968, 4791.712497250176, 4829.806807727722, 4975.5522003019905, 4987.925181122286, 3798.525184351956, 3910.882673519799, 3933.1347103637154, 3961.801909904493, 4011.9799401002806, 1193.5046955513365, 1204.2292932523192, 1221.3099598726692, 1223.2966044524435, 1244.7946088895412, 835.6740871060291, 928.9303302252223, 930.3255140023429, 938.4181807279394, 938.671464987249, 5909.8227053188475, 5929.495992840571, 5976.103584462278, 6015.759369625166, 6313.873722525615, 927.1099744245465, 976.1214906584131, 996.8704068471052, 1013.4443629029405, 1038.9584416623402, 3872.457855900176, 3953.8418463261146, 3956.1098752780395, 3965.821538030738, 3985.8405663773124, 11157.0, 11475.139364547693, 11658.6502404928, 11691.415429228504, 11692.181547291779, 11517.942410287895, 11526.88473115258, 11643.825342619868, 11669.35818529972, 11736.823947640793, 8398.412111152284, 8558.400911936105, 8707.6516939323, 8739.737807865775, 8749.825003500022, 5658.292713410824, 5790.913136302875, 5822.446867547576, 5878.441548052928, 5955.076963070731, 10678.786424271626, 10727.302725322828, 10755.946220268848, 10763.623273185402, 10782.622608208674, 10845.891541084804, 10917.781644367227, 10946.835797463204, 11046.944765276123, 11140.108791296514, 7097.396721278749, 7476.177620461636, 7665.42509311815, 7695.730649427243, 7827.647755851114, 8983.416077954913, 9022.413543119676, 9072.90927090747, 9082.545872706207, 9136.132067453582, 7645.388368930361, 7877.960610197141, 8127.065387480516, 8135.30849877767, 8147.063087744985, 7952.681892724227, 8083.272505474535, 8127.79680507992, 8189.95905020495, 8221.383396245425, 7103.715851366094, 7290.270972902667, 7405.0, 7454.515456495311, 7466.066741657293, 5050.949490505048, 5211.765470553758, 5247.2129180623215, 5254.632175747661, 5307.65500242483, 5007.974960125176, 5094.490550945025, 5116.667416617908, 5192.299039629602, 5220.791168353223], "value": 4724.226751284621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3684769970107, 332.48630865313095, 332.61915107202253, 335.1069400048871, 338.2592123250084, 5580.581456390767, 5597.580181486394, 5605.327360716709, 5627.943720562798, 5714.742836572354, 5403.89220209857, 5467.562594992401, 5483.0, 5512.972435137829, 5583.5761880720465, 4086.4074709167226, 4216.873493795191, 4320.740755554677, 4323.589259020388, 4328.9783551082355, 4323.610875021247, 4338.635443683184, 4343.956560434387, 4361.890952726191, 4371.431713877191, 4298.591633794785, 4345.174416860802, 4348.695591308609, 4354.804033818486, 4358.65130789536, 4272.722273052257, 4279.978600107011, 4334.241507736165, 4338.893582136567, 4351.847685331029, 3804.5814960354614, 3804.828782704757, 3827.5024246847734, 3837.9808100959594, 3861.0, 5438.456154384569, 5447.210154527571, 5461.972690136564, 5464.672119672792, 5467.535259502907, 4875.8781030474165, 5040.495950404967, 5051.267566202917, 5055.721935293557, 5066.847994560169, 5877.52979761618, 5880.70596470179, 5884.941150588482, 5960.791372301992, 5987.161797348374, 4238.957610423887, 4268.509121451011, 4269.786510674485, 4275.0, 4296.613304802551, 6000.159977603139, 6028.0, 6059.848503787441, 6089.269287685506, 6092.878142437171, 4298.441202643637, 4302.7848607569495, 4311.48262208537, 4315.8273669053515, 4319.028218650778, 4387.3857659927635, 4396.780160991938, 4400.405945197422, 4415.66882483815, 4419.668524860648, 4907.1167189905445, 4910.729909854921, 5003.099442100457, 5021.271915572294, 5040.79836806531, 5831.679257640785, 5878.382769809194, 5922.466977972003, 5929.762809487658, 5951.4941229995065, 1511.508759653117, 1513.3870782333172, 1523.8171419429739, 1539.5304432148077, 1541.167769404509, 931.6599441203912, 953.7710949372239, 985.4875464758429, 999.7850462150527, 999.9100080992746, 5607.383187849333, 5637.68992705397, 5644.971775141098, 5679.375268720438, 5723.656580605177, 5983.730732117066, 5998.820035398945, 6089.695515224221, 6096.969515152396, 6101.749141425997, 5463.31708536433, 5695.345035320908, 5783.0915797787475, 5793.710314484259, 5821.621594596338, 3230.2570408806105, 3240.7893486923276, 3256.70689637929, 3266.852991615383, 3302.7944800147775, 6076.422739839708, 6166.198394208814, 6234.37656234382, 6242.845073661387, 6268.811935641938, 6096.464050850496, 6204.81385558434, 6236.75052997875, 6240.937590624036, 6243.96878015607, 5897.292324921037, 6243.469305109026, 6254.562180647402, 6283.465905398001, 6284.811455656338, 6013.0758157390965, 6100.694965251809, 6101.7559297627595, 6126.693665316628, 6146.78486252979, 6009.36901625323, 6026.789062382795, 6033.793241351835, 6049.969750151221, 6057.848553786191, 6044.0, 6214.197882613991, 6257.12286314113, 6289.308176100534, 6304.936950630618, 4260.190563792869, 4270.594293542109, 4304.440422745023, 4321.827126914888, 4341.848035318749, 5929.687421905546, 6116.0, 6129.2032035835055, 6152.031349968146, 6250.843728906631, 5863.17915491823, 5872.618279811799, 5875.764969401176, 5886.52907767369, 5952.077427998667, 5911.231539899785, 5923.378045305353, 5974.805038992132, 5980.581359304807, 6003.8198854034445, 5583.385827559046, 5877.706114694333, 5878.2064421304285, 5883.235179426647, 5900.7049647518315, 5987.371326010881, 6021.518278537619, 6034.879302414015, 6048.667323297261, 6059.666718330534, 5579.860503487445, 5858.47273745348, 5896.204012458264, 5909.85225369352, 5922.585419020799], "value": 4493.951908015531, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.7340683946941, 762.4091329219854, 771.3520642660164, 806.2018601584433, 826.9952008309903, 13924.094933829294, 14540.272986350667, 14618.488352907638, 14757.40970361187, 14847.628809279773, 13633.659158521043, 13696.794548081762, 13783.931080344584, 13799.31003449826, 13844.238566878817, 650.6519012328405, 750.9136449308345, 753.0436345840793, 768.1742127213269, 769.3037800790294, 767.5049593012503, 772.5326177662517, 777.4247057177676, 780.0288640642408, 781.8240895798457, 824.1964085017121, 824.4393812207696, 827.2389401750404, 827.7765003449065, 828.9336853051741, 818.4843548564396, 819.5861090149496, 822.2024636102971, 825.471698113202, 825.6697321071589, 599.6492052149498, 603.3092109534558, 603.809799913026, 604.4650484321363, 604.8064619321818, 14739.59973802487, 14901.627459313495, 14905.329260183318, 14922.0, 14928.552143435714, 14713.896457765602, 15159.772603410958, 15160.070632600808, 15195.848041519554, 15440.691186176326, 12016.895040552043, 12172.756544869142, 12250.877491225063, 12333.69165770854, 12880.484780608764, 3893.1240470894104, 3924.823382947774, 4028.6978476614076, 4089.591040895916, 4090.734102283342, 73941.63029184873, 75678.0, 75895.24104758937, 76281.0, 76576.0, 11387.259828111146, 11483.77032459346, 11701.824472632918, 11709.004734597655, 12139.939300303442, 21357.572848543252, 21456.678149827763, 21575.892120539298, 21684.783152168275, 21708.89145554262, 7635.0, 7790.649420776079, 7970.362371010306, 7994.760157195294, 8125.837483250302, 4584.518625544337, 4585.633149348044, 4608.3778689876435, 4660.161170989187, 4681.063787242565, 3526.4181410067563, 3655.5247817784048, 3657.561092668897, 3658.158623516606, 3663.908402289964, 572.6134858970179, 587.632729544035, 595.8986972214734, 599.5892813422732, 599.8830228105478, 715.7745310227261, 730.9305615966581, 731.7329174851141, 738.4203400330822, 757.6287619066618, 10286.228532860065, 10413.698287714036, 10444.895551044392, 10647.361158330525, 10708.1433485321, 688.2566827825935, 702.0145841057965, 733.2191216354565, 757.4357103957586, 757.443279189795, 4801.375821143229, 4840.370751802243, 4921.557059864629, 5098.5411312982005, 5115.0, 116402.41798790952, 116705.41647291709, 119808.0, 120305.0, 121454.39272803579, 88036.0, 96799.0, 97643.0, 97797.5110124459, 102487.40334247942, 84194.57902710569, 85293.0, 86941.56529217314, 89125.55437222772, 89265.55367223252, 9859.211263099078, 9913.206943444651, 10047.949760251444, 10387.428691422045, 10400.531976061247, 47753.0, 51146.48853511566, 51864.0, 52487.0, 52637.7368113157, 69196.0, 77745.61127194327, 77756.61121694582, 78487.60756196182, 78663.21336786788, 13006.024548158737, 13071.477140914638, 13121.671958201121, 13639.659008524866, 13703.725925481634, 14410.639734006314, 14579.416823327372, 14775.335109920294, 15009.2495375233, 15167.24163791784, 12115.273083614658, 13094.410751516396, 13628.31858407056, 13677.31613419345, 13724.65688357799, 12524.436400362189, 12602.11785175029, 12671.239725616493, 12966.481340746264, 14380.28098595087, 13347.933260333637, 13638.590842274747, 13908.791368129689, 13944.302784860514, 14171.503997360043, 10630.149588033093, 10853.565857365933, 10948.890511094787, 11113.888861111285, 11302.773944521228, 11505.597304094317, 12227.694307642025, 12398.876011239772, 12476.43856026499, 12544.560940367044], "value": 7560.268863514636, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 111.0, 111.0, 113.0, 112.0, 111.0, 113.0, 114.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 162.0, 179.0, 129.0, 154.0, 159.0, 133.0, 192.0, 128.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 162.0, 168.0, 169.0, 162.0, 163.0, 163.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 158.0, 78.0, 76.0, 77.0, 75.0, 158.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 85.0, 85.0, 86.0, 138.0, 85.0, 85.0, 154.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 150.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 61.0, 57.0, 58.0, 56.0, 61.0, 56.0, 57.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 70.0, 61.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 84.0, 79.0, 87.0, 81.0, 87.0, 81.0, 116.0, 80.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 136.0, 129.0, 133.0, 123.0, 132.0, 137.0, 134.0, 132.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 164.0, 164.0, 165.0, 159.0, 161.0, 160.0, 166.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 65.0, 64.0, 63.0, 62.0, 64.0, 64.0], "value": 63.9, "unit": "score"}]}]} 06:01:25 INFO - Return code: 0 06:01:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:25 ERROR - # TBPL SUCCESS # 06:01:25 INFO - Running post-action listener: _resource_record_post_action 06:01:25 INFO - ##### 06:01:25 INFO - ##### Finished run-tests step (success) 06:01:25 INFO - ##### 06:01:25 INFO - Running post-run listener: _resource_record_post_run 06:01:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 303378432; Read time: 24; Write time: 270740 06:01:25 INFO - TinderboxPrint: CPU usage
13.4% 06:01:25 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 24 06:01:25 INFO - TinderboxPrint: I/O write bytes / time
303,378,432 / 270,740 06:01:25 INFO - TinderboxPrint: CPU idle
8,228.5 (86.5%) 06:01:25 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 06:01:25 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15355904; Read time: 0; Write time: 7640 06:01:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 287260672; Read time: 24; Write time: 262752 06:01:26 INFO - Running post-run listener: _upload_blobber_files 06:01:26 INFO - Blob upload gear active. 06:01:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:26 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 06:01:26 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:26 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:26 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:34 INFO - (blobuploader) - INFO - Done attempting. 06:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:35 INFO - (blobuploader) - INFO - Done attempting. 06:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:36 INFO - (blobuploader) - INFO - Done attempting. 06:01:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:36 INFO - Return code: 0 06:01:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6666e9ec040606a18c3d02658c55166036e85904b582f3c97b6a671512c48c4c57723dce98eb0946cfa088224af482e38e897e89108f98f59efecf3382b29663", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfa453b88e124b13e844666b8cf14fd82c277afa7d8d77de1f29ffe0c0f2ae1677b7be6543d9283d637dfdef2864de0a3ef17a19aa0bac4c0e6e98060d3bce32", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae0d955af3144d07fef4664a0709707002787198e643903afe0ef1ca66e0c8fffb2b769514b98e31d10fc3781ed772976cca91053d8dd30643494127651198e"} 06:01:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:36 INFO - Contents: 06:01:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6666e9ec040606a18c3d02658c55166036e85904b582f3c97b6a671512c48c4c57723dce98eb0946cfa088224af482e38e897e89108f98f59efecf3382b29663", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfa453b88e124b13e844666b8cf14fd82c277afa7d8d77de1f29ffe0c0f2ae1677b7be6543d9283d637dfdef2864de0a3ef17a19aa0bac4c0e6e98060d3bce32", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae0d955af3144d07fef4664a0709707002787198e643903afe0ef1ca66e0c8fffb2b769514b98e31d10fc3781ed772976cca91053d8dd30643494127651198e"} 06:01:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:36 INFO - Copying logs to upload dir... 06:01:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.930778 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2016-06-09 06:01:35.415553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:01:35.419012) ========= 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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 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/Firefox/sha512/6666e9ec040606a18c3d02658c55166036e85904b582f3c97b6a671512c48c4c57723dce98eb0946cfa088224af482e38e897e89108f98f59efecf3382b29663", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfa453b88e124b13e844666b8cf14fd82c277afa7d8d77de1f29ffe0c0f2ae1677b7be6543d9283d637dfdef2864de0a3ef17a19aa0bac4c0e6e98060d3bce32", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae0d955af3144d07fef4664a0709707002787198e643903afe0ef1ca66e0c8fffb2b769514b98e31d10fc3781ed772976cca91053d8dd30643494127651198e"} build_url:https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/GFmnN55tSVKrqwZFrZl5qA/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/Firefox/sha512/6666e9ec040606a18c3d02658c55166036e85904b582f3c97b6a671512c48c4c57723dce98eb0946cfa088224af482e38e897e89108f98f59efecf3382b29663", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfa453b88e124b13e844666b8cf14fd82c277afa7d8d77de1f29ffe0c0f2ae1677b7be6543d9283d637dfdef2864de0a3ef17a19aa0bac4c0e6e98060d3bce32", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae0d955af3144d07fef4664a0709707002787198e643903afe0ef1ca66e0c8fffb2b769514b98e31d10fc3781ed772976cca91053d8dd30643494127651198e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:01:35.444761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:01:35.445113) ========= 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=0e2a256762fed810e2f0f810000001b3-1465474869.3189-1679791507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:01:35.530657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:01:35.530993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:01:35.531324) ========= ========= Total master_lag: 0.18 =========