builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1490616081.23 results: success (0) revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.226538) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.227005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.227272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.273488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.273879) ========= 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-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 05:01:22-- 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% 46.0M=0s 2017-03-27 05:01:22 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113137 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.401583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.401922) ========= 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-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:21.451536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 05:01:21.451870) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9577ddeaafd85554c2a855f385a87472a089d5c0 --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 9577ddeaafd85554c2a855f385a87472a089d5c0 --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-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 05:01:22,338 truncating revision to first 12 chars 2017-03-27 05:01:22,338 Setting DEBUG logging. 2017-03-27 05:01:22,338 attempt 1/10 2017-03-27 05:01:22,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9577ddeaafd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 05:01:23,781 unpacking tar archive at: mozilla-central-9577ddeaafd8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.767839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 05:01:23.233159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:23.233470) ========= script_repo_revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:23.235070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:23.235377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:01:23.244877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-03-27 05:01:23.245195) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:24 INFO - MultiFileLogger online at 20170327 05:01:24 in /builds/slave/test 05:01:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:01:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:24 INFO - {'append_to_log': False, 05:01:24 INFO - 'base_work_dir': '/builds/slave/test', 05:01:24 INFO - 'blob_upload_branch': 'Firefox', 05:01:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:24 INFO - 'branch': 'Firefox', 05:01:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:24 INFO - 'config_files': ('talos/linux_config.py',), 05:01:24 INFO - 'default_actions': ('clobber', 05:01:24 INFO - 'read-buildbot-config', 05:01:24 INFO - 'download-and-extract', 05:01:24 INFO - 'populate-webroot', 05:01:24 INFO - 'create-virtualenv', 05:01:24 INFO - 'install', 05:01:24 INFO - 'run-tests'), 05:01:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:24 INFO - 'download_minidump_stackwalk': True, 05:01:24 INFO - 'download_symbols': 'ondemand', 05:01:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:24 INFO - 'gecko_profile': False, 05:01:24 INFO - 'gecko_profile_interval': 0, 05:01:24 INFO - 'installer_path': 'installer.exe', 05:01:24 INFO - 'log_level': 'info', 05:01:24 INFO - 'log_name': 'talos', 05:01:24 INFO - 'log_to_console': True, 05:01:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:24 INFO - 'opt_config_files': (), 05:01:24 INFO - 'pip_index': False, 05:01:24 INFO - 'suite': 'dromaeojs', 05:01:24 INFO - 'system_bits': '32', 05:01:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:24 INFO - 'title': 'talos-linux64-ix-011', 05:01:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:24 INFO - 'use_talos_json': True, 05:01:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:24 INFO - 'work_dir': 'build'} 05:01:24 INFO - [mozharness: 2017-03-27 12:01:24.220865Z] Running clobber step. 05:01:24 INFO - Running pre-action listener: _resource_record_pre_action 05:01:24 INFO - Running main action method: clobber 05:01:24 INFO - rmtree: /builds/slave/test/build 05:01:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:25 INFO - Running post-action listener: _resource_record_post_action 05:01:25 INFO - [mozharness: 2017-03-27 12:01:25.676491Z] Finished clobber step (success) 05:01:25 INFO - [mozharness: 2017-03-27 12:01:25.676592Z] Running read-buildbot-config step. 05:01:25 INFO - Running pre-action listener: _resource_record_pre_action 05:01:25 INFO - Running main action method: read_buildbot_config 05:01:25 INFO - Using buildbot properties: 05:01:25 INFO - { 05:01:25 INFO - "project": "", 05:01:25 INFO - "product": "firefox", 05:01:25 INFO - "who": "cbook@mozilla.com", 05:01:25 INFO - "installer_path": "public/build/target.tar.bz2", 05:01:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:01:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:01:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:01:25 INFO - "stage_platform": "linux64-pgo", 05:01:25 INFO - "basedir": "/builds/slave/test", 05:01:25 INFO - "buildnumber": 111, 05:01:25 INFO - "platform": "ubuntu64_hw", 05:01:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:01:25 INFO - "slavebuilddir": "test", 05:01:25 INFO - "taskId": "fQUrhhaPS2qF8skE7OJCUA", 05:01:25 INFO - "branch": "mozilla-central", 05:01:25 INFO - "script_repo_revision": "production", 05:01:25 INFO - "revision": "9577ddeaafd85554c2a855f385a87472a089d5c0", 05:01:25 INFO - "slavename": "talos-linux64-ix-011", 05:01:25 INFO - "repo_path": "mozilla-central" 05:01:25 INFO - } 05:01:25 INFO - Finding installer, test and symbols from parent task. 05:01:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fQUrhhaPS2qF8skE7OJCUA'}, attempt #1 05:01:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fQUrhhaPS2qF8skE7OJCUA'}, attempt #1 05:01:26 INFO - Task dependencies: finsQfIVTm6bLMEBugnTvw 05:01:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw'}, attempt #1 05:01:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 05:01:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/test_packages.json 05:01:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.crashreporter-symbols.zip 05:01:27 INFO - Running post-action listener: _resource_record_post_action 05:01:27 INFO - [mozharness: 2017-03-27 12:01:27.360548Z] Finished read-buildbot-config step (success) 05:01:27 INFO - [mozharness: 2017-03-27 12:01:27.360768Z] Running download-and-extract step. 05:01:27 INFO - Running pre-action listener: _resource_record_pre_action 05:01:27 INFO - Running main action method: download_and_extract 05:01:27 INFO - mkdir: /builds/slave/test/build/tests 05:01: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')]} 05:01:27 INFO - trying https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.test_packages.json 05:01:27 INFO - Downloading https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:01:27 INFO - Downloaded 986 bytes. 05:01:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:01:27 INFO - Using the following test package requirements: 05:01:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:01:27 INFO - u'common': [u'target.common.tests.zip'], 05:01:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:01:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:01:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:01:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:01:27 INFO - u'mozbase': [u'target.common.tests.zip'], 05:01:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:01:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:01:27 INFO - u'web-platform': [u'target.common.tests.zip', 05:01:27 INFO - u'target.web-platform.tests.zip'], 05:01:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:01:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:01:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip 05:01:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:01:27 INFO - Fetch https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip into memory 05:01:29 INFO - Expected file size: 60260392 05:01:29 INFO - Obtained file size: 60260392 05:01:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:01:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip 05:01:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:01:39 INFO - Fetch https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.common.tests.zip into memory 05:01:40 INFO - Expected file size: 60260392 05:01:40 INFO - Obtained file size: 60260392 05:01:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.talos.tests.zip 05:01:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:01:51 INFO - Fetch https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.talos.tests.zip into memory 05:01:52 INFO - Expected file size: 14404171 05:01:52 INFO - Obtained file size: 14404171 05:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:52 INFO - trying https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 05:01:52 INFO - Downloading https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:01:54 INFO - Downloaded 68072794 bytes. 05:01:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 05:01:54 INFO - mkdir: /builds/slave/test/properties 05:01:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:54 INFO - Contents: 05:01:54 INFO - build_url:https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 05:01:54 INFO - Running post-action listener: _resource_record_post_action 05:01:54 INFO - Running post-action listener: set_extra_try_arguments 05:01:54 INFO - [mozharness: 2017-03-27 12:01:54.525417Z] Finished download-and-extract step (success) 05:01:54 INFO - [mozharness: 2017-03-27 12:01:54.525647Z] Running populate-webroot step. 05:01:54 INFO - Running pre-action listener: _resource_record_pre_action 05:01:54 INFO - Running main action method: populate_webroot 05:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:54 INFO - '--tppagecycles', 05:01:54 INFO - '7'], 05:01:54 INFO - 'tests': ['tsvgm']}}, 05:01:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['damp', 'tps']}, 05:01:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'tests': ['damp', 'tps']}, 05:01:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['dromaeo_dom']}, 05:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['basic_compositor_video']}, 05:01:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:01:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['a11yr', 05:01:54 INFO - 'ts_paint', 05:01:54 INFO - 'tpaint', 05:01:54 INFO - 'sessionrestore', 05:01:54 INFO - 'sessionrestore_no_auto_restore', 05:01:54 INFO - 'tabpaint']}, 05:01:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['tsvgx', 05:01:54 INFO - 'tsvgr_opacity', 05:01:54 INFO - 'tart', 05:01:54 INFO - 'tscrollx', 05:01:54 INFO - 'cart', 05:01:54 INFO - 'tsvg_static']}, 05:01:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:54 INFO - 'tsvgr_opacity', 05:01:54 INFO - 'tart', 05:01:54 INFO - 'tscrollx', 05:01:54 INFO - 'cart', 05:01:54 INFO - 'tsvg_static']}, 05:01:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'talos_options': ['--disable-e10s'], 05:01:54 INFO - 'tests': ['tp5o']}, 05:01:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:01:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'talos_options': ['--disable-e10s', 05:01:54 INFO - '--xperf_path', 05:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:54 INFO - 'tests': ['tp5n']}, 05:01:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:01:54 INFO - 'talos_options': ['--xperf_path', 05:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:54 INFO - 'tests': ['tp5n']}}, 05:01:54 INFO - 'talos.zip': {'path': '', 05:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:54 INFO - Running post-action listener: _resource_record_post_action 05:01:54 INFO - [mozharness: 2017-03-27 12:01:54.548598Z] Finished populate-webroot step (success) 05:01:54 INFO - [mozharness: 2017-03-27 12:01:54.548689Z] Running create-virtualenv step. 05:01:54 INFO - Running pre-action listener: _resource_record_pre_action 05:01:54 INFO - Running main action method: create_virtualenv 05:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:54 INFO - Using real prefix '/usr' 05:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:57 INFO - Installing pip.................done. 05:01:57 INFO - Return code: 0 05:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:01:57 INFO - Reading from file tmpfile_stdout 05:01:57 INFO - Output received: 05:01:57 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) 05:01:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:01:57 INFO - Using env: {'DISPLAY': ':0', 05:01:57 INFO - 'HOME': '/home/cltbld', 05:01:57 INFO - 'LANG': 'en_US.UTF-8', 05:01:57 INFO - 'LANGUAGE': 'en_US:en', 05:01:57 INFO - 'LOGNAME': 'cltbld', 05:01:57 INFO - 'MAIL': '/var/mail/cltbld', 05:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:57 INFO - 'MOZ_NO_REMOTE': '1', 05:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:57 INFO - 'NO_EM_RESTART': '1', 05:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:57 INFO - 'PWD': '/builds/slave/test', 05:01:57 INFO - 'SHELL': '/bin/bash', 05:01:57 INFO - 'SHLVL': '1', 05:01:57 INFO - 'TERM': 'linux', 05:01:57 INFO - 'TMOUT': '86400', 05:01:57 INFO - 'USER': 'cltbld', 05:01:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:57 INFO - '_': '/tools/buildbot/bin/python'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01:58 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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:59 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:01:59 INFO - Using env: {'DISPLAY': ':0', 05:01:59 INFO - 'HOME': '/home/cltbld', 05:01:59 INFO - 'LANG': 'en_US.UTF-8', 05:01:59 INFO - 'LANGUAGE': 'en_US:en', 05:01:59 INFO - 'LOGNAME': 'cltbld', 05:01:59 INFO - 'MAIL': '/var/mail/cltbld', 05:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:59 INFO - 'MOZ_NO_REMOTE': '1', 05:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:59 INFO - 'NO_EM_RESTART': '1', 05:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:59 INFO - 'PWD': '/builds/slave/test', 05:01:59 INFO - 'SHELL': '/bin/bash', 05:01:59 INFO - 'SHLVL': '1', 05:01:59 INFO - 'TERM': 'linux', 05:01:59 INFO - 'TMOUT': '86400', 05:01:59 INFO - 'USER': 'cltbld', 05:01:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:59 INFO - '_': '/tools/buildbot/bin/python'} 05:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:59 INFO - Downloading/unpacking psutil>=3.1.1 05:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:06 INFO - Installing collected packages: psutil 05:02:06 INFO - Running setup.py install for psutil 05:02:06 INFO - building 'psutil._psutil_linux' extension 05:02:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:02:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:02:06 INFO - building 'psutil._psutil_posix' extension 05:02:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:02:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:06 INFO - Successfully installed psutil 05:02:06 INFO - Cleaning up... 05:02:06 INFO - Return code: 0 05:02:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:06 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')]} 05:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:06 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')]} 05:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:07 INFO - Using env: {'DISPLAY': ':0', 05:02:07 INFO - 'HOME': '/home/cltbld', 05:02:07 INFO - 'LANG': 'en_US.UTF-8', 05:02:07 INFO - 'LANGUAGE': 'en_US:en', 05:02:07 INFO - 'LOGNAME': 'cltbld', 05:02:07 INFO - 'MAIL': '/var/mail/cltbld', 05:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:07 INFO - 'MOZ_NO_REMOTE': '1', 05:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:07 INFO - 'NO_EM_RESTART': '1', 05:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:07 INFO - 'PWD': '/builds/slave/test', 05:02:07 INFO - 'SHELL': '/bin/bash', 05:02:07 INFO - 'SHLVL': '1', 05:02:07 INFO - 'TERM': 'linux', 05:02:07 INFO - 'TMOUT': '86400', 05:02:07 INFO - 'USER': 'cltbld', 05:02:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:07 INFO - '_': '/tools/buildbot/bin/python'} 05:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:11 INFO - Installing collected packages: mozsystemmonitor 05:02:11 INFO - Running setup.py install for mozsystemmonitor 05:02:11 INFO - Successfully installed mozsystemmonitor 05:02:11 INFO - Cleaning up... 05:02:11 INFO - Return code: 0 05:02:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:12 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:02:12 INFO - Using env: {'DISPLAY': ':0', 05:02:12 INFO - 'HOME': '/home/cltbld', 05:02:12 INFO - 'LANG': 'en_US.UTF-8', 05:02:12 INFO - 'LANGUAGE': 'en_US:en', 05:02:12 INFO - 'LOGNAME': 'cltbld', 05:02:12 INFO - 'MAIL': '/var/mail/cltbld', 05:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:12 INFO - 'MOZ_NO_REMOTE': '1', 05:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:12 INFO - 'NO_EM_RESTART': '1', 05:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:12 INFO - 'PWD': '/builds/slave/test', 05:02:12 INFO - 'SHELL': '/bin/bash', 05:02:12 INFO - 'SHLVL': '1', 05:02:12 INFO - 'TERM': 'linux', 05:02:12 INFO - 'TMOUT': '86400', 05:02:12 INFO - 'USER': 'cltbld', 05:02:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:12 INFO - '_': '/tools/buildbot/bin/python'} 05:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:17 INFO - warning: no files found matching '*.txt' 05:02:17 INFO - no previously-included directories found matching 'build' 05:02:17 INFO - no previously-included directories found matching 'dist' 05:02:17 INFO - no previously-included directories found matching '.git*' 05:02:17 INFO - Installing collected packages: jsonschema, functools32 05:02:17 INFO - Running setup.py install for functools32 05:02:17 INFO - warning: no files found matching '*.txt' 05:02:17 INFO - no previously-included directories found matching 'build' 05:02:17 INFO - no previously-included directories found matching 'dist' 05:02:17 INFO - no previously-included directories found matching '.git*' 05:02:17 INFO - Successfully installed jsonschema functools32 05:02:17 INFO - Cleaning up... 05:02:17 INFO - Return code: 0 05:02:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:17 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')]} 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:17 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')]} 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:18 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 05:02:18 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 05:02:18 INFO - Using env: {'DISPLAY': ':0', 05:02:18 INFO - 'HOME': '/home/cltbld', 05:02:18 INFO - 'LANG': 'en_US.UTF-8', 05:02:18 INFO - 'LANGUAGE': 'en_US:en', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MAIL': '/var/mail/cltbld', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SHLVL': '1', 05:02:18 INFO - 'TERM': 'linux', 05:02:18 INFO - 'TMOUT': '86400', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - '_': '/tools/buildbot/bin/python'} 05:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:18 INFO - Cleaning up... 05:02:18 INFO - Return code: 0 05:02:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:18 INFO - Using env: {'DISPLAY': ':0', 05:02:18 INFO - 'HOME': '/home/cltbld', 05:02:18 INFO - 'LANG': 'en_US.UTF-8', 05:02:18 INFO - 'LANGUAGE': 'en_US:en', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MAIL': '/var/mail/cltbld', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SHLVL': '1', 05:02:18 INFO - 'TERM': 'linux', 05:02:18 INFO - 'TMOUT': '86400', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - '_': '/tools/buildbot/bin/python'} 05:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - Downloading docopt-0.6.1.tar.gz 05:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:22 INFO - Running setup.py install for blobuploader 05:02:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:22 INFO - Running setup.py install for requests 05:02:23 INFO - Running setup.py install for docopt 05:02:23 INFO - Successfully installed blobuploader requests docopt 05:02:23 INFO - Cleaning up... 05:02:23 INFO - Return code: 0 05:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:23 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')]} 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:23 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')]} 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:23 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:23 INFO - Using env: {'DISPLAY': ':0', 05:02:23 INFO - 'HOME': '/home/cltbld', 05:02:23 INFO - 'LANG': 'en_US.UTF-8', 05:02:23 INFO - 'LANGUAGE': 'en_US:en', 05:02:23 INFO - 'LOGNAME': 'cltbld', 05:02:23 INFO - 'MAIL': '/var/mail/cltbld', 05:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:23 INFO - 'MOZ_NO_REMOTE': '1', 05:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:23 INFO - 'NO_EM_RESTART': '1', 05:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:23 INFO - 'PWD': '/builds/slave/test', 05:02:23 INFO - 'SHELL': '/bin/bash', 05:02:23 INFO - 'SHLVL': '1', 05:02:23 INFO - 'TERM': 'linux', 05:02:23 INFO - 'TMOUT': '86400', 05:02:23 INFO - 'USER': 'cltbld', 05:02:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:23 INFO - '_': '/tools/buildbot/bin/python'} 05:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:24 INFO - Running setup.py (path:/tmp/pip-AcK7j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:24 INFO - Running setup.py (path:/tmp/pip-4vJx8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:24 INFO - Running setup.py (path:/tmp/pip-kIVHLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:24 INFO - Running setup.py (path:/tmp/pip-rW01rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:24 INFO - Running setup.py (path:/tmp/pip-ib_o_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:24 INFO - Running setup.py (path:/tmp/pip-AZqWgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:24 INFO - Running setup.py (path:/tmp/pip-MqVQfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:24 INFO - Running setup.py (path:/tmp/pip-3xoyQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:25 INFO - Running setup.py (path:/tmp/pip-Lh6Jyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:25 INFO - Running setup.py (path:/tmp/pip-cWwiJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:25 INFO - Running setup.py (path:/tmp/pip-HJnfT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:25 INFO - Running setup.py (path:/tmp/pip-onDjri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:25 INFO - Running setup.py (path:/tmp/pip-65OAoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:25 INFO - Running setup.py (path:/tmp/pip-yqO9e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:25 INFO - Running setup.py (path:/tmp/pip-3auyWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:25 INFO - Running setup.py (path:/tmp/pip-TFpnPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:25 INFO - Running setup.py (path:/tmp/pip-iUTMwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:25 INFO - Running setup.py install for manifestparser 05:02:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:25 INFO - Running setup.py install for mozcrash 05:02:25 INFO - Running setup.py install for mozdebug 05:02:25 INFO - Running setup.py install for mozdevice 05:02:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:25 INFO - Running setup.py install for mozfile 05:02:25 INFO - Running setup.py install for mozhttpd 05:02:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:25 INFO - Running setup.py install for mozinfo 05:02:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:25 INFO - Running setup.py install for mozInstall 05:02:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozleak 05:02:26 INFO - Running setup.py install for mozlog 05:02:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for moznetwork 05:02:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozprocess 05:02:26 INFO - Running setup.py install for mozprofile 05:02:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozrunner 05:02:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozscreenshot 05:02:26 INFO - Running setup.py install for moztest 05:02:26 INFO - Running setup.py install for mozversion 05:02:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:27 INFO - Cleaning up... 05:02:27 INFO - Return code: 0 05:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:27 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:27 INFO - Using env: {'DISPLAY': ':0', 05:02:27 INFO - 'HOME': '/home/cltbld', 05:02:27 INFO - 'LANG': 'en_US.UTF-8', 05:02:27 INFO - 'LANGUAGE': 'en_US:en', 05:02:27 INFO - 'LOGNAME': 'cltbld', 05:02:27 INFO - 'MAIL': '/var/mail/cltbld', 05:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:27 INFO - 'MOZ_NO_REMOTE': '1', 05:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:27 INFO - 'NO_EM_RESTART': '1', 05:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:27 INFO - 'PWD': '/builds/slave/test', 05:02:27 INFO - 'SHELL': '/bin/bash', 05:02:27 INFO - 'SHLVL': '1', 05:02:27 INFO - 'TERM': 'linux', 05:02:27 INFO - 'TMOUT': '86400', 05:02:27 INFO - 'USER': 'cltbld', 05:02:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:27 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:28 INFO - Running setup.py (path:/tmp/pip-Lqp7qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:28 INFO - Running setup.py (path:/tmp/pip-Z5s2dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:28 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)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:28 INFO - Running setup.py (path:/tmp/pip-mis1V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:28 INFO - Running setup.py (path:/tmp/pip-z_fLqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:28 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)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:28 INFO - Running setup.py (path:/tmp/pip-Pcx4KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:28 INFO - Running setup.py (path:/tmp/pip-z48NJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:28 INFO - Running setup.py (path:/tmp/pip-FMAjIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:28 INFO - Running setup.py (path:/tmp/pip-IazcWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:28 INFO - Running setup.py (path:/tmp/pip-DLojjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:28 INFO - Running setup.py (path:/tmp/pip-Sc_vo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:28 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)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:28 INFO - Running setup.py (path:/tmp/pip-GkzgGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:28 INFO - Running setup.py (path:/tmp/pip-2yZRqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:28 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)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:28 INFO - Running setup.py (path:/tmp/pip-s4LikF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:29 INFO - Running setup.py (path:/tmp/pip-Euzkhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:29 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)) 05:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:29 INFO - Running setup.py (path:/tmp/pip-VlME2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:29 INFO - Running setup.py (path:/tmp/pip-LEvz2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:29 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)) 05:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:29 INFO - Running setup.py (path:/tmp/pip-XrYOHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:02:29 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)) 05:02:29 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)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:29 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)) 05:02:29 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)) 05:02:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:32 INFO - Downloading blessings-1.6.tar.gz 05:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:32 INFO - Installing collected packages: blessings 05:02:32 INFO - Running setup.py install for blessings 05:02:32 INFO - Successfully installed blessings 05:02:32 INFO - Cleaning up... 05:02:32 INFO - Return code: 0 05:02:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:32 INFO - Reading from file tmpfile_stdout 05:02:32 INFO - Current package versions: 05:02:32 INFO - argparse == 1.2.1 05:02:32 INFO - blessings == 1.6 05:02:32 INFO - blobuploader == 1.2.4 05:02:32 INFO - docopt == 0.6.1 05:02:32 INFO - functools32 == 3.2.3-2 05:02:32 INFO - jsonschema == 2.5.1 05:02:32 INFO - manifestparser == 1.1 05:02:32 INFO - mozInstall == 1.12 05:02:32 INFO - mozcrash == 1.0 05:02:32 INFO - mozdebug == 0.1 05:02:32 INFO - mozdevice == 0.49 05:02:32 INFO - mozfile == 1.2 05:02:32 INFO - mozhttpd == 0.7 05:02:32 INFO - mozinfo == 0.9 05:02:32 INFO - mozleak == 0.1 05:02:32 INFO - mozlog == 3.4 05:02:32 INFO - moznetwork == 0.27 05:02:32 INFO - mozprocess == 0.25 05:02:32 INFO - mozprofile == 0.28 05:02:32 INFO - mozrunner == 6.13 05:02:32 INFO - mozscreenshot == 0.1 05:02:32 INFO - mozsystemmonitor == 0.3 05:02:32 INFO - moztest == 0.8 05:02:32 INFO - mozversion == 1.4 05:02:32 INFO - psutil == 3.1.1 05:02:32 INFO - requests == 1.2.3 05:02:32 INFO - wsgiref == 0.1.2 05:02:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:34 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 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:34 INFO - Using env: {'DISPLAY': ':0', 05:02:34 INFO - 'HOME': '/home/cltbld', 05:02:34 INFO - 'LANG': 'en_US.UTF-8', 05:02:34 INFO - 'LANGUAGE': 'en_US:en', 05:02:34 INFO - 'LOGNAME': 'cltbld', 05:02:34 INFO - 'MAIL': '/var/mail/cltbld', 05:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:34 INFO - 'MOZ_NO_REMOTE': '1', 05:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:34 INFO - 'NO_EM_RESTART': '1', 05:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:34 INFO - 'PWD': '/builds/slave/test', 05:02:34 INFO - 'SHELL': '/bin/bash', 05:02:34 INFO - 'SHLVL': '1', 05:02:34 INFO - 'TERM': 'linux', 05:02:34 INFO - 'TMOUT': '86400', 05:02:34 INFO - 'USER': 'cltbld', 05:02:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:34 INFO - '_': '/tools/buildbot/bin/python'} 05:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:34 INFO - Cleaning up... 05:02:34 INFO - Return code: 0 05:02:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:34 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')]} 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:34 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')]} 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, '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-1490616080.876786-610626729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02: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', 'jsonschema'] in /builds/slave/test/build 05:02: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 jsonschema 05:02:35 INFO - Using env: {'DISPLAY': ':0', 05:02:35 INFO - 'HOME': '/home/cltbld', 05:02:35 INFO - 'LANG': 'en_US.UTF-8', 05:02:35 INFO - 'LANGUAGE': 'en_US:en', 05:02:35 INFO - 'LOGNAME': 'cltbld', 05:02:35 INFO - 'MAIL': '/var/mail/cltbld', 05:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:35 INFO - 'MOZ_NO_REMOTE': '1', 05:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:35 INFO - 'NO_EM_RESTART': '1', 05:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:35 INFO - 'PWD': '/builds/slave/test', 05:02:35 INFO - 'SHELL': '/bin/bash', 05:02:35 INFO - 'SHLVL': '1', 05:02:35 INFO - 'TERM': 'linux', 05:02:35 INFO - 'TMOUT': '86400', 05:02:35 INFO - 'USER': 'cltbld', 05:02:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:35 INFO - '_': '/tools/buildbot/bin/python'} 05:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:35 INFO - Cleaning up... 05:02:35 INFO - Return code: 0 05:02:35 INFO - Running post-action listener: _resource_record_post_action 05:02:35 INFO - Running post-action listener: _start_resource_monitoring 05:02:35 INFO - Starting resource monitoring. 05:02:35 INFO - [mozharness: 2017-03-27 12:02:35.478067Z] Finished create-virtualenv step (success) 05:02:35 INFO - [mozharness: 2017-03-27 12:02:35.478580Z] Running install step. 05:02:35 INFO - Running pre-action listener: _resource_record_pre_action 05:02:35 INFO - Running main action method: install 05:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:35 INFO - Reading from file tmpfile_stdout 05:02:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:35 INFO - Reading from file tmpfile_stdout 05:02:35 INFO - Output received: 05:02:35 INFO - Usage: mozinstall [options] installer 05:02:35 INFO - Options: 05:02:35 INFO - -h, --help show this help message and exit 05:02:35 INFO - -d DEST, --destination=DEST 05:02:35 INFO - Directory to install application into. [default: 05:02:35 INFO - "/builds/slave/test"] 05:02:35 INFO - --app=APP Application being installed. [default: firefox] 05:02:35 INFO - mkdir: /builds/slave/test/build/application 05:02:35 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'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:02:52 INFO - Reading from file tmpfile_stdout 05:02:52 INFO - Output received: 05:02:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:52 INFO - Running post-action listener: _resource_record_post_action 05:02:52 INFO - [mozharness: 2017-03-27 12:02:52.717064Z] Finished install step (success) 05:02:52 INFO - [mozharness: 2017-03-27 12:02:52.717401Z] Running run-tests step. 05:02:52 INFO - Running pre-action listener: _resource_record_pre_action 05:02:52 INFO - Running main action method: run_tests 05:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:52 INFO - Python 2.7.3 05:02:52 INFO - Return code: 0 05:02:52 INFO - grabbing minidump binary from tooltool 05:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a400>, '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 0x134b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:02:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:02:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:02:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:52 INFO - Return code: 0 05:02:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:52 INFO - ENV: RUST_BACKTRACE is now 1 05:02:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:02:52 INFO - Using env: {'DISPLAY': ':0', 05:02:52 INFO - 'HOME': '/home/cltbld', 05:02:52 INFO - 'LANG': 'en_US.UTF-8', 05:02:52 INFO - 'LANGUAGE': 'en_US:en', 05:02:52 INFO - 'LOGNAME': 'cltbld', 05:02:52 INFO - 'MAIL': '/var/mail/cltbld', 05:02:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:52 INFO - 'MOZ_NO_REMOTE': '1', 05:02:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:52 INFO - 'NO_EM_RESTART': '1', 05:02:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:52 INFO - 'PWD': '/builds/slave/test', 05:02:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:52 INFO - 'RUST_BACKTRACE': '1', 05:02:52 INFO - 'SHELL': '/bin/bash', 05:02:52 INFO - 'SHLVL': '1', 05:02:52 INFO - 'TERM': 'linux', 05:02:52 INFO - 'TMOUT': '86400', 05:02:52 INFO - 'USER': 'cltbld', 05:02:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490616080.876786-610626729', 05:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:52 INFO - '_': '/tools/buildbot/bin/python'} 05:02:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:02:53 INFO - mozversion application_buildid: 20170327105736 05:02:53 INFO - mozversion application_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 05:02:53 INFO - mozversion application_display_name: Nightly 05:02:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:53 INFO - mozversion application_name: Firefox 05:02:53 INFO - mozversion application_remotingname: firefox 05:02:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:02:53 INFO - mozversion application_vendor: Mozilla 05:02:53 INFO - mozversion application_version: 55.0a1 05:02:53 INFO - mozversion platform_buildid: 20170327105736 05:02:53 INFO - mozversion platform_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 05:02:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:02:53 INFO - mozversion platform_version: 55.0a1 05:02:53 INFO - using testdate: 1490616173 05:02:53 INFO - actual date: 1490616173 05:02:53 INFO - starting webserver on 'localhost:52530' 05:02:53 INFO - SUITE-START | Running 2 tests 05:02:53 INFO - TEST-START | dromaeo_css 05:02:53 INFO - operating with platform_type : linux_ 05:02:53 INFO - Initialising browser for dromaeo_css test... 05:02:53 INFO - TEST-INFO | started process 18633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajjHJ2/profile http://localhost:52530/getInfo.html) 05:02:57 INFO - PID 18633 | __metrics Screen width/height:1600/1200 05:02:57 INFO - PID 18633 | colorDepth:24 05:02:57 INFO - PID 18633 | Browser inner width/height: 1024/697 05:02:57 INFO - PID 18633 | __metrics 05:02:58 ERROR - PID 18633 | 1490616178222 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:02:58 INFO - PID 18633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:58 INFO - PID 18633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:59 INFO - TEST-INFO | 18633: exit 0 05:02:59 INFO - Browser initialized. 05:02:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:59 INFO - TEST-INFO | started process 18727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajjHJ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:11 INFO - PID 18727 | RSS: Main: 144855040 05:03:11 INFO - PID 18727 | 05:06:13 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52530/tests/dromaeo/cssquery-ext.html) 05:06:15 INFO - PID 18727 | RSS: Main: 293650432 05:06:15 INFO - PID 18727 | 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | A coding exception was thrown and uncaught in a Task. 05:08:00 INFO - PID 18727 | 05:08:00 ERROR - PID 18727 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:00 INFO - PID 18727 | Full stack: 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | A coding exception was thrown and uncaught in a Task. 05:08:00 INFO - PID 18727 | 05:08:00 ERROR - PID 18727 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:00 INFO - PID 18727 | Full stack: 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | A coding exception was thrown and uncaught in a Task. 05:08:00 INFO - PID 18727 | 05:08:00 ERROR - PID 18727 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:00 INFO - PID 18727 | Full stack: 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | ************************* 05:08:00 INFO - PID 18727 | A coding exception was thrown and uncaught in a Task. 05:08:00 INFO - PID 18727 | 05:08:00 ERROR - PID 18727 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:00 INFO - PID 18727 | Full stack: 05:08:00 INFO - PID 18727 | ************************* 05:09:17 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-ext.html (next: http://localhost:52530/tests/dromaeo/cssquery-jquery.html) 05:09:18 INFO - PID 18727 | RSS: Main: 227090432 05:09:18 INFO - PID 18727 | 05:12:20 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52530/tests/dromaeo/cssquery-mootools.html) 05:12:20 INFO - PID 18727 | RSS: Main: 217530368 05:12:20 INFO - PID 18727 | 05:15:22 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52530/tests/dromaeo/cssquery-prototype.html) 05:15:23 INFO - PID 18727 | RSS: Main: 203771904 05:15:23 INFO - PID 18727 | 05:18:26 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52530/tests/dromaeo/cssquery-yui.html) 05:18:26 INFO - PID 18727 | RSS: Main: 180883456 05:18:26 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | Cycle 1(1): loaded http://localhost:52530/tests/dromaeo/cssquery-yui.html (next: http://localhost:52530/tests/dromaeo/cssquery-dojo.html) 05:21:29 INFO - PID 18727 | RSS: Main: 270798848 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | __start_tp_report 05:21:29 INFO - PID 18727 | _x_x_mozilla_page_load 05:21:29 INFO - PID 18727 | _x_x_mozilla_page_load_details 05:21:29 INFO - PID 18727 | |i|pagename|runs| 05:21:29 INFO - PID 18727 | |0;dojo.html;3320.8671653133874;3327.9168020799493;3352.999999999999;3361.2605226850083;3383.949240761389;5642.238297829792;5740.167675687023;5790.884182316357;5794.188813566099;5796.130580412935;5753.856153596152;5768.192453056565;5774.307083150017;5809.3609702932745;5858.88282234355;5021.472745361739;5091.592672586185;5139.12634852076;5180.274761533388;5198.558122559568;5181.999999999981;5236.764345604438;5247.107991641411;5254.4220135785035;5300.204969254604;5058.747062646853;5113.667611605271;5116.897662046776;5122.692638441706;5172.456892026339;5165.251038599382;5181.404138524081;5190.558802501791;5238.895222095575;5249.816256431007;5110.207917772751;5167.457416971201;5170.1986192140275;5170.715610641413;5208;5583.134614134816;5727.169560413717;5731.254936858182;5737.053386191315;5749.425057494259;6118.510519158456;6132.969335153341;6138.815835524942;6195.5663103582765;6200.782972595983;6260.937390626081;6273.62358258506;6285;6295.5907865988565;6296.6536840473755;5772.855678607984;5778.27771528559;5802.7098645068;5823.184754134425;5871.794487192928;6143.143438301211;6228.5951413158;6318.968405157945;6404.135441715402;6429.067785171124;6119.746288422617;6133.407859146218;6140.13616995768;6149.477294429934;6155.661438620829;6166;6171.47542458896;6175.197224360894;6185.721642526097;6189.690515474208;6022.307434644984;6112.174856394418;6156.846078848064;6212.782552610637;6215.34738852423;6118;6119.296280927751;6121.755129794758;6179.84550386244;6200.255969283625;4769.856904292877;4774.689645173053;4775.06886157196;4801.4718380978065;4804.663673542818;4218.198542276958;4227.260229459832;4230.259704551752;4241.427407300037;4269.551697071763;5653.943460565341;5701.315842098975;5778.653280803165;5782.595218334676;5823.79616713413;6235.251769787564;6237.220347456568;6290.622562646256;6291.182146321041;6302.275238347649;5834.708264586754;5849.795257165979;5856.326522449887;5859.062549991981;5902.05567109269;5164.1995490698255;5231.607629427732;5244.160934250578;5305.495977882095;5319.388270348882;6427.839304017437;6430.871382572323;6437.1631687879335;6443;6453.161089058486;6057.697115144313;6178.351273116258;6196.721147548281;6228.439440450381;6230.283517395557;6318.147050148171;6318.747250109944;6329.5252856036905;6446.548741588043;6449.290578036506;6122.2959359674205;6158.168647232566;6166.537509686881;6168.321484636596;6171.352008039091;6277.18396608438;6286.245650521783;6301.4643755279485;6311.96844015777;6315.210598675166;5921.585489015728;5933.436323549256;5983.640981541122;6093.512518998381;6105.389461053859;6077.149199112039;6079.452849243589;6112.8777424452155;6124.969375153096;6134.079888016833;6034.39656034393;6036.547258955684;6055.697215139314;6056.0915862619195;6060.333363329942;5817.767289308549;5903.645781253139;5978.611390259794;6106.2061931948565;6126.846828829315;5845.18167456548;5896.734646940812;5970.014947533608;5985.281766188085;5988.431099045758 05:21:29 INFO - PID 18727 | |1;ext.html;645.1580687203198;703.6024646074967;722.6856317501887;1134.5291703942864;1145.375770205238;29780.851095744518;36567;37275.440868387;37296.81351593238;37428.06429839256;39417.605823941754;39904.40143397851;39906;39927;39943;6103.969480152615;6227.470664993459;8259.752207433772;8464.703735369263;8466.872996905051;8053.1946805319585;8228.341732661404;8231;8231.794205144859;8405.327573794113;8406.537640429773;8511.404201705884;8513.148685131498;8516.190961858614;8517.95741021294;8412;8443.915560844374;8472.957635211784;8476.237138657489;8485.575721213945;8043.55760433176;8090.555019473926;8092.3526117911015;8095.23095305945;8095.311898488636;41195.1760964782;41504;41566.58433415657;41606.375904361455;41693;3036.7418769404626;3038.7417069549115;3042.756579473659;3042.969570304313;3068.892588759405;28705.425891482264;28751.56872646912;29053.56419653707;29303.413931721247;29351.85324073387;3718.1819999600316;3720.720945929066;3751.549814022335;3782.0733920189455;3812.6759225465867;220730;220966;221464;223066;223721.88139059363;49102.5089749098;49173.50826491689;49274.753626232356;49287.50712492901;49324;52380;52464.47535524672;52525.47474525206;52771.20843187355;52821.471785281654;14217.218053006976;14586.19775912335;14605.269736513132;14611.269436528131;14620.195889226196;10476.947615261875;10614.416207108528;11537.19239653233;11643.719190888996;11662.067034637208;13469.12450690702;13565.864341356657;13614.863851361557;13802.516911908035;14199.503017394341;5251.658642188246;5254.816081437131;5259.500347466985;5292.760167434212;5335.599830012765;991.8859331176862;1025.876894772617;1038.1435315864442;1038.7662775875367;1059.4067322299536;25479.23562293134;25541.61687574688;25564.74435255661;25844;25863.0947916822;1136.6930928649383;1137.6188976692902;1165.1669056624385;1170.5961443302047;1180.0500597019482;12978.740425191443;13165.67085822843;13255;13322.533711320057;13364.264965426995;284341;285921;286097;286119;286206;54266.18600720992;54640.45359546433;54656;54715;54716.72641636846;1412.6731547206386;1458.0959804921017;1462.2615579132682;1472.6980968901564;1498.88008959283;23405.297841064796;24328.27015189547;24849;25007.624885627094;25140.371490712878;40903.795481022404;45649;46758.53241467678;46879;46945;209506;211352;211656;258760;260966;25933.22200333993;26159.476810464064;30019.69980300169;30134.438572721563;32893.50659740154;37756.43365349577;37777.81111094427;37844.243115138095;37930;37931.81034094812;28993.275168120123;29675.554866676586;31435.58539865757;31444.213894652818;31674.68325316717;31199.532007020367;31274.843625781727;31331.530027049157;31645.525317119802;32045.35909281848;35350;35731.285374292886;36304.63695363013;36478.08804779796;36531.81734091313;30524.542131868486;30531.694683053774;30783.076507704805;30820.22949426282;31789.20526986844;23340.533189336456;24239.394015149763;24796.25611231666;24818.926133793502;24887.253382398558 05:21:29 INFO - PID 18727 | |2;jquery.html;437.4728452215081;438.3753151758743;438.77403137384243;443.1845404455802;456.8446728112441;18206.726899096506;19509.609807803834;19860.602787944234;20072.096755645995;20133.697994530077;19755.506112347197;20697.793022069774;21105.366838994818;21243.68134477984;21443.463913402175;6565.671716414172;6773.864522709543;6816;6922.826929326782;6930.13373328334;6401.199850018747;6648.135742353512;6675.299093595176;6675.46596272297;6912.896306555381;6675.66621668917;6678.66606669667;6680.799576012728;6690.163729533809;6743.123393958778;6591.176102987127;6728.596284222914;6755.5271131020845;6767.830804229909;6792.388685018347;6420.711068001951;6584.670766461706;6618.834529136762;6650.900236496456;6673.065770792093;26831.463370732672;27195.592066119025;27306.180814575593;27353.179404617895;27599.17202483929;2056.465319017066;2076.5743022680313;2082.864613800113;2133.9253126140666;2166.4942864709033;16310.918445407815;16998;17490.650186996318;17560.005595858973;17932;1873.6065426260502;1934.9129289182022;1943.6598595245916;1944.1445763863856;1948.074664534349;88177;107150.46424767826;111963;112611;113313;20515.281965131147;20599.691004634944;20599.691004634944;20884.686729699068;21053.368398948056;39006;39256;39264;39326.606733932866;39542.20915581672;9955.402675839472;10325.84511232332;10410.479476026168;10462.581496740046;10715.678529644123;8195.34437245019;8239.95880020596;8358.373122015873;8472.49165050099;8492.70275540353;10420.426876521864;10761.569537218424;10873.107101804062;11103.72240693989;11185.832212516818;4071.4603217412373;4082.1631565528996;4138.420621113047;4148.834046638161;4211.473565804275;988.4810474500945;1007.596961215505;1010.9292349535609;1016.9949150254201;1019.4647809899861;20061.799382006284;20156.395308140778;20161.092750826247;20422;20656.58686826255;1024.6567399920962;1025.1388833379997;1031.9380837149795;1032.7211652853687;1051.3429106808244;10347.793044139074;11267;11277;11286.266392684449;11313.773724525463;579712.3330816926;587681;592006;594318;595592;104925.47537262265;106203.53345591162;106946;109147.45426272818;111322;1170.7278551298334;1173.6971961123147;1194.9402529873646;1199.748052908899;1200.2798321007326;16498.505044848673;16861.40985065566;17207.107218206238;17378.131093445023;17586.648267034845;44956.550434496545;45357.54642453533;46831.53168468272;47158.29262560996;47433.28850067183;56945.43054569567;57293;57628;57797.422025779204;66577.66711166414;8633.784155396166;8722.91277087221;8828.24959878392;9240;9267.304952128483;9145.908540914506;13344;14222.928885355506;14429.134251944917;14775.261236938326;11574.768504630028;11596.188266821242;11990.520379184734;12275.447604857982;12455.750884982432;10289.382637041503;10332.431716255378;11206.215564910704;11260.436978151223;11495.597654082067;12438.502459901865;12561.623151305475;12758.553450629555;12969.767872052518;12989;8459.365547584079;8494.74515764528;8974.14745599167;9219.492927888763;9312.953435232781;11191.384473854016;11785.469653865768;11840.585579504675;11849.170558060852;11852 05:21:29 INFO - PID 18727 | |3;mootools.html;1186.4186548591183;1328.8604696506866;1372.9038967272288;1406.4093080906025;1408.9506867259643;9103.954480227598;10380.740481487957;10883.782324353528;10902.945485272583;10912.345259284448;10587.841182382252;10675.83986240205;10676.252662313642;10683.626073087444;10691.78616427671;1951.8874241682176;2017;2309.3880121767743;2363.917262895799;2364.408897775556;2301.9539609207804;2356.4344557306295;2364.6807680963107;2369.857808531485;2369.8815059247054;2309.9422514437106;2332.93001209964;2341.519988402382;2344.4138965258685;2353.2587235021;2304.9308520744403;2338.6141286687675;2339.368370539945;2340.32130682102;2341.625339945609;2225.4770129019666;2225.9332220033425;2228.220122956968;2229.9331020069426;2232.0960011195493;10782.083522900562;10966.287191332538;10988;11015.889841101647;11035.613753518668;6080.878382432371;6249.468795152417;6276.278228003793;6294.622322660655;6300.30696623371;3557.1996300832106;3718.9814050929845;3882.592327805568;3925.097227637659;3940.1922605866016;1254.7051442910908;1311.4360824845312;1347.2253454263837;1364.4746772492563;1373.1417863835104;16449.67100657992;16533.58666033347;16549.420770273104;16571.50285491425;16577.254023568967;5132.127538318495;5141.53726164647;5173.482651734872;5407.324084489439;5508.724563771795;12530.185537940004;12551.3096779678;12554.560590379293;12561.623151305475;12586.87413125857;5991.5206783457215;6029.186059881948;6031.336552979169;6032.607880487754;6038.365971573009;5302.443243459458;5404.540614047772;5447.618666693294;5457.836264912059;5532.557395408438;4309.655227581786;4361.5856493633055;4396.516383197845;4458.4426946631675;4480.529544397791;1299.7595444842734;1310.8951283897266;1316.967075823112;1320.221069568959;1325.5824415309146;783.9725609603751;801.054755388647;802.7029998900327;812.6586833529932;814.9609248208582;6019.69901504923;6850.417714494224;7016.7544135954995;7115;7170.318819712224;872.1627237851607;897.5781382750097;949.5869296855751;951.286535098676;972.8005758819424;4138.813753381105;4258;4268.615824575803;4427.712198707074;4471.686981911235;13989.65025874341;14537.709245815236;14550.563483095524;14556.344964476624;14580.270986450634;13716.314184290746;14255.073420227653;14333.64165895861;14438.422463101568;14485.203313817841;9464.148226659634;9672;9677.37097088687;9744.415335079917;9752.609895604097;6359.586626869239;6830.7267709293055;6833.214180369321;6926.722931082701;6952.5480843745;12403.25580465175;12536.122471426912;12570.685732856751;12693.873061269269;13225.338733063501;12675.17611355259;12741.49034038628;12755.234685918875;12795.61613151607;12821.679458013625;9756.07317304855;9949.303548751517;9998.400095994264;10003.399796012263;10031.899681003097;9824;9842.458664773507;9990.750231244278;10017.849732253877;10091.44497052669;8574.614142363484;8634.78413039654;8725.345599080221;8817.823643526965;8842.46945183291;8546.572671366532;8645.135486451556;8671.869921951049;8686.174813392718;8768.254698350456;7969.26792662874;8015.278624923785;8018.639161237642;8109.59452027408;8113.797155071171;5994.550408719277;6019.759209631566;6075.878482430415;6268.561200716089;6283.277423096402;6120.143179954899;6147.631142131487;6149.600275982047;6170.81487555374;6328.7152078157515 05:21:29 INFO - PID 18727 | |4;prototype.html;407.89190864420914;411.4260606453997;421.1597862264781;426.10305307328076;430.14830635342;5638.971805140979;5847.912281315784;5872;5938.970305148474;5948.791792287277;5649.830505084844;5813;5814.883702325951;5824.621399609023;5850.88298234035;4630.120277147348;4672.11229866326;4672.509386514418;4687.414073240845;4694.342792009122;4554.2713165893465;4646.97676511617;4661.836835710751;4671.509491503394;4699.201135806904;4644.027822193799;4652.232381657022;4652.6510511711585;4655.720656760588;4673.6027437667835;4638.350630911675;4654.604358629537;4667.763042793628;4678.976605116953;4687.10944920464;4164.146349998243;4179.331306990897;4235.0682849773;4250.852269887144;4267.125239325962;5645.7579332546775;5682.51698605619;5720.542356611461;5725.77096916127;5730.828075157752;5429.864253393657;5439.129739241742;5441.619086663935;5444.564434845203;5457.2359869618285;5963.701814909281;6127.234095738033;6131.87736245277;6145.754169833202;6184.288806787187;4595.701279416827;4627.629789616823;4634.490206077363;4649.651276154268;4655.464621568529;6229.003359462465;6418.582792118497;6421.422072013541;6454.515911306624;6465.644389558573;4767.261074533453;4787.234042553175;4790.928136077961;4800.231962885921;4814.061258054646;4851.733154676456;4866.4403593586485;4868.610511159099;4872.319049927769;4879.072976134523;5180.300659410931;5390.544552970754;5415.862668839588;5426.810061647902;5430.8913821723345;5849.093390524476;6068.302145253264;6161.168242287324;6205.751769929243;6214.302490018522;1615.9757603635956;1630.5189968959185;1634.1502418742186;1635.5338728462332;1643.2030465224357;1146.7419830538229;1207.402335843763;1239.857416397126;1242.9005679545614;1245.5765039886483;5803.506701930383;5832.70677627676;5927.614705044159;5983.055506960255;5984.491318237911;6320.399562041599;6333.65164915934;6334.208223972004;6344.270408903035;6399.9040014399825;5833.387494313036;5897.64614123154;5907.70461476933;5915.349311575723;5938.002617356501;3214.2125179331215;3362.394768941614;3371.5279860819505;3391.423458012144;3397.3545026444895;6590.41829960806;6639.336066393419;6642.269350371455;6661.1007513985;6666.200055993312;6419.325970773001;6450.774222902176;6482.9405401132735;6493.149452406042;6502.902456463157;6539.967300163564;6563.835904102436;6569.868602627921;6577.572457790228;6593.274739778621;6173.59871608344;6334.366563343813;6361.363863613602;6418.261899881573;6430.710618022294;6276.246850377984;6288.685565721604;6290.591111577733;6295.18162638854;6331;6413.921317767405;6561.605014169698;6604.249873783355;6614.900776488453;6647.368499992493;4506.526814684542;4514.164879497303;4521.66087543429;4522.615577675934;4549.545045495424;6410.647414392067;6412.967935160481;6416.427975146119;6417.1711062347;6481.157449531531;5991.430814072656;6130.601510901777;6188.783392581238;6201.441870231521;6240.719167637377;5890.970545147246;6020.51835853122;6032.426919442646;6213.65824879636;6237.4074462927765;6197.380261973766;6236.314005459487;6237.844053898689;6241.438270555672;6255.812325630239;5890.676012819336;5896.941030589811;6214.8135555933395;6226.128342032029;6264.404881536247;5984.31180414258;6019.458248757633;6028.638281703112;6057.757689692363;6081.27024757032 05:21:29 INFO - PID 18727 | |5;yui.html;759.3659294489102;768.773211902489;768.8885111658809;772.5905270206786;773.1263672050584;15412.845871541282;15981.200939953014;16012.43956461524;16113;16136.19319034048;13774.311284435787;14422.062565933207;14683;14967.326470308835;15771.447999320026;818.116434251009;835.340081335744;835.9498430094184;839.1440730454963;840.9159084091604;818.0837462042521;833.9958300208491;835.2566216067704;836.3518273338151;837.1293854391425;863.7711006583261;879.7800549862534;882.1531329923249;882.1883866842488;882.2412725056446;861.995690021549;872.759991002473;875.9781005474882;878.964841406343;880.1506546182932;629.4115002472657;636.3572791480592;638.3297537585563;644.8258970078052;646.7994921574327;13930.442782288797;14208.360623771852;14328.641783955485;14474.348654310581;14492.34784434703;12223.69440763988;12330.260184388966;12465.563705270271;12633.747325053539;12829.23024618526;11154.888451115547;11237.269577477438;11326.603568875133;11342.546298148065;11577.6526704199;3035.180501264646;3043.421749867518;3044.862981165853;3063.417950589381;3089.7373723233554;76499.23500764977;76735;76738.61630691867;77714;77918.61040694817;9657.855132173023;9681.225501959827;9914.454704991294;9916.305858589829;9917.7024689258;19720.112594933264;19724.309649162496;19737.111829967685;19771.209151634062;19866.205351785768;7603.0876294844975;7673.923260767321;7684.577348245788;7867.960660196777;8026.077001144827;3988;4014.8394064237104;4043.1711499142607;4043.292423825819;4054.9797251013556;3795.35478968576;4009.3384591542654;4019.4774679291504;4027.2146931348107;4041.474608300902;768.6502641298196;785.972490962825;791.3669064748178;799.588212070784;813.9308158806567;585.4409039367393;611.4894063457064;613.6164896939413;615.6060121522229;617.5677026081761;10600.946995264974;10890.493082124076;11144.2756220847;11233.719157020976;11318.717032074099;589.2222266608122;604.1089393145076;620.7734177025444;622.1756173070609;624.406813527151;4627.9074418511445;4804.687695299865;4807.278908163734;4814.15752243356;4814.253790662453;72591;83126;83275;84534;87212.5639371799;40331.79834100811;55981;73283.63358183175;74154.62922685352;76438;48886;61825;62042;62618.68690656518;63146.36853631497;10783.51474183648;11347;11419.543218271509;11458.484368203284;11554.884451155382;32097.518537222426;32178.83910580432;32196.83901580477;32199.356012879143;32427.001944625685;39975.80012099921;40213.798931005156;40219.597804021585;40288.59711402848;41518;12910.548130815376;13107;13250.867491324963;13330.733385332433;13391.062625616114;14552.708945820812;14683.779743304072;14887.330070146652;15099.54701358961;15777.921110394374;14127.364268607731;14486.275686215859;14521;14713.632159196106;14933;12987.857003594301;13039;13101.213927164401;13347.399367028702;13732.794008089686;13102.868971310165;13456.46174153023;13648.863511365156;13883.305834708426;14174.07868488545;9248.537573121183;9276.536173191178;9406.670766523413;9883.30816842814;9903.50482475859;10617.522211500347;10718.785624287315;10765.571755488687;10903.400312982862;10914 05:21:29 INFO - PID 18727 | __end_tp_report 05:21:29 INFO - PID 18727 | __start_cc_report 05:21:29 INFO - PID 18727 | _x_x_mozilla_cycle_collect,1533 05:21:29 INFO - PID 18727 | __end_cc_report 05:21:29 INFO - PID 18727 | __startTimestamp1490617289430__endTimestamp 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | ------- Summary: start ------- 05:21:29 INFO - PID 18727 | Number of tests: 6 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#0] dojo.html Cycles:165 Average:5736.59 Median:5978.61 stddev:666.46 (11.1%) stddev-sans-first:640.99 05:21:29 INFO - PID 18727 | Values: 3320.9 3327.9 3353.0 3361.3 3383.9 5642.2 5740.2 5790.9 5794.2 5796.1 5753.9 5768.2 5774.3 5809.4 5858.9 5021.5 5091.6 5139.1 5180.3 5198.6 5182.0 5236.8 5247.1 5254.4 5300.2 5058.7 5113.7 5116.9 5122.7 5172.5 5165.3 5181.4 5190.6 5238.9 5249.8 5110.2 5167.5 5170.2 5170.7 5208.0 5583.1 5727.2 5731.3 5737.1 5749.4 6118.5 6133.0 6138.8 6195.6 6200.8 6260.9 6273.6 6285.0 6295.6 6296.7 5772.9 5778.3 5802.7 5823.2 5871.8 6143.1 6228.6 6319.0 6404.1 6429.1 6119.7 6133.4 6140.1 6149.5 6155.7 6166.0 6171.5 6175.2 6185.7 6189.7 6022.3 6112.2 6156.8 6212.8 6215.3 6118.0 6119.3 6121.8 6179.8 6200.3 4769.9 4774.7 4775.1 4801.5 4804.7 4218.2 4227.3 4230.3 4241.4 4269.6 5653.9 5701.3 5778.7 5782.6 5823.8 6235.3 6237.2 6290.6 6291.2 6302.3 5834.7 5849.8 5856.3 5859.1 5902.1 5164.2 5231.6 5244.2 5305.5 5319.4 6427.8 6430.9 6437.2 6443.0 6453.2 6057.7 6178.4 6196.7 6228.4 6230.3 6318.1 6318.7 6329.5 6446.5 6449.3 6122.3 6158.2 6166.5 6168.3 6171.4 6277.2 6286.2 6301.5 6312.0 6315.2 5921.6 5933.4 5983.6 6093.5 6105.4 6077.1 6079.5 6112.9 6125.0 6134.1 6034.4 6036.5 6055.7 6056.1 6060.3 5817.8 5903.6 5978.6 6106.2 6126.8 5845.2 5896.7 5970.0 5985.3 5988.4 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#1] ext.html Cycles:180 Average:40741.79 Median:31439.90 stddev:64718.40 (205.8%) stddev-sans-first:64829.92 05:21:29 INFO - PID 18727 | Values: 645.2 703.6 722.7 1134.5 1145.4 29780.9 36567.0 37275.4 37296.8 37428.1 39417.6 39904.4 39906.0 39927.0 39943.0 6104.0 6227.5 8259.8 8464.7 8466.9 8053.2 8228.3 8231.0 8231.8 8405.3 8406.5 8511.4 8513.1 8516.2 8518.0 8412.0 8443.9 8473.0 8476.2 8485.6 8043.6 8090.6 8092.4 8095.2 8095.3 41195.2 41504.0 41566.6 41606.4 41693.0 3036.7 3038.7 3042.8 3043.0 3068.9 28705.4 28751.6 29053.6 29303.4 29351.9 3718.2 3720.7 3751.5 3782.1 3812.7 220730.0 220966.0 221464.0 223066.0 223721.9 49102.5 49173.5 49274.8 49287.5 49324.0 52380.0 52464.5 52525.5 52771.2 52821.5 14217.2 14586.2 14605.3 14611.3 14620.2 10476.9 10614.4 11537.2 11643.7 11662.1 13469.1 13565.9 13614.9 13802.5 14199.5 5251.7 5254.8 5259.5 5292.8 5335.6 991.9 1025.9 1038.1 1038.8 1059.4 25479.2 25541.6 25564.7 25844.0 25863.1 1136.7 1137.6 1165.2 1170.6 1180.1 12978.7 13165.7 13255.0 13322.5 13364.3 284341.0 285921.0 286097.0 286119.0 286206.0 54266.2 54640.5 54656.0 54715.0 54716.7 1412.7 1458.1 1462.3 1472.7 1498.9 23405.3 24328.3 24849.0 25007.6 25140.4 40903.8 45649.0 46758.5 46879.0 46945.0 209506.0 211352.0 211656.0 258760.0 260966.0 25933.2 26159.5 30019.7 30134.4 32893.5 37756.4 37777.8 37844.2 37930.0 37931.8 28993.3 29675.6 31435.6 31444.2 31674.7 31199.5 31274.8 31331.5 31645.5 32045.4 35350.0 35731.3 36304.6 36478.1 36531.8 30524.5 30531.7 30783.1 30820.2 31789.2 23340.5 24239.4 24796.3 24818.9 24887.3 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#2] jquery.html Cycles:180 Average:34902.71 Median:20677.19 stddev:97305.18 (470.6%) stddev-sans-first:97543.74 05:21:29 INFO - PID 18727 | Values: 437.5 438.4 438.8 443.2 456.8 18206.7 19509.6 19860.6 20072.1 20133.7 19755.5 20697.8 21105.4 21243.7 21443.5 6565.7 6773.9 6816.0 6922.8 6930.1 6401.2 6648.1 6675.3 6675.5 6912.9 6675.7 6678.7 6680.8 6690.2 6743.1 6591.2 6728.6 6755.5 6767.8 6792.4 6420.7 6584.7 6618.8 6650.9 6673.1 26831.5 27195.6 27306.2 27353.2 27599.2 2056.5 2076.6 2082.9 2133.9 2166.5 16310.9 16998.0 17490.7 17560.0 17932.0 1873.6 1934.9 1943.7 1944.1 1948.1 88177.0 107150.5 111963.0 112611.0 113313.0 20515.3 20599.7 20599.7 20884.7 21053.4 39006.0 39256.0 39264.0 39326.6 39542.2 9955.4 10325.8 10410.5 10462.6 10715.7 8195.3 8240.0 8358.4 8472.5 8492.7 10420.4 10761.6 10873.1 11103.7 11185.8 4071.5 4082.2 4138.4 4148.8 4211.5 988.5 1007.6 1010.9 1017.0 1019.5 20061.8 20156.4 20161.1 20422.0 20656.6 1024.7 1025.1 1031.9 1032.7 1051.3 10347.8 11267.0 11277.0 11286.3 11313.8 579712.3 587681.0 592006.0 594318.0 595592.0 104925.5 106203.5 106946.0 109147.5 111322.0 1170.7 1173.7 1194.9 1199.7 1200.3 16498.5 16861.4 17207.1 17378.1 17586.6 44956.6 45357.5 46831.5 47158.3 47433.3 56945.4 57293.0 57628.0 57797.4 66577.7 8633.8 8722.9 8828.2 9240.0 9267.3 9145.9 13344.0 14222.9 14429.1 14775.3 11574.8 11596.2 11990.5 12275.4 12455.8 10289.4 10332.4 11206.2 11260.4 11495.6 12438.5 12561.6 12758.6 12969.8 12989.0 8459.4 8494.7 8974.1 9219.5 9313.0 11191.4 11785.5 11840.6 11849.2 11852.0 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#3] mootools.html Cycles:180 Average:6912.65 Median:3903.84 stddev:4369.79 (111.9%) stddev-sans-first:4360.86 05:21:29 INFO - PID 18727 | Values: 1186.4 1328.9 1372.9 1406.4 1409.0 9104.0 10380.7 10883.8 10902.9 10912.3 10587.8 10675.8 10676.3 10683.6 10691.8 1951.9 2017.0 2309.4 2363.9 2364.4 2302.0 2356.4 2364.7 2369.9 2369.9 2309.9 2332.9 2341.5 2344.4 2353.3 2304.9 2338.6 2339.4 2340.3 2341.6 2225.5 2225.9 2228.2 2229.9 2232.1 10782.1 10966.3 10988.0 11015.9 11035.6 6080.9 6249.5 6276.3 6294.6 6300.3 3557.2 3719.0 3882.6 3925.1 3940.2 1254.7 1311.4 1347.2 1364.5 1373.1 16449.7 16533.6 16549.4 16571.5 16577.3 5132.1 5141.5 5173.5 5407.3 5508.7 12530.2 12551.3 12554.6 12561.6 12586.9 5991.5 6029.2 6031.3 6032.6 6038.4 5302.4 5404.5 5447.6 5457.8 5532.6 4309.7 4361.6 4396.5 4458.4 4480.5 1299.8 1310.9 1317.0 1320.2 1325.6 784.0 801.1 802.7 812.7 815.0 6019.7 6850.4 7016.8 7115.0 7170.3 872.2 897.6 949.6 951.3 972.8 4138.8 4258.0 4268.6 4427.7 4471.7 13989.7 14537.7 14550.6 14556.3 14580.3 13716.3 14255.1 14333.6 14438.4 14485.2 9464.1 9672.0 9677.4 9744.4 9752.6 6359.6 6830.7 6833.2 6926.7 6952.5 12403.3 12536.1 12570.7 12693.9 13225.3 12675.2 12741.5 12755.2 12795.6 12821.7 9756.1 9949.3 9998.4 10003.4 10031.9 9824.0 9842.5 9990.8 10017.8 10091.4 8574.6 8634.8 8725.3 8817.8 8842.5 8546.6 8645.1 8671.9 8686.2 8768.3 7969.3 8015.3 8018.6 8109.6 8113.8 5994.6 6019.8 6075.9 6268.6 6283.3 6120.1 6147.6 6149.6 6170.8 6328.7 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#4] prototype.html Cycles:180 Average:5253.09 Median:5861.44 stddev:1497.72 (25.6%) stddev-sans-first:1457.10 05:21:29 INFO - PID 18727 | Values: 407.9 411.4 421.2 426.1 430.1 5639.0 5847.9 5872.0 5939.0 5948.8 5649.8 5813.0 5814.9 5824.6 5850.9 4630.1 4672.1 4672.5 4687.4 4694.3 4554.3 4647.0 4661.8 4671.5 4699.2 4644.0 4652.2 4652.7 4655.7 4673.6 4638.4 4654.6 4667.8 4679.0 4687.1 4164.1 4179.3 4235.1 4250.9 4267.1 5645.8 5682.5 5720.5 5725.8 5730.8 5429.9 5439.1 5441.6 5444.6 5457.2 5963.7 6127.2 6131.9 6145.8 6184.3 4595.7 4627.6 4634.5 4649.7 4655.5 6229.0 6418.6 6421.4 6454.5 6465.6 4767.3 4787.2 4790.9 4800.2 4814.1 4851.7 4866.4 4868.6 4872.3 4879.1 5180.3 5390.5 5415.9 5426.8 5430.9 5849.1 6068.3 6161.2 6205.8 6214.3 1616.0 1630.5 1634.2 1635.5 1643.2 1146.7 1207.4 1239.9 1242.9 1245.6 5803.5 5832.7 5927.6 5983.1 5984.5 6320.4 6333.7 6334.2 6344.3 6399.9 5833.4 5897.6 5907.7 5915.3 5938.0 3214.2 3362.4 3371.5 3391.4 3397.4 6590.4 6639.3 6642.3 6661.1 6666.2 6419.3 6450.8 6482.9 6493.1 6502.9 6540.0 6563.8 6569.9 6577.6 6593.3 6173.6 6334.4 6361.4 6418.3 6430.7 6276.2 6288.7 6290.6 6295.2 6331.0 6413.9 6561.6 6604.2 6614.9 6647.4 4506.5 4514.2 4521.7 4522.6 4549.5 6410.6 6413.0 6416.4 6417.2 6481.2 5991.4 6130.6 6188.8 6201.4 6240.7 5891.0 6020.5 6032.4 6213.7 6237.4 6197.4 6236.3 6237.8 6241.4 6255.8 5890.7 5896.9 6214.8 6226.1 6264.4 5984.3 6019.5 6028.6 6057.8 6081.3 05:21:29 INFO - PID 18727 | 05:21:29 INFO - PID 18727 | [#5] yui.html Cycles:180 Average:16577.60 Median:22186.64 stddev:21401.90 (96.5%) stddev-sans-first:21428.98 05:21:29 INFO - PID 18727 | Values: 759.4 768.8 768.9 772.6 773.1 15412.8 15981.2 16012.4 16113.0 16136.2 13774.3 14422.1 14683.0 14967.3 15771.4 818.1 835.3 835.9 839.1 840.9 818.1 834.0 835.3 836.4 837.1 863.8 879.8 882.2 882.2 882.2 862.0 872.8 876.0 879.0 880.2 629.4 636.4 638.3 644.8 646.8 13930.4 14208.4 14328.6 14474.3 14492.3 12223.7 12330.3 12465.6 12633.7 12829.2 11154.9 11237.3 11326.6 11342.5 11577.7 3035.2 3043.4 3044.9 3063.4 3089.7 76499.2 76735.0 76738.6 77714.0 77918.6 9657.9 9681.2 9914.5 9916.3 9917.7 19720.1 19724.3 19737.1 19771.2 19866.2 7603.1 7673.9 7684.6 7868.0 8026.1 3988.0 4014.8 4043.2 4043.3 4055.0 3795.4 4009.3 4019.5 4027.2 4041.5 768.7 786.0 791.4 799.6 813.9 585.4 611.5 613.6 615.6 617.6 10600.9 10890.5 11144.3 11233.7 11318.7 589.2 604.1 620.8 622.2 624.4 4627.9 4804.7 4807.3 4814.2 4814.3 72591.0 83126.0 83275.0 84534.0 87212.6 40331.8 55981.0 73283.6 74154.6 76438.0 48886.0 61825.0 62042.0 62618.7 63146.4 10783.5 11347.0 11419.5 11458.5 11554.9 32097.5 32178.8 32196.8 32199.4 32427.0 39975.8 40213.8 40219.6 40288.6 41518.0 12910.5 13107.0 13250.9 13330.7 13391.1 14552.7 14683.8 14887.3 15099.5 15777.9 14127.4 14486.3 14521.0 14713.6 14933.0 12987.9 13039.0 13101.2 13347.4 13732.8 13102.9 13456.5 13648.9 13883.3 14174.1 9248.5 9276.5 9406.7 9883.3 9903.5 10617.5 10718.8 10765.6 10903.4 10914.0 05:21:29 INFO - PID 18727 | -------- Summary: end -------- 05:21:29 INFO - PID 18727 | 05:21:30 INFO - TEST-INFO | 18727: exit 0 05:21:30 INFO - TEST-OK | dromaeo_css | took 1117242ms 05:21:30 INFO - TEST-START | kraken 05:21:30 INFO - operating with platform_type : linux_ 05:21:30 INFO - Initialising browser for kraken test... 05:21:30 INFO - TEST-INFO | started process 19055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgWQkCo/profile http://localhost:52530/getInfo.html) 05:21:34 INFO - PID 19055 | __metrics Screen width/height:1600/1200 05:21:34 INFO - PID 19055 | colorDepth:24 05:21:34 INFO - PID 19055 | Browser inner width/height: 1024/697 05:21:34 INFO - PID 19055 | __metrics 05:21:35 ERROR - PID 19055 | 1490617295171 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:21:35 INFO - PID 19055 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:21:35 INFO - PID 19055 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:36 INFO - TEST-INFO | 19055: exit 0 05:21:36 INFO - Browser initialized. 05:21:36 INFO - Running cycle 1/1 for kraken test... 05:21:36 INFO - TEST-INFO | started process 19146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgWQkCo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:48 INFO - PID 19146 | RSS: Main: 145612800 05:21:48 INFO - PID 19146 | 05:21:50 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52530/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:51 INFO - PID 19146 | RSS: Main: 200908800 05:21:51 INFO - PID 19146 | 05:21:54 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52530/tests/kraken/driver.html?testName=audio-dft) 05:21:54 INFO - PID 19146 | RSS: Main: 179826688 05:21:54 INFO - PID 19146 | 05:21:57 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52530/tests/kraken/driver.html?testName=audio-fft) 05:21:58 INFO - PID 19146 | RSS: Main: 261685248 05:21:58 INFO - PID 19146 | 05:22:00 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52530/tests/kraken/driver.html?testName=audio-oscillator) 05:22:01 INFO - PID 19146 | RSS: Main: 171106304 05:22:01 INFO - PID 19146 | 05:22:03 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:03 INFO - PID 19146 | RSS: Main: 176623616 05:22:03 INFO - PID 19146 | 05:22:06 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52530/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:07 INFO - PID 19146 | RSS: Main: 215822336 05:22:07 INFO - PID 19146 | 05:22:10 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52530/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:11 INFO - PID 19146 | RSS: Main: 228601856 05:22:11 INFO - PID 19146 | 05:22:14 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52530/tests/kraken/driver.html?testName=json-parse-financial) 05:22:14 INFO - PID 19146 | RSS: Main: 240996352 05:22:14 INFO - PID 19146 | 05:22:16 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:17 INFO - PID 19146 | RSS: Main: 178020352 05:22:17 INFO - PID 19146 | 05:22:18 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:19 INFO - PID 19146 | RSS: Main: 186302464 05:22:19 INFO - PID 19146 | 05:22:21 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:22 INFO - PID 19146 | RSS: Main: 194502656 05:22:22 INFO - PID 19146 | 05:22:24 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:25 INFO - PID 19146 | RSS: Main: 203239424 05:22:25 INFO - PID 19146 | 05:22:28 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:29 INFO - PID 19146 | RSS: Main: 199872512 05:22:29 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | Cycle 1(1): loaded http://localhost:52530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52530/tests/kraken/driver.html?testName=ai-astar) 05:22:30 INFO - PID 19146 | RSS: Main: 268537856 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | __start_tp_report 05:22:30 INFO - PID 19146 | _x_x_mozilla_page_load 05:22:30 INFO - PID 19146 | _x_x_mozilla_page_load_details 05:22:30 INFO - PID 19146 | |i|pagename|runs| 05:22:30 INFO - PID 19146 | |0;ai-astar;101;110;109;109;109;111;109;109;110;110 05:22:30 INFO - PID 19146 | |1;audio-beat-detection;148;116;117;161;115;121;119;117;141;116 05:22:30 INFO - PID 19146 | |2;audio-dft;160;168;162;161;161;161;162;161;161;162 05:22:30 INFO - PID 19146 | |3;audio-fft;75;74;76;115;78;74;75;74;93;76 05:22:30 INFO - PID 19146 | |4;audio-oscillator;82;81;104;82;83;82;97;83;87;114 05:22:30 INFO - PID 19146 | |5;imaging-gaussian-blur;114;113;113;113;114;113;113;113;113;113 05:22:30 INFO - PID 19146 | |6;imaging-darkroom;146;147;147;147;147;148;148;146;148;147 05:22:30 INFO - PID 19146 | |7;imaging-desaturate;94;94;94;95;94;94;95;95;95;94 05:22:30 INFO - PID 19146 | |8;json-parse-financial;57;56;58;57;60;58;57;56;57;56 05:22:30 INFO - PID 19146 | |9;json-stringify-tinderbox;55;54;55;58;55;55;56;56;55;55 05:22:30 INFO - PID 19146 | |10;stanford-crypto-aes;78;78;87;95;78;79;79;79;78;80 05:22:30 INFO - PID 19146 | |11;stanford-crypto-ccm;126;126;125;130;127;129;136;124;167;128 05:22:30 INFO - PID 19146 | |12;stanford-crypto-pbkdf2;176;185;185;190;183;177;179;178;180;177 05:22:30 INFO - PID 19146 | |13;stanford-crypto-sha256-iterative;66;66;71;65;64;64;64;64;63;63 05:22:30 INFO - PID 19146 | __end_tp_report 05:22:30 INFO - PID 19146 | __start_cc_report 05:22:30 INFO - PID 19146 | _x_x_mozilla_cycle_collect,1760 05:22:30 INFO - PID 19146 | __end_cc_report 05:22:30 INFO - PID 19146 | __startTimestamp1490617350965__endTimestamp 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | ------- Summary: start ------- 05:22:30 INFO - PID 19146 | Number of tests: 14 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.50 stddev:2.79 (2.5%) stddev-sans-first:0.73 05:22:30 INFO - PID 19146 | Values: 101.0 110.0 109.0 109.0 109.0 111.0 109.0 109.0 110.0 110.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:120.00 stddev:16.60 (13.8%) stddev-sans-first:15.79 05:22:30 INFO - PID 19146 | Values: 148.0 116.0 117.0 161.0 115.0 121.0 119.0 117.0 141.0 116.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:2.23 (1.4%) stddev-sans-first:2.26 05:22:30 INFO - PID 19146 | Values: 160.0 168.0 162.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:13.24 (17.5%) stddev-sans-first:13.87 05:22:30 INFO - PID 19146 | Values: 75.0 74.0 76.0 115.0 78.0 74.0 75.0 74.0 93.0 76.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.50 stddev:11.54 (14.0%) stddev-sans-first:11.92 05:22:30 INFO - PID 19146 | Values: 82.0 81.0 104.0 82.0 83.0 82.0 97.0 83.0 87.0 114.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:22:30 INFO - PID 19146 | Values: 114.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:22:30 INFO - PID 19146 | Values: 146.0 147.0 147.0 147.0 147.0 148.0 148.0 146.0 148.0 147.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:22:30 INFO - PID 19146 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.23 (2.2%) stddev-sans-first:1.30 05:22:30 INFO - PID 19146 | Values: 57.0 56.0 58.0 57.0 60.0 58.0 57.0 56.0 57.0 56.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:1.07 (2.0%) stddev-sans-first:1.13 05:22:30 INFO - PID 19146 | Values: 55.0 54.0 55.0 58.0 55.0 55.0 56.0 56.0 55.0 55.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.00 stddev:5.59 (7.1%) stddev-sans-first:5.81 05:22:30 INFO - PID 19146 | Values: 78.0 78.0 87.0 95.0 78.0 79.0 79.0 79.0 78.0 80.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:128.50 stddev:12.82 (10.0%) stddev-sans-first:13.43 05:22:30 INFO - PID 19146 | Values: 126.0 126.0 125.0 130.0 127.0 129.0 136.0 124.0 167.0 128.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:181.50 stddev:4.57 (2.5%) stddev-sans-first:4.48 05:22:30 INFO - PID 19146 | Values: 176.0 185.0 185.0 190.0 183.0 177.0 179.0 178.0 180.0 177.0 05:22:30 INFO - PID 19146 | 05:22:30 INFO - PID 19146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:2.36 (3.7%) stddev-sans-first:2.47 05:22:30 INFO - PID 19146 | Values: 66.0 66.0 71.0 65.0 64.0 64.0 64.0 64.0 63.0 63.0 05:22:30 INFO - PID 19146 | -------- Summary: end -------- 05:22:30 INFO - PID 19146 | 05:22:32 INFO - TEST-INFO | 19146: exit 0 05:22:32 INFO - TEST-OK | kraken | took 61812ms 05:22:32 INFO - SUITE-END | took 1179s 05:22:32 INFO - Completed test suite (00:19:39) 05:22:32 INFO - javascript benchmark 05:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7570.875779442847, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.8671653133874, 3327.9168020799493, 3352.999999999999, 3361.2605226850083, 3383.949240761389, 5642.238297829792, 5740.167675687023, 5790.884182316357, 5794.188813566099, 5796.130580412935, 5753.856153596152, 5768.192453056565, 5774.307083150017, 5809.3609702932745, 5858.88282234355, 5021.472745361739, 5091.592672586185, 5139.12634852076, 5180.274761533388, 5198.558122559568, 5181.999999999981, 5236.764345604438, 5247.107991641411, 5254.4220135785035, 5300.204969254604, 5058.747062646853, 5113.667611605271, 5116.897662046776, 5122.692638441706, 5172.456892026339, 5165.251038599382, 5181.404138524081, 5190.558802501791, 5238.895222095575, 5249.816256431007, 5110.207917772751, 5167.457416971201, 5170.1986192140275, 5170.715610641413, 5208.0, 5583.134614134816, 5727.169560413717, 5731.254936858182, 5737.053386191315, 5749.425057494259, 6118.510519158456, 6132.969335153341, 6138.815835524942, 6195.5663103582765, 6200.782972595983, 6260.937390626081, 6273.62358258506, 6285.0, 6295.5907865988565, 6296.6536840473755, 5772.855678607984, 5778.27771528559, 5802.7098645068, 5823.184754134425, 5871.794487192928, 6143.143438301211, 6228.5951413158, 6318.968405157945, 6404.135441715402, 6429.067785171124, 6119.746288422617, 6133.407859146218, 6140.13616995768, 6149.477294429934, 6155.661438620829, 6166.0, 6171.47542458896, 6175.197224360894, 6185.721642526097, 6189.690515474208, 6022.307434644984, 6112.174856394418, 6156.846078848064, 6212.782552610637, 6215.34738852423, 6118.0, 6119.296280927751, 6121.755129794758, 6179.84550386244, 6200.255969283625, 4769.856904292877, 4774.689645173053, 4775.06886157196, 4801.4718380978065, 4804.663673542818, 4218.198542276958, 4227.260229459832, 4230.259704551752, 4241.427407300037, 4269.551697071763, 5653.943460565341, 5701.315842098975, 5778.653280803165, 5782.595218334676, 5823.79616713413, 6235.251769787564, 6237.220347456568, 6290.622562646256, 6291.182146321041, 6302.275238347649, 5834.708264586754, 5849.795257165979, 5856.326522449887, 5859.062549991981, 5902.05567109269, 5164.1995490698255, 5231.607629427732, 5244.160934250578, 5305.495977882095, 5319.388270348882, 6427.839304017437, 6430.871382572323, 6437.1631687879335, 6443.0, 6453.161089058486, 6057.697115144313, 6178.351273116258, 6196.721147548281, 6228.439440450381, 6230.283517395557, 6318.147050148171, 6318.747250109944, 6329.5252856036905, 6446.548741588043, 6449.290578036506, 6122.2959359674205, 6158.168647232566, 6166.537509686881, 6168.321484636596, 6171.352008039091, 6277.18396608438, 6286.245650521783, 6301.4643755279485, 6311.96844015777, 6315.210598675166, 5921.585489015728, 5933.436323549256, 5983.640981541122, 6093.512518998381, 6105.389461053859, 6077.149199112039, 6079.452849243589, 6112.8777424452155, 6124.969375153096, 6134.079888016833, 6034.39656034393, 6036.547258955684, 6055.697215139314, 6056.0915862619195, 6060.333363329942, 5817.767289308549, 5903.645781253139, 5978.611390259794, 6106.2061931948565, 6126.846828829315, 5845.18167456548, 5896.734646940812, 5970.014947533608, 5985.281766188085, 5988.431099045758], "value": 5690.978455016476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.1580687203198, 703.6024646074967, 722.6856317501887, 1134.5291703942864, 1145.375770205238, 29780.851095744518, 36567.0, 37275.440868387, 37296.81351593238, 37428.06429839256, 39417.605823941754, 39904.40143397851, 39906.0, 39927.0, 39943.0, 6103.969480152615, 6227.470664993459, 8259.752207433772, 8464.703735369263, 8466.872996905051, 8053.1946805319585, 8228.341732661404, 8231.0, 8231.794205144859, 8405.327573794113, 8406.537640429773, 8511.404201705884, 8513.148685131498, 8516.190961858614, 8517.95741021294, 8412.0, 8443.915560844374, 8472.957635211784, 8476.237138657489, 8485.575721213945, 8043.55760433176, 8090.555019473926, 8092.3526117911015, 8095.23095305945, 8095.311898488636, 41195.1760964782, 41504.0, 41566.58433415657, 41606.375904361455, 41693.0, 3036.7418769404626, 3038.7417069549115, 3042.756579473659, 3042.969570304313, 3068.892588759405, 28705.425891482264, 28751.56872646912, 29053.56419653707, 29303.413931721247, 29351.85324073387, 3718.1819999600316, 3720.720945929066, 3751.549814022335, 3782.0733920189455, 3812.6759225465867, 220730.0, 220966.0, 221464.0, 223066.0, 223721.88139059363, 49102.5089749098, 49173.50826491689, 49274.753626232356, 49287.50712492901, 49324.0, 52380.0, 52464.47535524672, 52525.47474525206, 52771.20843187355, 52821.471785281654, 14217.218053006976, 14586.19775912335, 14605.269736513132, 14611.269436528131, 14620.195889226196, 10476.947615261875, 10614.416207108528, 11537.19239653233, 11643.719190888996, 11662.067034637208, 13469.12450690702, 13565.864341356657, 13614.863851361557, 13802.516911908035, 14199.503017394341, 5251.658642188246, 5254.816081437131, 5259.500347466985, 5292.760167434212, 5335.599830012765, 991.8859331176862, 1025.876894772617, 1038.1435315864442, 1038.7662775875367, 1059.4067322299536, 25479.23562293134, 25541.61687574688, 25564.74435255661, 25844.0, 25863.0947916822, 1136.6930928649383, 1137.6188976692902, 1165.1669056624385, 1170.5961443302047, 1180.0500597019482, 12978.740425191443, 13165.67085822843, 13255.0, 13322.533711320057, 13364.264965426995, 284341.0, 285921.0, 286097.0, 286119.0, 286206.0, 54266.18600720992, 54640.45359546433, 54656.0, 54715.0, 54716.72641636846, 1412.6731547206386, 1458.0959804921017, 1462.2615579132682, 1472.6980968901564, 1498.88008959283, 23405.297841064796, 24328.27015189547, 24849.0, 25007.624885627094, 25140.371490712878, 40903.795481022404, 45649.0, 46758.53241467678, 46879.0, 46945.0, 209506.0, 211352.0, 211656.0, 258760.0, 260966.0, 25933.22200333993, 26159.476810464064, 30019.69980300169, 30134.438572721563, 32893.50659740154, 37756.43365349577, 37777.81111094427, 37844.243115138095, 37930.0, 37931.81034094812, 28993.275168120123, 29675.554866676586, 31435.58539865757, 31444.213894652818, 31674.68325316717, 31199.532007020367, 31274.843625781727, 31331.530027049157, 31645.525317119802, 32045.35909281848, 35350.0, 35731.285374292886, 36304.63695363013, 36478.08804779796, 36531.81734091313, 30524.542131868486, 30531.694683053774, 30783.076507704805, 30820.22949426282, 31789.20526986844, 23340.533189336456, 24239.394015149763, 24796.25611231666, 24818.926133793502, 24887.253382398558], "value": 17172.318343160132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.4728452215081, 438.3753151758743, 438.77403137384243, 443.1845404455802, 456.8446728112441, 18206.726899096506, 19509.609807803834, 19860.602787944234, 20072.096755645995, 20133.697994530077, 19755.506112347197, 20697.793022069774, 21105.366838994818, 21243.68134477984, 21443.463913402175, 6565.671716414172, 6773.864522709543, 6816.0, 6922.826929326782, 6930.13373328334, 6401.199850018747, 6648.135742353512, 6675.299093595176, 6675.46596272297, 6912.896306555381, 6675.66621668917, 6678.66606669667, 6680.799576012728, 6690.163729533809, 6743.123393958778, 6591.176102987127, 6728.596284222914, 6755.5271131020845, 6767.830804229909, 6792.388685018347, 6420.711068001951, 6584.670766461706, 6618.834529136762, 6650.900236496456, 6673.065770792093, 26831.463370732672, 27195.592066119025, 27306.180814575593, 27353.179404617895, 27599.17202483929, 2056.465319017066, 2076.5743022680313, 2082.864613800113, 2133.9253126140666, 2166.4942864709033, 16310.918445407815, 16998.0, 17490.650186996318, 17560.005595858973, 17932.0, 1873.6065426260502, 1934.9129289182022, 1943.6598595245916, 1944.1445763863856, 1948.074664534349, 88177.0, 107150.46424767826, 111963.0, 112611.0, 113313.0, 20515.281965131147, 20599.691004634944, 20599.691004634944, 20884.686729699068, 21053.368398948056, 39006.0, 39256.0, 39264.0, 39326.606733932866, 39542.20915581672, 9955.402675839472, 10325.84511232332, 10410.479476026168, 10462.581496740046, 10715.678529644123, 8195.34437245019, 8239.95880020596, 8358.373122015873, 8472.49165050099, 8492.70275540353, 10420.426876521864, 10761.569537218424, 10873.107101804062, 11103.72240693989, 11185.832212516818, 4071.4603217412373, 4082.1631565528996, 4138.420621113047, 4148.834046638161, 4211.473565804275, 988.4810474500945, 1007.596961215505, 1010.9292349535609, 1016.9949150254201, 1019.4647809899861, 20061.799382006284, 20156.395308140778, 20161.092750826247, 20422.0, 20656.58686826255, 1024.6567399920962, 1025.1388833379997, 1031.9380837149795, 1032.7211652853687, 1051.3429106808244, 10347.793044139074, 11267.0, 11277.0, 11286.266392684449, 11313.773724525463, 579712.3330816926, 587681.0, 592006.0, 594318.0, 595592.0, 104925.47537262265, 106203.53345591162, 106946.0, 109147.45426272818, 111322.0, 1170.7278551298334, 1173.6971961123147, 1194.9402529873646, 1199.748052908899, 1200.2798321007326, 16498.505044848673, 16861.40985065566, 17207.107218206238, 17378.131093445023, 17586.648267034845, 44956.550434496545, 45357.54642453533, 46831.53168468272, 47158.29262560996, 47433.28850067183, 56945.43054569567, 57293.0, 57628.0, 57797.422025779204, 66577.66711166414, 8633.784155396166, 8722.91277087221, 8828.24959878392, 9240.0, 9267.304952128483, 9145.908540914506, 13344.0, 14222.928885355506, 14429.134251944917, 14775.261236938326, 11574.768504630028, 11596.188266821242, 11990.520379184734, 12275.447604857982, 12455.750884982432, 10289.382637041503, 10332.431716255378, 11206.215564910704, 11260.436978151223, 11495.597654082067, 12438.502459901865, 12561.623151305475, 12758.553450629555, 12969.767872052518, 12989.0, 8459.365547584079, 8494.74515764528, 8974.14745599167, 9219.492927888763, 9312.953435232781, 11191.384473854016, 11785.469653865768, 11840.585579504675, 11849.170558060852, 11852.0], "value": 10955.97407134456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1186.4186548591183, 1328.8604696506866, 1372.9038967272288, 1406.4093080906025, 1408.9506867259643, 9103.954480227598, 10380.740481487957, 10883.782324353528, 10902.945485272583, 10912.345259284448, 10587.841182382252, 10675.83986240205, 10676.252662313642, 10683.626073087444, 10691.78616427671, 1951.8874241682176, 2017.0, 2309.3880121767743, 2363.917262895799, 2364.408897775556, 2301.9539609207804, 2356.4344557306295, 2364.6807680963107, 2369.857808531485, 2369.8815059247054, 2309.9422514437106, 2332.93001209964, 2341.519988402382, 2344.4138965258685, 2353.2587235021, 2304.9308520744403, 2338.6141286687675, 2339.368370539945, 2340.32130682102, 2341.625339945609, 2225.4770129019666, 2225.9332220033425, 2228.220122956968, 2229.9331020069426, 2232.0960011195493, 10782.083522900562, 10966.287191332538, 10988.0, 11015.889841101647, 11035.613753518668, 6080.878382432371, 6249.468795152417, 6276.278228003793, 6294.622322660655, 6300.30696623371, 3557.1996300832106, 3718.9814050929845, 3882.592327805568, 3925.097227637659, 3940.1922605866016, 1254.7051442910908, 1311.4360824845312, 1347.2253454263837, 1364.4746772492563, 1373.1417863835104, 16449.67100657992, 16533.58666033347, 16549.420770273104, 16571.50285491425, 16577.254023568967, 5132.127538318495, 5141.53726164647, 5173.482651734872, 5407.324084489439, 5508.724563771795, 12530.185537940004, 12551.3096779678, 12554.560590379293, 12561.623151305475, 12586.87413125857, 5991.5206783457215, 6029.186059881948, 6031.336552979169, 6032.607880487754, 6038.365971573009, 5302.443243459458, 5404.540614047772, 5447.618666693294, 5457.836264912059, 5532.557395408438, 4309.655227581786, 4361.5856493633055, 4396.516383197845, 4458.4426946631675, 4480.529544397791, 1299.7595444842734, 1310.8951283897266, 1316.967075823112, 1320.221069568959, 1325.5824415309146, 783.9725609603751, 801.054755388647, 802.7029998900327, 812.6586833529932, 814.9609248208582, 6019.69901504923, 6850.417714494224, 7016.7544135954995, 7115.0, 7170.318819712224, 872.1627237851607, 897.5781382750097, 949.5869296855751, 951.286535098676, 972.8005758819424, 4138.813753381105, 4258.0, 4268.615824575803, 4427.712198707074, 4471.686981911235, 13989.65025874341, 14537.709245815236, 14550.563483095524, 14556.344964476624, 14580.270986450634, 13716.314184290746, 14255.073420227653, 14333.64165895861, 14438.422463101568, 14485.203313817841, 9464.148226659634, 9672.0, 9677.37097088687, 9744.415335079917, 9752.609895604097, 6359.586626869239, 6830.7267709293055, 6833.214180369321, 6926.722931082701, 6952.5480843745, 12403.25580465175, 12536.122471426912, 12570.685732856751, 12693.873061269269, 13225.338733063501, 12675.17611355259, 12741.49034038628, 12755.234685918875, 12795.61613151607, 12821.679458013625, 9756.07317304855, 9949.303548751517, 9998.400095994264, 10003.399796012263, 10031.899681003097, 9824.0, 9842.458664773507, 9990.750231244278, 10017.849732253877, 10091.44497052669, 8574.614142363484, 8634.78413039654, 8725.345599080221, 8817.823643526965, 8842.46945183291, 8546.572671366532, 8645.135486451556, 8671.869921951049, 8686.174813392718, 8768.254698350456, 7969.26792662874, 8015.278624923785, 8018.639161237642, 8109.59452027408, 8113.797155071171, 5994.550408719277, 6019.759209631566, 6075.878482430415, 6268.561200716089, 6283.277423096402, 6120.143179954899, 6147.631142131487, 6149.600275982047, 6170.81487555374, 6328.7152078157515], "value": 5230.749735540901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.89190864420914, 411.4260606453997, 421.1597862264781, 426.10305307328076, 430.14830635342, 5638.971805140979, 5847.912281315784, 5872.0, 5938.970305148474, 5948.791792287277, 5649.830505084844, 5813.0, 5814.883702325951, 5824.621399609023, 5850.88298234035, 4630.120277147348, 4672.11229866326, 4672.509386514418, 4687.414073240845, 4694.342792009122, 4554.2713165893465, 4646.97676511617, 4661.836835710751, 4671.509491503394, 4699.201135806904, 4644.027822193799, 4652.232381657022, 4652.6510511711585, 4655.720656760588, 4673.6027437667835, 4638.350630911675, 4654.604358629537, 4667.763042793628, 4678.976605116953, 4687.10944920464, 4164.146349998243, 4179.331306990897, 4235.0682849773, 4250.852269887144, 4267.125239325962, 5645.7579332546775, 5682.51698605619, 5720.542356611461, 5725.77096916127, 5730.828075157752, 5429.864253393657, 5439.129739241742, 5441.619086663935, 5444.564434845203, 5457.2359869618285, 5963.701814909281, 6127.234095738033, 6131.87736245277, 6145.754169833202, 6184.288806787187, 4595.701279416827, 4627.629789616823, 4634.490206077363, 4649.651276154268, 4655.464621568529, 6229.003359462465, 6418.582792118497, 6421.422072013541, 6454.515911306624, 6465.644389558573, 4767.261074533453, 4787.234042553175, 4790.928136077961, 4800.231962885921, 4814.061258054646, 4851.733154676456, 4866.4403593586485, 4868.610511159099, 4872.319049927769, 4879.072976134523, 5180.300659410931, 5390.544552970754, 5415.862668839588, 5426.810061647902, 5430.8913821723345, 5849.093390524476, 6068.302145253264, 6161.168242287324, 6205.751769929243, 6214.302490018522, 1615.9757603635956, 1630.5189968959185, 1634.1502418742186, 1635.5338728462332, 1643.2030465224357, 1146.7419830538229, 1207.402335843763, 1239.857416397126, 1242.9005679545614, 1245.5765039886483, 5803.506701930383, 5832.70677627676, 5927.614705044159, 5983.055506960255, 5984.491318237911, 6320.399562041599, 6333.65164915934, 6334.208223972004, 6344.270408903035, 6399.9040014399825, 5833.387494313036, 5897.64614123154, 5907.70461476933, 5915.349311575723, 5938.002617356501, 3214.2125179331215, 3362.394768941614, 3371.5279860819505, 3391.423458012144, 3397.3545026444895, 6590.41829960806, 6639.336066393419, 6642.269350371455, 6661.1007513985, 6666.200055993312, 6419.325970773001, 6450.774222902176, 6482.9405401132735, 6493.149452406042, 6502.902456463157, 6539.967300163564, 6563.835904102436, 6569.868602627921, 6577.572457790228, 6593.274739778621, 6173.59871608344, 6334.366563343813, 6361.363863613602, 6418.261899881573, 6430.710618022294, 6276.246850377984, 6288.685565721604, 6290.591111577733, 6295.18162638854, 6331.0, 6413.921317767405, 6561.605014169698, 6604.249873783355, 6614.900776488453, 6647.368499992493, 4506.526814684542, 4514.164879497303, 4521.66087543429, 4522.615577675934, 4549.545045495424, 6410.647414392067, 6412.967935160481, 6416.427975146119, 6417.1711062347, 6481.157449531531, 5991.430814072656, 6130.601510901777, 6188.783392581238, 6201.441870231521, 6240.719167637377, 5890.970545147246, 6020.51835853122, 6032.426919442646, 6213.65824879636, 6237.4074462927765, 6197.380261973766, 6236.314005459487, 6237.844053898689, 6241.438270555672, 6255.812325630239, 5890.676012819336, 5896.941030589811, 6214.8135555933395, 6226.128342032029, 6264.404881536247, 5984.31180414258, 6019.458248757633, 6028.638281703112, 6057.757689692363, 6081.27024757032], "value": 4798.000495533436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3659294489102, 768.773211902489, 768.8885111658809, 772.5905270206786, 773.1263672050584, 15412.845871541282, 15981.200939953014, 16012.43956461524, 16113.0, 16136.19319034048, 13774.311284435787, 14422.062565933207, 14683.0, 14967.326470308835, 15771.447999320026, 818.116434251009, 835.340081335744, 835.9498430094184, 839.1440730454963, 840.9159084091604, 818.0837462042521, 833.9958300208491, 835.2566216067704, 836.3518273338151, 837.1293854391425, 863.7711006583261, 879.7800549862534, 882.1531329923249, 882.1883866842488, 882.2412725056446, 861.995690021549, 872.759991002473, 875.9781005474882, 878.964841406343, 880.1506546182932, 629.4115002472657, 636.3572791480592, 638.3297537585563, 644.8258970078052, 646.7994921574327, 13930.442782288797, 14208.360623771852, 14328.641783955485, 14474.348654310581, 14492.34784434703, 12223.69440763988, 12330.260184388966, 12465.563705270271, 12633.747325053539, 12829.23024618526, 11154.888451115547, 11237.269577477438, 11326.603568875133, 11342.546298148065, 11577.6526704199, 3035.180501264646, 3043.421749867518, 3044.862981165853, 3063.417950589381, 3089.7373723233554, 76499.23500764977, 76735.0, 76738.61630691867, 77714.0, 77918.61040694817, 9657.855132173023, 9681.225501959827, 9914.454704991294, 9916.305858589829, 9917.7024689258, 19720.112594933264, 19724.309649162496, 19737.111829967685, 19771.209151634062, 19866.205351785768, 7603.0876294844975, 7673.923260767321, 7684.577348245788, 7867.960660196777, 8026.077001144827, 3988.0, 4014.8394064237104, 4043.1711499142607, 4043.292423825819, 4054.9797251013556, 3795.35478968576, 4009.3384591542654, 4019.4774679291504, 4027.2146931348107, 4041.474608300902, 768.6502641298196, 785.972490962825, 791.3669064748178, 799.588212070784, 813.9308158806567, 585.4409039367393, 611.4894063457064, 613.6164896939413, 615.6060121522229, 617.5677026081761, 10600.946995264974, 10890.493082124076, 11144.2756220847, 11233.719157020976, 11318.717032074099, 589.2222266608122, 604.1089393145076, 620.7734177025444, 622.1756173070609, 624.406813527151, 4627.9074418511445, 4804.687695299865, 4807.278908163734, 4814.15752243356, 4814.253790662453, 72591.0, 83126.0, 83275.0, 84534.0, 87212.5639371799, 40331.79834100811, 55981.0, 73283.63358183175, 74154.62922685352, 76438.0, 48886.0, 61825.0, 62042.0, 62618.68690656518, 63146.36853631497, 10783.51474183648, 11347.0, 11419.543218271509, 11458.484368203284, 11554.884451155382, 32097.518537222426, 32178.83910580432, 32196.83901580477, 32199.356012879143, 32427.001944625685, 39975.80012099921, 40213.798931005156, 40219.597804021585, 40288.59711402848, 41518.0, 12910.548130815376, 13107.0, 13250.867491324963, 13330.733385332433, 13391.062625616114, 14552.708945820812, 14683.779743304072, 14887.330070146652, 15099.54701358961, 15777.921110394374, 14127.364268607731, 14486.275686215859, 14521.0, 14713.632159196106, 14933.0, 12987.857003594301, 13039.0, 13101.213927164401, 13347.399367028702, 13732.794008089686, 13102.868971310165, 13456.46174153023, 13648.863511365156, 13883.305834708426, 14174.07868488545, 9248.537573121183, 9276.536173191178, 9406.670766523413, 9883.30816842814, 9903.50482475859, 10617.522211500347, 10718.785624287315, 10765.571755488687, 10903.400312982862, 10914.0], "value": 7007.3377801149445, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0, 110.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 117.0, 161.0, 115.0, 121.0, 119.0, 117.0, 141.0, 116.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 168.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 115.0, 78.0, 74.0, 75.0, 74.0, 93.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 104.0, 82.0, 83.0, 82.0, 97.0, 83.0, 87.0, 114.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 60.0, 58.0, 57.0, 56.0, 57.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 58.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 87.0, 95.0, 78.0, 79.0, 79.0, 79.0, 78.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 125.0, 130.0, 127.0, 129.0, 136.0, 124.0, 167.0, 128.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 185.0, 185.0, 190.0, 183.0, 177.0, 179.0, 178.0, 180.0, 177.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 71.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 65.0, "unit": "score"}]}]} 05:22:32 INFO - Return code: 0 05:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:32 ERROR - # TBPL SUCCESS # 05:22:32 INFO - Running post-action listener: _resource_record_post_action 05:22:32 INFO - [mozharness: 2017-03-27 12:22:32.262417Z] Finished run-tests step (success) 05:22:32 INFO - Running post-run listener: _resource_record_post_run 05:22:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258449408; Read time: 16; Write time: 235840 05:22:32 INFO - TinderboxPrint: CPU usage
13.0% 05:22:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:22:32 INFO - TinderboxPrint: I/O write bytes / time
258,449,408 / 235,840 05:22:32 INFO - TinderboxPrint: CPU idle
8,308.2 (87.0%) 05:22:32 INFO - TinderboxPrint: CPU user
1,191.1 (12.5%) 05:22:32 INFO - TinderboxPrint: Swap in / out
0 / 0 05:22:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1413120; Read time: 0; Write time: 360 05:22:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 257036288; Read time: 0; Write time: 235480 05:22:32 INFO - Running post-run listener: _upload_blobber_files 05:22:32 INFO - Blob upload gear active. 05:22:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:32 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 05:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:22:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:34 INFO - (blobuploader) - INFO - Done attempting. 05:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:34 INFO - (blobuploader) - INFO - Done attempting. 05:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:38 INFO - (blobuploader) - INFO - Done attempting. 05:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:39 INFO - (blobuploader) - INFO - Done attempting. 05:22:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:39 INFO - Return code: 0 05:22:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833d3ce2019862a4282aa858349f47e5ba17240de710bda2cc8c80547a56ed9f8f7aafa20df6b09ea01d450842ee0c1d613082b96fc8cf6274101242c2e7eba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a549c31289f6a4db34228efe79f4c3d8f91c32671ff77d46c84f23e3456e23e331a97832f5bbe5763e8879a9ad41dcd0d04bfe4dae5abd13b162b2f343f04a2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76cab47896ed2dc08e260c149766d988b6bc53d79763681072f33963dedff964da0da19ebd10aa7208192f9c94a5616bff422bfaa3dca18f53f9af9396165d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff05a405220fa2fe039075de797adde02db3df64adb1170afcdce85c9b751922bbe1b195333d5c9cef6c2b16afc2dd99d444d2540edaad5d2b29b1fd45ea78fe"} 05:22:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:39 INFO - Contents: 05:22:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833d3ce2019862a4282aa858349f47e5ba17240de710bda2cc8c80547a56ed9f8f7aafa20df6b09ea01d450842ee0c1d613082b96fc8cf6274101242c2e7eba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a549c31289f6a4db34228efe79f4c3d8f91c32671ff77d46c84f23e3456e23e331a97832f5bbe5763e8879a9ad41dcd0d04bfe4dae5abd13b162b2f343f04a2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76cab47896ed2dc08e260c149766d988b6bc53d79763681072f33963dedff964da0da19ebd10aa7208192f9c94a5616bff422bfaa3dca18f53f9af9396165d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff05a405220fa2fe039075de797adde02db3df64adb1170afcdce85c9b751922bbe1b195333d5c9cef6c2b16afc2dd99d444d2540edaad5d2b29b1fd45ea78fe"} 05:22:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:39 INFO - Copying logs to upload dir... 05:22:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.163947 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-03-27 05:22:38.425382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:22:38.429091) ========= 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-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833d3ce2019862a4282aa858349f47e5ba17240de710bda2cc8c80547a56ed9f8f7aafa20df6b09ea01d450842ee0c1d613082b96fc8cf6274101242c2e7eba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a549c31289f6a4db34228efe79f4c3d8f91c32671ff77d46c84f23e3456e23e331a97832f5bbe5763e8879a9ad41dcd0d04bfe4dae5abd13b162b2f343f04a2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76cab47896ed2dc08e260c149766d988b6bc53d79763681072f33963dedff964da0da19ebd10aa7208192f9c94a5616bff422bfaa3dca18f53f9af9396165d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff05a405220fa2fe039075de797adde02db3df64adb1170afcdce85c9b751922bbe1b195333d5c9cef6c2b16afc2dd99d444d2540edaad5d2b29b1fd45ea78fe"} build_url:https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/finsQfIVTm6bLMEBugnTvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833d3ce2019862a4282aa858349f47e5ba17240de710bda2cc8c80547a56ed9f8f7aafa20df6b09ea01d450842ee0c1d613082b96fc8cf6274101242c2e7eba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a549c31289f6a4db34228efe79f4c3d8f91c32671ff77d46c84f23e3456e23e331a97832f5bbe5763e8879a9ad41dcd0d04bfe4dae5abd13b162b2f343f04a2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76cab47896ed2dc08e260c149766d988b6bc53d79763681072f33963dedff964da0da19ebd10aa7208192f9c94a5616bff422bfaa3dca18f53f9af9396165d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff05a405220fa2fe039075de797adde02db3df64adb1170afcdce85c9b751922bbe1b195333d5c9cef6c2b16afc2dd99d444d2540edaad5d2b29b1fd45ea78fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:22:38.454761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:22:38.455049) ========= 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-1490616080.876786-610626729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:22:38.541730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:22:38.542388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:22:38.542891) ========= ========= Total master_lag: 0.17 =========