builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1490059073.49 results: success (0) revision: f897fc6fb17f13251963aa4236e541064e9881d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.485478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.485931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.486225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.500918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.501375) ========= 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=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-20 18:17:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2017-03-20 18:17:53 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.639488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.640050) ========= 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=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020484 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:53.690336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 18:17:53.690685) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f897fc6fb17f13251963aa4236e541064e9881d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev f897fc6fb17f13251963aa4236e541064e9881d3 --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=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-20 18:17:53,998 truncating revision to first 12 chars 2017-03-20 18:17:53,998 Setting DEBUG logging. 2017-03-20 18:17:53,998 attempt 1/10 2017-03-20 18:17:53,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f897fc6fb17f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 18:17:54,698 unpacking tar archive at: mozilla-central-f897fc6fb17f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 18:17:54.772265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:54.772598) ========= script_repo_revision: f897fc6fb17f13251963aa4236e541064e9881d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:54.772968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:54.773241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 18:17:54.782629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-20 18:17:54.783007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:17:55 INFO - MultiFileLogger online at 20170320 18:17:55 in /builds/slave/test 18:17:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:17:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:17:55 INFO - {'append_to_log': False, 18:17:55 INFO - 'base_work_dir': '/builds/slave/test', 18:17:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:17:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:17:55 INFO - 'branch': 'Firefox-Non-PGO', 18:17:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:17:55 INFO - 'config_files': ('talos/linux_config.py',), 18:17:55 INFO - 'default_actions': ('clobber', 18:17:55 INFO - 'read-buildbot-config', 18:17:55 INFO - 'download-and-extract', 18:17:55 INFO - 'populate-webroot', 18:17:55 INFO - 'create-virtualenv', 18:17:55 INFO - 'install', 18:17:55 INFO - 'run-tests'), 18:17:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:17:55 INFO - 'download_minidump_stackwalk': True, 18:17:55 INFO - 'download_symbols': 'ondemand', 18:17:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:17:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:17:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:17:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:17:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:17:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:17:55 INFO - 'gecko_profile': False, 18:17:55 INFO - 'gecko_profile_interval': 0, 18:17:55 INFO - 'installer_path': 'installer.exe', 18:17:55 INFO - 'log_level': 'info', 18:17:55 INFO - 'log_name': 'talos', 18:17:55 INFO - 'log_to_console': True, 18:17:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:17:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:17:55 INFO - 'opt_config_files': (), 18:17:55 INFO - 'pip_index': False, 18:17:55 INFO - 'suite': 'dromaeojs-e10s', 18:17:55 INFO - 'system_bits': '32', 18:17:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:17:55 INFO - 'title': 'talos-linux64-ix-011', 18:17:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:17:55 INFO - 'use_talos_json': True, 18:17:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:17:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:17:55 INFO - 'work_dir': 'build'} 18:17:55 INFO - [mozharness: 2017-03-21 01:17:55.191434Z] Running clobber step. 18:17:55 INFO - Running pre-action listener: _resource_record_pre_action 18:17:55 INFO - Running main action method: clobber 18:17:55 INFO - rmtree: /builds/slave/test/build 18:17:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:17:56 INFO - Running post-action listener: _resource_record_post_action 18:17:56 INFO - [mozharness: 2017-03-21 01:17:56.139561Z] Finished clobber step (success) 18:17:56 INFO - [mozharness: 2017-03-21 01:17:56.139660Z] Running read-buildbot-config step. 18:17:56 INFO - Running pre-action listener: _resource_record_pre_action 18:17:56 INFO - Running main action method: read_buildbot_config 18:17:56 INFO - Using buildbot properties: 18:17:56 INFO - { 18:17:56 INFO - "project": "", 18:17:56 INFO - "product": "firefox", 18:17:56 INFO - "who": "kwierso@gmail.com", 18:17:56 INFO - "installer_path": "public/build/target.tar.bz2", 18:17:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:17:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:17:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:17:56 INFO - "stage_platform": "linux64", 18:17:56 INFO - "basedir": "/builds/slave/test", 18:17:56 INFO - "buildnumber": 727, 18:17:56 INFO - "platform": "ubuntu64_hw", 18:17:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:17:56 INFO - "slavebuilddir": "test", 18:17:56 INFO - "taskId": "CTOuhMjVRZyo8Z2dZmCD0Q", 18:17:56 INFO - "branch": "mozilla-central", 18:17:56 INFO - "script_repo_revision": "production", 18:17:56 INFO - "revision": "f897fc6fb17f13251963aa4236e541064e9881d3", 18:17:56 INFO - "slavename": "talos-linux64-ix-011", 18:17:56 INFO - "repo_path": "mozilla-central" 18:17:56 INFO - } 18:17:56 INFO - Finding installer, test and symbols from parent task. 18:17:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTOuhMjVRZyo8Z2dZmCD0Q'}, attempt #1 18:17:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTOuhMjVRZyo8Z2dZmCD0Q'}, attempt #1 18:17:57 INFO - Task dependencies: YU8nHYp9RaG67T11BOqdQA 18:17:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA'}, attempt #1 18:17:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 18:17:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/test_packages.json 18:17:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.crashreporter-symbols.zip 18:17:57 INFO - Running post-action listener: _resource_record_post_action 18:17:57 INFO - [mozharness: 2017-03-21 01:17:57.523451Z] Finished read-buildbot-config step (success) 18:17:57 INFO - [mozharness: 2017-03-21 01:17:57.523671Z] Running download-and-extract step. 18:17:57 INFO - Running pre-action listener: _resource_record_pre_action 18:17:57 INFO - Running main action method: download_and_extract 18:17:57 INFO - mkdir: /builds/slave/test/build/tests 18:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:57 INFO - trying https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.test_packages.json 18:17:57 INFO - Downloading https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:17:58 INFO - Downloaded 986 bytes. 18:17:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:17:58 INFO - Using the following test package requirements: 18:17:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:17:58 INFO - u'common': [u'target.common.tests.zip'], 18:17:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:17:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:17:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:17:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:17:58 INFO - u'mozbase': [u'target.common.tests.zip'], 18:17:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:17:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:17:58 INFO - u'web-platform': [u'target.common.tests.zip', 18:17:58 INFO - u'target.web-platform.tests.zip'], 18:17:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:17:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:17:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip 18:17:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:17:58 INFO - Fetch https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip into memory 18:17:59 INFO - Expected file size: 58186060 18:17:59 INFO - Obtained file size: 58186060 18:18:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:18:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip 18:18:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:18:09 INFO - Fetch https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.common.tests.zip into memory 18:18:10 INFO - Expected file size: 58186060 18:18:10 INFO - Obtained file size: 58186060 18:18:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.talos.tests.zip 18:18:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:18:20 INFO - Fetch https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.talos.tests.zip into memory 18:18:21 INFO - Expected file size: 14404171 18:18:21 INFO - Obtained file size: 14404171 18:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:21 INFO - trying https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 18:18:21 INFO - Downloading https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:18:23 INFO - Downloaded 61777150 bytes. 18:18:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 18:18:23 INFO - mkdir: /builds/slave/test/properties 18:18:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:23 INFO - Contents: 18:18:23 INFO - build_url:https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 18:18:23 INFO - Running post-action listener: _resource_record_post_action 18:18:23 INFO - Running post-action listener: set_extra_try_arguments 18:18:23 INFO - [mozharness: 2017-03-21 01:18:23.995811Z] Finished download-and-extract step (success) 18:18:23 INFO - [mozharness: 2017-03-21 01:18:23.996055Z] Running populate-webroot step. 18:18:23 INFO - Running pre-action listener: _resource_record_pre_action 18:18:23 INFO - Running main action method: populate_webroot 18:18:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:24 INFO - '--tppagecycles', 18:18:24 INFO - '7'], 18:18:24 INFO - 'tests': ['tsvgm']}}, 18:18:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['damp', 'tps']}, 18:18:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'tests': ['damp', 'tps']}, 18:18:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['dromaeo_dom']}, 18:18:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['basic_compositor_video']}, 18:18:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['a11yr', 18:18:24 INFO - 'ts_paint', 18:18:24 INFO - 'tpaint', 18:18:24 INFO - 'sessionrestore', 18:18:24 INFO - 'sessionrestore_no_auto_restore', 18:18:24 INFO - 'tabpaint']}, 18:18:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['tsvgx', 18:18:24 INFO - 'tsvgr_opacity', 18:18:24 INFO - 'tart', 18:18:24 INFO - 'tscrollx', 18:18:24 INFO - 'cart', 18:18:24 INFO - 'tsvg_static']}, 18:18:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:24 INFO - 'tsvgr_opacity', 18:18:24 INFO - 'tart', 18:18:24 INFO - 'tscrollx', 18:18:24 INFO - 'cart', 18:18:24 INFO - 'tsvg_static']}, 18:18:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'talos_options': ['--disable-e10s'], 18:18:24 INFO - 'tests': ['tp5o']}, 18:18:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:18:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'talos_options': ['--disable-e10s', 18:18:24 INFO - '--xperf_path', 18:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:24 INFO - 'tests': ['tp5n']}, 18:18:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:18:24 INFO - 'talos_options': ['--xperf_path', 18:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:24 INFO - 'tests': ['tp5n']}}, 18:18:24 INFO - 'talos.zip': {'path': '', 18:18:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:24 INFO - Running post-action listener: _resource_record_post_action 18:18:24 INFO - [mozharness: 2017-03-21 01:18:24.011632Z] Finished populate-webroot step (success) 18:18:24 INFO - [mozharness: 2017-03-21 01:18:24.011721Z] Running create-virtualenv step. 18:18:24 INFO - Running pre-action listener: _resource_record_pre_action 18:18:24 INFO - Running main action method: create_virtualenv 18:18:24 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:24 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 18:18:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:24 INFO - Using real prefix '/usr' 18:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:26 INFO - Installing pip.................done. 18:18:26 INFO - Return code: 0 18:18:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:18:26 INFO - Reading from file tmpfile_stdout 18:18:26 INFO - Output received: 18:18:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:18:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:26 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:26 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 18:18:26 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 18:18:26 INFO - Using env: {'DISPLAY': ':0', 18:18:26 INFO - 'HOME': '/home/cltbld', 18:18:26 INFO - 'LANG': 'en_US.UTF-8', 18:18:26 INFO - 'LANGUAGE': 'en_US:en', 18:18:26 INFO - 'LOGNAME': 'cltbld', 18:18:26 INFO - 'MAIL': '/var/mail/cltbld', 18:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:26 INFO - 'MOZ_NO_REMOTE': '1', 18:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:26 INFO - 'NO_EM_RESTART': '1', 18:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:26 INFO - 'PWD': '/builds/slave/test', 18:18:26 INFO - 'SHELL': '/bin/bash', 18:18:26 INFO - 'SHLVL': '1', 18:18:26 INFO - 'TERM': 'linux', 18:18:26 INFO - 'TMOUT': '86400', 18:18:26 INFO - 'USER': 'cltbld', 18:18:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:26 INFO - '_': '/tools/buildbot/bin/python'} 18:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:27 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 18:18:27 INFO - Cleaning up... 18:18:27 INFO - Return code: 0 18:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:27 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:27 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 18:18:27 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 18:18:27 INFO - Using env: {'DISPLAY': ':0', 18:18:27 INFO - 'HOME': '/home/cltbld', 18:18:27 INFO - 'LANG': 'en_US.UTF-8', 18:18:27 INFO - 'LANGUAGE': 'en_US:en', 18:18:27 INFO - 'LOGNAME': 'cltbld', 18:18:27 INFO - 'MAIL': '/var/mail/cltbld', 18:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:27 INFO - 'MOZ_NO_REMOTE': '1', 18:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:27 INFO - 'NO_EM_RESTART': '1', 18:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:27 INFO - 'PWD': '/builds/slave/test', 18:18:27 INFO - 'SHELL': '/bin/bash', 18:18:27 INFO - 'SHLVL': '1', 18:18:27 INFO - 'TERM': 'linux', 18:18:27 INFO - 'TMOUT': '86400', 18:18:27 INFO - 'USER': 'cltbld', 18:18:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:27 INFO - '_': '/tools/buildbot/bin/python'} 18:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:27 INFO - Downloading/unpacking psutil>=3.1.1 18:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:29 INFO - Installing collected packages: psutil 18:18:29 INFO - Running setup.py install for psutil 18:18:29 INFO - building 'psutil._psutil_linux' extension 18:18:29 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 18:18:29 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 18:18:29 INFO - building 'psutil._psutil_posix' extension 18:18:29 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 18:18:29 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 18:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:29 INFO - Successfully installed psutil 18:18:29 INFO - Cleaning up... 18:18:29 INFO - Return code: 0 18:18:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:29 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:29 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 18:18:29 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 18:18:29 INFO - Using env: {'DISPLAY': ':0', 18:18:29 INFO - 'HOME': '/home/cltbld', 18:18:29 INFO - 'LANG': 'en_US.UTF-8', 18:18:29 INFO - 'LANGUAGE': 'en_US:en', 18:18:29 INFO - 'LOGNAME': 'cltbld', 18:18:29 INFO - 'MAIL': '/var/mail/cltbld', 18:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:29 INFO - 'MOZ_NO_REMOTE': '1', 18:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:29 INFO - 'NO_EM_RESTART': '1', 18:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:29 INFO - 'PWD': '/builds/slave/test', 18:18:29 INFO - 'SHELL': '/bin/bash', 18:18:29 INFO - 'SHLVL': '1', 18:18:29 INFO - 'TERM': 'linux', 18:18:29 INFO - 'TMOUT': '86400', 18:18:29 INFO - 'USER': 'cltbld', 18:18:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:29 INFO - '_': '/tools/buildbot/bin/python'} 18:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:32 INFO - Installing collected packages: mozsystemmonitor 18:18:32 INFO - Running setup.py install for mozsystemmonitor 18:18:32 INFO - Successfully installed mozsystemmonitor 18:18:32 INFO - Cleaning up... 18:18:32 INFO - Return code: 0 18:18:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:32 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:32 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 18:18:32 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 18:18:32 INFO - Using env: {'DISPLAY': ':0', 18:18:32 INFO - 'HOME': '/home/cltbld', 18:18:32 INFO - 'LANG': 'en_US.UTF-8', 18:18:32 INFO - 'LANGUAGE': 'en_US:en', 18:18:32 INFO - 'LOGNAME': 'cltbld', 18:18:32 INFO - 'MAIL': '/var/mail/cltbld', 18:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:32 INFO - 'MOZ_NO_REMOTE': '1', 18:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:32 INFO - 'NO_EM_RESTART': '1', 18:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:32 INFO - 'PWD': '/builds/slave/test', 18:18:32 INFO - 'SHELL': '/bin/bash', 18:18:32 INFO - 'SHLVL': '1', 18:18:32 INFO - 'TERM': 'linux', 18:18:32 INFO - 'TMOUT': '86400', 18:18:32 INFO - 'USER': 'cltbld', 18:18:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:32 INFO - '_': '/tools/buildbot/bin/python'} 18:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:32 INFO - Downloading/unpacking jsonschema==2.5.1 18:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:34 INFO - warning: no files found matching '*.txt' 18:18:34 INFO - no previously-included directories found matching 'build' 18:18:34 INFO - no previously-included directories found matching 'dist' 18:18:34 INFO - no previously-included directories found matching '.git*' 18:18:34 INFO - Installing collected packages: jsonschema, functools32 18:18:34 INFO - Running setup.py install for functools32 18:18:35 INFO - warning: no files found matching '*.txt' 18:18:35 INFO - no previously-included directories found matching 'build' 18:18:35 INFO - no previously-included directories found matching 'dist' 18:18:35 INFO - no previously-included directories found matching '.git*' 18:18:35 INFO - Successfully installed jsonschema functools32 18:18:35 INFO - Cleaning up... 18:18:35 INFO - Return code: 0 18:18:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:35 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:35 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:18:35 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 functools32==3.2.3-2 18:18:35 INFO - Using env: {'DISPLAY': ':0', 18:18:35 INFO - 'HOME': '/home/cltbld', 18:18:35 INFO - 'LANG': 'en_US.UTF-8', 18:18:35 INFO - 'LANGUAGE': 'en_US:en', 18:18:35 INFO - 'LOGNAME': 'cltbld', 18:18:35 INFO - 'MAIL': '/var/mail/cltbld', 18:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:35 INFO - 'MOZ_NO_REMOTE': '1', 18:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:35 INFO - 'NO_EM_RESTART': '1', 18:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:35 INFO - 'PWD': '/builds/slave/test', 18:18:35 INFO - 'SHELL': '/bin/bash', 18:18:35 INFO - 'SHLVL': '1', 18:18:35 INFO - 'TERM': 'linux', 18:18:35 INFO - 'TMOUT': '86400', 18:18:35 INFO - 'USER': 'cltbld', 18:18:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:35 INFO - '_': '/tools/buildbot/bin/python'} 18:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:18:35 INFO - Cleaning up... 18:18:35 INFO - Return code: 0 18:18:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:35 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:35 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 18:18:35 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 18:18:35 INFO - Using env: {'DISPLAY': ':0', 18:18:35 INFO - 'HOME': '/home/cltbld', 18:18:35 INFO - 'LANG': 'en_US.UTF-8', 18:18:35 INFO - 'LANGUAGE': 'en_US:en', 18:18:35 INFO - 'LOGNAME': 'cltbld', 18:18:35 INFO - 'MAIL': '/var/mail/cltbld', 18:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:35 INFO - 'MOZ_NO_REMOTE': '1', 18:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:35 INFO - 'NO_EM_RESTART': '1', 18:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:35 INFO - 'PWD': '/builds/slave/test', 18:18:35 INFO - 'SHELL': '/bin/bash', 18:18:35 INFO - 'SHLVL': '1', 18:18:35 INFO - 'TERM': 'linux', 18:18:35 INFO - 'TMOUT': '86400', 18:18:35 INFO - 'USER': 'cltbld', 18:18:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:35 INFO - '_': '/tools/buildbot/bin/python'} 18:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:38 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 18:18:38 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 18:18:38 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 18:18:38 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 18:18:38 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 18:18:38 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 18:18:38 INFO - Downloading docopt-0.6.1.tar.gz 18:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:38 INFO - Running setup.py install for blobuploader 18:18:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:38 INFO - Running setup.py install for requests 18:18:38 INFO - Running setup.py install for docopt 18:18:38 INFO - Successfully installed blobuploader requests docopt 18:18:38 INFO - Cleaning up... 18:18:38 INFO - Return code: 0 18:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:39 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:39 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 18:18:39 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 18:18:39 INFO - Using env: {'DISPLAY': ':0', 18:18:39 INFO - 'HOME': '/home/cltbld', 18:18:39 INFO - 'LANG': 'en_US.UTF-8', 18:18:39 INFO - 'LANGUAGE': 'en_US:en', 18:18:39 INFO - 'LOGNAME': 'cltbld', 18:18:39 INFO - 'MAIL': '/var/mail/cltbld', 18:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:39 INFO - 'MOZ_NO_REMOTE': '1', 18:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:39 INFO - 'NO_EM_RESTART': '1', 18:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:39 INFO - 'PWD': '/builds/slave/test', 18:18:39 INFO - 'SHELL': '/bin/bash', 18:18:39 INFO - 'SHLVL': '1', 18:18:39 INFO - 'TERM': 'linux', 18:18:39 INFO - 'TMOUT': '86400', 18:18:39 INFO - 'USER': 'cltbld', 18:18:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:39 INFO - '_': '/tools/buildbot/bin/python'} 18:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:39 INFO - Running setup.py (path:/tmp/pip-re16mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:39 INFO - Running setup.py (path:/tmp/pip-ifR5lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:39 INFO - Running setup.py (path:/tmp/pip-dFK3en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:39 INFO - Running setup.py (path:/tmp/pip-jmzbhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:39 INFO - Running setup.py (path:/tmp/pip-drUlNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:39 INFO - Running setup.py (path:/tmp/pip-Xc8X3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:39 INFO - Running setup.py (path:/tmp/pip-1C5jCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:39 INFO - Running setup.py (path:/tmp/pip-Io4A0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:39 INFO - Running setup.py (path:/tmp/pip-xhA2Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:39 INFO - Running setup.py (path:/tmp/pip-luc8xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:39 INFO - Running setup.py (path:/tmp/pip-pkW8Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:40 INFO - Running setup.py (path:/tmp/pip-bwNFTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:40 INFO - Running setup.py (path:/tmp/pip-DZ2WzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:40 INFO - Running setup.py (path:/tmp/pip-OnC2V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:40 INFO - Running setup.py (path:/tmp/pip-p40iO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:40 INFO - Running setup.py (path:/tmp/pip-iIM1vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:40 INFO - Running setup.py (path:/tmp/pip-EP_z04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:40 INFO - Running setup.py install for manifestparser 18:18:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:40 INFO - Running setup.py install for mozcrash 18:18:40 INFO - Running setup.py install for mozdebug 18:18:40 INFO - Running setup.py install for mozdevice 18:18:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:40 INFO - Running setup.py install for mozfile 18:18:40 INFO - Running setup.py install for mozhttpd 18:18:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozinfo 18:18:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozInstall 18:18:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozleak 18:18:41 INFO - Running setup.py install for mozlog 18:18:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for moznetwork 18:18:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozprocess 18:18:41 INFO - Running setup.py install for mozprofile 18:18:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozrunner 18:18:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:41 INFO - Running setup.py install for mozscreenshot 18:18:42 INFO - Running setup.py install for moztest 18:18:42 INFO - Running setup.py install for mozversion 18:18:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:42 INFO - Cleaning up... 18:18:42 INFO - Return code: 0 18:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:42 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 18:18:42 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 18:18:42 INFO - Using env: {'DISPLAY': ':0', 18:18:42 INFO - 'HOME': '/home/cltbld', 18:18:42 INFO - 'LANG': 'en_US.UTF-8', 18:18:42 INFO - 'LANGUAGE': 'en_US:en', 18:18:42 INFO - 'LOGNAME': 'cltbld', 18:18:42 INFO - 'MAIL': '/var/mail/cltbld', 18:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:42 INFO - 'MOZ_NO_REMOTE': '1', 18:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:42 INFO - 'NO_EM_RESTART': '1', 18:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:42 INFO - 'PWD': '/builds/slave/test', 18:18:42 INFO - 'SHELL': '/bin/bash', 18:18:42 INFO - 'SHLVL': '1', 18:18:42 INFO - 'TERM': 'linux', 18:18:42 INFO - 'TMOUT': '86400', 18:18:42 INFO - 'USER': 'cltbld', 18:18:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:42 INFO - '_': '/tools/buildbot/bin/python'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:42 INFO - Running setup.py (path:/tmp/pip-dFlSDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:42 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:42 INFO - Running setup.py (path:/tmp/pip-fYLpI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:42 INFO - Running setup.py (path:/tmp/pip-vHemUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:42 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:42 INFO - Running setup.py (path:/tmp/pip-0BSpfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:42 INFO - Running setup.py (path:/tmp/pip-Io_k2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:42 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:42 INFO - Running setup.py (path:/tmp/pip-dz5P99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:42 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:42 INFO - Running setup.py (path:/tmp/pip-dUg3DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:42 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)) 18:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:42 INFO - Running setup.py (path:/tmp/pip-Cyg3KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:43 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:43 INFO - Running setup.py (path:/tmp/pip-Hv3EcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:43 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:43 INFO - Running setup.py (path:/tmp/pip-jeHsAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:43 INFO - Running setup.py (path:/tmp/pip-3QW5IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:43 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:43 INFO - Running setup.py (path:/tmp/pip-LVNInt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:43 INFO - Running setup.py (path:/tmp/pip-zbbwMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:43 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:43 INFO - Running setup.py (path:/tmp/pip-x64KVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:43 INFO - Running setup.py (path:/tmp/pip-rbIH3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:43 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:43 INFO - Running setup.py (path:/tmp/pip-qgdBTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 18:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:43 INFO - Running setup.py (path:/tmp/pip-NXmybO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:43 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)) 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:43 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)) 18:18:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:43 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 18:18:43 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 18:18:43 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 18:18:43 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 18:18:43 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 18:18:43 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 18:18:45 INFO - Downloading blessings-1.6.tar.gz 18:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:45 INFO - Installing collected packages: blessings 18:18:45 INFO - Running setup.py install for blessings 18:18:45 INFO - Successfully installed blessings 18:18:45 INFO - Cleaning up... 18:18:45 INFO - Return code: 0 18:18:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:46 INFO - Reading from file tmpfile_stdout 18:18:46 INFO - Current package versions: 18:18:46 INFO - argparse == 1.2.1 18:18:46 INFO - blessings == 1.6 18:18:46 INFO - blobuploader == 1.2.4 18:18:46 INFO - docopt == 0.6.1 18:18:46 INFO - functools32 == 3.2.3-2 18:18:46 INFO - jsonschema == 2.5.1 18:18:46 INFO - manifestparser == 1.1 18:18:46 INFO - mozInstall == 1.12 18:18:46 INFO - mozcrash == 1.0 18:18:46 INFO - mozdebug == 0.1 18:18:46 INFO - mozdevice == 0.49 18:18:46 INFO - mozfile == 1.2 18:18:46 INFO - mozhttpd == 0.7 18:18:46 INFO - mozinfo == 0.9 18:18:46 INFO - mozleak == 0.1 18:18:46 INFO - mozlog == 3.4 18:18:46 INFO - moznetwork == 0.27 18:18:46 INFO - mozprocess == 0.25 18:18:46 INFO - mozprofile == 0.28 18:18:46 INFO - mozrunner == 6.13 18:18:46 INFO - mozscreenshot == 0.1 18:18:46 INFO - mozsystemmonitor == 0.3 18:18:46 INFO - moztest == 0.8 18:18:46 INFO - mozversion == 1.4 18:18:46 INFO - psutil == 3.1.1 18:18:46 INFO - requests == 1.2.3 18:18:46 INFO - wsgiref == 0.1.2 18:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'DISPLAY': ':0', 18:18:46 INFO - 'HOME': '/home/cltbld', 18:18:46 INFO - 'LANG': 'en_US.UTF-8', 18:18:46 INFO - 'LANGUAGE': 'en_US:en', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MAIL': '/var/mail/cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SHLVL': '1', 18:18:46 INFO - 'TERM': 'linux', 18:18:46 INFO - 'TMOUT': '86400', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - '_': '/tools/buildbot/bin/python'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 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)) 18:18:46 INFO - Cleaning up... 18:18:46 INFO - Return code: 0 18:18:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0xc951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf32b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, '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': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', '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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'DISPLAY': ':0', 18:18:46 INFO - 'HOME': '/home/cltbld', 18:18:46 INFO - 'LANG': 'en_US.UTF-8', 18:18:46 INFO - 'LANGUAGE': 'en_US:en', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MAIL': '/var/mail/cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SHLVL': '1', 18:18:46 INFO - 'TERM': 'linux', 18:18:46 INFO - 'TMOUT': '86400', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - '_': '/tools/buildbot/bin/python'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:18:46 INFO - Cleaning up... 18:18:46 INFO - Return code: 0 18:18:46 INFO - Running post-action listener: _resource_record_post_action 18:18:46 INFO - Running post-action listener: _start_resource_monitoring 18:18:46 INFO - Starting resource monitoring. 18:18:46 INFO - [mozharness: 2017-03-21 01:18:46.695846Z] Finished create-virtualenv step (success) 18:18:46 INFO - [mozharness: 2017-03-21 01:18:46.696515Z] Running install step. 18:18:46 INFO - Running pre-action listener: _resource_record_pre_action 18:18:46 INFO - Running main action method: install 18:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:46 INFO - Reading from file tmpfile_stdout 18:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:46 INFO - Reading from file tmpfile_stdout 18:18:46 INFO - Output received: 18:18:46 INFO - Usage: mozinstall [options] installer 18:18:46 INFO - Options: 18:18:46 INFO - -h, --help show this help message and exit 18:18:46 INFO - -d DEST, --destination=DEST 18:18:46 INFO - Directory to install application into. [default: 18:18:46 INFO - "/builds/slave/test"] 18:18:46 INFO - --app=APP Application being installed. [default: firefox] 18:18:46 INFO - mkdir: /builds/slave/test/build/application 18:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:19:03 INFO - Reading from file tmpfile_stdout 18:19:03 INFO - Output received: 18:19:03 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:03 INFO - Running post-action listener: _resource_record_post_action 18:19:03 INFO - [mozharness: 2017-03-21 01:19:03.394476Z] Finished install step (success) 18:19:03 INFO - [mozharness: 2017-03-21 01:19:03.394753Z] Running run-tests step. 18:19:03 INFO - Running pre-action listener: _resource_record_pre_action 18:19:03 INFO - Running main action method: run_tests 18:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:03 INFO - Python 2.7.3 18:19:03 INFO - Return code: 0 18:19:03 INFO - grabbing minidump binary from tooltool 18:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:03 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 0xf30290>, '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 0xf30b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf31040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:03 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 18:19:03 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 18:19:03 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 18:19:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:03 INFO - Return code: 0 18:19:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:03 INFO - ENV: RUST_BACKTRACE is now 1 18:19:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 18:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 18:19:03 INFO - Using env: {'DISPLAY': ':0', 18:19:03 INFO - 'HOME': '/home/cltbld', 18:19:03 INFO - 'LANG': 'en_US.UTF-8', 18:19:03 INFO - 'LANGUAGE': 'en_US:en', 18:19:03 INFO - 'LOGNAME': 'cltbld', 18:19:03 INFO - 'MAIL': '/var/mail/cltbld', 18:19:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:03 INFO - 'MOZ_NO_REMOTE': '1', 18:19:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:03 INFO - 'NO_EM_RESTART': '1', 18:19:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:03 INFO - 'PWD': '/builds/slave/test', 18:19:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:03 INFO - 'RUST_BACKTRACE': '1', 18:19:03 INFO - 'SHELL': '/bin/bash', 18:19:03 INFO - 'SHLVL': '1', 18:19:03 INFO - 'TERM': 'linux', 18:19:03 INFO - 'TMOUT': '86400', 18:19:03 INFO - 'USER': 'cltbld', 18:19:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697', 18:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:03 INFO - '_': '/tools/buildbot/bin/python'} 18:19:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 18:19:03 INFO - mozversion application_buildid: 20170321004942 18:19:03 INFO - mozversion application_changeset: f897fc6fb17f13251963aa4236e541064e9881d3 18:19:03 INFO - mozversion application_display_name: Nightly 18:19:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:03 INFO - mozversion application_name: Firefox 18:19:03 INFO - mozversion application_remotingname: firefox 18:19:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:03 INFO - mozversion application_vendor: Mozilla 18:19:03 INFO - mozversion application_version: 55.0a1 18:19:03 INFO - mozversion platform_buildid: 20170321004942 18:19:03 INFO - mozversion platform_changeset: f897fc6fb17f13251963aa4236e541064e9881d3 18:19:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:03 INFO - mozversion platform_version: 55.0a1 18:19:03 INFO - using testdate: 1490059143 18:19:03 INFO - actual date: 1490059143 18:19:03 INFO - starting webserver on 'localhost:58257' 18:19:03 INFO - SUITE-START | Running 2 tests 18:19:03 INFO - TEST-START | dromaeo_css 18:19:03 INFO - operating with platform_type : linux_ 18:19:03 INFO - Initialising browser for dromaeo_css test... 18:19:03 INFO - TEST-INFO | started process 3850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy6KWP2/profile http://localhost:58257/getInfo.html) 18:19:08 INFO - PID 3850 | __metrics Screen width/height:1600/1200 18:19:08 INFO - PID 3850 | colorDepth:24 18:19:08 INFO - PID 3850 | Browser inner width/height: 1024/697 18:19:08 INFO - PID 3850 | __metrics 18:19:09 ERROR - PID 3850 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 18:19:10 INFO - TEST-INFO | 3850: exit 0 18:19:10 INFO - Browser initialized. 18:19:10 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:10 INFO - TEST-INFO | started process 3980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy6KWP2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:22 INFO - PID 3980 | RSS: Main: 155258880 18:19:22 INFO - PID 3980 | 18:22:27 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58257/tests/dromaeo/cssquery-ext.html) 18:22:29 INFO - PID 3980 | RSS: Main: 163975168 18:22:29 INFO - PID 3980 | 18:24:10 INFO - PID 3980 | ************************* 18:24:10 INFO - PID 3980 | A coding exception was thrown and uncaught in a Task. 18:24:10 INFO - PID 3980 | 18:24:10 ERROR - PID 3980 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:24:10 INFO - PID 3980 | Full stack: 18:24:10 INFO - PID 3980 | ************************* 18:25:31 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-ext.html (next: http://localhost:58257/tests/dromaeo/cssquery-jquery.html) 18:25:32 INFO - PID 3980 | RSS: Main: 160788480 18:25:32 INFO - PID 3980 | 18:28:34 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58257/tests/dromaeo/cssquery-mootools.html) 18:28:34 INFO - PID 3980 | RSS: Main: 168628224 18:28:34 INFO - PID 3980 | 18:31:36 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58257/tests/dromaeo/cssquery-prototype.html) 18:31:37 INFO - PID 3980 | RSS: Main: 160198656 18:31:37 INFO - PID 3980 | 18:34:40 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58257/tests/dromaeo/cssquery-yui.html) 18:34:40 INFO - PID 3980 | RSS: Main: 168464384 18:34:40 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-yui.html (next: http://localhost:58257/tests/dromaeo/cssquery-dojo.html) 18:37:43 INFO - PID 3980 | RSS: Main: 163938304 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | __start_tp_report 18:37:43 INFO - PID 3980 | _x_x_mozilla_page_load 18:37:43 INFO - PID 3980 | _x_x_mozilla_page_load_details 18:37:43 INFO - PID 3980 | |i|pagename|runs| 18:37:43 INFO - PID 3980 | |0;dojo.html;2671.3188137025054;2697.95953060704;2715.9815069348992;2743.3141714571357;2751.9174424767266;5013.724245166514;5078.923816142761;5097.133487307157;5122.257272695457;5143.7685304161305;5049.722265275408;5056.701803467051;5121.871953201172;5138.743062846861;5197.948020519793;4621.237495813187;4685.60172385346;4687.484376718558;4695;4698.530146985308;4664.113818374515;4683.367745354385;4709.0581883623245;4737.313089602006;4782.354382158399;4619.3763841881255;4657.930131048037;4667.719936803803;4670.299455081731;4685.344051832746;4631.884202894921;4632.143053535106;4644.907101857978;4690.742009189493;4690.7654617269;4556.3621093047;4599.908001839978;4608.9308660370125;4611.354410382549;4657.4876763555985;5007.899842003176;5044.192929131358;5053.6967781932835;5056.014077254937;5081.618878584121;5358.732063396854;5411.702356370398;5459.426760190163;5467.015937131315;5475.315585551806;5484.095124304525;5486.451354864482;5487.780488780444;5487.862803429906;5494.36814766303;5081.695098294114;5090.974545127251;5102.821401250939;5109.821156259513;5134.7946082156295;5419.376771671308;5551.111822108443;5576.191452239403;5704.229928959538;5711.571632127607;5292.867678308073;5365.141577347606;5389.51494365509;5444.700541470178;5447.428020057837;5422.349318081855;5432.48391402824;5434.266374039454;5485.50630443262;5537.252470916455;5388.08402571556;5396.784128634889;5399.37907140676;5404.270423492857;5462.7268636568015;5344.091504444254;5410.864728381822;5439.619226654176;5465;5506.834794956158;4651.139539185261;4658.34783130362;4667.089917466062;4689.929651055237;4703;4000.8199631016673;4005.839766409369;4010.3382941814857;4024.436578878959;4039.7576145431367;4655.045715628288;4701.694389864648;4714.434267887876;4744.976275118603;4805.231163013901;5544.0575102232715;5546.69493177871;5551.972885016285;5572.498475137257;5600.915986260209;4737.502562230985;4753.120672675566;4768.785404656799;4771.141194584939;4811.9518804812205;4867.488913664085;4911.607071434277;4916.287138364989;4964.478729733398;4968.950310496921;5077.8730531737;5120.283160357479;5141.53726164647;5141.71720555373;5141.742912854417;5490.972545137249;5494.36814766307;5502.0921547944145;5503.3395992481155;5513.972430137824;5095.388553373471;5121.667091639031;5122.923156152735;5124.769385377593;5138.76875540609;5390.595705322038;5409.053415652324;5430.755615997368;5441.129419292894;5485.424030476902;5506.724663766716;5537.280153580009;5538.141588053858;5543.1408131739645;5565.805196818092;5187.948120518747;5225.033368826779;5293.788248470018;5296.523312901857;5299.5230429261555;5201.349831271091;5221.008008478377;5224.843254702213;5278.577713782965;5309.415964243853;5135.075686376488;5189.065968125774;5205.609579281645;5242.161254199463;5253.369595648546;5329.200619907045;5330.680159190461;5335.439778823167;5335.519803217729;5346.652467589594;5110.66780659256;5169.974150129226;5178.8964220716125;5203.765830537711;5204.401493828107 18:37:43 INFO - PID 3980 | |1;ext.html;609.5580703989608;653.7352372289222;672.3847679373372;845.6363763581658;851.7913111287736;33271.66728332716;34028.82985585069;34040.31919361611;34055.82972085139;34134.317313653715;31061.378772424538;31410.528842067386;31624.73501059955;33435.49846752301;33538.8323058385;6126.938730612693;8926.330525210602;9115.179633832953;9120.224780893632;9128.58921348541;9056.592453339616;9137.177654011137;9195.402298850553;9198.356115071947;9209.585568649427;9329.160375566198;9381.81236375272;9419.152276295132;9423.528823558829;9438.197753190987;9282.76793080175;9337.533123343874;9344.859827102599;9347.112024357675;9349.672761453385;9118.72031992002;9271.165595096407;9279.721608351692;9281.443113413217;9299.72100836976;34188.48717269243;34223.6577634223;34235.144121396916;34264.828675856465;34415.82792086049;3296.4890441981292;3354.0440974322446;3354.37943980362;3379.5805761580195;3444.397230484655;24332.756672433225;24598.262052138463;24667.87666061658;24855.62716559253;25111.121110761218;3100.193949573105;3224.7581431392505;3237.038947639938;3246.383187194449;3272.5745653065187;113306.43346783213;113988;151816;153223;153967.23016384846;38217.235655286735;38733.41899871448;38819.2236155281;38865.61134388676;38890.22219555593;40589;40590.18819623591;40685.79657101695;40686.38970415446;40770.38844417336;12049.81925271104;12167.148299619119;12226.20529665569;12236.81644775329;12253.142280040312;9678.516074196403;9835.803283934281;9870.753231169134;9883.308168428284;9921.355111917703;13402.664933376744;13490.976353547047;13574.185548867099;13589.796153057712;13658.317084145952;5439.265699130567;5475.206095116186;5535.474129957647;5559.972200139055;5597.557502136238;807.567951146134;833.1044127562894;834.1450013735969;834.2700137379793;862.3101518784947;22779.658305125435;23862.16482423107;24102.15642452506;24140.275791726275;24229;889.5996801439378;891.7101941868918;918.5223683684446;919.5448253114618;920.1672486399685;12503.124781265406;12602.936985315015;12661;12744.61766147017;12870.549530766379;219730;220619;220835;221008;221568;42717.786411068366;43069.13861722748;43141;43233.35149972753;43245.567544324156;1152.3201311226417;1187.7565099154826;1189.8691143974156;1191.1602320364295;1330.7737684593642;22223.777762222817;22485.775142248367;23389;23666.526669466857;23679.52640947206;30945;30995.69004309928;31015.844920775253;31016.68983310138;31033.379332412773;214828;214948;215578;215799;216641;27528.587071193546;27652.446951060465;27872;28981.565276520447;29093.12720618385;35577.46633800443;36090.63909360978;36207.45688814722;36272.637273626926;36840.44739328966;29906.551401728557;30981.380372392876;31334.686653133176;31920;32073.35853282968;30042.54936176003;30191.849040754656;30338.241543961576;30621;31246;29262.70737292685;29553.85223073871;29554;29703.554446682883;30257.24356891095;26141.73858261393;26611.866940665946;27118;27288.181354559394;27694.584581230894;21468.78531214668;21510.247141349977;21514.139434423072;21729.456763581038;21763.891180543997 18:37:43 INFO - PID 3980 | |2;jquery.html;366.43020103738695;380.7449009163861;389.2623478508227;401.27169187923914;403.85663089603173;17291.135443227835;18593.25626974921;18791;18875.811241887575;18889.811101888994;17259.137043147824;17283.654326913453;17867.409225662304;18720.90639546804;18820.811791882075;5576.247206627114;5777.537796976232;5816.214811000525;5825.213596164527;5826.543364158961;5565.860853478675;5782.653040817543;5789.189513468097;5794.478496935275;5801.970990145043;5597.216389705424;5751.309842818868;5785.305763308409;5817.1565123057135;5818.941810581903;5638.718064096779;5741.942580574183;5743.4543718346895;5747.2528571285675;5747.885042299131;5527.640703354309;5550.639208451437;5573.6098473106895;5606.299212598426;5613.045782216992;21018.684719729215;21153.894230528902;21161.15355385783;21279.361619151452;21284;2284.4060544258614;2303.5623231585946;2309.6073667476403;2345.5074434368803;2351.353377821113;13452.798208026887;13831.308434578332;14085.85914140866;14375.137491750529;14655.487057953027;1834.1287888253107;1912.1586501939241;1919.0692514130635;1924.8171423714725;1926.268018153093;75732.62133689351;84326;84362.57818710929;84698;85105.14894851034;16172.433964811175;16325.673486530202;16505.504834854975;16834.24245908937;16998.745018824728;28620.856895715388;28663.283417914718;28720.425591488052;28734.281642959093;28742.281442963675;7375.852482950419;7444.664990075459;7522.097348318237;7622.161562228151;7692.7692169235015;5914.9704251479325;5931.288245410578;6062.060380641008;6081.665508396992;6082.330943596201;8697.565121744014;9061.41100828444;9157.95421022904;9286.72139835806;9345.439273643604;3747.4191500317493;3834.328992426314;3898.6296301851844;3917.471141395932;3935.4293627423863;794.1859593916282;827.606886728799;829.9336053115736;830.7466222802103;852.0754980845728;17751;18643.720344194848;18917.337893173673;19000.926728647893;19281.22875085009;820.796162304215;827.2513375395276;836.677879016583;840.1010918317342;842.2630198576246;10004.19966402686;11471.4264286787;11474.36890970988;11499.942500287445;11900;445553;461830;469988;472870;474304;86225.56887215524;87227;88302.55848720715;92364.53817730868;93067.53466232626;1116.7319843237726;1139.3847322445952;1190.4464424042862;1193.9701507462382;1199.0527483288279;17521.474355769347;17735.46793596194;18331.45005649833;18452.169652365406;18636;41934.790326048176;42335;42735.57264427316;42799.7860010698;42895.35656965086;53546.73226633842;53662.73168634132;53989.19016214681;54681;55863;10342.017508336696;10514.371407148214;10563.894361056291;10903.492196794623;11741.354225517336;12676.176048557183;12792;12924.806127908278;12962.805557916827;13247.271400072703;10799.622013229498;10899.400532970763;10906.454677266263;11295.830562541403;11354.148438867283;10218.489075546342;10379.948100259451;10449.477526123512;10495.52770125331;10574.577016919236;10463.48876269705;10625.149988001096;10649.201309901633;10708.89291107079;11409.31544107323;10433.895661043292;10849.26059401019;10849.294795838245;11122.777544449227;11547;11124.666260012213;11533.942330288295;11587.710307242049;11652.708682283012;11692.590759323382 18:37:43 INFO - PID 3980 | |3;mootools.html;1462.3784891421144;1465.2746890289309;1471.176141360838;1500.0924440713368;1543.0587341721548;7830.725924592626;8043.758687239392;8873.55632218389;9282.907170928298;9288.21050210732;8890.86663700045;9211.861822072657;9221.446713197196;9237.722868313944;9248.352615316931;2038.2254743197564;2067.4107879254416;2069.8033686799804;2073.150008496517;2075.0973326602902;2003.7996200379919;2050.692396140576;2051.6922461630725;2058.0327246194265;2062.5874825035053;1971.5662554238045;1978.0900785638623;1978.8911609861523;2001.8999050047512;2004.5790384019374;1966.9311574094909;1967.7540307461638;1977.5056235941015;1978.1592823050146;1981.960360792776;1954.7458830352105;1987.7415935928382;2001.729766481521;2003.328884823586;2012.8590998630102;9433.528323583861;9458.763530911783;9471.194948429391;9504.904950950471;9527.571259293349;4384.188925048876;4528.41130653013;4559.156556037144;4577.176108300505;4585.197590421662;2504.962425563618;2618.581027035665;2647.8543680097587;2666.919992400231;2737.219892330696;930.1814403325099;956.5073986896754;958.8945216026232;974.5517062151418;978.6232300564263;12754;12754.48982040708;12816;12816.102872798907;12853.421596028202;3707.4253490708984;3797.7911214882893;3876.2247550490015;3877.3214687429586;4019.6181362771076;11102;11128.054115400282;11178.27341222818;11191.2725672831;11199.776004479865;4546.977265113719;4547.499775024745;4565.543445655408;4573.108243892409;4576.130535198302;3276;3393.745469089828;4058.3912413137673;4213.346931225665;4227.048913994388;3392.3384939936477;3421.8289085545625;3515.2969406118877;3520.3135388598976;3544.096255454894;958.6117622362954;982.2976571751232;998.1266391907081;1000.4697510319543;1002.4436437777103;687.1376422589718;696.1298377028714;696.3837004251274;709.5671640299413;726.393461459687;5543;5562.440038375443;5605.243292155588;5616.831495055155;5790.536757059425;869.3132425384002;870.3950754225879;882.7307671160357;885.6678745470449;902.6389444222364;3464.359093567698;3508.9122771930397;3517.525134106914;3538.8230588470474;3587.1749497615174;10886.72783180411;11371.54513819438;11378.31730096197;11525.942370288094;11573.537058517564;11336.093112550976;11356.205065645325;11432.942835285936;11457.427128643534;11620.65138045843;8435.325173986066;8495.617697203641;8557.914420855835;8638.179372959685;8672;5495.53287970527;5520.834374968757;5648.548116150616;5722.430816298203;5725.742341594721;9864.654737084167;10182.338148020355;10239.641612543524;10271.229657775846;10367.27429079957;10347.12049475803;10464.686059418229;10528.99974502421;10546.789064218827;10669.41318227505;7695.846083078419;7772.883406748791;7778.572178530235;7814.179511151475;7840.3335716464735;8526.488410695378;8545.060043395097;8599.14008599135;8618.913810861812;8625.396222264631;7766.145723970471;7893.723719669784;7904.762857114296;8045.275925166763;8141.674333026849;7590.886136707843;7601.429892758176;7660.387169026576;7703.3067023968115;7809.570473624005;6868.210155832143;6883.174019117738;6943.27095654949;7001.299870012958;7039.436845052486;5246.763895624782;5273.050850846885;5329.173978033411;5433.8369848904595;5525.370015845255;4856.1987272099705;4905.313256144214;4933.939203071357;4939.802407903788;5030.798768049237 18:37:43 INFO - PID 3980 | |4;prototype.html;345.8478269561393;349.0349184504844;356.97679650822687;357.60306060273075;358.85287032316756;5202.800277829137;5379.166229234465;5417.916416716657;5475.78096876125;5497.972510137453;5157.432682404942;5312.4687531246855;5358.4641535846395;5369.140937450009;5424.566034717223;4619.607333376667;4626.791794369245;4626.8380606678775;4627.421572303462;4652.488226295105;4535.183666939949;4562.9771851140695;4629.3518907353;4655.44134703836;4666.533346665324;4585.28928016158;4590.517995610463;4606.654500912428;4609.631229501649;4618.838340658078;4608.654350923694;4617.6536759742985;4622.375979242793;4631.2126938420215;4632.698874573142;4361.367601697736;4382.298832186867;4387.1445068211715;4459;4479.39528163697;5239.895202095937;5244.003639308519;5270.446603106657;5298.841034768963;5303.28405665238;5427.1316589345515;5434.728263586805;5442.666546696085;5445.101558242885;5451.972740136274;5652.74562644682;5693.010088121558;5730.656160630334;5754.97122514389;5806.82579522615;4871.3667223260745;4897.902041959176;4900.705957642553;4911.5088491150955;4925.482824303468;5704.857378565569;5817.156512305734;5867.677277749722;6064.211652485193;6087.634741915499;5080.974595127074;5104.719240441811;5112.744362781846;5114.693118412907;5117.385913690307;5196.32447781786;5199.506046925536;5247.344081989751;5250.107481728115;5251.947480525222;5307.601929855199;5354.732263386893;5360.249565060894;5400.270963419888;5414;5674.2623458950075;5695.145728140812;5706.115552089433;5713.914291285634;5725.971370143123;1589.3324803582523;1804.1790985101748;1825.3428765644358;1835.4126679462445;1838.7333836593618;1214.9878501214876;1218.214251807579;1269.6191142657167;1275.7688830278826;1286.2475451860766;4921.8523444296015;4930.950690493121;4952.529509696573;4958.528939750718;4977.1538838397555;5832;5854.887571361428;5857.297124345106;5860.472557469848;5871.55963302754;4722.88192795176;4911.3369695090705;4954.157793175169;4963.230699241623;5009.5491405773655;3098.2254436390904;3112.128603990886;3121.843907804601;3126.390353881017;3126.45287074761;5430.5927055471;5431.5926305526455;5432.212329212242;5439.972800136054;5454.91817622736;5699.943000569941;5981.850453738692;6010.497375656086;6048.6673232971725;6057.242844644419;5480.671159730429;5484.753186106715;5486.835394938158;5493.23094766733;5506.659669640387;5775.9133612996675;5890.941090589211;5909.172715819703;5911;5944.910826337695;5609.06487261894;5755.1367294906095;5782;5794.101914203306;5806.912896306643;5439.48324909133;5470.562355011669;5481.561475082063;5502.669839809624;5523.7238138093735;4680.251159814414;4713.269443236304;4727.101850648366;4731.266653668687;4738.905221895612;5706.42935706426;5858.882822343615;5896.941030589639;5904.439078287556;5907.852303692442;5610.354809196994;5615.129654903497;5622.606417550732;5626.971865140648;5634.394197653649;5429.104197807317;5596.244506991667;5622.915656265078;5639.802606908903;5642.576806739593;5507.311586051744;5522.861928451821;5537.335519737658;5547.1679248113105;5550.361708403585;5705.4009329019855;5728.828135155952;5731.455511726379;5732.254806875079;5733.531213615703;5395.757190926496;5510.586705997146;5524.613277070566;5559.16612508127;5567.916481252865 18:37:43 INFO - PID 3980 | |5;yui.html;620.8230654263535;699.7375984005997;750.6959681329062;758.5448730761548;766.946313758037;12259.693507662312;12781.680457988543;12823;12842;12862.549810756625;11982;11999;12003.759924801521;12077.637670869888;12078.758424831498;817.468645380503;827.2926647716206;841.5792103948025;862.874883141944;869.952152631605;852.6589364254316;855.6748435594496;859.2395729779128;859.9914000859974;871.2376670413388;882.1046637662778;887.6316328723605;888.0231745080392;890.1321211818457;902.3277658144658;901.8376692195402;902.3232575568323;902.3548163063408;903.3902116071658;905.0090151284334;651.1437459740473;658.2430205263937;658.8748137853793;664.7872680742164;665.1685393258427;13345.466181352735;13442.529511467052;13494.257815820127;13502.527411540646;13512.729745405037;13535.661608459768;13903.652408689763;14142.717145657132;14155.292235388293;14258.28708564578;10633.989770971746;10702.090322322534;10732.892671073267;11004.339739615649;11063.612773552886;3062.1579065757096;3110.28463453407;3114.408262430131;3114.5172498262805;3229.273413481971;64533.35466645368;64562.3543764561;65262.673686631264;66005.33994660089;66531.334686653;9622.51887405641;9634.910562011622;9653.22774178064;9750.219982401391;9833.360831545926;19572.608547828964;19608;19608;19636.41090767279;19637.80362196388;6415.26224484181;6491.123698300669;6544.803655890331;6795.286494918061;6823.522353435212;3222.581064461605;3256.2185075582165;3292.6707329266883;3328.3509715605223;3337.466005439118;2812.2688101093454;2831.4620222157723;2853.885844566236;2856.5429531274895;2870.641169853768;456.63925498856196;460.5854730742359;460.83179639431364;467.2267397457214;470.9740964246931;564.2495481010328;584.7894957062312;587.5006244692063;590.9586328957017;607.4684650930436;8331.66673333072;8393.244607985189;8467.915320846836;8678.6962456315;8782.033976262606;596.8418369132183;613.9877202456015;624;626.5520153090562;632.099258556555;4146.3365861462025;4333.848315309012;4343.478782546114;4397.802098905557;4457.77711114443;49279;62534.68732656308;63136.368636313964;63154.68422657949;65088.67455662692;46182.538174618494;47720.5227947723;49815.75092124516;49841;51507.22739158916;46176;46209.5379046212;46282.537174627825;46745.29882051772;48050.5194948053;8434.587590331423;8957.075921219688;9234.122758337948;9241.353105282566;9435.52822358893;32387.35225295528;32842;32939.341213175125;33517.32965340728;34150.31699366048;37932.24135517219;38383.23233535369;38517.229655406176;39361.40957885691;39519.407208892466;11121;11204.887951120385;11269.605563805228;11447;11695.356755378536;12704.174228675107;12873.485060597472;12902.548410805577;12948.870511294766;12961.481540738265;11916.165868389477;12280.631581052583;12384.133110682526;12655.240685558896;13099.869001310246;12009.579664711693;12206.267623942593;12254.87745122573;12829.358532073173;12850.35748212567;11581.942090289494;11771.705707357385;11957.402129893297;12058;12058.457369418222;9781.41311521311;10272.589096436059;10364.092844171222;10713.410762408143;10725.89274107249;8723.52020638871;9823.424784124883;10070.798584028425;10072.647457338959;10137.391756494633 18:37:43 INFO - PID 3980 | __end_tp_report 18:37:43 INFO - PID 3980 | __start_cc_report 18:37:43 INFO - PID 3980 | _x_x_mozilla_cycle_collect,388 18:37:43 INFO - PID 3980 | __end_cc_report 18:37:43 INFO - PID 3980 | __startTimestamp1490060263938__endTimestamp 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | ------- Summary: start ------- 18:37:43 INFO - PID 3980 | Number of tests: 6 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#0] dojo.html Cycles:165 Average:5036.64 Median:5141.54 stddev:550.00 (10.7%) stddev-sans-first:519.45 18:37:43 INFO - PID 3980 | Values: 2671.3 2698.0 2716.0 2743.3 2751.9 5013.7 5078.9 5097.1 5122.3 5143.8 5049.7 5056.7 5121.9 5138.7 5197.9 4621.2 4685.6 4687.5 4695.0 4698.5 4664.1 4683.4 4709.1 4737.3 4782.4 4619.4 4657.9 4667.7 4670.3 4685.3 4631.9 4632.1 4644.9 4690.7 4690.8 4556.4 4599.9 4608.9 4611.4 4657.5 5007.9 5044.2 5053.7 5056.0 5081.6 5358.7 5411.7 5459.4 5467.0 5475.3 5484.1 5486.5 5487.8 5487.9 5494.4 5081.7 5091.0 5102.8 5109.8 5134.8 5419.4 5551.1 5576.2 5704.2 5711.6 5292.9 5365.1 5389.5 5444.7 5447.4 5422.3 5432.5 5434.3 5485.5 5537.3 5388.1 5396.8 5399.4 5404.3 5462.7 5344.1 5410.9 5439.6 5465.0 5506.8 4651.1 4658.3 4667.1 4689.9 4703.0 4000.8 4005.8 4010.3 4024.4 4039.8 4655.0 4701.7 4714.4 4745.0 4805.2 5544.1 5546.7 5552.0 5572.5 5600.9 4737.5 4753.1 4768.8 4771.1 4812.0 4867.5 4911.6 4916.3 4964.5 4969.0 5077.9 5120.3 5141.5 5141.7 5141.7 5491.0 5494.4 5502.1 5503.3 5514.0 5095.4 5121.7 5122.9 5124.8 5138.8 5390.6 5409.1 5430.8 5441.1 5485.4 5506.7 5537.3 5538.1 5543.1 5565.8 5187.9 5225.0 5293.8 5296.5 5299.5 5201.3 5221.0 5224.8 5278.6 5309.4 5135.1 5189.1 5205.6 5242.2 5253.4 5329.2 5330.7 5335.4 5335.5 5346.7 5110.7 5170.0 5178.9 5203.8 5204.4 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#1] ext.html Cycles:180 Average:33696.48 Median:3241.71 stddev:50618.96 (1561.5%) stddev-sans-first:50699.99 18:37:43 INFO - PID 3980 | Values: 609.6 653.7 672.4 845.6 851.8 33271.7 34028.8 34040.3 34055.8 34134.3 31061.4 31410.5 31624.7 33435.5 33538.8 6126.9 8926.3 9115.2 9120.2 9128.6 9056.6 9137.2 9195.4 9198.4 9209.6 9329.2 9381.8 9419.2 9423.5 9438.2 9282.8 9337.5 9344.9 9347.1 9349.7 9118.7 9271.2 9279.7 9281.4 9299.7 34188.5 34223.7 34235.1 34264.8 34415.8 3296.5 3354.0 3354.4 3379.6 3444.4 24332.8 24598.3 24667.9 24855.6 25111.1 3100.2 3224.8 3237.0 3246.4 3272.6 113306.4 113988.0 151816.0 153223.0 153967.2 38217.2 38733.4 38819.2 38865.6 38890.2 40589.0 40590.2 40685.8 40686.4 40770.4 12049.8 12167.1 12226.2 12236.8 12253.1 9678.5 9835.8 9870.8 9883.3 9921.4 13402.7 13491.0 13574.2 13589.8 13658.3 5439.3 5475.2 5535.5 5560.0 5597.6 807.6 833.1 834.1 834.3 862.3 22779.7 23862.2 24102.2 24140.3 24229.0 889.6 891.7 918.5 919.5 920.2 12503.1 12602.9 12661.0 12744.6 12870.5 219730.0 220619.0 220835.0 221008.0 221568.0 42717.8 43069.1 43141.0 43233.4 43245.6 1152.3 1187.8 1189.9 1191.2 1330.8 22223.8 22485.8 23389.0 23666.5 23679.5 30945.0 30995.7 31015.8 31016.7 31033.4 214828.0 214948.0 215578.0 215799.0 216641.0 27528.6 27652.4 27872.0 28981.6 29093.1 35577.5 36090.6 36207.5 36272.6 36840.4 29906.6 30981.4 31334.7 31920.0 32073.4 30042.5 30191.8 30338.2 30621.0 31246.0 29262.7 29553.9 29554.0 29703.6 30257.2 26141.7 26611.9 27118.0 27288.2 27694.6 21468.8 21510.2 21514.1 21729.5 21763.9 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#2] jquery.html Cycles:180 Average:28894.13 Median:28642.07 stddev:76646.36 (267.6%) stddev-sans-first:76831.44 18:37:43 INFO - PID 3980 | Values: 366.4 380.7 389.3 401.3 403.9 17291.1 18593.3 18791.0 18875.8 18889.8 17259.1 17283.7 17867.4 18720.9 18820.8 5576.2 5777.5 5816.2 5825.2 5826.5 5565.9 5782.7 5789.2 5794.5 5802.0 5597.2 5751.3 5785.3 5817.2 5818.9 5638.7 5741.9 5743.5 5747.3 5747.9 5527.6 5550.6 5573.6 5606.3 5613.0 21018.7 21153.9 21161.2 21279.4 21284.0 2284.4 2303.6 2309.6 2345.5 2351.4 13452.8 13831.3 14085.9 14375.1 14655.5 1834.1 1912.2 1919.1 1924.8 1926.3 75732.6 84326.0 84362.6 84698.0 85105.1 16172.4 16325.7 16505.5 16834.2 16998.7 28620.9 28663.3 28720.4 28734.3 28742.3 7375.9 7444.7 7522.1 7622.2 7692.8 5915.0 5931.3 6062.1 6081.7 6082.3 8697.6 9061.4 9158.0 9286.7 9345.4 3747.4 3834.3 3898.6 3917.5 3935.4 794.2 827.6 829.9 830.7 852.1 17751.0 18643.7 18917.3 19000.9 19281.2 820.8 827.3 836.7 840.1 842.3 10004.2 11471.4 11474.4 11499.9 11900.0 445553.0 461830.0 469988.0 472870.0 474304.0 86225.6 87227.0 88302.6 92364.5 93067.5 1116.7 1139.4 1190.4 1194.0 1199.1 17521.5 17735.5 18331.5 18452.2 18636.0 41934.8 42335.0 42735.6 42799.8 42895.4 53546.7 53662.7 53989.2 54681.0 55863.0 10342.0 10514.4 10563.9 10903.5 11741.4 12676.2 12792.0 12924.8 12962.8 13247.3 10799.6 10899.4 10906.5 11295.8 11354.1 10218.5 10379.9 10449.5 10495.5 10574.6 10463.5 10625.1 10649.2 10708.9 11409.3 10433.9 10849.3 10849.3 11122.8 11547.0 11124.7 11533.9 11587.7 11652.7 11692.6 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#3] mootools.html Cycles:180 Average:5702.32 Median:4562.35 stddev:3597.76 (78.9%) stddev-sans-first:3593.75 18:37:43 INFO - PID 3980 | Values: 1462.4 1465.3 1471.2 1500.1 1543.1 7830.7 8043.8 8873.6 9282.9 9288.2 8890.9 9211.9 9221.4 9237.7 9248.4 2038.2 2067.4 2069.8 2073.2 2075.1 2003.8 2050.7 2051.7 2058.0 2062.6 1971.6 1978.1 1978.9 2001.9 2004.6 1966.9 1967.8 1977.5 1978.2 1982.0 1954.7 1987.7 2001.7 2003.3 2012.9 9433.5 9458.8 9471.2 9504.9 9527.6 4384.2 4528.4 4559.2 4577.2 4585.2 2505.0 2618.6 2647.9 2666.9 2737.2 930.2 956.5 958.9 974.6 978.6 12754.0 12754.5 12816.0 12816.1 12853.4 3707.4 3797.8 3876.2 3877.3 4019.6 11102.0 11128.1 11178.3 11191.3 11199.8 4547.0 4547.5 4565.5 4573.1 4576.1 3276.0 3393.7 4058.4 4213.3 4227.0 3392.3 3421.8 3515.3 3520.3 3544.1 958.6 982.3 998.1 1000.5 1002.4 687.1 696.1 696.4 709.6 726.4 5543.0 5562.4 5605.2 5616.8 5790.5 869.3 870.4 882.7 885.7 902.6 3464.4 3508.9 3517.5 3538.8 3587.2 10886.7 11371.5 11378.3 11525.9 11573.5 11336.1 11356.2 11432.9 11457.4 11620.7 8435.3 8495.6 8557.9 8638.2 8672.0 5495.5 5520.8 5648.5 5722.4 5725.7 9864.7 10182.3 10239.6 10271.2 10367.3 10347.1 10464.7 10529.0 10546.8 10669.4 7695.8 7772.9 7778.6 7814.2 7840.3 8526.5 8545.1 8599.1 8618.9 8625.4 7766.1 7893.7 7904.8 8045.3 8141.7 7590.9 7601.4 7660.4 7703.3 7809.6 6868.2 6883.2 6943.3 7001.3 7039.4 5246.8 5273.1 5329.2 5433.8 5525.4 4856.2 4905.3 4933.9 4939.8 5030.8 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#4] prototype.html Cycles:180 Average:4917.50 Median:5407.14 stddev:1286.29 (23.8%) stddev-sans-first:1243.29 18:37:43 INFO - PID 3980 | Values: 345.8 349.0 357.0 357.6 358.9 5202.8 5379.2 5417.9 5475.8 5498.0 5157.4 5312.5 5358.5 5369.1 5424.6 4619.6 4626.8 4626.8 4627.4 4652.5 4535.2 4563.0 4629.4 4655.4 4666.5 4585.3 4590.5 4606.7 4609.6 4618.8 4608.7 4617.7 4622.4 4631.2 4632.7 4361.4 4382.3 4387.1 4459.0 4479.4 5239.9 5244.0 5270.4 5298.8 5303.3 5427.1 5434.7 5442.7 5445.1 5452.0 5652.7 5693.0 5730.7 5755.0 5806.8 4871.4 4897.9 4900.7 4911.5 4925.5 5704.9 5817.2 5867.7 6064.2 6087.6 5081.0 5104.7 5112.7 5114.7 5117.4 5196.3 5199.5 5247.3 5250.1 5251.9 5307.6 5354.7 5360.2 5400.3 5414.0 5674.3 5695.1 5706.1 5713.9 5726.0 1589.3 1804.2 1825.3 1835.4 1838.7 1215.0 1218.2 1269.6 1275.8 1286.2 4921.9 4931.0 4952.5 4958.5 4977.2 5832.0 5854.9 5857.3 5860.5 5871.6 4722.9 4911.3 4954.2 4963.2 5009.5 3098.2 3112.1 3121.8 3126.4 3126.5 5430.6 5431.6 5432.2 5440.0 5454.9 5699.9 5981.9 6010.5 6048.7 6057.2 5480.7 5484.8 5486.8 5493.2 5506.7 5775.9 5890.9 5909.2 5911.0 5944.9 5609.1 5755.1 5782.0 5794.1 5806.9 5439.5 5470.6 5481.6 5502.7 5523.7 4680.3 4713.3 4727.1 4731.3 4738.9 5706.4 5858.9 5896.9 5904.4 5907.9 5610.4 5615.1 5622.6 5627.0 5634.4 5429.1 5596.2 5622.9 5639.8 5642.6 5507.3 5522.9 5537.3 5547.2 5550.4 5705.4 5728.8 5731.5 5732.3 5733.5 5395.8 5510.6 5524.6 5559.2 5567.9 18:37:43 INFO - PID 3980 | 18:37:43 INFO - PID 3980 | [#5] yui.html Cycles:180 Average:14207.31 Median:4427.79 stddev:17033.63 (384.7%) stddev-sans-first:17050.86 18:37:43 INFO - PID 3980 | Values: 620.8 699.7 750.7 758.5 766.9 12259.7 12781.7 12823.0 12842.0 12862.5 11982.0 11999.0 12003.8 12077.6 12078.8 817.5 827.3 841.6 862.9 870.0 852.7 855.7 859.2 860.0 871.2 882.1 887.6 888.0 890.1 902.3 901.8 902.3 902.4 903.4 905.0 651.1 658.2 658.9 664.8 665.2 13345.5 13442.5 13494.3 13502.5 13512.7 13535.7 13903.7 14142.7 14155.3 14258.3 10634.0 10702.1 10732.9 11004.3 11063.6 3062.2 3110.3 3114.4 3114.5 3229.3 64533.4 64562.4 65262.7 66005.3 66531.3 9622.5 9634.9 9653.2 9750.2 9833.4 19572.6 19608.0 19608.0 19636.4 19637.8 6415.3 6491.1 6544.8 6795.3 6823.5 3222.6 3256.2 3292.7 3328.4 3337.5 2812.3 2831.5 2853.9 2856.5 2870.6 456.6 460.6 460.8 467.2 471.0 564.2 584.8 587.5 591.0 607.5 8331.7 8393.2 8467.9 8678.7 8782.0 596.8 614.0 624.0 626.6 632.1 4146.3 4333.8 4343.5 4397.8 4457.8 49279.0 62534.7 63136.4 63154.7 65088.7 46182.5 47720.5 49815.8 49841.0 51507.2 46176.0 46209.5 46282.5 46745.3 48050.5 8434.6 8957.1 9234.1 9241.4 9435.5 32387.4 32842.0 32939.3 33517.3 34150.3 37932.2 38383.2 38517.2 39361.4 39519.4 11121.0 11204.9 11269.6 11447.0 11695.4 12704.2 12873.5 12902.5 12948.9 12961.5 11916.2 12280.6 12384.1 12655.2 13099.9 12009.6 12206.3 12254.9 12829.4 12850.4 11581.9 11771.7 11957.4 12058.0 12058.5 9781.4 10272.6 10364.1 10713.4 10725.9 8723.5 9823.4 10070.8 10072.6 10137.4 18:37:43 INFO - PID 3980 | -------- Summary: end -------- 18:37:43 INFO - PID 3980 | 18:37:44 INFO - TEST-INFO | 3980: exit 0 18:37:44 INFO - TEST-OK | dromaeo_css | took 1121098ms 18:37:44 INFO - TEST-START | kraken 18:37:44 INFO - operating with platform_type : linux_ 18:37:44 INFO - Initialising browser for kraken test... 18:37:44 INFO - TEST-INFO | started process 4354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppwkPr4/profile http://localhost:58257/getInfo.html) 18:37:49 INFO - PID 4354 | __metrics Screen width/height:1600/1200 18:37:49 INFO - PID 4354 | colorDepth:24 18:37:49 INFO - PID 4354 | Browser inner width/height: 1024/697 18:37:49 INFO - PID 4354 | __metrics 18:37:50 ERROR - PID 4354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 18:37:51 INFO - TEST-INFO | 4354: exit 0 18:37:51 INFO - Browser initialized. 18:37:51 INFO - Running cycle 1/1 for kraken test... 18:37:51 INFO - TEST-INFO | started process 4486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppwkPr4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:03 INFO - PID 4486 | RSS: Main: 155353088 18:38:03 INFO - PID 4486 | 18:38:06 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:07 INFO - PID 4486 | RSS: Main: 161107968 18:38:07 INFO - PID 4486 | 18:38:09 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-dft) 18:38:10 INFO - PID 4486 | RSS: Main: 160616448 18:38:10 INFO - PID 4486 | 18:38:13 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-fft) 18:38:14 INFO - PID 4486 | RSS: Main: 156979200 18:38:14 INFO - PID 4486 | 18:38:16 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator) 18:38:16 INFO - PID 4486 | RSS: Main: 157728768 18:38:16 INFO - PID 4486 | 18:38:19 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:19 INFO - PID 4486 | RSS: Main: 158326784 18:38:19 INFO - PID 4486 | 18:38:22 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:23 INFO - PID 4486 | RSS: Main: 163299328 18:38:23 INFO - PID 4486 | 18:38:27 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:27 INFO - PID 4486 | RSS: Main: 160784384 18:38:27 INFO - PID 4486 | 18:38:30 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial) 18:38:31 INFO - PID 4486 | RSS: Main: 161742848 18:38:31 INFO - PID 4486 | 18:38:33 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:33 INFO - PID 4486 | RSS: Main: 162406400 18:38:33 INFO - PID 4486 | 18:38:35 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:36 INFO - PID 4486 | RSS: Main: 162246656 18:38:36 INFO - PID 4486 | 18:38:38 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:39 INFO - PID 4486 | RSS: Main: 162623488 18:38:39 INFO - PID 4486 | 18:38:42 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:42 INFO - PID 4486 | RSS: Main: 162844672 18:38:42 INFO - PID 4486 | 18:38:46 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:46 INFO - PID 4486 | RSS: Main: 160641024 18:38:46 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58257/tests/kraken/driver.html?testName=ai-astar) 18:38:48 INFO - PID 4486 | RSS: Main: 163250176 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | __start_tp_report 18:38:48 INFO - PID 4486 | _x_x_mozilla_page_load 18:38:48 INFO - PID 4486 | _x_x_mozilla_page_load_details 18:38:48 INFO - PID 4486 | |i|pagename|runs| 18:38:48 INFO - PID 4486 | |0;ai-astar;112;124;118;118;119;119;119;119;120;119 18:38:48 INFO - PID 4486 | |1;audio-beat-detection;151;125;126;185;126;125;127;126;144;128 18:38:48 INFO - PID 4486 | |2;audio-dft;164;166;166;169;167;168;163;165;166;165 18:38:48 INFO - PID 4486 | |3;audio-fft;75;76;76;115;76;79;75;75;95;77 18:38:48 INFO - PID 4486 | |4;audio-oscillator;85;84;119;85;84;85;109;85;84;114 18:38:48 INFO - PID 4486 | |5;imaging-gaussian-blur;114;114;114;113;114;120;114;113;113;114 18:38:48 INFO - PID 4486 | |6;imaging-darkroom;152;152;155;151;151;152;150;154;152;152 18:38:48 INFO - PID 4486 | |7;imaging-desaturate;95;96;94;95;95;95;95;95;94;95 18:38:48 INFO - PID 4486 | |8;json-parse-financial;71;71;72;73;77;74;74;72;71;71 18:38:48 INFO - PID 4486 | |9;json-stringify-tinderbox;55;56;54;55;57;56;55;55;55;55 18:38:48 INFO - PID 4486 | |10;stanford-crypto-aes;83;82;85;92;84;82;83;84;86;83 18:38:48 INFO - PID 4486 | |11;stanford-crypto-ccm;136;145;135;142;134;135;141;141;190;154 18:38:48 INFO - PID 4486 | |12;stanford-crypto-pbkdf2;199;202;212;199;200;204;201;201;197;199 18:38:48 INFO - PID 4486 | |13;stanford-crypto-sha256-iterative;73;73;74;75;72;77;72;71;69;70 18:38:48 INFO - PID 4486 | __end_tp_report 18:38:48 INFO - PID 4486 | __start_cc_report 18:38:48 INFO - PID 4486 | _x_x_mozilla_cycle_collect,877 18:38:48 INFO - PID 4486 | __end_cc_report 18:38:48 INFO - PID 4486 | __startTimestamp1490060328857__endTimestamp 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | ------- Summary: start ------- 18:38:48 INFO - PID 4486 | Number of tests: 14 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#0] ai-astar Cycles:10 Average:118.70 Median:119.00 stddev:2.91 (2.4%) stddev-sans-first:1.81 18:38:48 INFO - PID 4486 | Values: 112.0 124.0 118.0 118.0 119.0 119.0 119.0 119.0 120.0 119.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:127.50 stddev:19.37 (15.2%) stddev-sans-first:19.80 18:38:48 INFO - PID 4486 | Values: 151.0 125.0 126.0 185.0 126.0 125.0 127.0 126.0 144.0 128.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:1.79 (1.1%) stddev-sans-first:1.76 18:38:48 INFO - PID 4486 | Values: 164.0 166.0 166.0 169.0 167.0 168.0 163.0 165.0 166.0 165.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.11 (17.3%) stddev-sans-first:13.67 18:38:48 INFO - PID 4486 | Values: 75.0 76.0 76.0 115.0 76.0 79.0 75.0 75.0 95.0 77.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.50 stddev:14.42 (17.1%) stddev-sans-first:14.97 18:38:48 INFO - PID 4486 | Values: 85.0 84.0 119.0 85.0 84.0 85.0 109.0 85.0 84.0 114.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:2.06 (1.8%) stddev-sans-first:2.18 18:38:48 INFO - PID 4486 | Values: 114.0 114.0 114.0 113.0 114.0 120.0 114.0 113.0 113.0 114.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:1.45 (1.0%) stddev-sans-first:1.54 18:38:48 INFO - PID 4486 | Values: 152.0 152.0 155.0 151.0 151.0 152.0 150.0 154.0 152.0 152.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:38:48 INFO - PID 4486 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.50 stddev:1.96 (2.7%) stddev-sans-first:1.99 18:38:48 INFO - PID 4486 | Values: 71.0 71.0 72.0 73.0 77.0 74.0 74.0 72.0 71.0 71.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 18:38:48 INFO - PID 4486 | Values: 55.0 56.0 54.0 55.0 57.0 56.0 55.0 55.0 55.0 55.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.95 (3.5%) stddev-sans-first:3.09 18:38:48 INFO - PID 4486 | Values: 83.0 82.0 85.0 92.0 84.0 82.0 83.0 84.0 86.0 83.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.50 stddev:16.83 (11.9%) stddev-sans-first:17.51 18:38:48 INFO - PID 4486 | Values: 136.0 145.0 135.0 142.0 134.0 135.0 141.0 141.0 190.0 154.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.40 Median:201.00 stddev:4.20 (2.1%) stddev-sans-first:4.36 18:38:48 INFO - PID 4486 | Values: 199.0 202.0 212.0 199.0 200.0 204.0 201.0 201.0 197.0 199.0 18:38:48 INFO - PID 4486 | 18:38:48 INFO - PID 4486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:2.37 (3.2%) stddev-sans-first:2.51 18:38:48 INFO - PID 4486 | Values: 73.0 73.0 74.0 75.0 72.0 77.0 72.0 71.0 69.0 70.0 18:38:48 INFO - PID 4486 | -------- Summary: end -------- 18:38:48 INFO - PID 4486 | 18:38:50 INFO - TEST-INFO | 4486: exit 0 18:38:50 INFO - TEST-OK | kraken | took 65335ms 18:38:50 INFO - SUITE-END | took 1186s 18:38:50 INFO - Completed test suite (00:19:46) 18:38:50 INFO - javascript benchmark 18:38:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6730.90957687956, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.3188137025054, 2697.95953060704, 2715.9815069348992, 2743.3141714571357, 2751.9174424767266, 5013.724245166514, 5078.923816142761, 5097.133487307157, 5122.257272695457, 5143.7685304161305, 5049.722265275408, 5056.701803467051, 5121.871953201172, 5138.743062846861, 5197.948020519793, 4621.237495813187, 4685.60172385346, 4687.484376718558, 4695.0, 4698.530146985308, 4664.113818374515, 4683.367745354385, 4709.0581883623245, 4737.313089602006, 4782.354382158399, 4619.3763841881255, 4657.930131048037, 4667.719936803803, 4670.299455081731, 4685.344051832746, 4631.884202894921, 4632.143053535106, 4644.907101857978, 4690.742009189493, 4690.7654617269, 4556.3621093047, 4599.908001839978, 4608.9308660370125, 4611.354410382549, 4657.4876763555985, 5007.899842003176, 5044.192929131358, 5053.6967781932835, 5056.014077254937, 5081.618878584121, 5358.732063396854, 5411.702356370398, 5459.426760190163, 5467.015937131315, 5475.315585551806, 5484.095124304525, 5486.451354864482, 5487.780488780444, 5487.862803429906, 5494.36814766303, 5081.695098294114, 5090.974545127251, 5102.821401250939, 5109.821156259513, 5134.7946082156295, 5419.376771671308, 5551.111822108443, 5576.191452239403, 5704.229928959538, 5711.571632127607, 5292.867678308073, 5365.141577347606, 5389.51494365509, 5444.700541470178, 5447.428020057837, 5422.349318081855, 5432.48391402824, 5434.266374039454, 5485.50630443262, 5537.252470916455, 5388.08402571556, 5396.784128634889, 5399.37907140676, 5404.270423492857, 5462.7268636568015, 5344.091504444254, 5410.864728381822, 5439.619226654176, 5465.0, 5506.834794956158, 4651.139539185261, 4658.34783130362, 4667.089917466062, 4689.929651055237, 4703.0, 4000.8199631016673, 4005.839766409369, 4010.3382941814857, 4024.436578878959, 4039.7576145431367, 4655.045715628288, 4701.694389864648, 4714.434267887876, 4744.976275118603, 4805.231163013901, 5544.0575102232715, 5546.69493177871, 5551.972885016285, 5572.498475137257, 5600.915986260209, 4737.502562230985, 4753.120672675566, 4768.785404656799, 4771.141194584939, 4811.9518804812205, 4867.488913664085, 4911.607071434277, 4916.287138364989, 4964.478729733398, 4968.950310496921, 5077.8730531737, 5120.283160357479, 5141.53726164647, 5141.71720555373, 5141.742912854417, 5490.972545137249, 5494.36814766307, 5502.0921547944145, 5503.3395992481155, 5513.972430137824, 5095.388553373471, 5121.667091639031, 5122.923156152735, 5124.769385377593, 5138.76875540609, 5390.595705322038, 5409.053415652324, 5430.755615997368, 5441.129419292894, 5485.424030476902, 5506.724663766716, 5537.280153580009, 5538.141588053858, 5543.1408131739645, 5565.805196818092, 5187.948120518747, 5225.033368826779, 5293.788248470018, 5296.523312901857, 5299.5230429261555, 5201.349831271091, 5221.008008478377, 5224.843254702213, 5278.577713782965, 5309.415964243853, 5135.075686376488, 5189.065968125774, 5205.609579281645, 5242.161254199463, 5253.369595648546, 5329.200619907045, 5330.680159190461, 5335.439778823167, 5335.519803217729, 5346.652467589594, 5110.66780659256, 5169.974150129226, 5178.8964220716125, 5203.765830537711, 5204.401493828107], "value": 4999.095043848609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.5580703989608, 653.7352372289222, 672.3847679373372, 845.6363763581658, 851.7913111287736, 33271.66728332716, 34028.82985585069, 34040.31919361611, 34055.82972085139, 34134.317313653715, 31061.378772424538, 31410.528842067386, 31624.73501059955, 33435.49846752301, 33538.8323058385, 6126.938730612693, 8926.330525210602, 9115.179633832953, 9120.224780893632, 9128.58921348541, 9056.592453339616, 9137.177654011137, 9195.402298850553, 9198.356115071947, 9209.585568649427, 9329.160375566198, 9381.81236375272, 9419.152276295132, 9423.528823558829, 9438.197753190987, 9282.76793080175, 9337.533123343874, 9344.859827102599, 9347.112024357675, 9349.672761453385, 9118.72031992002, 9271.165595096407, 9279.721608351692, 9281.443113413217, 9299.72100836976, 34188.48717269243, 34223.6577634223, 34235.144121396916, 34264.828675856465, 34415.82792086049, 3296.4890441981292, 3354.0440974322446, 3354.37943980362, 3379.5805761580195, 3444.397230484655, 24332.756672433225, 24598.262052138463, 24667.87666061658, 24855.62716559253, 25111.121110761218, 3100.193949573105, 3224.7581431392505, 3237.038947639938, 3246.383187194449, 3272.5745653065187, 113306.43346783213, 113988.0, 151816.0, 153223.0, 153967.23016384846, 38217.235655286735, 38733.41899871448, 38819.2236155281, 38865.61134388676, 38890.22219555593, 40589.0, 40590.18819623591, 40685.79657101695, 40686.38970415446, 40770.38844417336, 12049.81925271104, 12167.148299619119, 12226.20529665569, 12236.81644775329, 12253.142280040312, 9678.516074196403, 9835.803283934281, 9870.753231169134, 9883.308168428284, 9921.355111917703, 13402.664933376744, 13490.976353547047, 13574.185548867099, 13589.796153057712, 13658.317084145952, 5439.265699130567, 5475.206095116186, 5535.474129957647, 5559.972200139055, 5597.557502136238, 807.567951146134, 833.1044127562894, 834.1450013735969, 834.2700137379793, 862.3101518784947, 22779.658305125435, 23862.16482423107, 24102.15642452506, 24140.275791726275, 24229.0, 889.5996801439378, 891.7101941868918, 918.5223683684446, 919.5448253114618, 920.1672486399685, 12503.124781265406, 12602.936985315015, 12661.0, 12744.61766147017, 12870.549530766379, 219730.0, 220619.0, 220835.0, 221008.0, 221568.0, 42717.786411068366, 43069.13861722748, 43141.0, 43233.35149972753, 43245.567544324156, 1152.3201311226417, 1187.7565099154826, 1189.8691143974156, 1191.1602320364295, 1330.7737684593642, 22223.777762222817, 22485.775142248367, 23389.0, 23666.526669466857, 23679.52640947206, 30945.0, 30995.69004309928, 31015.844920775253, 31016.68983310138, 31033.379332412773, 214828.0, 214948.0, 215578.0, 215799.0, 216641.0, 27528.587071193546, 27652.446951060465, 27872.0, 28981.565276520447, 29093.12720618385, 35577.46633800443, 36090.63909360978, 36207.45688814722, 36272.637273626926, 36840.44739328966, 29906.551401728557, 30981.380372392876, 31334.686653133176, 31920.0, 32073.35853282968, 30042.54936176003, 30191.849040754656, 30338.241543961576, 30621.0, 31246.0, 29262.70737292685, 29553.85223073871, 29554.0, 29703.554446682883, 30257.24356891095, 26141.73858261393, 26611.866940665946, 27118.0, 27288.181354559394, 27694.584581230894, 21468.78531214668, 21510.247141349977, 21514.139434423072, 21729.456763581038, 21763.891180543997], "value": 15433.842714660974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.43020103738695, 380.7449009163861, 389.2623478508227, 401.27169187923914, 403.85663089603173, 17291.135443227835, 18593.25626974921, 18791.0, 18875.811241887575, 18889.811101888994, 17259.137043147824, 17283.654326913453, 17867.409225662304, 18720.90639546804, 18820.811791882075, 5576.247206627114, 5777.537796976232, 5816.214811000525, 5825.213596164527, 5826.543364158961, 5565.860853478675, 5782.653040817543, 5789.189513468097, 5794.478496935275, 5801.970990145043, 5597.216389705424, 5751.309842818868, 5785.305763308409, 5817.1565123057135, 5818.941810581903, 5638.718064096779, 5741.942580574183, 5743.4543718346895, 5747.2528571285675, 5747.885042299131, 5527.640703354309, 5550.639208451437, 5573.6098473106895, 5606.299212598426, 5613.045782216992, 21018.684719729215, 21153.894230528902, 21161.15355385783, 21279.361619151452, 21284.0, 2284.4060544258614, 2303.5623231585946, 2309.6073667476403, 2345.5074434368803, 2351.353377821113, 13452.798208026887, 13831.308434578332, 14085.85914140866, 14375.137491750529, 14655.487057953027, 1834.1287888253107, 1912.1586501939241, 1919.0692514130635, 1924.8171423714725, 1926.268018153093, 75732.62133689351, 84326.0, 84362.57818710929, 84698.0, 85105.14894851034, 16172.433964811175, 16325.673486530202, 16505.504834854975, 16834.24245908937, 16998.745018824728, 28620.856895715388, 28663.283417914718, 28720.425591488052, 28734.281642959093, 28742.281442963675, 7375.852482950419, 7444.664990075459, 7522.097348318237, 7622.161562228151, 7692.7692169235015, 5914.9704251479325, 5931.288245410578, 6062.060380641008, 6081.665508396992, 6082.330943596201, 8697.565121744014, 9061.41100828444, 9157.95421022904, 9286.72139835806, 9345.439273643604, 3747.4191500317493, 3834.328992426314, 3898.6296301851844, 3917.471141395932, 3935.4293627423863, 794.1859593916282, 827.606886728799, 829.9336053115736, 830.7466222802103, 852.0754980845728, 17751.0, 18643.720344194848, 18917.337893173673, 19000.926728647893, 19281.22875085009, 820.796162304215, 827.2513375395276, 836.677879016583, 840.1010918317342, 842.2630198576246, 10004.19966402686, 11471.4264286787, 11474.36890970988, 11499.942500287445, 11900.0, 445553.0, 461830.0, 469988.0, 472870.0, 474304.0, 86225.56887215524, 87227.0, 88302.55848720715, 92364.53817730868, 93067.53466232626, 1116.7319843237726, 1139.3847322445952, 1190.4464424042862, 1193.9701507462382, 1199.0527483288279, 17521.474355769347, 17735.46793596194, 18331.45005649833, 18452.169652365406, 18636.0, 41934.790326048176, 42335.0, 42735.57264427316, 42799.7860010698, 42895.35656965086, 53546.73226633842, 53662.73168634132, 53989.19016214681, 54681.0, 55863.0, 10342.017508336696, 10514.371407148214, 10563.894361056291, 10903.492196794623, 11741.354225517336, 12676.176048557183, 12792.0, 12924.806127908278, 12962.805557916827, 13247.271400072703, 10799.622013229498, 10899.400532970763, 10906.454677266263, 11295.830562541403, 11354.148438867283, 10218.489075546342, 10379.948100259451, 10449.477526123512, 10495.52770125331, 10574.577016919236, 10463.48876269705, 10625.149988001096, 10649.201309901633, 10708.89291107079, 11409.31544107323, 10433.895661043292, 10849.26059401019, 10849.294795838245, 11122.777544449227, 11547.0, 11124.666260012213, 11533.942330288295, 11587.710307242049, 11652.708682283012, 11692.590759323382], "value": 9764.079016784446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.3784891421144, 1465.2746890289309, 1471.176141360838, 1500.0924440713368, 1543.0587341721548, 7830.725924592626, 8043.758687239392, 8873.55632218389, 9282.907170928298, 9288.21050210732, 8890.86663700045, 9211.861822072657, 9221.446713197196, 9237.722868313944, 9248.352615316931, 2038.2254743197564, 2067.4107879254416, 2069.8033686799804, 2073.150008496517, 2075.0973326602902, 2003.7996200379919, 2050.692396140576, 2051.6922461630725, 2058.0327246194265, 2062.5874825035053, 1971.5662554238045, 1978.0900785638623, 1978.8911609861523, 2001.8999050047512, 2004.5790384019374, 1966.9311574094909, 1967.7540307461638, 1977.5056235941015, 1978.1592823050146, 1981.960360792776, 1954.7458830352105, 1987.7415935928382, 2001.729766481521, 2003.328884823586, 2012.8590998630102, 9433.528323583861, 9458.763530911783, 9471.194948429391, 9504.904950950471, 9527.571259293349, 4384.188925048876, 4528.41130653013, 4559.156556037144, 4577.176108300505, 4585.197590421662, 2504.962425563618, 2618.581027035665, 2647.8543680097587, 2666.919992400231, 2737.219892330696, 930.1814403325099, 956.5073986896754, 958.8945216026232, 974.5517062151418, 978.6232300564263, 12754.0, 12754.48982040708, 12816.0, 12816.102872798907, 12853.421596028202, 3707.4253490708984, 3797.7911214882893, 3876.2247550490015, 3877.3214687429586, 4019.6181362771076, 11102.0, 11128.054115400282, 11178.27341222818, 11191.2725672831, 11199.776004479865, 4546.977265113719, 4547.499775024745, 4565.543445655408, 4573.108243892409, 4576.130535198302, 3276.0, 3393.745469089828, 4058.3912413137673, 4213.346931225665, 4227.048913994388, 3392.3384939936477, 3421.8289085545625, 3515.2969406118877, 3520.3135388598976, 3544.096255454894, 958.6117622362954, 982.2976571751232, 998.1266391907081, 1000.4697510319543, 1002.4436437777103, 687.1376422589718, 696.1298377028714, 696.3837004251274, 709.5671640299413, 726.393461459687, 5543.0, 5562.440038375443, 5605.243292155588, 5616.831495055155, 5790.536757059425, 869.3132425384002, 870.3950754225879, 882.7307671160357, 885.6678745470449, 902.6389444222364, 3464.359093567698, 3508.9122771930397, 3517.525134106914, 3538.8230588470474, 3587.1749497615174, 10886.72783180411, 11371.54513819438, 11378.31730096197, 11525.942370288094, 11573.537058517564, 11336.093112550976, 11356.205065645325, 11432.942835285936, 11457.427128643534, 11620.65138045843, 8435.325173986066, 8495.617697203641, 8557.914420855835, 8638.179372959685, 8672.0, 5495.53287970527, 5520.834374968757, 5648.548116150616, 5722.430816298203, 5725.742341594721, 9864.654737084167, 10182.338148020355, 10239.641612543524, 10271.229657775846, 10367.27429079957, 10347.12049475803, 10464.686059418229, 10528.99974502421, 10546.789064218827, 10669.41318227505, 7695.846083078419, 7772.883406748791, 7778.572178530235, 7814.179511151475, 7840.3335716464735, 8526.488410695378, 8545.060043395097, 8599.14008599135, 8618.913810861812, 8625.396222264631, 7766.145723970471, 7893.723719669784, 7904.762857114296, 8045.275925166763, 8141.674333026849, 7590.886136707843, 7601.429892758176, 7660.387169026576, 7703.3067023968115, 7809.570473624005, 6868.210155832143, 6883.174019117738, 6943.27095654949, 7001.299870012958, 7039.436845052486, 5246.763895624782, 5273.050850846885, 5329.173978033411, 5433.8369848904595, 5525.370015845255, 4856.1987272099705, 4905.313256144214, 4933.939203071357, 4939.802407903788, 5030.798768049237], "value": 4336.589576644484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8478269561393, 349.0349184504844, 356.97679650822687, 357.60306060273075, 358.85287032316756, 5202.800277829137, 5379.166229234465, 5417.916416716657, 5475.78096876125, 5497.972510137453, 5157.432682404942, 5312.4687531246855, 5358.4641535846395, 5369.140937450009, 5424.566034717223, 4619.607333376667, 4626.791794369245, 4626.8380606678775, 4627.421572303462, 4652.488226295105, 4535.183666939949, 4562.9771851140695, 4629.3518907353, 4655.44134703836, 4666.533346665324, 4585.28928016158, 4590.517995610463, 4606.654500912428, 4609.631229501649, 4618.838340658078, 4608.654350923694, 4617.6536759742985, 4622.375979242793, 4631.2126938420215, 4632.698874573142, 4361.367601697736, 4382.298832186867, 4387.1445068211715, 4459.0, 4479.39528163697, 5239.895202095937, 5244.003639308519, 5270.446603106657, 5298.841034768963, 5303.28405665238, 5427.1316589345515, 5434.728263586805, 5442.666546696085, 5445.101558242885, 5451.972740136274, 5652.74562644682, 5693.010088121558, 5730.656160630334, 5754.97122514389, 5806.82579522615, 4871.3667223260745, 4897.902041959176, 4900.705957642553, 4911.5088491150955, 4925.482824303468, 5704.857378565569, 5817.156512305734, 5867.677277749722, 6064.211652485193, 6087.634741915499, 5080.974595127074, 5104.719240441811, 5112.744362781846, 5114.693118412907, 5117.385913690307, 5196.32447781786, 5199.506046925536, 5247.344081989751, 5250.107481728115, 5251.947480525222, 5307.601929855199, 5354.732263386893, 5360.249565060894, 5400.270963419888, 5414.0, 5674.2623458950075, 5695.145728140812, 5706.115552089433, 5713.914291285634, 5725.971370143123, 1589.3324803582523, 1804.1790985101748, 1825.3428765644358, 1835.4126679462445, 1838.7333836593618, 1214.9878501214876, 1218.214251807579, 1269.6191142657167, 1275.7688830278826, 1286.2475451860766, 4921.8523444296015, 4930.950690493121, 4952.529509696573, 4958.528939750718, 4977.1538838397555, 5832.0, 5854.887571361428, 5857.297124345106, 5860.472557469848, 5871.55963302754, 4722.88192795176, 4911.3369695090705, 4954.157793175169, 4963.230699241623, 5009.5491405773655, 3098.2254436390904, 3112.128603990886, 3121.843907804601, 3126.390353881017, 3126.45287074761, 5430.5927055471, 5431.5926305526455, 5432.212329212242, 5439.972800136054, 5454.91817622736, 5699.943000569941, 5981.850453738692, 6010.497375656086, 6048.6673232971725, 6057.242844644419, 5480.671159730429, 5484.753186106715, 5486.835394938158, 5493.23094766733, 5506.659669640387, 5775.9133612996675, 5890.941090589211, 5909.172715819703, 5911.0, 5944.910826337695, 5609.06487261894, 5755.1367294906095, 5782.0, 5794.101914203306, 5806.912896306643, 5439.48324909133, 5470.562355011669, 5481.561475082063, 5502.669839809624, 5523.7238138093735, 4680.251159814414, 4713.269443236304, 4727.101850648366, 4731.266653668687, 4738.905221895612, 5706.42935706426, 5858.882822343615, 5896.941030589639, 5904.439078287556, 5907.852303692442, 5610.354809196994, 5615.129654903497, 5622.606417550732, 5626.971865140648, 5634.394197653649, 5429.104197807317, 5596.244506991667, 5622.915656265078, 5639.802606908903, 5642.576806739593, 5507.311586051744, 5522.861928451821, 5537.335519737658, 5547.1679248113105, 5550.361708403585, 5705.4009329019855, 5728.828135155952, 5731.455511726379, 5732.254806875079, 5733.531213615703, 5395.757190926496, 5510.586705997146, 5524.613277070566, 5559.16612508127, 5567.916481252865], "value": 4522.564954961944, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8230654263535, 699.7375984005997, 750.6959681329062, 758.5448730761548, 766.946313758037, 12259.693507662312, 12781.680457988543, 12823.0, 12842.0, 12862.549810756625, 11982.0, 11999.0, 12003.759924801521, 12077.637670869888, 12078.758424831498, 817.468645380503, 827.2926647716206, 841.5792103948025, 862.874883141944, 869.952152631605, 852.6589364254316, 855.6748435594496, 859.2395729779128, 859.9914000859974, 871.2376670413388, 882.1046637662778, 887.6316328723605, 888.0231745080392, 890.1321211818457, 902.3277658144658, 901.8376692195402, 902.3232575568323, 902.3548163063408, 903.3902116071658, 905.0090151284334, 651.1437459740473, 658.2430205263937, 658.8748137853793, 664.7872680742164, 665.1685393258427, 13345.466181352735, 13442.529511467052, 13494.257815820127, 13502.527411540646, 13512.729745405037, 13535.661608459768, 13903.652408689763, 14142.717145657132, 14155.292235388293, 14258.28708564578, 10633.989770971746, 10702.090322322534, 10732.892671073267, 11004.339739615649, 11063.612773552886, 3062.1579065757096, 3110.28463453407, 3114.408262430131, 3114.5172498262805, 3229.273413481971, 64533.35466645368, 64562.3543764561, 65262.673686631264, 66005.33994660089, 66531.334686653, 9622.51887405641, 9634.910562011622, 9653.22774178064, 9750.219982401391, 9833.360831545926, 19572.608547828964, 19608.0, 19608.0, 19636.41090767279, 19637.80362196388, 6415.26224484181, 6491.123698300669, 6544.803655890331, 6795.286494918061, 6823.522353435212, 3222.581064461605, 3256.2185075582165, 3292.6707329266883, 3328.3509715605223, 3337.466005439118, 2812.2688101093454, 2831.4620222157723, 2853.885844566236, 2856.5429531274895, 2870.641169853768, 456.63925498856196, 460.5854730742359, 460.83179639431364, 467.2267397457214, 470.9740964246931, 564.2495481010328, 584.7894957062312, 587.5006244692063, 590.9586328957017, 607.4684650930436, 8331.66673333072, 8393.244607985189, 8467.915320846836, 8678.6962456315, 8782.033976262606, 596.8418369132183, 613.9877202456015, 624.0, 626.5520153090562, 632.099258556555, 4146.3365861462025, 4333.848315309012, 4343.478782546114, 4397.802098905557, 4457.77711114443, 49279.0, 62534.68732656308, 63136.368636313964, 63154.68422657949, 65088.67455662692, 46182.538174618494, 47720.5227947723, 49815.75092124516, 49841.0, 51507.22739158916, 46176.0, 46209.5379046212, 46282.537174627825, 46745.29882051772, 48050.5194948053, 8434.587590331423, 8957.075921219688, 9234.122758337948, 9241.353105282566, 9435.52822358893, 32387.35225295528, 32842.0, 32939.341213175125, 33517.32965340728, 34150.31699366048, 37932.24135517219, 38383.23233535369, 38517.229655406176, 39361.40957885691, 39519.407208892466, 11121.0, 11204.887951120385, 11269.605563805228, 11447.0, 11695.356755378536, 12704.174228675107, 12873.485060597472, 12902.548410805577, 12948.870511294766, 12961.481540738265, 11916.165868389477, 12280.631581052583, 12384.133110682526, 12655.240685558896, 13099.869001310246, 12009.579664711693, 12206.267623942593, 12254.87745122573, 12829.358532073173, 12850.35748212567, 11581.942090289494, 11771.705707357385, 11957.402129893297, 12058.0, 12058.457369418222, 9781.41311521311, 10272.589096436059, 10364.092844171222, 10713.410762408143, 10725.89274107249, 8723.52020638871, 9823.424784124883, 10070.798584028425, 10072.647457338959, 10137.391756494633], "value": 6293.251993666311, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 124.0, 118.0, 118.0, 119.0, 119.0, 119.0, 119.0, 120.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 126.0, 185.0, 126.0, 125.0, 127.0, 126.0, 144.0, 128.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 169.0, 167.0, 168.0, 163.0, 165.0, 166.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 115.0, 76.0, 79.0, 75.0, 75.0, 95.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 85.0, 84.0, 85.0, 109.0, 85.0, 84.0, 114.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 120.0, 114.0, 113.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 155.0, 151.0, 151.0, 152.0, 150.0, 154.0, 152.0, 152.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 73.0, 77.0, 74.0, 74.0, 72.0, 71.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 57.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 92.0, 84.0, 82.0, 83.0, 84.0, 86.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 135.0, 142.0, 134.0, 135.0, 141.0, 141.0, 190.0, 154.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 212.0, 199.0, 200.0, 204.0, 201.0, 201.0, 197.0, 199.0], "value": 201.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 75.0, 72.0, 77.0, 72.0, 71.0, 69.0, 70.0], "value": 72.6, "unit": "score"}]}]} 18:38:50 INFO - Return code: 0 18:38:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:50 ERROR - # TBPL SUCCESS # 18:38:50 INFO - Running post-action listener: _resource_record_post_action 18:38:50 INFO - [mozharness: 2017-03-21 01:38:50.682682Z] Finished run-tests step (success) 18:38:50 INFO - Running post-run listener: _resource_record_post_run 18:38:50 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 362721280; Read time: 20; Write time: 364916 18:38:50 INFO - TinderboxPrint: CPU usage
13.3% 18:38:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 18:38:50 INFO - TinderboxPrint: I/O write bytes / time
362,721,280 / 364,916 18:38:50 INFO - TinderboxPrint: CPU idle
8,319.5 (86.7%) 18:38:50 INFO - TinderboxPrint: CPU user
1,219.6 (12.7%) 18:38:50 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106131456; Read time: 0; Write time: 122192 18:38:50 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256589824; Read time: 20; Write time: 242724 18:38:51 INFO - Running post-run listener: _upload_blobber_files 18:38:51 INFO - Blob upload gear active. 18:38:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:51 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 18:38:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:52 INFO - (blobuploader) - INFO - Done attempting. 18:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:53 INFO - (blobuploader) - INFO - Done attempting. 18:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:56 INFO - (blobuploader) - INFO - Done attempting. 18:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:57 INFO - (blobuploader) - INFO - Done attempting. 18:38:57 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:57 INFO - Return code: 0 18:38:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e0abf99995cd661ca4a921e9580a9aae863e729dc8fda9dd518809e396fecf89ef09fdca3eb1d8f23987e453b3d064b2eef0c705ba6113f4393b9a0796953e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4360c1cc8300f4b0c8eaede924f85dc248e631f824a69a4a858c0edabdf1c5f8fec3e308ae7f1c2a09caf24f51f6d0119a81f56fc8deac46bbeabb1aa2113ed0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ba15eb07532007242469347c2f1793f9211c9bdef90c8df8ec421c8a68bb521eed264afcb64eca7a128827aec280a22be1bdd06b28fc966b92b214a85aeffd2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b40f684dfd26b9dae759a737d544c83e8ba21a16be281547d3b39108a076dc720eccddd36753917b26d410c7feeb73b7ecafd4743931e668bd380203a927910"} 18:38:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:57 INFO - Contents: 18:38:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e0abf99995cd661ca4a921e9580a9aae863e729dc8fda9dd518809e396fecf89ef09fdca3eb1d8f23987e453b3d064b2eef0c705ba6113f4393b9a0796953e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4360c1cc8300f4b0c8eaede924f85dc248e631f824a69a4a858c0edabdf1c5f8fec3e308ae7f1c2a09caf24f51f6d0119a81f56fc8deac46bbeabb1aa2113ed0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ba15eb07532007242469347c2f1793f9211c9bdef90c8df8ec421c8a68bb521eed264afcb64eca7a128827aec280a22be1bdd06b28fc966b92b214a85aeffd2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b40f684dfd26b9dae759a737d544c83e8ba21a16be281547d3b39108a076dc720eccddd36753917b26d410c7feeb73b7ecafd4743931e668bd380203a927910"} 18:38:57 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:57 INFO - Copying logs to upload dir... 18:38:57 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.444618 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-20 18:38:57.242632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 18:38:57.246691) ========= 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=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 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-Non-PGO/sha512/36e0abf99995cd661ca4a921e9580a9aae863e729dc8fda9dd518809e396fecf89ef09fdca3eb1d8f23987e453b3d064b2eef0c705ba6113f4393b9a0796953e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4360c1cc8300f4b0c8eaede924f85dc248e631f824a69a4a858c0edabdf1c5f8fec3e308ae7f1c2a09caf24f51f6d0119a81f56fc8deac46bbeabb1aa2113ed0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ba15eb07532007242469347c2f1793f9211c9bdef90c8df8ec421c8a68bb521eed264afcb64eca7a128827aec280a22be1bdd06b28fc966b92b214a85aeffd2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b40f684dfd26b9dae759a737d544c83e8ba21a16be281547d3b39108a076dc720eccddd36753917b26d410c7feeb73b7ecafd4743931e668bd380203a927910"} build_url:https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/YU8nHYp9RaG67T11BOqdQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e0abf99995cd661ca4a921e9580a9aae863e729dc8fda9dd518809e396fecf89ef09fdca3eb1d8f23987e453b3d064b2eef0c705ba6113f4393b9a0796953e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4360c1cc8300f4b0c8eaede924f85dc248e631f824a69a4a858c0edabdf1c5f8fec3e308ae7f1c2a09caf24f51f6d0119a81f56fc8deac46bbeabb1aa2113ed0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ba15eb07532007242469347c2f1793f9211c9bdef90c8df8ec421c8a68bb521eed264afcb64eca7a128827aec280a22be1bdd06b28fc966b92b214a85aeffd2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b40f684dfd26b9dae759a737d544c83e8ba21a16be281547d3b39108a076dc720eccddd36753917b26d410c7feeb73b7ecafd4743931e668bd380203a927910"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 18:38:57.271963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:38:57.272301) ========= 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=5cf47e208febbcd81da23b2e0000026f-1490059073.87110-1696622697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 18:38:57.355078) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 18:38:57.355395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 18:38:57.355679) ========= ========= Total master_lag: 0.17 =========