builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1466167826.5 results: success (0) buildid: 20160617030217 builduid: d765a6e8db54448daad47692ea1380b3 revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.500270) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.500861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.501150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.653479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.653744) ========= 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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 05:50:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.3M=0s 2016-06-17 05:50:26 (82.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.792705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.793073) ========= 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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018288 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.927852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:26.928196) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f95858f8ddf21ea2271a12810332efd09eff138 --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 5f95858f8ddf21ea2271a12810332efd09eff138 --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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 05:50:27,058 truncating revision to first 12 chars 2016-06-17 05:50:27,058 Setting DEBUG logging. 2016-06-17 05:50:27,058 attempt 1/10 2016-06-17 05:50:27,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f95858f8ddf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 05:50:27,373 unpacking tar archive at: mozilla-central-5f95858f8ddf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679607 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:27.625536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:27.625850) ========= script_repo_revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:27.626245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:27.626938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 05:50:27.639137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 52 secs) (at 2016-06-17 05:50:27.639515) ========= /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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:27 INFO - MultiFileLogger online at 20160617 05:50:27 in /builds/slave/test 05:50:27 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:50:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:27 INFO - {'append_to_log': False, 05:50:27 INFO - 'base_work_dir': '/builds/slave/test', 05:50:27 INFO - 'blob_upload_branch': 'Firefox', 05:50:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:27 INFO - 'branch': 'Firefox', 05:50:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:27 INFO - 'config_files': ('talos/linux_config.py',), 05:50:27 INFO - 'default_actions': ('clobber', 05:50:27 INFO - 'read-buildbot-config', 05:50:27 INFO - 'download-and-extract', 05:50:27 INFO - 'populate-webroot', 05:50:27 INFO - 'create-virtualenv', 05:50:27 INFO - 'install', 05:50:27 INFO - 'run-tests'), 05:50:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:27 INFO - 'download_minidump_stackwalk': True, 05:50:27 INFO - 'download_symbols': 'ondemand', 05:50:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:27 INFO - 'installer_path': 'installer.exe', 05:50:27 INFO - 'log_level': 'info', 05:50:27 INFO - 'log_name': 'talos', 05:50:27 INFO - 'log_to_console': True, 05:50:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:27 INFO - 'opt_config_files': (), 05:50:27 INFO - 'pip_index': False, 05:50:27 INFO - 'sps_profile': False, 05:50:27 INFO - 'sps_profile_interval': 0, 05:50:27 INFO - 'suite': 'dromaeojs-e10s', 05:50:27 INFO - 'system_bits': '32', 05:50:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:27 INFO - 'title': 'talos-linux64-ix-035', 05:50:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:27 INFO - 'use_talos_json': True, 05:50:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:27 INFO - 'work_dir': 'build'} 05:50:27 INFO - ##### 05:50:27 INFO - ##### Running clobber step. 05:50:27 INFO - ##### 05:50:27 INFO - Running pre-action listener: _resource_record_pre_action 05:50:27 INFO - Running main action method: clobber 05:50:27 INFO - rmtree: /builds/slave/test/build 05:50:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:28 INFO - Running post-action listener: _resource_record_post_action 05:50:28 INFO - ##### 05:50:28 INFO - ##### Finished clobber step (success) 05:50:28 INFO - ##### 05:50:28 INFO - ##### 05:50:28 INFO - ##### Running read-buildbot-config step. 05:50:28 INFO - ##### 05:50:28 INFO - Running pre-action listener: _resource_record_pre_action 05:50:28 INFO - Running main action method: read_buildbot_config 05:50:28 INFO - Using buildbot properties: 05:50:28 INFO - { 05:50:28 INFO - "project": "", 05:50:28 INFO - "product": "firefox", 05:50:28 INFO - "script_repo_revision": "production", 05:50:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:50:28 INFO - "repository": "", 05:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:50:28 INFO - "buildid": "20160617030217", 05:50:28 INFO - "stage_platform": "linux64-pgo", 05:50:28 INFO - "basedir": "/builds/slave/test", 05:50:28 INFO - "nightly_build": "True", 05:50:28 INFO - "buildnumber": 255, 05:50:28 INFO - "slavename": "talos-linux64-ix-035", 05:50:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:50:28 INFO - "platform": "ubuntu64_hw", 05:50:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:50:28 INFO - "branch": "mozilla-central", 05:50:28 INFO - "repo_path": "mozilla-central", 05:50:28 INFO - "revision": "5f95858f8ddf21ea2271a12810332efd09eff138", 05:50:28 INFO - "pgo_build": "True", 05:50:28 INFO - "builduid": "d765a6e8db54448daad47692ea1380b3", 05:50:28 INFO - "slavebuilddir": "test" 05:50:28 INFO - } 05:50:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:50:28 INFO - Running post-action listener: _resource_record_post_action 05:50:28 INFO - ##### 05:50:28 INFO - ##### Finished read-buildbot-config step (success) 05:50:28 INFO - ##### 05:50:28 INFO - ##### 05:50:28 INFO - ##### Running download-and-extract step. 05:50:28 INFO - ##### 05:50:28 INFO - Running pre-action listener: _resource_record_pre_action 05:50:28 INFO - Running main action method: download_and_extract 05:50:28 INFO - mkdir: /builds/slave/test/build/tests 05:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:28 INFO - https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:32 INFO - Downloaded 1361 bytes. 05:50:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:32 INFO - Using the following test package requirements: 05:50:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'jsshell-linux-x86_64.zip'], 05:50:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:32 INFO - https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:50 INFO - Downloaded 24220863 bytes. 05:50:50 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:50:50 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:50:51 INFO - Return code: 0 05:50:51 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:50:51 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:50:51 INFO - https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:52 INFO - Downloaded 24220863 bytes. 05:50:52 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:50:52 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:50:54 INFO - Return code: 0 05:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:54 INFO - https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:55 INFO - Downloaded 14405384 bytes. 05:50:55 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:50:55 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:50:55 INFO - Return code: 0 05:50: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:50:55 INFO - https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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:50:58 INFO - Downloaded 59405286 bytes. 05:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:58 INFO - mkdir: /builds/slave/test/properties 05:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:58 INFO - Contents: 05:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:59 INFO - Running post-action listener: _resource_record_post_action 05:50:59 INFO - Running post-action listener: set_extra_try_arguments 05:50:59 INFO - ##### 05:50:59 INFO - ##### Finished download-and-extract step (success) 05:50:59 INFO - ##### 05:50:59 INFO - ##### 05:50:59 INFO - ##### Running populate-webroot step. 05:50:59 INFO - ##### 05:50:59 INFO - Running pre-action listener: _resource_record_pre_action 05:50:59 INFO - Running main action method: populate_webroot 05:50:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:59 INFO - '--tppagecycles', 05:50:59 INFO - '7'], 05:50:59 INFO - 'tests': ['tsvgm']}}, 05:50:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['damp', 'tps']}, 05:50:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'tests': ['damp', 'tps']}, 05:50:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['dromaeo_dom']}, 05:50:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['basic_compositor_video']}, 05:50:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['a11yr', 05:50:59 INFO - 'ts_paint', 05:50:59 INFO - 'tpaint', 05:50:59 INFO - 'sessionrestore', 05:50:59 INFO - 'sessionrestore_no_auto_restore', 05:50:59 INFO - 'tabpaint']}, 05:50:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['tsvgx', 05:50:59 INFO - 'tsvgr_opacity', 05:50:59 INFO - 'tart', 05:50:59 INFO - 'tscrollx', 05:50:59 INFO - 'cart']}, 05:50:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:59 INFO - 'tsvgr_opacity', 05:50:59 INFO - 'tart', 05:50:59 INFO - 'tscrollx', 05:50:59 INFO - 'cart']}, 05:50:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'talos_options': ['--disable-e10s'], 05:50:59 INFO - 'tests': ['tp5o']}, 05:50:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'tests': ['tp5o']}, 05:50:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'talos_options': ['--disable-e10s', 05:50:59 INFO - '--xperf_path', 05:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:59 INFO - 'tests': ['tp5n']}, 05:50:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:59 INFO - 'talos_options': ['--xperf_path', 05:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:59 INFO - 'tests': ['tp5n']}}, 05:50:59 INFO - 'talos.zip': {'path': '', 05:50:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:59 INFO - Running post-action listener: _resource_record_post_action 05:50:59 INFO - ##### 05:50:59 INFO - ##### Finished populate-webroot step (success) 05:50:59 INFO - ##### 05:50:59 INFO - ##### 05:50:59 INFO - ##### Running create-virtualenv step. 05:50:59 INFO - ##### 05:50:59 INFO - Running pre-action listener: _resource_record_pre_action 05:50:59 INFO - Running main action method: create_virtualenv 05:50:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:59 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:50:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:59 INFO - Using real prefix '/usr' 05:50:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:02 INFO - Installing pip.................done. 05:51:02 INFO - Return code: 0 05:51:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51: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:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:02 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:02 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:51:02 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:51:02 INFO - Using env: {'DISPLAY': ':0', 05:51:02 INFO - 'HOME': '/home/cltbld', 05:51:02 INFO - 'LANG': 'en_US.UTF-8', 05:51:02 INFO - 'LANGUAGE': 'en_US:en', 05:51:02 INFO - 'LOGNAME': 'cltbld', 05:51:02 INFO - 'MAIL': '/var/mail/cltbld', 05:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:02 INFO - 'MOZ_NO_REMOTE': '1', 05:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:02 INFO - 'NO_EM_RESTART': '1', 05:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:02 INFO - 'PWD': '/builds/slave/test', 05:51:02 INFO - 'SHELL': '/bin/bash', 05:51:02 INFO - 'SHLVL': '1', 05:51:02 INFO - 'TERM': 'linux', 05:51:02 INFO - 'TMOUT': '86400', 05:51:02 INFO - 'USER': 'cltbld', 05:51:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:02 INFO - '_': '/tools/buildbot/bin/python'} 05:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:02 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:51:02 INFO - Cleaning up... 05:51:02 INFO - Return code: 0 05:51:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51: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:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:02 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:02 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:51:02 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:51:02 INFO - Using env: {'DISPLAY': ':0', 05:51:02 INFO - 'HOME': '/home/cltbld', 05:51:02 INFO - 'LANG': 'en_US.UTF-8', 05:51:02 INFO - 'LANGUAGE': 'en_US:en', 05:51:02 INFO - 'LOGNAME': 'cltbld', 05:51:02 INFO - 'MAIL': '/var/mail/cltbld', 05:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:02 INFO - 'MOZ_NO_REMOTE': '1', 05:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:02 INFO - 'NO_EM_RESTART': '1', 05:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:02 INFO - 'PWD': '/builds/slave/test', 05:51:02 INFO - 'SHELL': '/bin/bash', 05:51:02 INFO - 'SHLVL': '1', 05:51:02 INFO - 'TERM': 'linux', 05:51:02 INFO - 'TMOUT': '86400', 05:51:02 INFO - 'USER': 'cltbld', 05:51:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:02 INFO - '_': '/tools/buildbot/bin/python'} 05:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:02 INFO - Downloading/unpacking psutil>=3.1.1 05:51:02 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:51:02 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:51:02 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:51:02 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:51:02 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:51:02 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:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:04 INFO - Installing collected packages: psutil 05:51:04 INFO - Running setup.py install for psutil 05:51:04 INFO - building 'psutil._psutil_linux' extension 05:51:04 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:51:04 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:51:04 INFO - building 'psutil._psutil_posix' extension 05:51:04 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:51:05 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:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:05 INFO - Successfully installed psutil 05:51:05 INFO - Cleaning up... 05:51:05 INFO - Return code: 0 05:51:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:51:05 INFO - Using env: {'DISPLAY': ':0', 05:51:05 INFO - 'HOME': '/home/cltbld', 05:51:05 INFO - 'LANG': 'en_US.UTF-8', 05:51:05 INFO - 'LANGUAGE': 'en_US:en', 05:51:05 INFO - 'LOGNAME': 'cltbld', 05:51:05 INFO - 'MAIL': '/var/mail/cltbld', 05:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:05 INFO - 'MOZ_NO_REMOTE': '1', 05:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:05 INFO - 'NO_EM_RESTART': '1', 05:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:05 INFO - 'PWD': '/builds/slave/test', 05:51:05 INFO - 'SHELL': '/bin/bash', 05:51:05 INFO - 'SHLVL': '1', 05:51:05 INFO - 'TERM': 'linux', 05:51:05 INFO - 'TMOUT': '86400', 05:51:05 INFO - 'USER': 'cltbld', 05:51:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:05 INFO - '_': '/tools/buildbot/bin/python'} 05:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:07 INFO - Installing collected packages: mozsystemmonitor 05:51:07 INFO - Running setup.py install for mozsystemmonitor 05:51:07 INFO - Successfully installed mozsystemmonitor 05:51:07 INFO - Cleaning up... 05:51:07 INFO - Return code: 0 05:51:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:07 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:51:07 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:51:07 INFO - Using env: {'DISPLAY': ':0', 05:51:07 INFO - 'HOME': '/home/cltbld', 05:51:07 INFO - 'LANG': 'en_US.UTF-8', 05:51:07 INFO - 'LANGUAGE': 'en_US:en', 05:51:07 INFO - 'LOGNAME': 'cltbld', 05:51:07 INFO - 'MAIL': '/var/mail/cltbld', 05:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:07 INFO - 'MOZ_NO_REMOTE': '1', 05:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:07 INFO - 'NO_EM_RESTART': '1', 05:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:07 INFO - 'PWD': '/builds/slave/test', 05:51:07 INFO - 'SHELL': '/bin/bash', 05:51:07 INFO - 'SHLVL': '1', 05:51:07 INFO - 'TERM': 'linux', 05:51:07 INFO - 'TMOUT': '86400', 05:51:07 INFO - 'USER': 'cltbld', 05:51:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:07 INFO - '_': '/tools/buildbot/bin/python'} 05:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:09 INFO - warning: no files found matching '*.txt' 05:51:09 INFO - no previously-included directories found matching 'build' 05:51:09 INFO - no previously-included directories found matching 'dist' 05:51:09 INFO - no previously-included directories found matching '.git*' 05:51:09 INFO - Installing collected packages: jsonschema, functools32 05:51:09 INFO - Running setup.py install for functools32 05:51:10 INFO - warning: no files found matching '*.txt' 05:51:10 INFO - no previously-included directories found matching 'build' 05:51:10 INFO - no previously-included directories found matching 'dist' 05:51:10 INFO - no previously-included directories found matching '.git*' 05:51:10 INFO - Successfully installed jsonschema functools32 05:51:10 INFO - Cleaning up... 05:51:10 INFO - Return code: 0 05:51:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:51:10 INFO - Using env: {'DISPLAY': ':0', 05:51:10 INFO - 'HOME': '/home/cltbld', 05:51:10 INFO - 'LANG': 'en_US.UTF-8', 05:51:10 INFO - 'LANGUAGE': 'en_US:en', 05:51:10 INFO - 'LOGNAME': 'cltbld', 05:51:10 INFO - 'MAIL': '/var/mail/cltbld', 05:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:10 INFO - 'MOZ_NO_REMOTE': '1', 05:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:10 INFO - 'NO_EM_RESTART': '1', 05:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:10 INFO - 'PWD': '/builds/slave/test', 05:51:10 INFO - 'SHELL': '/bin/bash', 05:51:10 INFO - 'SHLVL': '1', 05:51:10 INFO - 'TERM': 'linux', 05:51:10 INFO - 'TMOUT': '86400', 05:51:10 INFO - 'USER': 'cltbld', 05:51:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:10 INFO - '_': '/tools/buildbot/bin/python'} 05:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:10 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Downloading docopt-0.6.1.tar.gz 05:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:12 INFO - Running setup.py install for blobuploader 05:51:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:13 INFO - Running setup.py install for requests 05:51:13 INFO - Running setup.py install for docopt 05:51:13 INFO - Successfully installed blobuploader requests docopt 05:51:13 INFO - Cleaning up... 05:51:13 INFO - Return code: 0 05:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:13 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:13 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:51:13 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:51:13 INFO - Using env: {'DISPLAY': ':0', 05:51:13 INFO - 'HOME': '/home/cltbld', 05:51:13 INFO - 'LANG': 'en_US.UTF-8', 05:51:13 INFO - 'LANGUAGE': 'en_US:en', 05:51:13 INFO - 'LOGNAME': 'cltbld', 05:51:13 INFO - 'MAIL': '/var/mail/cltbld', 05:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:13 INFO - 'MOZ_NO_REMOTE': '1', 05:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:13 INFO - 'NO_EM_RESTART': '1', 05:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:13 INFO - 'PWD': '/builds/slave/test', 05:51:13 INFO - 'SHELL': '/bin/bash', 05:51:13 INFO - 'SHLVL': '1', 05:51:13 INFO - 'TERM': 'linux', 05:51:13 INFO - 'TMOUT': '86400', 05:51:13 INFO - 'USER': 'cltbld', 05:51:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:13 INFO - '_': '/tools/buildbot/bin/python'} 05:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:13 INFO - Running setup.py (path:/tmp/pip-YzBMWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:13 INFO - Running setup.py (path:/tmp/pip-6BRIJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:13 INFO - Running setup.py (path:/tmp/pip-2i3sGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:14 INFO - Running setup.py (path:/tmp/pip-zwnVH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:14 INFO - Running setup.py (path:/tmp/pip-0u_8jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:14 INFO - Running setup.py (path:/tmp/pip-HeecoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:14 INFO - Running setup.py (path:/tmp/pip-ZfdHyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:14 INFO - Running setup.py (path:/tmp/pip-UnyWUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:14 INFO - Running setup.py (path:/tmp/pip-werqnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:14 INFO - Running setup.py (path:/tmp/pip-CMeiMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:14 INFO - Running setup.py (path:/tmp/pip-i1uw7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:14 INFO - Running setup.py (path:/tmp/pip-KSVQlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:14 INFO - Running setup.py (path:/tmp/pip-mzwfcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:14 INFO - Running setup.py (path:/tmp/pip-pULpqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:14 INFO - Running setup.py (path:/tmp/pip-jVSBMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:14 INFO - Running setup.py (path:/tmp/pip-D5KPiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:14 INFO - Running setup.py (path:/tmp/pip-ONt63N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:15 INFO - Running setup.py install for manifestparser 05:51:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Running setup.py install for mozcrash 05:51:15 INFO - Running setup.py install for mozdebug 05:51:15 INFO - Running setup.py install for mozdevice 05:51:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Running setup.py install for mozfile 05:51:15 INFO - Running setup.py install for mozhttpd 05:51:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Running setup.py install for mozinfo 05:51:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Running setup.py install for mozInstall 05:51:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:15 INFO - Running setup.py install for mozleak 05:51:15 INFO - Running setup.py install for mozlog 05:51:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Running setup.py install for moznetwork 05:51:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Running setup.py install for mozprocess 05:51:16 INFO - Running setup.py install for mozprofile 05:51:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Running setup.py install for mozrunner 05:51:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Running setup.py install for mozscreenshot 05:51:16 INFO - Running setup.py install for moztest 05:51:16 INFO - Running setup.py install for mozversion 05:51:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:16 INFO - Cleaning up... 05:51:16 INFO - Return code: 0 05:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:16 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:16 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:51:16 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:51:16 INFO - Using env: {'DISPLAY': ':0', 05:51:16 INFO - 'HOME': '/home/cltbld', 05:51:16 INFO - 'LANG': 'en_US.UTF-8', 05:51:16 INFO - 'LANGUAGE': 'en_US:en', 05:51:16 INFO - 'LOGNAME': 'cltbld', 05:51:16 INFO - 'MAIL': '/var/mail/cltbld', 05:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:16 INFO - 'MOZ_NO_REMOTE': '1', 05:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:16 INFO - 'NO_EM_RESTART': '1', 05:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:16 INFO - 'PWD': '/builds/slave/test', 05:51:16 INFO - 'SHELL': '/bin/bash', 05:51:16 INFO - 'SHLVL': '1', 05:51:16 INFO - 'TERM': 'linux', 05:51:16 INFO - 'TMOUT': '86400', 05:51:16 INFO - 'USER': 'cltbld', 05:51:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:16 INFO - '_': '/tools/buildbot/bin/python'} 05:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:17 INFO - Running setup.py (path:/tmp/pip-j52sNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:17 INFO - Running setup.py (path:/tmp/pip-lLFhbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:17 INFO - Running setup.py (path:/tmp/pip-Yh8_Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:17 INFO - Running setup.py (path:/tmp/pip-rKu2zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:17 INFO - Running setup.py (path:/tmp/pip-kRFqby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:17 INFO - Running setup.py (path:/tmp/pip-Uljztt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:17 INFO - Running setup.py (path:/tmp/pip-CSkrbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:17 INFO - Running setup.py (path:/tmp/pip-SuPJkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:17 INFO - Running setup.py (path:/tmp/pip-1VXpcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:17 INFO - Running setup.py (path:/tmp/pip-MJY9r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:17 INFO - Running setup.py (path:/tmp/pip-T0VOR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:17 INFO - Running setup.py (path:/tmp/pip-L0b71x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:17 INFO - Running setup.py (path:/tmp/pip-WyCHjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:17 INFO - Running setup.py (path:/tmp/pip-QRX29g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:18 INFO - Running setup.py (path:/tmp/pip-6pF9yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:18 INFO - Running setup.py (path:/tmp/pip-sVChcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:18 INFO - Running setup.py (path:/tmp/pip-gTayY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51: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:51: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:51: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:51: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:51: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:51: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:51:20 INFO - Downloading blessings-1.6.tar.gz 05:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:20 INFO - Installing collected packages: blessings 05:51:20 INFO - Running setup.py install for blessings 05:51:20 INFO - Successfully installed blessings 05:51:20 INFO - Cleaning up... 05:51:20 INFO - Return code: 0 05:51:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:20 INFO - Reading from file tmpfile_stdout 05:51:20 INFO - Current package versions: 05:51:20 INFO - argparse == 1.2.1 05:51:20 INFO - blessings == 1.6 05:51:20 INFO - blobuploader == 1.2.4 05:51:20 INFO - docopt == 0.6.1 05:51:20 INFO - functools32 == 3.2.3-2 05:51:20 INFO - jsonschema == 2.5.1 05:51:20 INFO - manifestparser == 1.1 05:51:20 INFO - mozInstall == 1.12 05:51:20 INFO - mozcrash == 0.17 05:51:20 INFO - mozdebug == 0.1 05:51:20 INFO - mozdevice == 0.48 05:51:20 INFO - mozfile == 1.2 05:51:20 INFO - mozhttpd == 0.7 05:51:20 INFO - mozinfo == 0.9 05:51:20 INFO - mozleak == 0.1 05:51:20 INFO - mozlog == 3.2 05:51:20 INFO - moznetwork == 0.27 05:51:20 INFO - mozprocess == 0.22 05:51:20 INFO - mozprofile == 0.28 05:51:20 INFO - mozrunner == 6.11 05:51:20 INFO - mozscreenshot == 0.1 05:51:20 INFO - mozsystemmonitor == 0.3 05:51:20 INFO - moztest == 0.7 05:51:20 INFO - mozversion == 1.4 05:51:20 INFO - psutil == 3.1.1 05:51:20 INFO - requests == 1.2.3 05:51:20 INFO - wsgiref == 0.1.2 05:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:20 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:51:20 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:51:20 INFO - Using env: {'DISPLAY': ':0', 05:51:20 INFO - 'HOME': '/home/cltbld', 05:51:20 INFO - 'LANG': 'en_US.UTF-8', 05:51:20 INFO - 'LANGUAGE': 'en_US:en', 05:51:20 INFO - 'LOGNAME': 'cltbld', 05:51:20 INFO - 'MAIL': '/var/mail/cltbld', 05:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:20 INFO - 'MOZ_NO_REMOTE': '1', 05:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:20 INFO - 'NO_EM_RESTART': '1', 05:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:20 INFO - 'PWD': '/builds/slave/test', 05:51:20 INFO - 'SHELL': '/bin/bash', 05:51:20 INFO - 'SHLVL': '1', 05:51:20 INFO - 'TERM': 'linux', 05:51:20 INFO - 'TMOUT': '86400', 05:51:20 INFO - 'USER': 'cltbld', 05:51:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:20 INFO - '_': '/tools/buildbot/bin/python'} 05:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 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:51:20 INFO - Cleaning up... 05:51:20 INFO - Return code: 0 05:51:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:20 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:51:20 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:51:20 INFO - Using env: {'DISPLAY': ':0', 05:51:20 INFO - 'HOME': '/home/cltbld', 05:51:20 INFO - 'LANG': 'en_US.UTF-8', 05:51:20 INFO - 'LANGUAGE': 'en_US:en', 05:51:20 INFO - 'LOGNAME': 'cltbld', 05:51:20 INFO - 'MAIL': '/var/mail/cltbld', 05:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:20 INFO - 'MOZ_NO_REMOTE': '1', 05:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:20 INFO - 'NO_EM_RESTART': '1', 05:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:20 INFO - 'PWD': '/builds/slave/test', 05:51:20 INFO - 'SHELL': '/bin/bash', 05:51:20 INFO - 'SHLVL': '1', 05:51:20 INFO - 'TERM': 'linux', 05:51:20 INFO - 'TMOUT': '86400', 05:51:20 INFO - 'USER': 'cltbld', 05:51:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:20 INFO - '_': '/tools/buildbot/bin/python'} 05:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:21 INFO - Cleaning up... 05:51:21 INFO - Return code: 0 05:51:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:51:21 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:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:21 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:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:21 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 0x7fd8954c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1353350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', '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:51:21 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:51:21 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:51:21 INFO - Using env: {'DISPLAY': ':0', 05:51:21 INFO - 'HOME': '/home/cltbld', 05:51:21 INFO - 'LANG': 'en_US.UTF-8', 05:51:21 INFO - 'LANGUAGE': 'en_US:en', 05:51:21 INFO - 'LOGNAME': 'cltbld', 05:51:21 INFO - 'MAIL': '/var/mail/cltbld', 05:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:21 INFO - 'MOZ_NO_REMOTE': '1', 05:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:21 INFO - 'NO_EM_RESTART': '1', 05:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:21 INFO - 'PWD': '/builds/slave/test', 05:51:21 INFO - 'SHELL': '/bin/bash', 05:51:21 INFO - 'SHLVL': '1', 05:51:21 INFO - 'TERM': 'linux', 05:51:21 INFO - 'TMOUT': '86400', 05:51:21 INFO - 'USER': 'cltbld', 05:51:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:21 INFO - '_': '/tools/buildbot/bin/python'} 05:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:21 INFO - Downloading/unpacking flake8 05:51: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:51: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:51: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:51: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:51: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:51: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:51:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:23 INFO - no previously-included directories found matching 'docs/_build' 05:51:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:23 INFO - Running setup.py install for pep8 05:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:24 INFO - no previously-included directories found matching 'docs/_build' 05:51:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:51:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:24 INFO - Cleaning up... 05:51:24 INFO - Return code: 0 05:51:24 INFO - Running post-action listener: _resource_record_post_action 05:51:24 INFO - Running post-action listener: _start_resource_monitoring 05:51:24 INFO - Starting resource monitoring. 05:51:24 INFO - ##### 05:51:24 INFO - ##### Finished create-virtualenv step (success) 05:51:24 INFO - ##### 05:51:24 INFO - ##### 05:51:24 INFO - ##### Running install step. 05:51:24 INFO - ##### 05:51:24 INFO - Running pre-action listener: _resource_record_pre_action 05:51:24 INFO - Running main action method: install 05:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:24 INFO - Reading from file tmpfile_stdout 05:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:24 INFO - Reading from file tmpfile_stdout 05:51:24 INFO - Output received: 05:51:24 INFO - Usage: mozinstall [options] installer 05:51:24 INFO - Options: 05:51:24 INFO - -h, --help show this help message and exit 05:51:24 INFO - -d DEST, --destination=DEST 05:51:24 INFO - Directory to install application into. [default: 05:51:24 INFO - "/builds/slave/test"] 05:51:24 INFO - --app=APP Application being installed. [default: firefox] 05:51:24 INFO - mkdir: /builds/slave/test/build/application 05:51:24 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:51:24 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:51:41 INFO - Reading from file tmpfile_stdout 05:51:41 INFO - Output received: 05:51:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:41 INFO - Running post-action listener: _resource_record_post_action 05:51:41 INFO - ##### 05:51:41 INFO - ##### Finished install step (success) 05:51:41 INFO - ##### 05:51:41 INFO - ##### 05:51:41 INFO - ##### Running run-tests step. 05:51:41 INFO - ##### 05:51:41 INFO - Running pre-action listener: _resource_record_pre_action 05:51:41 INFO - Running main action method: run_tests 05:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:41 INFO - Python 2.7.3 05:51:41 INFO - Return code: 0 05:51:41 INFO - grabbing minidump binary from tooltool 05:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:41 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 0x13e21c0>, '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 0x13e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:41 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:51:41 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:51:41 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:51:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:41 INFO - Return code: 0 05:51:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:51:42 INFO - Return code: 0 05:51:42 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/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:51:42 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/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:51:42 INFO - Using env: {'DISPLAY': ':0', 05:51:42 INFO - 'HOME': '/home/cltbld', 05:51:42 INFO - 'LANG': 'en_US.UTF-8', 05:51:42 INFO - 'LANGUAGE': 'en_US:en', 05:51:42 INFO - 'LOGNAME': 'cltbld', 05:51:42 INFO - 'MAIL': '/var/mail/cltbld', 05:51:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:42 INFO - 'MOZ_NO_REMOTE': '1', 05:51:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:42 INFO - 'NO_EM_RESTART': '1', 05:51:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:42 INFO - 'PWD': '/builds/slave/test', 05:51:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:42 INFO - 'SHELL': '/bin/bash', 05:51:42 INFO - 'SHLVL': '1', 05:51:42 INFO - 'TERM': 'linux', 05:51:42 INFO - 'TMOUT': '86400', 05:51:42 INFO - 'USER': 'cltbld', 05:51:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337', 05:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:42 INFO - '_': '/tools/buildbot/bin/python'} 05:51:42 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/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:51:42 INFO - mozversion application_buildid: 20160617030217 05:51:42 INFO - mozversion application_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 05:51:42 INFO - mozversion application_display_name: Nightly 05:51:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:42 INFO - mozversion application_name: Firefox 05:51:42 INFO - mozversion application_remotingname: firefox 05:51:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:42 INFO - mozversion application_vendor: Mozilla 05:51:42 INFO - mozversion application_version: 50.0a1 05:51:42 INFO - mozversion platform_buildid: 20160617030217 05:51:42 INFO - mozversion platform_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 05:51:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:42 INFO - mozversion platform_version: 50.0a1 05:51:42 INFO - using testdate: 1466167902 05:51:42 INFO - actual date: 1466167902 05:51:42 INFO - starting webserver on 'localhost:53549' 05:51:42 INFO - SUITE-START | Running 2 tests 05:51:42 INFO - TEST-START | dromaeo_css 05:51:42 INFO - operating with platform_type : linux_ 05:51:42 INFO - Initialising browser for dromaeo_css test... 05:51:42 INFO - TEST-INFO | started process 5231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mxrqL/profile http://localhost:53549/getInfo.html) 05:51:47 INFO - PROCESS | 5231 | __metrics Screen width/height:1600/1200 05:51:47 INFO - PROCESS | 5231 | colorDepth:24 05:51:47 INFO - PROCESS | 5231 | Browser inner width/height: 1024/697 05:51:47 INFO - PROCESS | 5231 | __metrics 05:51:48 ERROR - PROCESS | 5231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:51:48 INFO - TEST-INFO | 5231: exit 0 05:51:48 INFO - Browser initialized. 05:51:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:48 INFO - TEST-INFO | started process 5351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mxrqL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:00 INFO - PROCESS | 5351 | RSS: Main: 184537088 05:52:00 INFO - PROCESS | 5351 | 05:52:50 INFO - PROCESS | 5351 | 1466167970548 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:54:58 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53549/tests/dromaeo/cssquery-ext.html) 05:54:59 INFO - PROCESS | 5351 | RSS: Main: 188805120 05:54:59 INFO - PROCESS | 5351 | 05:58:01 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-ext.html (next: http://localhost:53549/tests/dromaeo/cssquery-jquery.html) 05:58:02 INFO - PROCESS | 5351 | RSS: Main: 187101184 05:58:02 INFO - PROCESS | 5351 | 06:01:03 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53549/tests/dromaeo/cssquery-mootools.html) 06:01:04 INFO - PROCESS | 5351 | RSS: Main: 188878848 06:01:04 INFO - PROCESS | 5351 | 06:04:06 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53549/tests/dromaeo/cssquery-prototype.html) 06:04:06 INFO - PROCESS | 5351 | RSS: Main: 186503168 06:04:06 INFO - PROCESS | 5351 | 06:07:09 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53549/tests/dromaeo/cssquery-yui.html) 06:07:09 INFO - PROCESS | 5351 | RSS: Main: 188272640 06:07:09 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:53549/tests/dromaeo/cssquery-yui.html (next: http://localhost:53549/tests/dromaeo/cssquery-dojo.html) 06:10:12 INFO - PROCESS | 5351 | RSS: Main: 189251584 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | __start_tp_report 06:10:12 INFO - PROCESS | 5351 | _x_x_mozilla_page_load 06:10:12 INFO - PROCESS | 5351 | _x_x_mozilla_page_load_details 06:10:12 INFO - PROCESS | 5351 | |i|pagename|runs| 06:10:12 INFO - PROCESS | 5351 | |0;dojo.html;3112.6420461646912;3146.197719581508;3167.366526694661;3167.4456970030237;3183.299674071705;5413.593980451467;5424.321959755031;5490.094134467813;5525.806596769114;5542.334919809628;5337.1994200869885;5353.919691204625;5395.0558652235895;5440.401555828856;5445.047116754572;4882.170031094723;4888.584470320027;4985.700857948516;5046.167382381903;5077.796888124471;629.2853293770956;4917.459079501252;5022.748862556858;5048.040872234264;5071.011152825201;4925.926111108336;4937.703737775727;4947.307376967227;4965;5008.749562521859;4869.026194761062;4989.176785830334;4996.90006199874;5003.5997120230295;5058.4435712071645;4941.777620007108;4972.229304457815;5014.122528557525;5044.495550444963;5047.87380315495;5529.668219906818;5536.169574563807;5585.3297604287745;5611.971940140274;5616.321000936382;5631.521320687746;5718.399568045378;5977.3723759005115;5977.5815692901515;6002.939970600281;5877.05967045275;5894.941050589525;5956.761729530857;6030.306514750816;6032.366601506867;5489;5529.30883639545;5537.556995440355;5553.972230138824;5565.499105080562;5860.531157507475;5955.553333500005;6062.757489700362;6064.181335519736;6078.422549857756;5720.170575266563;5783.826485205451;5800.4199580042505;5821.7089145543405;5839.503642190376;5893.764249429974;5903.3801450847905;5915.881682366415;5916.112583112567;5919.911201331984;5717.056685646905;5830.475257226785;5845.503132233723;5888.146218798336;5925.792597259076;5676.77292908279;5761.942380576141;5784.623999440023;5798.10129429939;5963.612365196248;4393.165298593257;4438.489573699066;4455.376247325377;4460.107978404332;4505.932411013838;3923.9993801580413;3973.463582416337;3980.104476492766;3980.3631418972827;4014.879553613396;5610.382857885711;5610.579206559442;5629.352624448159;5650;5663.292088488939;5872.17789509469;5953.226080609493;5953.255843019622;5957.463828255478;5979.79070732531;5478.753456094485;5575.275214222206;5602.467765562265;5638.097904335286;5662.8301150965535;5126.769295381642;5153.768080436389;5161.354830646169;5165.354330708661;5171.534561889448;6141.938580614136;6159.476444502178;6181.412765787243;6188.81433556994;6190.1952746142715;5702.800401985994;5781.248437703071;5803.303603567599;5835.503982161564;5927.436893495111;6043.12374705674;6048.909266361096;6051.909221361595;6060.333363329942;6076.3012253591405;5603.80386686464;5746.885062298814;5754.395788442321;5785.768569257182;5807.767689292381;5825.592208545361;5854.970725146517;5932.317783454958;6016.639001659914;6018.608790428608;5745.971270143623;5765.4522820332;5787.36339002701;5807.622504537191;5812.82561523155;5576.832695019156;5686.630369026;5741.425857414392;5741.598088133791;5766.077427611562;5518.613697041169;5567.721613919207;5571.331440227199;5571.582131340085;5731.3408957968695;5721.284839395075;5732.426757324234;5760.395158508464;5761.5102716269585;5771.8557036074435;5576.637518561442;5629.268195134607;5640.464155905182;5641.633293835887;5653.802116925888 06:10:12 INFO - PROCESS | 5351 | |1;ext.html;580.1500801326057;620.8013435700572;633.9841503962401;650.993490065099;652.929196118366;42143.578564214346;43562.128757424834;43736.343954840704;43821.34267985983;46953;45859.770701146444;46200.99999999991;46465.76767116168;46535;46812.53187468133;8818.559072046388;8884.422512536697;8944.373893827435;8971;8985.595648195847;8794.472331660088;8814.735557933273;8820.779480513007;8903.15420035099;8905.510196939165;8825.205731484166;8947.50788706621;8998.910010899872;8999.055099214555;9003.909960900406;8878.644854205824;8908;8925.375223734374;8931.553422328858;8933.821323573524;8912.910870891274;8947.507887066275;8983.056779038172;8988.730338089803;9015.594298256528;42148;42424.151516969796;42489.36265956013;42589.36115958263;42593.78703106465;3551.698105661022;3653.30587188436;3686.7787932724123;3686.8340924658455;3779.848806047755;33096;33215.335693286;33332.33335333304;33597.83201083979;33910.83044584761;3738.6635202831876;3745.906352341186;3816.542014958223;3896.5518965319066;3979.621935916083;364576;364918;365605;367171;367544.16227918956;34073.65926340705;57030.7148464255;57942.420575794546;57948.130778038365;57990;35061.47407788885;36577.63422365742;36695;36867.078323041605;36924.261514769554;14017.5093871714;14070.507532236323;14109.858901410855;14126.929365353313;14149.363278652485;11555.942220288845;11570;11654.067674586013;11659.475323610457;11683.766324673628;8227.218414250636;8251.95874020626;8257.917420825836;8341.24928756415;8353.248207661218;3217.436948533997;3238.2066393733685;3254.2677897473354;3292.7201187899295;3297.851596678155;1046.3512622174148;1073.0825144501339;1078.6548304542628;1118.4799068433056;1123.550579768083;32935.50596741051;33079.50380744291;33168.83415582955;33260.334793304;33315.662483464315;1111.5553778488509;1131.9547218111347;1135.982960255597;1160.257435241446;1184.709746112208;17048.914755426144;17291.06051971168;17319.134043297785;17432.91283543574;17577.296908123786;549211;549854;551838;552335;553853;58614.70692646509;59176.704116479144;59327.406725933055;59350;59673.70163149157;1380.3581334679423;1381.8687224713635;1382.1223523062927;1387.4034165309015;1394.6443656867434;30733.23166920845;32001.359972800878;32198;32437.351252974335;32568.51147232746;50908.23637645513;50914.490855090975;50960;50997;51018;451889;456154;457571;458662;458982;28231.15306540807;28282.2929426766;28870.278243044093;28877.278068047628;28887;48416.27375589439;48704.26943595778;48937.2659410102;49531;49864;41466.58533414627;42157.367639486045;42407;42694.78652606841;43114.353284700126;40306.79846600866;40350.1929961405;40642.79678601588;40801.591984080966;40808.3878741825;41178.38232426576;41610;41690.79154604208;41724.3741343874;44209;34483.655163449046;37099.443508346856;37619.62380376161;37862.43206351962;37880.62119378771;27891.860540697166;28037;28593.857030715546;28637.427251455272;28656.570151448163 06:10:12 INFO - PROCESS | 5351 | |2;jquery.html;381.99427008594876;386.92068126034155;392.76826672263365;392.85071672764343;415.13444468283626;14281.50014749484;17987.550311242227;19564;19658.606827863452;19729.704054439197;18141.092945352746;18316.450506484827;18614.06929653519;18619;18785;5657.32112146543;5680.488756011969;5787.160861675055;5849.561282903778;5851.034579294412;5718.656880587178;5732.111522713986;5758.7408566614395;5774.989376859054;5779.190913272145;5595.4124816894255;5664.716764161796;5724.54203663708;5751.827445176651;5798.362180160179;5529.529989950859;5728.828135155952;5763.855903602423;5766.077427611583;5772.595918285742;4986.650934434591;5096.3884333879805;5107.514786095315;5111.258867464197;5158.561522270612;21242.256521021845;22078.11687532497;22129.55740885173;22500.549989000127;22576.66135007976;2398.0887262840183;2456.5332586808627;2541.263033720219;2639.2741995951073;2748.3816141368234;14559.272036398137;14778.408863645442;14806.555803325917;14860.62848428787;14914.552563423114;1933.7389452423884;1979.1489659446431;1987.4037788663488;2002.399280215944;2022.2921977307824;81416.59291703562;82714;83243;83403.58298208531;84157.15842841554;10084.092431681183;10392.168626509861;10731;10800.891991080145;10939.28894621847;11466.77066458683;11941.64175074749;12011.699707507207;14590.781138282935;14651.948727178204;7099.3965512930945;7121.216666166718;7143.178534468602;7257.92742072583;7351.301626345488;6990.161180658353;7020.157581090302;7063.540869843444;7083.822904427328;7158.2841715829045;3897.3569361055106;4025.577314382006;4026.6577340925764;4034.092329225901;4080.8367665293054;1924.2399252295265;1944.377799104273;1953.841857496211;1954.853385996056;1973.6348775476583;860.7761981884755;957.3011701457974;1002.0730823987927;1013.3362647465922;1019.0115587879744;18298.63402731938;18678.813211867706;18803.435896923114;18927.62144757097;19210.80789192118;1006.1296978113879;1016.6797458800454;1031.293563908725;1043.9321444106108;1062.4050531702271;10063.19494440443;10608.681739547827;10628.25602207838;10648.414337211529;10671.35971841692;481375;488755;503821;506571;509705;87900;88030.55984720035;88208.11791882127;88246.55876720576;90041;1003.9397636141855;1011.0849681038671;1067.946602669879;1069.342354452022;1070.4326706845384;16429.260683269044;16621.50135495937;16721.163941803105;16732.58168545796;17161.056141912315;33388;38624.613753863225;38651.806740966116;39550.80224598858;41156.79421602873;54810.45189548053;55156;55232.72383638056;55594.72202638961;55597;8046.114927358103;8103.108658047728;8148.144444833444;8157.265846073882;8182.509049457051;8912.019677835304;12555.497780088694;13117.868821311664;13848.446062157804;14235.50175743844;11993.940030299793;12045.457954392248;12104.878951210376;12248;12314.261144331369;12090.45592948337;12257.509699611915;12314.384280786104;12419.379031048593;12764.106512544033;12091.15361924692;12410.75178496443;12509.437075331814;12510.687232819253;12545.372731363577;8440.66237350499;8671.523066231417;8866.601002954754;8867.866981995405;8926.73219803407;11459.255148415326;11745.706357341134;11862.288262704265;11928.582499612472;12358.62924112278 06:10:12 INFO - PROCESS | 5351 | |3;mootools.html;1473.719993201292;1487.4570781664693;1605.6387312854608;1748.8688348373876;1799.7030489969156;7738.651760670769;8315.667373305076;8388;8948.73153805387;8969.910300896989;8360.372972027108;8520.999999999984;8711.86932196016;8738.91261087389;8755;2260.446190683285;2307.792298693117;2314.5255222679393;2322.6167682332393;2332.5917964356254;2230.241717815942;2288.336382449096;2289.3589794857467;2290.209877592228;2299.41364951937;2288.645259984705;2292.5873342798373;2304;2318.9652155217686;2322.6051571232847;2164.145162660748;2166.3717521918625;2171.8262538996923;2173.8586991845477;2187.1907394264067;2198.5712786006734;2199.3511913985412;2222.588821068108;2226.320972103524;2229.1863469833556;8832.337574681924;8916.866247006235;8943.418677785989;8952.283817294601;8958.10418958099;5133.512316329943;5202.583793296527;5215.348081489814;5217.608679349064;5232.2674825524455;3144.2296637324002;3210.678932106794;3352.5641666583433;3401.4047541680357;3421.863125474978;1137.1585027079902;1147.5868687272575;1163.2090178678495;1172.2321879169158;1177.735009622828;12277.570285039981;12347.75304493905;12369.567065152767;12472.8129078063;12510.37448127599;4512.819487220474;4518.841840535565;4638.466576343763;4639.768011599406;4648.814047438064;10419.583216671399;10500.422476763699;10559.841602375971;10565.471726413649;10593.470326483644;5104.157813960729;5131.871703207375;5153.433122356538;5172.793088276502;5181.53366197044;4179.770112643834;4624.375709279204;4717.24524076153;4742.810287588527;4748.881277968078;3857.517810273716;3884.0872394987155;4003.7597744135446;4008.3386241269864;4044.838206471708;1237.6287113865803;1260.8423947006625;1264.3551788587702;1267.930263835498;1270.8220849081135;975.2295686407658;997.2221667099674;997.6807421625156;998.6354980432235;1015.8019186258756;6035.1249068885645;6098.359672234352;6230.937690623126;6247.843803904939;6343.587666801735;426.9402283680287;426.9786510674454;429.0453740427586;434.13390286378876;436.2997389190304;4218.325067989107;4246.745195288293;4265.872023839228;4275.273203555403;4299.269124248885;10656.733581660366;11009.559617615205;11078.335299882034;11102.333859968428;11128.944355278172;11007.834882476769;11026.173037022256;11030;11040.447977601088;11047.83428248577;7838.980932478741;8186.467879587808;8207.138250483853;8227.629756660845;8350.914381130535;6197.25632924052;6385.93614063872;6406.359364063556;6468.15913931186;6501.804945851632;10130.493475326057;10131.797364052825;10206;10259.384436933808;10278.691639250834;9994.350367226107;10316.896831031894;10318.690439286833;10450.47747612601;10451.484534742267;7796.532208067534;7833.804154896173;7957.323627491728;8112.067112281927;8145.470544414594;8888.911110888808;8900.465972041698;8913.777155571162;8919.241864441596;8971.775705607412;7450.776476705708;7509.3617042552;7514.361279291322;7540.698372065056;7786.299233069051;7535.510191837513;7594.126675432396;7604.163542010264;7610.695572177272;7735.651895664596;6788.355106264897;6896.7586134485055;6911.136107986502;6912.792616221522;6913.827154321182;5204.245384419314;5245.265662807286;5307.65500242483;5348.625596208228;5393.568514518751;5166.070107380558;5210.635255532076;5225.320708307896;5279.287296214962;5418.106012507892 06:10:12 INFO - PROCESS | 5351 | |4;prototype.html;312.1369413571474;324.040839116216;334.05129432411945;334.91627093226685;338.28115255082946;5461.672299662013;5477.397486276506;5633.661980281186;5635.859103522414;5679.687617181054;5559.749811258493;5594.580406469521;5604.467575580324;5617.831465056045;5666.914996275059;4359.604926423545;4359.869203923888;4373.562643735633;4409.4488188976375;4450.221211288028;4187.450643261997;4420.513743488214;4422.204003279408;4475.552444755531;4488.169688607618;4326.935095973563;4361.193179261831;4361.34579813029;4375.781210939456;4378.496472905609;4362.2550979608095;4403.779811009469;4404.603585677304;4412.205802955466;4433;3764.623537646241;3829.5596006459054;3873.786941718204;3877.747946383476;3880.0299925018744;5379;5433;5447.373552041487;5488.341399032141;5509.311336082989;4853.854384368475;4888.511148885119;4896.387951506062;4912.901741965176;4977.776000080005;5779.855503612402;5840.386759390288;5851.180834683105;5867.591777973298;5898;4143.316352801814;4144.295469770116;4149.854755083587;4166.937495937564;4177;6103.908441373383;6106.328303886569;6119.694015299262;6131.264248290189;6132.504472450705;4049.453323801308;4230.873073807791;4255.553166917491;4266.381374700651;4280.464941882265;4316.072044510445;4332.913341733148;4342.435483387139;4349.369341445473;4351.673624478177;4939.90120197594;4994.450610432849;5010.849674509771;5017.347744793154;5023.874403139877;5724.255846739898;5847.853803654858;5913.674747888821;5968.731407086691;5989.760409583568;1453.3532578002898;1485.4058376649427;1485.9182744949132;1489.6201468625432;1497.468398718461;915.8414605524017;947.625687853294;947.8909925358535;951.167728237792;962.932594718377;5022.522860328263;5041.269015992734;5053.898922021539;5143.174173168546;5152.522047617843;5350.545203657733;5353.9732301338245;5368.758405871745;5376.623636345496;5384.6000039989885;5055.949440505621;5092.3335198656905;5112.974435127875;5320.361556613231;5781.479666830005;3234.2237862913203;3237.4981877808978;3241.124896277992;3264.2862497189167;3272.640009598942;6128.969355153285;6236.282827474808;6266.091416744546;6282.371762823773;6304.9912014078445;6154.446099851035;6167;6221.595596286227;6241.251049874044;6250.249970003629;6210.627362358273;6221.3156552779155;6267.874642507124;6285.622862628257;6346;5834.854128646818;6039.275286965592;6052.636841789506;6096.603720758137;6098.786542470993;5921.348651648402;5957.493613042767;5994.6403215807195;6013.218281623361;6047.485963693135;5622.522085622604;6169.876602468015;6198.256209254918;6211.689415529115;6261.655608941552;4174.373843923436;4185.497740271066;4214.8198504418815;4218.177455396169;4235.703500755041;6072.119542666377;6081.057436097412;6089.147519347206;6128;6154.846128846635;5695.658260504383;5797.826065218051;5835.432409739701;5844.6785426801935;5923.703814809329;5792.275965504312;5799.478046975623;5829.15477255804;5857.941420585739;5862.179294898632;5576.665400076008;5730.598858079894;5737.311522617312;5781.860711536759;5808.854778630399;5749.367569567261;5847.356790752929;5902.2327097477055;5912.87655345483;5999.160117583455;5751.8562035949435;5756.366799651951;5784.871949969884;5810.54736315921;5865.853353666193 06:10:12 INFO - PROCESS | 5351 | |5;yui.html;735.0811485642946;751.7105914223023;763.1529002806883;780.0210735526913;790.3282210121394;14587.708245835078;15794;15863.365465381385;15892.52322430326;15930.283137258808;14460.783088253685;14480.927595362034;14483;14630.122192668447;14652.633684157874;654.9410553050225;774.8721460958935;790.8971833661616;803.5178892664413;803.6303300481785;770.8419773946327;777.5956502618635;781.9100803407624;782.0224719101124;786.8622990976585;848.7962888906679;852.3138873207066;852.7143406958676;853.1937319233327;854.4915775113798;842.4860834890711;844.5903736687701;844.6959094725925;845.0282175498165;845.6828689241535;613.2457077794294;616.257409821169;618.3414663383527;618.3538202578317;621.201755743867;15371.308291126927;15557.533274001798;15563.766543501742;15585.298661560257;15602.453914112952;15593.844061559352;15597.220138993005;15620.843791562053;15636.921815390964;15859.60350991223;12257.448414821265;12340.074494412955;12340.13619046667;12370.75258494834;12848.614541563767;3882.9611703882883;3907.687385009221;4010.2981978154;4051.7974101295113;4135.813888375031;82897;82909;83173.58413207895;83565.99999999939;83833;11670.241434306912;12022.398880055962;12160.331181785086;12288.570281641993;12321.630351089481;23148.65277020846;23218.419539511648;23417.180398685963;23448;23449.531009379716;8317.667293308321;8441.831163376699;8494.15058494158;8500.659973600987;8620.094890036582;4810.39870016248;4832.251001094836;4838.395200599925;4898.2652602109965;5024;3449;3571.3035957988463;3578.5884623268657;3578.6421357864006;3587.8026708531283;574.9885002299931;581.7382178019908;612.063542779548;643.231338550437;644.7098805537527;614.3948211012149;658.9095047696071;698.3698081718176;719.924407937159;739.3530660671912;9594.376365536218;9724.95137524308;9788.55951482185;9888.703338899844;10090.394576325443;696.2202333386639;718.2601920022386;726.7565365602583;729.6315360742897;732.7948174511146;4260.744355338689;4370.956290437055;4554;4689.132510485571;4842.709437433765;70397.64801176064;70674;92586;121545;122259.38870305591;61796.38203617996;70930.64534677293;99996.5003324683;105519.47240263749;107615.46192268988;79778.20221797824;92536.07463925409;94428.97353724873;96335;99844;9582.952085239529;9798.657047003606;9805.705828825146;9839.458829764431;9907.653232136841;50144.74927625339;50536.24195637142;51346.48653513417;51877;53110;67010;71001;71741;71932.28067719255;75028;13018.2839943804;13018.869811301765;13070.54253101137;13314.600561983156;13530.93234533821;14182.645433864236;14279.64300892486;14529.636759081108;15110.320035598204;15206.847931520986;13131.212127272012;13136.211827290394;13300.135491193041;13331.33343332849;13517.391717372546;13832;13853.584392468241;14036.649083772987;14141.151530908179;14528.782068269196;12614;13175.736485270432;13475.73048539004;13674.316284185552;13717.039807213798;10713.625023124154;10928.781424371628;11234.494447749707;11495.137864660017;11939.701507462383;10309.278350515691;10603.151747860307;10679;10716.732081697708;10748.301360411548 06:10:12 INFO - PROCESS | 5351 | __end_tp_report 06:10:12 INFO - PROCESS | 5351 | __start_cc_report 06:10:12 INFO - PROCESS | 5351 | _x_x_mozilla_cycle_collect,372 06:10:12 INFO - PROCESS | 5351 | __end_cc_report 06:10:12 INFO - PROCESS | 5351 | __startTimestamp1466169012833__endTimestamp 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | ------- Summary: start ------- 06:10:12 INFO - PROCESS | 5351 | Number of tests: 6 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#0] dojo.html Cycles:165 Average:5432.61 Median:5650.00 stddev:733.00 (13.0%) stddev-sans-first:712.30 06:10:12 INFO - PROCESS | 5351 | Values: 3112.6 3146.2 3167.4 3167.4 3183.3 5413.6 5424.3 5490.1 5525.8 5542.3 5337.2 5353.9 5395.1 5440.4 5445.0 4882.2 4888.6 4985.7 5046.2 5077.8 629.3 4917.5 5022.7 5048.0 5071.0 4925.9 4937.7 4947.3 4965.0 5008.7 4869.0 4989.2 4996.9 5003.6 5058.4 4941.8 4972.2 5014.1 5044.5 5047.9 5529.7 5536.2 5585.3 5612.0 5616.3 5631.5 5718.4 5977.4 5977.6 6002.9 5877.1 5894.9 5956.8 6030.3 6032.4 5489.0 5529.3 5537.6 5554.0 5565.5 5860.5 5955.6 6062.8 6064.2 6078.4 5720.2 5783.8 5800.4 5821.7 5839.5 5893.8 5903.4 5915.9 5916.1 5919.9 5717.1 5830.5 5845.5 5888.1 5925.8 5676.8 5761.9 5784.6 5798.1 5963.6 4393.2 4438.5 4455.4 4460.1 4505.9 3924.0 3973.5 3980.1 3980.4 4014.9 5610.4 5610.6 5629.4 5650.0 5663.3 5872.2 5953.2 5953.3 5957.5 5979.8 5478.8 5575.3 5602.5 5638.1 5662.8 5126.8 5153.8 5161.4 5165.4 5171.5 6141.9 6159.5 6181.4 6188.8 6190.2 5702.8 5781.2 5803.3 5835.5 5927.4 6043.1 6048.9 6051.9 6060.3 6076.3 5603.8 5746.9 5754.4 5785.8 5807.8 5825.6 5855.0 5932.3 6016.6 6018.6 5746.0 5765.5 5787.4 5807.6 5812.8 5576.8 5686.6 5741.4 5741.6 5766.1 5518.6 5567.7 5571.3 5571.6 5731.3 5721.3 5732.4 5760.4 5761.5 5771.9 5576.6 5629.3 5640.5 5641.6 5653.8 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#1] ext.html Cycles:180 Average:60670.73 Median:40993.39 stddev:123411.47 (301.1%) stddev-sans-first:123675.20 06:10:12 INFO - PROCESS | 5351 | Values: 580.2 620.8 634.0 651.0 652.9 42143.6 43562.1 43736.3 43821.3 46953.0 45859.8 46201.0 46465.8 46535.0 46812.5 8818.6 8884.4 8944.4 8971.0 8985.6 8794.5 8814.7 8820.8 8903.2 8905.5 8825.2 8947.5 8998.9 8999.1 9003.9 8878.6 8908.0 8925.4 8931.6 8933.8 8912.9 8947.5 8983.1 8988.7 9015.6 42148.0 42424.2 42489.4 42589.4 42593.8 3551.7 3653.3 3686.8 3686.8 3779.8 33096.0 33215.3 33332.3 33597.8 33910.8 3738.7 3745.9 3816.5 3896.6 3979.6 364576.0 364918.0 365605.0 367171.0 367544.2 34073.7 57030.7 57942.4 57948.1 57990.0 35061.5 36577.6 36695.0 36867.1 36924.3 14017.5 14070.5 14109.9 14126.9 14149.4 11555.9 11570.0 11654.1 11659.5 11683.8 8227.2 8252.0 8257.9 8341.2 8353.2 3217.4 3238.2 3254.3 3292.7 3297.9 1046.4 1073.1 1078.7 1118.5 1123.6 32935.5 33079.5 33168.8 33260.3 33315.7 1111.6 1132.0 1136.0 1160.3 1184.7 17048.9 17291.1 17319.1 17432.9 17577.3 549211.0 549854.0 551838.0 552335.0 553853.0 58614.7 59176.7 59327.4 59350.0 59673.7 1380.4 1381.9 1382.1 1387.4 1394.6 30733.2 32001.4 32198.0 32437.4 32568.5 50908.2 50914.5 50960.0 50997.0 51018.0 451889.0 456154.0 457571.0 458662.0 458982.0 28231.2 28282.3 28870.3 28877.3 28887.0 48416.3 48704.3 48937.3 49531.0 49864.0 41466.6 42157.4 42407.0 42694.8 43114.4 40306.8 40350.2 40642.8 40801.6 40808.4 41178.4 41610.0 41690.8 41724.4 44209.0 34483.7 37099.4 37619.6 37862.4 37880.6 27891.9 28037.0 28593.9 28637.4 28656.6 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#2] jquery.html Cycles:180 Average:28908.48 Median:22538.61 stddev:82036.66 (364.0%) stddev-sans-first:82238.83 06:10:12 INFO - PROCESS | 5351 | Values: 382.0 386.9 392.8 392.9 415.1 14281.5 17987.6 19564.0 19658.6 19729.7 18141.1 18316.5 18614.1 18619.0 18785.0 5657.3 5680.5 5787.2 5849.6 5851.0 5718.7 5732.1 5758.7 5775.0 5779.2 5595.4 5664.7 5724.5 5751.8 5798.4 5529.5 5728.8 5763.9 5766.1 5772.6 4986.7 5096.4 5107.5 5111.3 5158.6 21242.3 22078.1 22129.6 22500.5 22576.7 2398.1 2456.5 2541.3 2639.3 2748.4 14559.3 14778.4 14806.6 14860.6 14914.6 1933.7 1979.1 1987.4 2002.4 2022.3 81416.6 82714.0 83243.0 83403.6 84157.2 10084.1 10392.2 10731.0 10800.9 10939.3 11466.8 11941.6 12011.7 14590.8 14651.9 7099.4 7121.2 7143.2 7257.9 7351.3 6990.2 7020.2 7063.5 7083.8 7158.3 3897.4 4025.6 4026.7 4034.1 4080.8 1924.2 1944.4 1953.8 1954.9 1973.6 860.8 957.3 1002.1 1013.3 1019.0 18298.6 18678.8 18803.4 18927.6 19210.8 1006.1 1016.7 1031.3 1043.9 1062.4 10063.2 10608.7 10628.3 10648.4 10671.4 481375.0 488755.0 503821.0 506571.0 509705.0 87900.0 88030.6 88208.1 88246.6 90041.0 1003.9 1011.1 1067.9 1069.3 1070.4 16429.3 16621.5 16721.2 16732.6 17161.1 33388.0 38624.6 38651.8 39550.8 41156.8 54810.5 55156.0 55232.7 55594.7 55597.0 8046.1 8103.1 8148.1 8157.3 8182.5 8912.0 12555.5 13117.9 13848.4 14235.5 11993.9 12045.5 12104.9 12248.0 12314.3 12090.5 12257.5 12314.4 12419.4 12764.1 12091.2 12410.8 12509.4 12510.7 12545.4 8440.7 8671.5 8866.6 8867.9 8926.7 11459.3 11745.7 11862.3 11928.6 12358.6 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#3] mootools.html Cycles:180 Average:5820.61 Median:2474.56 stddev:3358.34 (135.7%) stddev-sans-first:3351.87 06:10:12 INFO - PROCESS | 5351 | Values: 1473.7 1487.5 1605.6 1748.9 1799.7 7738.7 8315.7 8388.0 8948.7 8969.9 8360.4 8521.0 8711.9 8738.9 8755.0 2260.4 2307.8 2314.5 2322.6 2332.6 2230.2 2288.3 2289.4 2290.2 2299.4 2288.6 2292.6 2304.0 2319.0 2322.6 2164.1 2166.4 2171.8 2173.9 2187.2 2198.6 2199.4 2222.6 2226.3 2229.2 8832.3 8916.9 8943.4 8952.3 8958.1 5133.5 5202.6 5215.3 5217.6 5232.3 3144.2 3210.7 3352.6 3401.4 3421.9 1137.2 1147.6 1163.2 1172.2 1177.7 12277.6 12347.8 12369.6 12472.8 12510.4 4512.8 4518.8 4638.5 4639.8 4648.8 10419.6 10500.4 10559.8 10565.5 10593.5 5104.2 5131.9 5153.4 5172.8 5181.5 4179.8 4624.4 4717.2 4742.8 4748.9 3857.5 3884.1 4003.8 4008.3 4044.8 1237.6 1260.8 1264.4 1267.9 1270.8 975.2 997.2 997.7 998.6 1015.8 6035.1 6098.4 6230.9 6247.8 6343.6 426.9 427.0 429.0 434.1 436.3 4218.3 4246.7 4265.9 4275.3 4299.3 10656.7 11009.6 11078.3 11102.3 11128.9 11007.8 11026.2 11030.0 11040.4 11047.8 7839.0 8186.5 8207.1 8227.6 8350.9 6197.3 6385.9 6406.4 6468.2 6501.8 10130.5 10131.8 10206.0 10259.4 10278.7 9994.4 10316.9 10318.7 10450.5 10451.5 7796.5 7833.8 7957.3 8112.1 8145.5 8888.9 8900.5 8913.8 8919.2 8971.8 7450.8 7509.4 7514.4 7540.7 7786.3 7535.5 7594.1 7604.2 7610.7 7735.7 6788.4 6896.8 6911.1 6912.8 6913.8 5204.2 5245.3 5307.7 5348.6 5393.6 5166.1 5210.6 5225.3 5279.3 5418.1 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#4] prototype.html Cycles:180 Average:4900.46 Median:5534.53 stddev:1447.64 (26.2%) stddev-sans-first:1410.15 06:10:12 INFO - PROCESS | 5351 | Values: 312.1 324.0 334.1 334.9 338.3 5461.7 5477.4 5633.7 5635.9 5679.7 5559.7 5594.6 5604.5 5617.8 5666.9 4359.6 4359.9 4373.6 4409.4 4450.2 4187.5 4420.5 4422.2 4475.6 4488.2 4326.9 4361.2 4361.3 4375.8 4378.5 4362.3 4403.8 4404.6 4412.2 4433.0 3764.6 3829.6 3873.8 3877.7 3880.0 5379.0 5433.0 5447.4 5488.3 5509.3 4853.9 4888.5 4896.4 4912.9 4977.8 5779.9 5840.4 5851.2 5867.6 5898.0 4143.3 4144.3 4149.9 4166.9 4177.0 6103.9 6106.3 6119.7 6131.3 6132.5 4049.5 4230.9 4255.6 4266.4 4280.5 4316.1 4332.9 4342.4 4349.4 4351.7 4939.9 4994.5 5010.8 5017.3 5023.9 5724.3 5847.9 5913.7 5968.7 5989.8 1453.4 1485.4 1485.9 1489.6 1497.5 915.8 947.6 947.9 951.2 962.9 5022.5 5041.3 5053.9 5143.2 5152.5 5350.5 5354.0 5368.8 5376.6 5384.6 5055.9 5092.3 5113.0 5320.4 5781.5 3234.2 3237.5 3241.1 3264.3 3272.6 6129.0 6236.3 6266.1 6282.4 6305.0 6154.4 6167.0 6221.6 6241.3 6250.2 6210.6 6221.3 6267.9 6285.6 6346.0 5834.9 6039.3 6052.6 6096.6 6098.8 5921.3 5957.5 5994.6 6013.2 6047.5 5622.5 6169.9 6198.3 6211.7 6261.7 4174.4 4185.5 4214.8 4218.2 4235.7 6072.1 6081.1 6089.1 6128.0 6154.8 5695.7 5797.8 5835.4 5844.7 5923.7 5792.3 5799.5 5829.2 5857.9 5862.2 5576.7 5730.6 5737.3 5781.9 5808.9 5749.4 5847.4 5902.2 5912.9 5999.2 5751.9 5756.4 5784.9 5810.5 5865.9 06:10:12 INFO - PROCESS | 5351 | 06:10:12 INFO - PROCESS | 5351 | [#5] yui.html Cycles:180 Average:20405.50 Median:4835.32 stddev:28742.94 (594.4%) stddev-sans-first:28785.62 06:10:12 INFO - PROCESS | 5351 | Values: 735.1 751.7 763.2 780.0 790.3 14587.7 15794.0 15863.4 15892.5 15930.3 14460.8 14480.9 14483.0 14630.1 14652.6 654.9 774.9 790.9 803.5 803.6 770.8 777.6 781.9 782.0 786.9 848.8 852.3 852.7 853.2 854.5 842.5 844.6 844.7 845.0 845.7 613.2 616.3 618.3 618.4 621.2 15371.3 15557.5 15563.8 15585.3 15602.5 15593.8 15597.2 15620.8 15636.9 15859.6 12257.4 12340.1 12340.1 12370.8 12848.6 3883.0 3907.7 4010.3 4051.8 4135.8 82897.0 82909.0 83173.6 83566.0 83833.0 11670.2 12022.4 12160.3 12288.6 12321.6 23148.7 23218.4 23417.2 23448.0 23449.5 8317.7 8441.8 8494.2 8500.7 8620.1 4810.4 4832.3 4838.4 4898.3 5024.0 3449.0 3571.3 3578.6 3578.6 3587.8 575.0 581.7 612.1 643.2 644.7 614.4 658.9 698.4 719.9 739.4 9594.4 9725.0 9788.6 9888.7 10090.4 696.2 718.3 726.8 729.6 732.8 4260.7 4371.0 4554.0 4689.1 4842.7 70397.6 70674.0 92586.0 121545.0 122259.4 61796.4 70930.6 99996.5 105519.5 107615.5 79778.2 92536.1 94429.0 96335.0 99844.0 9583.0 9798.7 9805.7 9839.5 9907.7 50144.7 50536.2 51346.5 51877.0 53110.0 67010.0 71001.0 71741.0 71932.3 75028.0 13018.3 13018.9 13070.5 13314.6 13530.9 14182.6 14279.6 14529.6 15110.3 15206.8 13131.2 13136.2 13300.1 13331.3 13517.4 13832.0 13853.6 14036.6 14141.2 14528.8 12614.0 13175.7 13475.7 13674.3 13717.0 10713.6 10928.8 11234.5 11495.1 11939.7 10309.3 10603.2 10679.0 10716.7 10748.3 06:10:12 INFO - PROCESS | 5351 | -------- Summary: end -------- 06:10:12 INFO - PROCESS | 5351 | 06:10:13 INFO - TEST-INFO | 5351: exit 0 06:10:13 INFO - TEST-OK | dromaeo_css | took 1110795ms 06:10:13 INFO - TEST-START | kraken 06:10:13 INFO - operating with platform_type : linux_ 06:10:13 INFO - Initialising browser for kraken test... 06:10:13 INFO - TEST-INFO | started process 5582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjypP03/profile http://localhost:53549/getInfo.html) 06:10:18 INFO - PROCESS | 5582 | __metrics Screen width/height:1600/1200 06:10:18 INFO - PROCESS | 5582 | colorDepth:24 06:10:18 INFO - PROCESS | 5582 | Browser inner width/height: 1024/697 06:10:18 INFO - PROCESS | 5582 | __metrics 06:10:18 ERROR - PROCESS | 5582 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:10:19 INFO - TEST-INFO | 5582: exit 0 06:10:19 INFO - Browser initialized. 06:10:19 INFO - Running cycle 1/1 for kraken test... 06:10:19 INFO - TEST-INFO | started process 5702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjypP03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:31 INFO - PROCESS | 5702 | RSS: Main: 184725504 06:10:31 INFO - PROCESS | 5702 | 06:10:33 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53549/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:34 INFO - PROCESS | 5702 | RSS: Main: 190767104 06:10:34 INFO - PROCESS | 5702 | 06:10:37 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53549/tests/kraken/driver.html?testName=audio-dft) 06:10:38 INFO - PROCESS | 5702 | RSS: Main: 190001152 06:10:38 INFO - PROCESS | 5702 | 06:10:41 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53549/tests/kraken/driver.html?testName=audio-fft) 06:10:41 INFO - PROCESS | 5702 | RSS: Main: 184721408 06:10:41 INFO - PROCESS | 5702 | 06:10:44 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53549/tests/kraken/driver.html?testName=audio-oscillator) 06:10:44 INFO - PROCESS | 5702 | RSS: Main: 186019840 06:10:44 INFO - PROCESS | 5702 | 06:10:46 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:47 INFO - PROCESS | 5702 | RSS: Main: 186753024 06:10:47 INFO - PROCESS | 5702 | 06:10:50 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53549/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:51 INFO - PROCESS | 5702 | RSS: Main: 186683392 06:10:51 INFO - PROCESS | 5702 | 06:10:54 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53549/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:55 INFO - PROCESS | 5702 | RSS: Main: 184041472 06:10:55 INFO - PROCESS | 5702 | 06:10:58 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53549/tests/kraken/driver.html?testName=json-parse-financial) 06:10:58 INFO - PROCESS | 5702 | RSS: Main: 185253888 06:10:58 INFO - PROCESS | 5702 | 06:11:00 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:00 INFO - PROCESS | 5702 | RSS: Main: 185581568 06:11:00 INFO - PROCESS | 5702 | 06:11:02 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:03 INFO - PROCESS | 5702 | RSS: Main: 186118144 06:11:03 INFO - PROCESS | 5702 | 06:11:05 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:06 INFO - PROCESS | 5702 | RSS: Main: 186470400 06:11:06 INFO - PROCESS | 5702 | 06:11:08 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:09 INFO - PROCESS | 5702 | RSS: Main: 186499072 06:11:09 INFO - PROCESS | 5702 | 06:11:12 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:12 INFO - PROCESS | 5702 | RSS: Main: 186101760 06:11:12 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | Cycle 1(1): loaded http://localhost:53549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53549/tests/kraken/driver.html?testName=ai-astar) 06:11:14 INFO - PROCESS | 5702 | RSS: Main: 187289600 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | __start_tp_report 06:11:14 INFO - PROCESS | 5702 | _x_x_mozilla_page_load 06:11:14 INFO - PROCESS | 5702 | _x_x_mozilla_page_load_details 06:11:14 INFO - PROCESS | 5702 | |i|pagename|runs| 06:11:14 INFO - PROCESS | 5702 | |0;ai-astar;112;105;110;111;111;112;110;111;110;109 06:11:14 INFO - PROCESS | 5702 | |1;audio-beat-detection;156;125;156;187;130;164;148;131;190;128 06:11:14 INFO - PROCESS | 5702 | |2;audio-dft;162;162;161;161;167;167;161;163;160;165 06:11:14 INFO - PROCESS | 5702 | |3;audio-fft;75;75;74;155;76;74;76;74;159;76 06:11:14 INFO - PROCESS | 5702 | |4;audio-oscillator;84;84;157;85;86;84;144;84;85;146 06:11:14 INFO - PROCESS | 5702 | |5;imaging-gaussian-blur;118;117;117;117;118;119;117;117;118;118 06:11:14 INFO - PROCESS | 5702 | |6;imaging-darkroom;147;147;147;148;148;148;147;147;149;151 06:11:14 INFO - PROCESS | 5702 | |7;imaging-desaturate;96;95;96;96;100;96;95;96;96;95 06:11:14 INFO - PROCESS | 5702 | |8;json-parse-financial;53;56;55;53;53;56;52;54;53;52 06:11:14 INFO - PROCESS | 5702 | |9;json-stringify-tinderbox;63;62;61;64;61;61;63;62;62;63 06:11:14 INFO - PROCESS | 5702 | |10;stanford-crypto-aes;83;80;80;81;83;82;81;81;108;88 06:11:14 INFO - PROCESS | 5702 | |11;stanford-crypto-ccm;140;124;124;124;135;134;132;157;131;137 06:11:14 INFO - PROCESS | 5702 | |12;stanford-crypto-pbkdf2;165;165;168;163;162;165;166;163;164;160 06:11:14 INFO - PROCESS | 5702 | |13;stanford-crypto-sha256-iterative;63;65;67;65;62;65;64;67;68;62 06:11:14 INFO - PROCESS | 5702 | __end_tp_report 06:11:14 INFO - PROCESS | 5702 | __start_cc_report 06:11:14 INFO - PROCESS | 5702 | _x_x_mozilla_cycle_collect,924 06:11:14 INFO - PROCESS | 5702 | __end_cc_report 06:11:14 INFO - PROCESS | 5702 | __startTimestamp1466169074692__endTimestamp 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | ------- Summary: start ------- 06:11:14 INFO - PROCESS | 5702 | Number of tests: 14 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.02 (1.8%) stddev-sans-first:2.03 06:11:14 INFO - PROCESS | 5702 | Values: 112.0 105.0 110.0 111.0 111.0 112.0 110.0 111.0 110.0 109.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.00 stddev:23.78 (15.2%) stddev-sans-first:25.16 06:11:14 INFO - PROCESS | 5702 | Values: 156.0 125.0 156.0 187.0 130.0 164.0 148.0 131.0 190.0 128.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.56 (1.6%) stddev-sans-first:2.69 06:11:14 INFO - PROCESS | 5702 | Values: 162.0 162.0 161.0 161.0 167.0 167.0 161.0 163.0 160.0 165.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:34.60 (46.1%) stddev-sans-first:36.18 06:11:14 INFO - PROCESS | 5702 | Values: 75.0 75.0 74.0 155.0 76.0 74.0 76.0 74.0 159.0 76.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.00 stddev:31.30 (37.3%) stddev-sans-first:32.36 06:11:14 INFO - PROCESS | 5702 | Values: 84.0 84.0 157.0 85.0 86.0 84.0 144.0 84.0 85.0 146.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:11:14 INFO - PROCESS | 5702 | Values: 118.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 118.0 118.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 06:11:14 INFO - PROCESS | 5702 | Values: 147.0 147.0 147.0 148.0 148.0 148.0 147.0 147.0 149.0 151.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.45 (1.5%) stddev-sans-first:1.54 06:11:14 INFO - PROCESS | 5702 | Values: 96.0 95.0 96.0 96.0 100.0 96.0 95.0 96.0 96.0 95.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.49 (2.8%) stddev-sans-first:1.56 06:11:14 INFO - PROCESS | 5702 | Values: 53.0 56.0 55.0 53.0 53.0 56.0 52.0 54.0 53.0 52.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 06:11:14 INFO - PROCESS | 5702 | Values: 63.0 62.0 61.0 64.0 61.0 61.0 63.0 62.0 62.0 63.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.50 stddev:8.51 (10.4%) stddev-sans-first:9.01 06:11:14 INFO - PROCESS | 5702 | Values: 83.0 80.0 80.0 81.0 83.0 82.0 81.0 81.0 108.0 88.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:134.50 stddev:9.93 (7.4%) stddev-sans-first:10.28 06:11:14 INFO - PROCESS | 5702 | Values: 140.0 124.0 124.0 124.0 135.0 134.0 132.0 157.0 131.0 137.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:165.00 stddev:2.23 (1.4%) stddev-sans-first:2.35 06:11:14 INFO - PROCESS | 5702 | Values: 165.0 165.0 168.0 163.0 162.0 165.0 166.0 163.0 164.0 160.0 06:11:14 INFO - PROCESS | 5702 | 06:11:14 INFO - PROCESS | 5702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:2.10 (3.2%) stddev-sans-first:2.12 06:11:14 INFO - PROCESS | 5702 | Values: 63.0 65.0 67.0 65.0 62.0 65.0 64.0 67.0 68.0 62.0 06:11:14 INFO - PROCESS | 5702 | -------- Summary: end -------- 06:11:14 INFO - PROCESS | 5702 | 06:11:15 INFO - TEST-INFO | 5702: exit 0 06:11:15 INFO - TEST-OK | kraken | took 62123ms 06:11:15 INFO - SUITE-END | took 1172s 06:11:15 INFO - Completed test suite (00:19:33) 06:11:15 INFO - javascript benchmark 06:11:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7228.385747390635, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.6420461646912, 3146.197719581508, 3167.366526694661, 3167.4456970030237, 3183.299674071705, 5413.593980451467, 5424.321959755031, 5490.094134467813, 5525.806596769114, 5542.334919809628, 5337.1994200869885, 5353.919691204625, 5395.0558652235895, 5440.401555828856, 5445.047116754572, 4882.170031094723, 4888.584470320027, 4985.700857948516, 5046.167382381903, 5077.796888124471, 629.2853293770956, 4917.459079501252, 5022.748862556858, 5048.040872234264, 5071.011152825201, 4925.926111108336, 4937.703737775727, 4947.307376967227, 4965.0, 5008.749562521859, 4869.026194761062, 4989.176785830334, 4996.90006199874, 5003.5997120230295, 5058.4435712071645, 4941.777620007108, 4972.229304457815, 5014.122528557525, 5044.495550444963, 5047.87380315495, 5529.668219906818, 5536.169574563807, 5585.3297604287745, 5611.971940140274, 5616.321000936382, 5631.521320687746, 5718.399568045378, 5977.3723759005115, 5977.5815692901515, 6002.939970600281, 5877.05967045275, 5894.941050589525, 5956.761729530857, 6030.306514750816, 6032.366601506867, 5489.0, 5529.30883639545, 5537.556995440355, 5553.972230138824, 5565.499105080562, 5860.531157507475, 5955.553333500005, 6062.757489700362, 6064.181335519736, 6078.422549857756, 5720.170575266563, 5783.826485205451, 5800.4199580042505, 5821.7089145543405, 5839.503642190376, 5893.764249429974, 5903.3801450847905, 5915.881682366415, 5916.112583112567, 5919.911201331984, 5717.056685646905, 5830.475257226785, 5845.503132233723, 5888.146218798336, 5925.792597259076, 5676.77292908279, 5761.942380576141, 5784.623999440023, 5798.10129429939, 5963.612365196248, 4393.165298593257, 4438.489573699066, 4455.376247325377, 4460.107978404332, 4505.932411013838, 3923.9993801580413, 3973.463582416337, 3980.104476492766, 3980.3631418972827, 4014.879553613396, 5610.382857885711, 5610.579206559442, 5629.352624448159, 5650.0, 5663.292088488939, 5872.17789509469, 5953.226080609493, 5953.255843019622, 5957.463828255478, 5979.79070732531, 5478.753456094485, 5575.275214222206, 5602.467765562265, 5638.097904335286, 5662.8301150965535, 5126.769295381642, 5153.768080436389, 5161.354830646169, 5165.354330708661, 5171.534561889448, 6141.938580614136, 6159.476444502178, 6181.412765787243, 6188.81433556994, 6190.1952746142715, 5702.800401985994, 5781.248437703071, 5803.303603567599, 5835.503982161564, 5927.436893495111, 6043.12374705674, 6048.909266361096, 6051.909221361595, 6060.333363329942, 6076.3012253591405, 5603.80386686464, 5746.885062298814, 5754.395788442321, 5785.768569257182, 5807.767689292381, 5825.592208545361, 5854.970725146517, 5932.317783454958, 6016.639001659914, 6018.608790428608, 5745.971270143623, 5765.4522820332, 5787.36339002701, 5807.622504537191, 5812.82561523155, 5576.832695019156, 5686.630369026, 5741.425857414392, 5741.598088133791, 5766.077427611562, 5518.613697041169, 5567.721613919207, 5571.331440227199, 5571.582131340085, 5731.3408957968695, 5721.284839395075, 5732.426757324234, 5760.395158508464, 5761.5102716269585, 5771.8557036074435, 5576.637518561442, 5629.268195134607, 5640.464155905182, 5641.633293835887, 5653.802116925888], "value": 5384.4171055295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1500801326057, 620.8013435700572, 633.9841503962401, 650.993490065099, 652.929196118366, 42143.578564214346, 43562.128757424834, 43736.343954840704, 43821.34267985983, 46953.0, 45859.770701146444, 46200.99999999991, 46465.76767116168, 46535.0, 46812.53187468133, 8818.559072046388, 8884.422512536697, 8944.373893827435, 8971.0, 8985.595648195847, 8794.472331660088, 8814.735557933273, 8820.779480513007, 8903.15420035099, 8905.510196939165, 8825.205731484166, 8947.50788706621, 8998.910010899872, 8999.055099214555, 9003.909960900406, 8878.644854205824, 8908.0, 8925.375223734374, 8931.553422328858, 8933.821323573524, 8912.910870891274, 8947.507887066275, 8983.056779038172, 8988.730338089803, 9015.594298256528, 42148.0, 42424.151516969796, 42489.36265956013, 42589.36115958263, 42593.78703106465, 3551.698105661022, 3653.30587188436, 3686.7787932724123, 3686.8340924658455, 3779.848806047755, 33096.0, 33215.335693286, 33332.33335333304, 33597.83201083979, 33910.83044584761, 3738.6635202831876, 3745.906352341186, 3816.542014958223, 3896.5518965319066, 3979.621935916083, 364576.0, 364918.0, 365605.0, 367171.0, 367544.16227918956, 34073.65926340705, 57030.7148464255, 57942.420575794546, 57948.130778038365, 57990.0, 35061.47407788885, 36577.63422365742, 36695.0, 36867.078323041605, 36924.261514769554, 14017.5093871714, 14070.507532236323, 14109.858901410855, 14126.929365353313, 14149.363278652485, 11555.942220288845, 11570.0, 11654.067674586013, 11659.475323610457, 11683.766324673628, 8227.218414250636, 8251.95874020626, 8257.917420825836, 8341.24928756415, 8353.248207661218, 3217.436948533997, 3238.2066393733685, 3254.2677897473354, 3292.7201187899295, 3297.851596678155, 1046.3512622174148, 1073.0825144501339, 1078.6548304542628, 1118.4799068433056, 1123.550579768083, 32935.50596741051, 33079.50380744291, 33168.83415582955, 33260.334793304, 33315.662483464315, 1111.5553778488509, 1131.9547218111347, 1135.982960255597, 1160.257435241446, 1184.709746112208, 17048.914755426144, 17291.06051971168, 17319.134043297785, 17432.91283543574, 17577.296908123786, 549211.0, 549854.0, 551838.0, 552335.0, 553853.0, 58614.70692646509, 59176.704116479144, 59327.406725933055, 59350.0, 59673.70163149157, 1380.3581334679423, 1381.8687224713635, 1382.1223523062927, 1387.4034165309015, 1394.6443656867434, 30733.23166920845, 32001.359972800878, 32198.0, 32437.351252974335, 32568.51147232746, 50908.23637645513, 50914.490855090975, 50960.0, 50997.0, 51018.0, 451889.0, 456154.0, 457571.0, 458662.0, 458982.0, 28231.15306540807, 28282.2929426766, 28870.278243044093, 28877.278068047628, 28887.0, 48416.27375589439, 48704.26943595778, 48937.2659410102, 49531.0, 49864.0, 41466.58533414627, 42157.367639486045, 42407.0, 42694.78652606841, 43114.353284700126, 40306.79846600866, 40350.1929961405, 40642.79678601588, 40801.591984080966, 40808.3878741825, 41178.38232426576, 41610.0, 41690.79154604208, 41724.3741343874, 44209.0, 34483.655163449046, 37099.443508346856, 37619.62380376161, 37862.43206351962, 37880.62119378771, 27891.860540697166, 28037.0, 28593.857030715546, 28637.427251455272, 28656.570151448163], "value": 19040.186903865884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.99427008594876, 386.92068126034155, 392.76826672263365, 392.85071672764343, 415.13444468283626, 14281.50014749484, 17987.550311242227, 19564.0, 19658.606827863452, 19729.704054439197, 18141.092945352746, 18316.450506484827, 18614.06929653519, 18619.0, 18785.0, 5657.32112146543, 5680.488756011969, 5787.160861675055, 5849.561282903778, 5851.034579294412, 5718.656880587178, 5732.111522713986, 5758.7408566614395, 5774.989376859054, 5779.190913272145, 5595.4124816894255, 5664.716764161796, 5724.54203663708, 5751.827445176651, 5798.362180160179, 5529.529989950859, 5728.828135155952, 5763.855903602423, 5766.077427611583, 5772.595918285742, 4986.650934434591, 5096.3884333879805, 5107.514786095315, 5111.258867464197, 5158.561522270612, 21242.256521021845, 22078.11687532497, 22129.55740885173, 22500.549989000127, 22576.66135007976, 2398.0887262840183, 2456.5332586808627, 2541.263033720219, 2639.2741995951073, 2748.3816141368234, 14559.272036398137, 14778.408863645442, 14806.555803325917, 14860.62848428787, 14914.552563423114, 1933.7389452423884, 1979.1489659446431, 1987.4037788663488, 2002.399280215944, 2022.2921977307824, 81416.59291703562, 82714.0, 83243.0, 83403.58298208531, 84157.15842841554, 10084.092431681183, 10392.168626509861, 10731.0, 10800.891991080145, 10939.28894621847, 11466.77066458683, 11941.64175074749, 12011.699707507207, 14590.781138282935, 14651.948727178204, 7099.3965512930945, 7121.216666166718, 7143.178534468602, 7257.92742072583, 7351.301626345488, 6990.161180658353, 7020.157581090302, 7063.540869843444, 7083.822904427328, 7158.2841715829045, 3897.3569361055106, 4025.577314382006, 4026.6577340925764, 4034.092329225901, 4080.8367665293054, 1924.2399252295265, 1944.377799104273, 1953.841857496211, 1954.853385996056, 1973.6348775476583, 860.7761981884755, 957.3011701457974, 1002.0730823987927, 1013.3362647465922, 1019.0115587879744, 18298.63402731938, 18678.813211867706, 18803.435896923114, 18927.62144757097, 19210.80789192118, 1006.1296978113879, 1016.6797458800454, 1031.293563908725, 1043.9321444106108, 1062.4050531702271, 10063.19494440443, 10608.681739547827, 10628.25602207838, 10648.414337211529, 10671.35971841692, 481375.0, 488755.0, 503821.0, 506571.0, 509705.0, 87900.0, 88030.55984720035, 88208.11791882127, 88246.55876720576, 90041.0, 1003.9397636141855, 1011.0849681038671, 1067.946602669879, 1069.342354452022, 1070.4326706845384, 16429.260683269044, 16621.50135495937, 16721.163941803105, 16732.58168545796, 17161.056141912315, 33388.0, 38624.613753863225, 38651.806740966116, 39550.80224598858, 41156.79421602873, 54810.45189548053, 55156.0, 55232.72383638056, 55594.72202638961, 55597.0, 8046.114927358103, 8103.108658047728, 8148.144444833444, 8157.265846073882, 8182.509049457051, 8912.019677835304, 12555.497780088694, 13117.868821311664, 13848.446062157804, 14235.50175743844, 11993.940030299793, 12045.457954392248, 12104.878951210376, 12248.0, 12314.261144331369, 12090.45592948337, 12257.509699611915, 12314.384280786104, 12419.379031048593, 12764.106512544033, 12091.15361924692, 12410.75178496443, 12509.437075331814, 12510.687232819253, 12545.372731363577, 8440.66237350499, 8671.523066231417, 8866.601002954754, 8867.866981995405, 8926.73219803407, 11459.255148415326, 11745.706357341134, 11862.288262704265, 11928.582499612472, 12358.62924112278], "value": 9111.798820940476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.719993201292, 1487.4570781664693, 1605.6387312854608, 1748.8688348373876, 1799.7030489969156, 7738.651760670769, 8315.667373305076, 8388.0, 8948.73153805387, 8969.910300896989, 8360.372972027108, 8520.999999999984, 8711.86932196016, 8738.91261087389, 8755.0, 2260.446190683285, 2307.792298693117, 2314.5255222679393, 2322.6167682332393, 2332.5917964356254, 2230.241717815942, 2288.336382449096, 2289.3589794857467, 2290.209877592228, 2299.41364951937, 2288.645259984705, 2292.5873342798373, 2304.0, 2318.9652155217686, 2322.6051571232847, 2164.145162660748, 2166.3717521918625, 2171.8262538996923, 2173.8586991845477, 2187.1907394264067, 2198.5712786006734, 2199.3511913985412, 2222.588821068108, 2226.320972103524, 2229.1863469833556, 8832.337574681924, 8916.866247006235, 8943.418677785989, 8952.283817294601, 8958.10418958099, 5133.512316329943, 5202.583793296527, 5215.348081489814, 5217.608679349064, 5232.2674825524455, 3144.2296637324002, 3210.678932106794, 3352.5641666583433, 3401.4047541680357, 3421.863125474978, 1137.1585027079902, 1147.5868687272575, 1163.2090178678495, 1172.2321879169158, 1177.735009622828, 12277.570285039981, 12347.75304493905, 12369.567065152767, 12472.8129078063, 12510.37448127599, 4512.819487220474, 4518.841840535565, 4638.466576343763, 4639.768011599406, 4648.814047438064, 10419.583216671399, 10500.422476763699, 10559.841602375971, 10565.471726413649, 10593.470326483644, 5104.157813960729, 5131.871703207375, 5153.433122356538, 5172.793088276502, 5181.53366197044, 4179.770112643834, 4624.375709279204, 4717.24524076153, 4742.810287588527, 4748.881277968078, 3857.517810273716, 3884.0872394987155, 4003.7597744135446, 4008.3386241269864, 4044.838206471708, 1237.6287113865803, 1260.8423947006625, 1264.3551788587702, 1267.930263835498, 1270.8220849081135, 975.2295686407658, 997.2221667099674, 997.6807421625156, 998.6354980432235, 1015.8019186258756, 6035.1249068885645, 6098.359672234352, 6230.937690623126, 6247.843803904939, 6343.587666801735, 426.9402283680287, 426.9786510674454, 429.0453740427586, 434.13390286378876, 436.2997389190304, 4218.325067989107, 4246.745195288293, 4265.872023839228, 4275.273203555403, 4299.269124248885, 10656.733581660366, 11009.559617615205, 11078.335299882034, 11102.333859968428, 11128.944355278172, 11007.834882476769, 11026.173037022256, 11030.0, 11040.447977601088, 11047.83428248577, 7838.980932478741, 8186.467879587808, 8207.138250483853, 8227.629756660845, 8350.914381130535, 6197.25632924052, 6385.93614063872, 6406.359364063556, 6468.15913931186, 6501.804945851632, 10130.493475326057, 10131.797364052825, 10206.0, 10259.384436933808, 10278.691639250834, 9994.350367226107, 10316.896831031894, 10318.690439286833, 10450.47747612601, 10451.484534742267, 7796.532208067534, 7833.804154896173, 7957.323627491728, 8112.067112281927, 8145.470544414594, 8888.911110888808, 8900.465972041698, 8913.777155571162, 8919.241864441596, 8971.775705607412, 7450.776476705708, 7509.3617042552, 7514.361279291322, 7540.698372065056, 7786.299233069051, 7535.510191837513, 7594.126675432396, 7604.163542010264, 7610.695572177272, 7735.651895664596, 6788.355106264897, 6896.7586134485055, 6911.136107986502, 6912.792616221522, 6913.827154321182, 5204.245384419314, 5245.265662807286, 5307.65500242483, 5348.625596208228, 5393.568514518751, 5166.070107380558, 5210.635255532076, 5225.320708307896, 5279.287296214962, 5418.106012507892], "value": 4557.519586792756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.1369413571474, 324.040839116216, 334.05129432411945, 334.91627093226685, 338.28115255082946, 5461.672299662013, 5477.397486276506, 5633.661980281186, 5635.859103522414, 5679.687617181054, 5559.749811258493, 5594.580406469521, 5604.467575580324, 5617.831465056045, 5666.914996275059, 4359.604926423545, 4359.869203923888, 4373.562643735633, 4409.4488188976375, 4450.221211288028, 4187.450643261997, 4420.513743488214, 4422.204003279408, 4475.552444755531, 4488.169688607618, 4326.935095973563, 4361.193179261831, 4361.34579813029, 4375.781210939456, 4378.496472905609, 4362.2550979608095, 4403.779811009469, 4404.603585677304, 4412.205802955466, 4433.0, 3764.623537646241, 3829.5596006459054, 3873.786941718204, 3877.747946383476, 3880.0299925018744, 5379.0, 5433.0, 5447.373552041487, 5488.341399032141, 5509.311336082989, 4853.854384368475, 4888.511148885119, 4896.387951506062, 4912.901741965176, 4977.776000080005, 5779.855503612402, 5840.386759390288, 5851.180834683105, 5867.591777973298, 5898.0, 4143.316352801814, 4144.295469770116, 4149.854755083587, 4166.937495937564, 4177.0, 6103.908441373383, 6106.328303886569, 6119.694015299262, 6131.264248290189, 6132.504472450705, 4049.453323801308, 4230.873073807791, 4255.553166917491, 4266.381374700651, 4280.464941882265, 4316.072044510445, 4332.913341733148, 4342.435483387139, 4349.369341445473, 4351.673624478177, 4939.90120197594, 4994.450610432849, 5010.849674509771, 5017.347744793154, 5023.874403139877, 5724.255846739898, 5847.853803654858, 5913.674747888821, 5968.731407086691, 5989.760409583568, 1453.3532578002898, 1485.4058376649427, 1485.9182744949132, 1489.6201468625432, 1497.468398718461, 915.8414605524017, 947.625687853294, 947.8909925358535, 951.167728237792, 962.932594718377, 5022.522860328263, 5041.269015992734, 5053.898922021539, 5143.174173168546, 5152.522047617843, 5350.545203657733, 5353.9732301338245, 5368.758405871745, 5376.623636345496, 5384.6000039989885, 5055.949440505621, 5092.3335198656905, 5112.974435127875, 5320.361556613231, 5781.479666830005, 3234.2237862913203, 3237.4981877808978, 3241.124896277992, 3264.2862497189167, 3272.640009598942, 6128.969355153285, 6236.282827474808, 6266.091416744546, 6282.371762823773, 6304.9912014078445, 6154.446099851035, 6167.0, 6221.595596286227, 6241.251049874044, 6250.249970003629, 6210.627362358273, 6221.3156552779155, 6267.874642507124, 6285.622862628257, 6346.0, 5834.854128646818, 6039.275286965592, 6052.636841789506, 6096.603720758137, 6098.786542470993, 5921.348651648402, 5957.493613042767, 5994.6403215807195, 6013.218281623361, 6047.485963693135, 5622.522085622604, 6169.876602468015, 6198.256209254918, 6211.689415529115, 6261.655608941552, 4174.373843923436, 4185.497740271066, 4214.8198504418815, 4218.177455396169, 4235.703500755041, 6072.119542666377, 6081.057436097412, 6089.147519347206, 6128.0, 6154.846128846635, 5695.658260504383, 5797.826065218051, 5835.432409739701, 5844.6785426801935, 5923.703814809329, 5792.275965504312, 5799.478046975623, 5829.15477255804, 5857.941420585739, 5862.179294898632, 5576.665400076008, 5730.598858079894, 5737.311522617312, 5781.860711536759, 5808.854778630399, 5749.367569567261, 5847.356790752929, 5902.2327097477055, 5912.87655345483, 5999.160117583455, 5751.8562035949435, 5756.366799651951, 5784.871949969884, 5810.54736315921, 5865.853353666193], "value": 4430.398114735458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.0811485642946, 751.7105914223023, 763.1529002806883, 780.0210735526913, 790.3282210121394, 14587.708245835078, 15794.0, 15863.365465381385, 15892.52322430326, 15930.283137258808, 14460.783088253685, 14480.927595362034, 14483.0, 14630.122192668447, 14652.633684157874, 654.9410553050225, 774.8721460958935, 790.8971833661616, 803.5178892664413, 803.6303300481785, 770.8419773946327, 777.5956502618635, 781.9100803407624, 782.0224719101124, 786.8622990976585, 848.7962888906679, 852.3138873207066, 852.7143406958676, 853.1937319233327, 854.4915775113798, 842.4860834890711, 844.5903736687701, 844.6959094725925, 845.0282175498165, 845.6828689241535, 613.2457077794294, 616.257409821169, 618.3414663383527, 618.3538202578317, 621.201755743867, 15371.308291126927, 15557.533274001798, 15563.766543501742, 15585.298661560257, 15602.453914112952, 15593.844061559352, 15597.220138993005, 15620.843791562053, 15636.921815390964, 15859.60350991223, 12257.448414821265, 12340.074494412955, 12340.13619046667, 12370.75258494834, 12848.614541563767, 3882.9611703882883, 3907.687385009221, 4010.2981978154, 4051.7974101295113, 4135.813888375031, 82897.0, 82909.0, 83173.58413207895, 83565.99999999939, 83833.0, 11670.241434306912, 12022.398880055962, 12160.331181785086, 12288.570281641993, 12321.630351089481, 23148.65277020846, 23218.419539511648, 23417.180398685963, 23448.0, 23449.531009379716, 8317.667293308321, 8441.831163376699, 8494.15058494158, 8500.659973600987, 8620.094890036582, 4810.39870016248, 4832.251001094836, 4838.395200599925, 4898.2652602109965, 5024.0, 3449.0, 3571.3035957988463, 3578.5884623268657, 3578.6421357864006, 3587.8026708531283, 574.9885002299931, 581.7382178019908, 612.063542779548, 643.231338550437, 644.7098805537527, 614.3948211012149, 658.9095047696071, 698.3698081718176, 719.924407937159, 739.3530660671912, 9594.376365536218, 9724.95137524308, 9788.55951482185, 9888.703338899844, 10090.394576325443, 696.2202333386639, 718.2601920022386, 726.7565365602583, 729.6315360742897, 732.7948174511146, 4260.744355338689, 4370.956290437055, 4554.0, 4689.132510485571, 4842.709437433765, 70397.64801176064, 70674.0, 92586.0, 121545.0, 122259.38870305591, 61796.38203617996, 70930.64534677293, 99996.5003324683, 105519.47240263749, 107615.46192268988, 79778.20221797824, 92536.07463925409, 94428.97353724873, 96335.0, 99844.0, 9582.952085239529, 9798.657047003606, 9805.705828825146, 9839.458829764431, 9907.653232136841, 50144.74927625339, 50536.24195637142, 51346.48653513417, 51877.0, 53110.0, 67010.0, 71001.0, 71741.0, 71932.28067719255, 75028.0, 13018.2839943804, 13018.869811301765, 13070.54253101137, 13314.600561983156, 13530.93234533821, 14182.645433864236, 14279.64300892486, 14529.636759081108, 15110.320035598204, 15206.847931520986, 13131.212127272012, 13136.211827290394, 13300.135491193041, 13331.33343332849, 13517.391717372546, 13832.0, 13853.584392468241, 14036.649083772987, 14141.151530908179, 14528.782068269196, 12614.0, 13175.736485270432, 13475.73048539004, 13674.316284185552, 13717.039807213798, 10713.625023124154, 10928.781424371628, 11234.494447749707, 11495.137864660017, 11939.701507462383, 10309.278350515691, 10603.151747860307, 10679.0, 10716.732081697708, 10748.301360411548], "value": 7561.731005146822, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 156.0, 187.0, 130.0, 164.0, 148.0, 131.0, 190.0, 128.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 167.0, 167.0, 161.0, 163.0, 160.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 155.0, 76.0, 74.0, 76.0, 74.0, 159.0, 76.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 157.0, 85.0, 86.0, 84.0, 144.0, 84.0, 85.0, 146.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 151.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 100.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 55.0, 53.0, 53.0, 56.0, 52.0, 54.0, 53.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 64.0, 61.0, 61.0, 63.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 81.0, 83.0, 82.0, 81.0, 81.0, 108.0, 88.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 124.0, 124.0, 124.0, 135.0, 134.0, 132.0, 157.0, 131.0, 137.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 163.0, 162.0, 165.0, 166.0, 163.0, 164.0, 160.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 67.0, 65.0, 62.0, 65.0, 64.0, 67.0, 68.0, 62.0], "value": 64.8, "unit": "score"}]}]} 06:11:15 INFO - Return code: 0 06:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:16 ERROR - # TBPL SUCCESS # 06:11:16 INFO - Running post-action listener: _resource_record_post_action 06:11:16 INFO - ##### 06:11:16 INFO - ##### Finished run-tests step (success) 06:11:16 INFO - ##### 06:11:16 INFO - Running post-run listener: _resource_record_post_run 06:11:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 549740544; Read time: 0; Write time: 472412 06:11:16 INFO - TinderboxPrint: CPU usage
13.5% 06:11:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:11:16 INFO - TinderboxPrint: I/O write bytes / time
549,740,544 / 472,412 06:11:16 INFO - TinderboxPrint: CPU idle
8,218.6 (86.5%) 06:11:16 INFO - TinderboxPrint: CPU user
1,226.4 (12.9%) 06:11:16 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255680512; Read time: 0; Write time: 267640 06:11:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293470208; Read time: 0; Write time: 204772 06:11:16 INFO - Running post-run listener: _upload_blobber_files 06:11:16 INFO - Blob upload gear active. 06:11:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:16 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:11:16 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:11:16 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:11:17 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:11:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:17 INFO - (blobuploader) - INFO - Done attempting. 06:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:20 INFO - (blobuploader) - INFO - Done attempting. 06:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:21 INFO - (blobuploader) - INFO - Done attempting. 06:11:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:21 INFO - Return code: 0 06:11:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0702e56be533df44e548e57e067a59022557504851269ec6c4b8d0d4cfd6e52675657f92a51c4f68c77b61d2a86702af545a5d274b295091e80f029162ec214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b88bb9dbbb286b9c4c8b4901c230919445c4acb49003a0cac6fa5b2640b59dd51a81c4d3c416deb8b15acf83501d61f4e759cbc97db3f85c8d5c63c3acaa1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a004cb1fee5437fd341d4dc710ab416f6675b14096ed2a78ef970320656d9c9f0c6e412c3ed7f35b08f124b144af78e2fa42718f4b7d711197aae86747dea2c"} 06:11:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:21 INFO - Contents: 06:11:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0702e56be533df44e548e57e067a59022557504851269ec6c4b8d0d4cfd6e52675657f92a51c4f68c77b61d2a86702af545a5d274b295091e80f029162ec214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b88bb9dbbb286b9c4c8b4901c230919445c4acb49003a0cac6fa5b2640b59dd51a81c4d3c416deb8b15acf83501d61f4e759cbc97db3f85c8d5c63c3acaa1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a004cb1fee5437fd341d4dc710ab416f6675b14096ed2a78ef970320656d9c9f0c6e412c3ed7f35b08f124b144af78e2fa42718f4b7d711197aae86747dea2c"} 06:11:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:21 INFO - Copying logs to upload dir... 06:11:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.236461 ========= master_lag: 358.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 52 secs) (at 2016-06-17 06:17:20.197227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:17:20.201044) ========= 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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 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/a0702e56be533df44e548e57e067a59022557504851269ec6c4b8d0d4cfd6e52675657f92a51c4f68c77b61d2a86702af545a5d274b295091e80f029162ec214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b88bb9dbbb286b9c4c8b4901c230919445c4acb49003a0cac6fa5b2640b59dd51a81c4d3c416deb8b15acf83501d61f4e759cbc97db3f85c8d5c63c3acaa1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a004cb1fee5437fd341d4dc710ab416f6675b14096ed2a78ef970320656d9c9f0c6e412c3ed7f35b08f124b144af78e2fa42718f4b7d711197aae86747dea2c"} build_url:https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/XeBgSb6KSJK4MdHtD7Q1lQ/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/a0702e56be533df44e548e57e067a59022557504851269ec6c4b8d0d4cfd6e52675657f92a51c4f68c77b61d2a86702af545a5d274b295091e80f029162ec214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5b88bb9dbbb286b9c4c8b4901c230919445c4acb49003a0cac6fa5b2640b59dd51a81c4d3c416deb8b15acf83501d61f4e759cbc97db3f85c8d5c63c3acaa1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a004cb1fee5437fd341d4dc710ab416f6675b14096ed2a78ef970320656d9c9f0c6e412c3ed7f35b08f124b144af78e2fa42718f4b7d711197aae86747dea2c"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:17:20.513380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 mins, 17 secs) (at 2016-06-17 06:17:20.513948) ========= 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=ed14279e38b05397cf4aa391000001a4-1466166699.656466-164128337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 557.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 mins, 17 secs) (at 2016-06-17 06:26:37.890406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:26:37.890746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:26:37.978119) ========= ========= Total master_lag: 916.15 =========