builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1486351311.72 results: success (0) revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.724662) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.725284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.725690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.744775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.745101) ========= 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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 19:21:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-02-05 19:21:52 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149519 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.908875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.909236) ========= 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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019534 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.959250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:51.959672) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --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 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 19:21:52,524 truncating revision to first 12 chars 2017-02-05 19:21:52,524 Setting DEBUG logging. 2017-02-05 19:21:52,524 attempt 1/10 2017-02-05 19:21:52,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20a8536b0bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 19:21:52,842 unpacking tar archive at: mozilla-central-20a8536b0bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:52.594395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:52.594828) ========= script_repo_revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:52.595310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:52.595637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:21:52.606591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-05 19:21:52.607033) ========= /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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:53 INFO - MultiFileLogger online at 20170205 19:21:53 in /builds/slave/test 19:21:53 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 19:21:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:53 INFO - {'append_to_log': False, 19:21:53 INFO - 'base_work_dir': '/builds/slave/test', 19:21:53 INFO - 'blob_upload_branch': 'Firefox', 19:21:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:53 INFO - 'branch': 'Firefox', 19:21:53 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:53 INFO - 'config_files': ('talos/linux_config.py',), 19:21:53 INFO - 'default_actions': ('clobber', 19:21:53 INFO - 'read-buildbot-config', 19:21:53 INFO - 'download-and-extract', 19:21:53 INFO - 'populate-webroot', 19:21:53 INFO - 'create-virtualenv', 19:21:53 INFO - 'install', 19:21:53 INFO - 'run-tests'), 19:21:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:53 INFO - 'download_minidump_stackwalk': True, 19:21:53 INFO - 'download_symbols': 'ondemand', 19:21:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:53 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:53 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:53 INFO - 'installer_path': 'installer.exe', 19:21:53 INFO - 'log_level': 'info', 19:21:53 INFO - 'log_name': 'talos', 19:21:53 INFO - 'log_to_console': True, 19:21:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:53 INFO - 'opt_config_files': (), 19:21:53 INFO - 'pip_index': False, 19:21:53 INFO - 'sps_profile': False, 19:21:53 INFO - 'sps_profile_interval': 0, 19:21:53 INFO - 'suite': 'dromaeojs', 19:21:53 INFO - 'system_bits': '32', 19:21:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:53 INFO - 'title': 'talos-linux64-ix-003', 19:21:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:53 INFO - 'use_talos_json': True, 19:21:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:53 INFO - 'work_dir': 'build'} 19:21:53 INFO - [mozharness: 2017-02-06 03:21:53.272591Z] Running clobber step. 19:21:53 INFO - Running pre-action listener: _resource_record_pre_action 19:21:53 INFO - Running main action method: clobber 19:21:53 INFO - rmtree: /builds/slave/test/build 19:21:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:53 INFO - Running post-action listener: _resource_record_post_action 19:21:53 INFO - [mozharness: 2017-02-06 03:21:53.740582Z] Finished clobber step (success) 19:21:53 INFO - [mozharness: 2017-02-06 03:21:53.740681Z] Running read-buildbot-config step. 19:21:53 INFO - Running pre-action listener: _resource_record_pre_action 19:21:53 INFO - Running main action method: read_buildbot_config 19:21:53 INFO - Using buildbot properties: 19:21:53 INFO - { 19:21:53 INFO - "project": "", 19:21:53 INFO - "product": "firefox", 19:21:53 INFO - "who": "philringnalda@gmail.com", 19:21:53 INFO - "installer_path": "public/build/target.tar.bz2", 19:21:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:21:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:21:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:21:53 INFO - "stage_platform": "linux64-pgo", 19:21:53 INFO - "basedir": "/builds/slave/test", 19:21:53 INFO - "buildnumber": 21, 19:21:53 INFO - "platform": "ubuntu64_hw", 19:21:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:21:53 INFO - "slavebuilddir": "test", 19:21:53 INFO - "taskId": "P-LLBsbiSlSiHHgiCLdViQ", 19:21:53 INFO - "branch": "mozilla-central", 19:21:53 INFO - "script_repo_revision": "production", 19:21:53 INFO - "revision": "20a8536b0bfac74389d3a57bd8dd957d98779ce1", 19:21:53 INFO - "slavename": "talos-linux64-ix-003", 19:21:53 INFO - "repo_path": "mozilla-central" 19:21:53 INFO - } 19:21:53 INFO - Finding installer, test and symbols from parent task. 19:21:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-LLBsbiSlSiHHgiCLdViQ'}, attempt #1 19:21:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-LLBsbiSlSiHHgiCLdViQ'}, attempt #1 19:21:54 INFO - Task dependencies: C4a8SwiHSwGtRiwN1gQkyg 19:21:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg'}, attempt #1 19:21:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 19:21:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/test_packages.json 19:21:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.crashreporter-symbols.zip 19:21:55 INFO - Running post-action listener: _resource_record_post_action 19:21:55 INFO - [mozharness: 2017-02-06 03:21:55.165402Z] Finished read-buildbot-config step (success) 19:21:55 INFO - [mozharness: 2017-02-06 03:21:55.165620Z] Running download-and-extract step. 19:21:55 INFO - Running pre-action listener: _resource_record_pre_action 19:21:55 INFO - Running main action method: download_and_extract 19:21:55 INFO - mkdir: /builds/slave/test/build/tests 19:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:55 INFO - trying https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.test_packages.json 19:21:55 INFO - Downloading https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:21:55 INFO - Downloaded 896 bytes. 19:21:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:21:55 INFO - Using the following test package requirements: 19:21:55 INFO - {u'common': [u'target.common.tests.zip'], 19:21:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:21:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:21:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:21:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:21:55 INFO - u'mozbase': [u'target.common.tests.zip'], 19:21:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:21:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:21:55 INFO - u'web-platform': [u'target.common.tests.zip', 19:21:55 INFO - u'target.web-platform.tests.zip'], 19:21:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:21:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:21:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip 19:21:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:21:55 INFO - Fetch https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip into memory 19:21:57 INFO - Expected file size: 41755943 19:21:57 INFO - Obtained file size: 41755943 19:22:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:22:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip 19:22:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:22:01 INFO - Fetch https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.common.tests.zip into memory 19:22:02 INFO - Expected file size: 41755943 19:22:02 INFO - Obtained file size: 41755943 19:22:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.talos.tests.zip 19:22:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:22:07 INFO - Fetch https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.talos.tests.zip into memory 19:22:08 INFO - Expected file size: 14403454 19:22:08 INFO - Obtained file size: 14403454 19:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:08 INFO - trying https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 19:22:08 INFO - Downloading https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:22:09 INFO - Downloaded 61558096 bytes. 19:22:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 19:22:09 INFO - mkdir: /builds/slave/test/properties 19:22:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:22:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:22:09 INFO - Contents: 19:22:09 INFO - build_url:https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 19:22:09 INFO - Running post-action listener: _resource_record_post_action 19:22:09 INFO - Running post-action listener: set_extra_try_arguments 19:22:09 INFO - [mozharness: 2017-02-06 03:22:09.900845Z] Finished download-and-extract step (success) 19:22:09 INFO - [mozharness: 2017-02-06 03:22:09.900942Z] Running populate-webroot step. 19:22:09 INFO - Running pre-action listener: _resource_record_pre_action 19:22:09 INFO - Running main action method: populate_webroot 19:22:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:22:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:22:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:22:09 INFO - '--tppagecycles', 19:22:09 INFO - '7'], 19:22:09 INFO - 'tests': ['tsvgm']}}, 19:22:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:22:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:22:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:22:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:22:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['damp', 'tps']}, 19:22:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'tests': ['damp', 'tps']}, 19:22:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['dromaeo_dom']}, 19:22:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:22:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['basic_compositor_video']}, 19:22:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:22:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['a11yr', 19:22:09 INFO - 'ts_paint', 19:22:09 INFO - 'tpaint', 19:22:09 INFO - 'sessionrestore', 19:22:09 INFO - 'sessionrestore_no_auto_restore', 19:22:09 INFO - 'tabpaint']}, 19:22:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['tsvgx', 19:22:09 INFO - 'tsvgr_opacity', 19:22:09 INFO - 'tart', 19:22:09 INFO - 'tscrollx', 19:22:09 INFO - 'cart', 19:22:09 INFO - 'tsvg_static']}, 19:22:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:22:09 INFO - 'tsvgr_opacity', 19:22:09 INFO - 'tart', 19:22:09 INFO - 'tscrollx', 19:22:09 INFO - 'cart', 19:22:09 INFO - 'tsvg_static']}, 19:22:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'talos_options': ['--disable-e10s'], 19:22:09 INFO - 'tests': ['tp5o']}, 19:22:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:22:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'talos_options': ['--disable-e10s', 19:22:09 INFO - '--xperf_path', 19:22:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:09 INFO - 'tests': ['tp5n']}, 19:22:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:22:09 INFO - 'talos_options': ['--xperf_path', 19:22:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:09 INFO - 'tests': ['tp5n']}}, 19:22:09 INFO - 'talos.zip': {'path': '', 19:22:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:22:09 INFO - Running post-action listener: _resource_record_post_action 19:22:09 INFO - [mozharness: 2017-02-06 03:22:09.914040Z] Finished populate-webroot step (success) 19:22:09 INFO - [mozharness: 2017-02-06 03:22:09.914133Z] Running create-virtualenv step. 19:22:09 INFO - Running pre-action listener: _resource_record_pre_action 19:22:09 INFO - Running main action method: create_virtualenv 19:22:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:22:09 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 19:22:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:22:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:22:10 INFO - Using real prefix '/usr' 19:22:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:22:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:22:12 INFO - Installing pip.................done. 19:22:12 INFO - Return code: 0 19:22:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:22:12 INFO - Reading from file tmpfile_stdout 19:22:12 INFO - Output received: 19:22:12 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) 19:22:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:22:12 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')]} 19:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:12 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')]} 19:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22: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', 'pip>=1.5'] in /builds/slave/test/build 19:22: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 pip>=1.5 19:22:12 INFO - Using env: {'DISPLAY': ':0', 19:22:12 INFO - 'HOME': '/home/cltbld', 19:22:12 INFO - 'LANG': 'en_US.UTF-8', 19:22:12 INFO - 'LANGUAGE': 'en_US:en', 19:22:12 INFO - 'LOGNAME': 'cltbld', 19:22:12 INFO - 'MAIL': '/var/mail/cltbld', 19:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:12 INFO - 'MOZ_NO_REMOTE': '1', 19:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:12 INFO - 'NO_EM_RESTART': '1', 19:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:12 INFO - 'PWD': '/builds/slave/test', 19:22:12 INFO - 'SHELL': '/bin/bash', 19:22:12 INFO - 'SHLVL': '1', 19:22:12 INFO - 'TERM': 'linux', 19:22:12 INFO - 'TMOUT': '86400', 19:22:12 INFO - 'USER': 'cltbld', 19:22:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:12 INFO - '_': '/tools/buildbot/bin/python'} 19:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:12 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 19:22:12 INFO - Cleaning up... 19:22:12 INFO - Return code: 0 19:22:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:22:12 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')]} 19:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:12 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')]} 19:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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', '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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:22: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 psutil>=3.1.1 19:22:12 INFO - Using env: {'DISPLAY': ':0', 19:22:12 INFO - 'HOME': '/home/cltbld', 19:22:12 INFO - 'LANG': 'en_US.UTF-8', 19:22:12 INFO - 'LANGUAGE': 'en_US:en', 19:22:12 INFO - 'LOGNAME': 'cltbld', 19:22:12 INFO - 'MAIL': '/var/mail/cltbld', 19:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:12 INFO - 'MOZ_NO_REMOTE': '1', 19:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:12 INFO - 'NO_EM_RESTART': '1', 19:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:12 INFO - 'PWD': '/builds/slave/test', 19:22:12 INFO - 'SHELL': '/bin/bash', 19:22:12 INFO - 'SHLVL': '1', 19:22:12 INFO - 'TERM': 'linux', 19:22:12 INFO - 'TMOUT': '86400', 19:22:12 INFO - 'USER': 'cltbld', 19:22:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:12 INFO - '_': '/tools/buildbot/bin/python'} 19:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:13 INFO - Downloading/unpacking psutil>=3.1.1 19:22:13 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 19:22:13 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 19:22:13 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 19:22:13 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 19:22:13 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 19:22:13 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 19:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:15 INFO - Installing collected packages: psutil 19:22:15 INFO - Running setup.py install for psutil 19:22:15 INFO - building 'psutil._psutil_linux' extension 19:22:15 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 19:22:15 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 19:22:15 INFO - building 'psutil._psutil_posix' extension 19:22:15 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 19:22:15 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 19:22:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:15 INFO - Successfully installed psutil 19:22:15 INFO - Cleaning up... 19:22:15 INFO - Return code: 0 19:22:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:22:15 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')]} 19:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:15 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')]} 19:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:15 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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:15 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 19:22:15 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 19:22:15 INFO - Using env: {'DISPLAY': ':0', 19:22:15 INFO - 'HOME': '/home/cltbld', 19:22:15 INFO - 'LANG': 'en_US.UTF-8', 19:22:15 INFO - 'LANGUAGE': 'en_US:en', 19:22:15 INFO - 'LOGNAME': 'cltbld', 19:22:15 INFO - 'MAIL': '/var/mail/cltbld', 19:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:15 INFO - 'MOZ_NO_REMOTE': '1', 19:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:15 INFO - 'NO_EM_RESTART': '1', 19:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:15 INFO - 'PWD': '/builds/slave/test', 19:22:15 INFO - 'SHELL': '/bin/bash', 19:22:15 INFO - 'SHLVL': '1', 19:22:15 INFO - 'TERM': 'linux', 19:22:15 INFO - 'TMOUT': '86400', 19:22:15 INFO - 'USER': 'cltbld', 19:22:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:15 INFO - '_': '/tools/buildbot/bin/python'} 19:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:22:18 INFO - Installing collected packages: mozsystemmonitor 19:22:18 INFO - Running setup.py install for mozsystemmonitor 19:22:18 INFO - Successfully installed mozsystemmonitor 19:22:18 INFO - Cleaning up... 19:22:18 INFO - Return code: 0 19:22:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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', '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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:22: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 jsonschema==2.5.1 19:22:18 INFO - Using env: {'DISPLAY': ':0', 19:22:18 INFO - 'HOME': '/home/cltbld', 19:22:18 INFO - 'LANG': 'en_US.UTF-8', 19:22:18 INFO - 'LANGUAGE': 'en_US:en', 19:22:18 INFO - 'LOGNAME': 'cltbld', 19:22:18 INFO - 'MAIL': '/var/mail/cltbld', 19:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:18 INFO - 'MOZ_NO_REMOTE': '1', 19:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:18 INFO - 'NO_EM_RESTART': '1', 19:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:18 INFO - 'PWD': '/builds/slave/test', 19:22:18 INFO - 'SHELL': '/bin/bash', 19:22:18 INFO - 'SHLVL': '1', 19:22:18 INFO - 'TERM': 'linux', 19:22:18 INFO - 'TMOUT': '86400', 19:22:18 INFO - 'USER': 'cltbld', 19:22:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:18 INFO - '_': '/tools/buildbot/bin/python'} 19:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:18 INFO - Downloading/unpacking jsonschema==2.5.1 19:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:22:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 INFO - Downloading functools32-3.2.3-2.tar.gz 19:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:22:20 INFO - warning: no files found matching '*.txt' 19:22:20 INFO - no previously-included directories found matching 'build' 19:22:20 INFO - no previously-included directories found matching 'dist' 19:22:20 INFO - no previously-included directories found matching '.git*' 19:22:20 INFO - Installing collected packages: jsonschema, functools32 19:22:20 INFO - Running setup.py install for functools32 19:22:20 INFO - warning: no files found matching '*.txt' 19:22:20 INFO - no previously-included directories found matching 'build' 19:22:20 INFO - no previously-included directories found matching 'dist' 19:22:20 INFO - no previously-included directories found matching '.git*' 19:22:20 INFO - Successfully installed jsonschema functools32 19:22:20 INFO - Cleaning up... 19:22:20 INFO - Return code: 0 19:22:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:22:20 INFO - Using env: {'DISPLAY': ':0', 19:22:20 INFO - 'HOME': '/home/cltbld', 19:22:20 INFO - 'LANG': 'en_US.UTF-8', 19:22:20 INFO - 'LANGUAGE': 'en_US:en', 19:22:20 INFO - 'LOGNAME': 'cltbld', 19:22:20 INFO - 'MAIL': '/var/mail/cltbld', 19:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:20 INFO - 'MOZ_NO_REMOTE': '1', 19:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:20 INFO - 'NO_EM_RESTART': '1', 19:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:20 INFO - 'PWD': '/builds/slave/test', 19:22:20 INFO - 'SHELL': '/bin/bash', 19:22:20 INFO - 'SHLVL': '1', 19:22:20 INFO - 'TERM': 'linux', 19:22:20 INFO - 'TMOUT': '86400', 19:22:20 INFO - 'USER': 'cltbld', 19:22:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:20 INFO - '_': '/tools/buildbot/bin/python'} 19:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:22:21 INFO - Cleaning up... 19:22:21 INFO - Return code: 0 19:22:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:22:21 INFO - Using env: {'DISPLAY': ':0', 19:22:21 INFO - 'HOME': '/home/cltbld', 19:22:21 INFO - 'LANG': 'en_US.UTF-8', 19:22:21 INFO - 'LANGUAGE': 'en_US:en', 19:22:21 INFO - 'LOGNAME': 'cltbld', 19:22:21 INFO - 'MAIL': '/var/mail/cltbld', 19:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:21 INFO - 'MOZ_NO_REMOTE': '1', 19:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:21 INFO - 'NO_EM_RESTART': '1', 19:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:21 INFO - 'PWD': '/builds/slave/test', 19:22:21 INFO - 'SHELL': '/bin/bash', 19:22:21 INFO - 'SHLVL': '1', 19:22:21 INFO - 'TERM': 'linux', 19:22:21 INFO - 'TMOUT': '86400', 19:22:21 INFO - 'USER': 'cltbld', 19:22:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:21 INFO - '_': '/tools/buildbot/bin/python'} 19:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:22:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:22:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - Downloading docopt-0.6.1.tar.gz 19:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:22:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:22:24 INFO - Running setup.py install for blobuploader 19:22:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:22:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:22:24 INFO - Running setup.py install for requests 19:22:24 INFO - Running setup.py install for docopt 19:22:24 INFO - Successfully installed blobuploader requests docopt 19:22:24 INFO - Cleaning up... 19:22:24 INFO - Return code: 0 19:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:24 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')]} 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:24 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')]} 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:24 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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:24 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 19:22:24 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 19:22:24 INFO - Using env: {'DISPLAY': ':0', 19:22:24 INFO - 'HOME': '/home/cltbld', 19:22:24 INFO - 'LANG': 'en_US.UTF-8', 19:22:24 INFO - 'LANGUAGE': 'en_US:en', 19:22:24 INFO - 'LOGNAME': 'cltbld', 19:22:24 INFO - 'MAIL': '/var/mail/cltbld', 19:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:24 INFO - 'MOZ_NO_REMOTE': '1', 19:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:24 INFO - 'NO_EM_RESTART': '1', 19:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:24 INFO - 'PWD': '/builds/slave/test', 19:22:24 INFO - 'SHELL': '/bin/bash', 19:22:24 INFO - 'SHLVL': '1', 19:22:24 INFO - 'TERM': 'linux', 19:22:24 INFO - 'TMOUT': '86400', 19:22:24 INFO - 'USER': 'cltbld', 19:22:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:24 INFO - '_': '/tools/buildbot/bin/python'} 19:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:25 INFO - Running setup.py (path:/tmp/pip-HbuxkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:25 INFO - Running setup.py (path:/tmp/pip-silRrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:25 INFO - Running setup.py (path:/tmp/pip-bYwJtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:25 INFO - Running setup.py (path:/tmp/pip-IL_Qmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:25 INFO - Running setup.py (path:/tmp/pip-j_LfRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:25 INFO - Running setup.py (path:/tmp/pip-n65ZLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:25 INFO - Running setup.py (path:/tmp/pip-2HuuNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:25 INFO - Running setup.py (path:/tmp/pip-GwpFtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:25 INFO - Running setup.py (path:/tmp/pip-qXyHCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:25 INFO - Running setup.py (path:/tmp/pip-4iBQOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:25 INFO - Running setup.py (path:/tmp/pip-MDQRhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:25 INFO - Running setup.py (path:/tmp/pip-0Bzv10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:25 INFO - Running setup.py (path:/tmp/pip-Q2d5oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:25 INFO - Running setup.py (path:/tmp/pip-OuqkVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:26 INFO - Running setup.py (path:/tmp/pip-OTnNLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:26 INFO - Running setup.py (path:/tmp/pip-RGBQiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:26 INFO - Running setup.py (path:/tmp/pip-Wg1pk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:22:26 INFO - Running setup.py install for manifestparser 19:22:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:22:26 INFO - Running setup.py install for mozcrash 19:22:26 INFO - Running setup.py install for mozdebug 19:22:26 INFO - Running setup.py install for mozdevice 19:22:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:22:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:22:26 INFO - Running setup.py install for mozfile 19:22:26 INFO - Running setup.py install for mozhttpd 19:22:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:22:26 INFO - Running setup.py install for mozinfo 19:22:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:22:26 INFO - Running setup.py install for mozInstall 19:22:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Running setup.py install for mozleak 19:22:27 INFO - Running setup.py install for mozlog 19:22:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Running setup.py install for moznetwork 19:22:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Running setup.py install for mozprocess 19:22:27 INFO - Running setup.py install for mozprofile 19:22:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Running setup.py install for mozrunner 19:22:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Running setup.py install for mozscreenshot 19:22:27 INFO - Running setup.py install for moztest 19:22:27 INFO - Running setup.py install for mozversion 19:22:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:22:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:22:27 INFO - Cleaning up... 19:22:28 INFO - Return code: 0 19:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:28 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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:28 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 19:22:28 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 19:22:28 INFO - Using env: {'DISPLAY': ':0', 19:22:28 INFO - 'HOME': '/home/cltbld', 19:22:28 INFO - 'LANG': 'en_US.UTF-8', 19:22:28 INFO - 'LANGUAGE': 'en_US:en', 19:22:28 INFO - 'LOGNAME': 'cltbld', 19:22:28 INFO - 'MAIL': '/var/mail/cltbld', 19:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:28 INFO - 'MOZ_NO_REMOTE': '1', 19:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:28 INFO - 'NO_EM_RESTART': '1', 19:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:28 INFO - 'PWD': '/builds/slave/test', 19:22:28 INFO - 'SHELL': '/bin/bash', 19:22:28 INFO - 'SHLVL': '1', 19:22:28 INFO - 'TERM': 'linux', 19:22:28 INFO - 'TMOUT': '86400', 19:22:28 INFO - 'USER': 'cltbld', 19:22:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:28 INFO - '_': '/tools/buildbot/bin/python'} 19:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:28 INFO - Running setup.py (path:/tmp/pip-SW_sSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:28 INFO - Running setup.py (path:/tmp/pip-u77n2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:28 INFO - Running setup.py (path:/tmp/pip-Fealpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:28 INFO - Running setup.py (path:/tmp/pip-mEd1_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:28 INFO - Running setup.py (path:/tmp/pip-addTRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:28 INFO - Running setup.py (path:/tmp/pip-OmVVV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:28 INFO - Running setup.py (path:/tmp/pip-3U2LRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:28 INFO - Running setup.py (path:/tmp/pip-EdPoS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:28 INFO - Running setup.py (path:/tmp/pip-bP0dYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:28 INFO - Running setup.py (path:/tmp/pip-3d4s92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22: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)) 19:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:28 INFO - Running setup.py (path:/tmp/pip-J2raIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:29 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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:29 INFO - Running setup.py (path:/tmp/pip-68nmPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:29 INFO - Running setup.py (path:/tmp/pip-QkKIm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22: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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:29 INFO - Running setup.py (path:/tmp/pip-8kB90F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22: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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:29 INFO - Running setup.py (path:/tmp/pip-p2RNoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22: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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:29 INFO - Running setup.py (path:/tmp/pip-xh_qvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22: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)) 19:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:29 INFO - Running setup.py (path:/tmp/pip-pfRJx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22: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)) 19:22: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)) 19:22: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)) 19:22: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)) 19:22: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)) 19:22: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)) 19:22:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22:31 INFO - Downloading blessings-1.6.tar.gz 19:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:22:31 INFO - Installing collected packages: blessings 19:22:31 INFO - Running setup.py install for blessings 19:22:31 INFO - Successfully installed blessings 19:22:31 INFO - Cleaning up... 19:22:31 INFO - Return code: 0 19:22:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:31 INFO - Reading from file tmpfile_stdout 19:22:31 INFO - Current package versions: 19:22:31 INFO - argparse == 1.2.1 19:22:31 INFO - blessings == 1.6 19:22:31 INFO - blobuploader == 1.2.4 19:22:31 INFO - docopt == 0.6.1 19:22:31 INFO - functools32 == 3.2.3-2 19:22:31 INFO - jsonschema == 2.5.1 19:22:31 INFO - manifestparser == 1.1 19:22:31 INFO - mozInstall == 1.12 19:22:31 INFO - mozcrash == 1.0 19:22:31 INFO - mozdebug == 0.1 19:22:31 INFO - mozdevice == 0.49 19:22:31 INFO - mozfile == 1.2 19:22:31 INFO - mozhttpd == 0.7 19:22:31 INFO - mozinfo == 0.9 19:22:31 INFO - mozleak == 0.1 19:22:31 INFO - mozlog == 3.4 19:22:31 INFO - moznetwork == 0.27 19:22:31 INFO - mozprocess == 0.24 19:22:31 INFO - mozprofile == 0.28 19:22:31 INFO - mozrunner == 6.13 19:22:31 INFO - mozscreenshot == 0.1 19:22:31 INFO - mozsystemmonitor == 0.3 19:22:31 INFO - moztest == 0.8 19:22:31 INFO - mozversion == 1.4 19:22:31 INFO - psutil == 3.1.1 19:22:31 INFO - requests == 1.2.3 19:22:31 INFO - wsgiref == 0.1.2 19:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:31 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')]} 19:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:31 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')]} 19:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:31 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 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:31 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 19:22:31 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 19:22:31 INFO - Using env: {'DISPLAY': ':0', 19:22:31 INFO - 'HOME': '/home/cltbld', 19:22:31 INFO - 'LANG': 'en_US.UTF-8', 19:22:31 INFO - 'LANGUAGE': 'en_US:en', 19:22:31 INFO - 'LOGNAME': 'cltbld', 19:22:31 INFO - 'MAIL': '/var/mail/cltbld', 19:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:31 INFO - 'MOZ_NO_REMOTE': '1', 19:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:31 INFO - 'NO_EM_RESTART': '1', 19:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:31 INFO - 'PWD': '/builds/slave/test', 19:22:31 INFO - 'SHELL': '/bin/bash', 19:22:31 INFO - 'SHLVL': '1', 19:22:31 INFO - 'TERM': 'linux', 19:22:31 INFO - 'TMOUT': '86400', 19:22:31 INFO - 'USER': 'cltbld', 19:22:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:31 INFO - '_': '/tools/buildbot/bin/python'} 19:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 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)) 19:22:32 INFO - Cleaning up... 19:22:32 INFO - Return code: 0 19:22:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, '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': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', '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 19:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:22:32 INFO - Using env: {'DISPLAY': ':0', 19:22:32 INFO - 'HOME': '/home/cltbld', 19:22:32 INFO - 'LANG': 'en_US.UTF-8', 19:22:32 INFO - 'LANGUAGE': 'en_US:en', 19:22:32 INFO - 'LOGNAME': 'cltbld', 19:22:32 INFO - 'MAIL': '/var/mail/cltbld', 19:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:32 INFO - 'MOZ_NO_REMOTE': '1', 19:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:32 INFO - 'NO_EM_RESTART': '1', 19:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:32 INFO - 'PWD': '/builds/slave/test', 19:22:32 INFO - 'SHELL': '/bin/bash', 19:22:32 INFO - 'SHLVL': '1', 19:22:32 INFO - 'TERM': 'linux', 19:22:32 INFO - 'TMOUT': '86400', 19:22:32 INFO - 'USER': 'cltbld', 19:22:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:32 INFO - '_': '/tools/buildbot/bin/python'} 19:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:22:32 INFO - Cleaning up... 19:22:32 INFO - Return code: 0 19:22:32 INFO - Running post-action listener: _resource_record_post_action 19:22:32 INFO - Running post-action listener: _start_resource_monitoring 19:22:32 INFO - Starting resource monitoring. 19:22:32 INFO - [mozharness: 2017-02-06 03:22:32.469865Z] Finished create-virtualenv step (success) 19:22:32 INFO - [mozharness: 2017-02-06 03:22:32.470310Z] Running install step. 19:22:32 INFO - Running pre-action listener: _resource_record_pre_action 19:22:32 INFO - Running main action method: install 19:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:32 INFO - Reading from file tmpfile_stdout 19:22:32 INFO - Detecting whether we're running mozinstall >=1.0... 19:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:22:32 INFO - Reading from file tmpfile_stdout 19:22:32 INFO - Output received: 19:22:32 INFO - Usage: mozinstall [options] installer 19:22:32 INFO - Options: 19:22:32 INFO - -h, --help show this help message and exit 19:22:32 INFO - -d DEST, --destination=DEST 19:22:32 INFO - Directory to install application into. [default: 19:22:32 INFO - "/builds/slave/test"] 19:22:32 INFO - --app=APP Application being installed. [default: firefox] 19:22:32 INFO - mkdir: /builds/slave/test/build/application 19:22:32 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'] 19:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:22:50 INFO - Reading from file tmpfile_stdout 19:22:50 INFO - Output received: 19:22:50 INFO - /builds/slave/test/build/application/firefox/firefox 19:22:50 INFO - Running post-action listener: _resource_record_post_action 19:22:50 INFO - [mozharness: 2017-02-06 03:22:50.298111Z] Finished install step (success) 19:22:50 INFO - [mozharness: 2017-02-06 03:22:50.298382Z] Running run-tests step. 19:22:50 INFO - Running pre-action listener: _resource_record_pre_action 19:22:50 INFO - Running main action method: run_tests 19:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:22:50 INFO - Python 2.7.3 19:22:50 INFO - Return code: 0 19:22:50 INFO - grabbing minidump binary from tooltool 19:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:22:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163f0>, '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 0x2b16cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b171a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:22:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:22:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:22:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:22:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:22:50 INFO - Return code: 0 19:22:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:22:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:22:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:22:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:22:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:22:50 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/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:22:50 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/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 19:22:50 INFO - Using env: {'DISPLAY': ':0', 19:22:50 INFO - 'HOME': '/home/cltbld', 19:22:50 INFO - 'LANG': 'en_US.UTF-8', 19:22:50 INFO - 'LANGUAGE': 'en_US:en', 19:22:50 INFO - 'LOGNAME': 'cltbld', 19:22:50 INFO - 'MAIL': '/var/mail/cltbld', 19:22:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:22:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:50 INFO - 'MOZ_NO_REMOTE': '1', 19:22:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:50 INFO - 'NO_EM_RESTART': '1', 19:22:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:50 INFO - 'PWD': '/builds/slave/test', 19:22:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:22:50 INFO - 'SHELL': '/bin/bash', 19:22:50 INFO - 'SHLVL': '1', 19:22:50 INFO - 'TERM': 'linux', 19:22:50 INFO - 'TMOUT': '86400', 19:22:50 INFO - 'USER': 'cltbld', 19:22:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486350314.835098-771563047', 19:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:50 INFO - '_': '/tools/buildbot/bin/python'} 19:22:50 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/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:22:50 INFO - mozversion application_buildid: 20170206021819 19:22:50 INFO - mozversion application_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 19:22:50 INFO - mozversion application_display_name: Nightly 19:22:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:22:50 INFO - mozversion application_name: Firefox 19:22:50 INFO - mozversion application_remotingname: firefox 19:22:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:22:50 INFO - mozversion application_vendor: Mozilla 19:22:50 INFO - mozversion application_version: 54.0a1 19:22:50 INFO - mozversion platform_buildid: 20170206021819 19:22:50 INFO - mozversion platform_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 19:22:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:22:50 INFO - mozversion platform_version: 54.0a1 19:22:50 INFO - using testdate: 1486351370 19:22:50 INFO - actual date: 1486351370 19:22:50 INFO - starting webserver on 'localhost:40143' 19:22:50 INFO - SUITE-START | Running 2 tests 19:22:50 INFO - TEST-START | dromaeo_css 19:22:50 INFO - operating with platform_type : linux_ 19:22:50 INFO - Initialising browser for dromaeo_css test... 19:22:50 INFO - TEST-INFO | started process 12219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQOwFR/profile http://localhost:40143/getInfo.html) 19:22:54 INFO - PROCESS | 12219 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 19:22:54 INFO - PROCESS | 12219 | __metrics Screen width/height:1600/1200 19:22:54 INFO - PROCESS | 12219 | colorDepth:24 19:22:54 INFO - PROCESS | 12219 | Browser inner width/height: 1024/697 19:22:54 INFO - PROCESS | 12219 | __metrics 19:22:55 INFO - PROCESS | 12219 | 1486351375484 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884: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 19:22:55 INFO - PROCESS | 12219 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:22:55 INFO - PROCESS | 12219 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:22:56 INFO - TEST-INFO | 12219: exit 0 19:22:56 INFO - Browser initialized. 19:22:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:22:56 INFO - TEST-INFO | started process 12300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQOwFR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:08 INFO - PROCESS | 12300 | RSS: Main: 148463616 19:23:08 INFO - PROCESS | 12300 | 19:26:10 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40143/tests/dromaeo/cssquery-ext.html) 19:26:11 INFO - PROCESS | 12300 | RSS: Main: 268742656 19:26:11 INFO - PROCESS | 12300 | 19:27:58 INFO - PROCESS | 12300 | ************************* 19:27:58 INFO - PROCESS | 12300 | A coding exception was thrown and uncaught in a Task. 19:27:58 INFO - PROCESS | 12300 | 19:27:58 ERROR - PROCESS | 12300 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:27:58 INFO - PROCESS | 12300 | Full stack: 19:27:58 INFO - PROCESS | 12300 | ************************* 19:29:14 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-ext.html (next: http://localhost:40143/tests/dromaeo/cssquery-jquery.html) 19:29:14 INFO - PROCESS | 12300 | RSS: Main: 245141504 19:29:14 INFO - PROCESS | 12300 | 19:32:16 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40143/tests/dromaeo/cssquery-mootools.html) 19:32:17 INFO - PROCESS | 12300 | RSS: Main: 215822336 19:32:17 INFO - PROCESS | 12300 | 19:35:19 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40143/tests/dromaeo/cssquery-prototype.html) 19:35:19 INFO - PROCESS | 12300 | RSS: Main: 234078208 19:35:19 INFO - PROCESS | 12300 | 19:38:22 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40143/tests/dromaeo/cssquery-yui.html) 19:38:23 INFO - PROCESS | 12300 | RSS: Main: 189558784 19:38:23 INFO - PROCESS | 12300 | 19:41:25 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-yui.html (next: http://localhost:40143/tests/dromaeo/cssquery-dojo.html) 19:41:26 INFO - PROCESS | 12300 | RSS: Main: 262483968 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | __start_tp_report 19:41:26 INFO - PROCESS | 12300 | _x_x_mozilla_page_load 19:41:26 INFO - PROCESS | 12300 | _x_x_mozilla_page_load_details 19:41:26 INFO - PROCESS | 12300 | |i|pagename|runs| 19:41:26 INFO - PROCESS | 12300 | |0;dojo.html;3109.2382366320253;3129.6087989001376;3169.2869104451493;3187.9840600796992;3212.132724164476;5116.718580478072;5204.973975130129;5253.343332083489;5335.439778823226;5336.092864213078;5233.084210263208;5264.578833693305;5283.471652834724;5309;5342.706151161685;4618.399608050949;4812.566868981791;4963.131451995886;4964.429090654567;4968.875778105558;4778.307145463906;4801.519848015206;4897.094037603037;4958.776855041532;4963.478834722357;4844.878878028042;4852.005338905534;4899.6080313575185;4941.604671626261;4985.277134815431;4893.266010098514;4893.804247830119;4894.5105489451125;4900.17696468183;4965.553100220997;4852.199387101124;4929.827456039057;4934.629902757308;4937.901241975141;4978.427480839714;5227.059129356714;5280.3663560372615;5287.841364759063;5334.119870221448;5340.465953404668;5716.628419152742;5717.942820571782;5726.427357264281;5730.997075511768;5740;5741.110127930177;5768.221290125864;5786.305643322786;5803.448672376117;5847.44449277318;5347.197920311906;5353.919691204596;5383.569314454834;5387.461253874581;5400.91898621521;5729.541636669056;5885.352611212763;5887.8233652990475;5890.617109887844;5897.67562784051;5592.972035139798;5596;5664.943350566524;5701.087825947829;5713;5694.800681976111;5743.1385292206505;5743.54051675865;5751.942480575224;5806.1000544915605;5716.742746576414;5721.971390143106;5727.198192253088;5728.455796699307;5729.5702822288495;5561.777528898799;5594.692291923983;5642.746076426571;5647.548196144298;5727.828165155052;4424.75663838492;4425.845095421645;4446.799894004777;4461.598456138963;4463.598276155161;3912.295786758354;3919.0986073202753;3922.666573341241;3927.293087244266;3950.288947989332;5247.868803279948;5303.655262407931;5306.734663266821;5404.972975135099;5448.83653490396;5638.520725738358;5677.801276955287;5688.488036076773;5690.516306113944;5716.828495145152;5353.598480114007;5360.276362690986;5361.812336568201;5369.919451208235;5370.355557333145;4841.419029716457;4870.196417591058;4873.926891096637;4879.878003049952;4908.239222920453;5902.173695682608;5923.348431672513;5969.164316995624;5983.790567330297;6048.334683184934;5702.6293290935955;5751.194832723339;5759.827205183851;5761.769529218785;5770.653760774367;5799.594028417971;5828.213191219301;5834.416558344302;5875.059990401515;5997.730102145501;5529.612927095065;5590.720463976866;5614.2701448811395;5629.605927585029;5634.661920284796;5591.077472217039;5638.126090455986;5678.77284908599;5695.8860822784145;5728.742206600797;5576.302962129734;5588.105903055492;5590.496855283044;5593.328800543798;5594.272744543184;5410.053240682943;5513;5544.085225937836;5571.66570005801;5574.637648552831;5565.5825813063375;5611.298587676541;5611.6352437091455;5646.745896434588;5659.490645841894;5566.666000039849;5613.719314034201;5618.6628802272;5620.156976453564;5621.943780562142;5300.628955973045;5340.679559226459;5434.2935418395355;5505.779768809202;5553.111502159635 19:41:26 INFO - PROCESS | 12300 | |1;ext.html;564.6217034586826;577.3620149734543;587.7120211096562;602.7823795932217;610.3804638292137;32889.50665740016;43516.78241608792;45032.324515132255;45038.774806126006;48442.27336589954;44645.33032004523;45673.31490027652;45731.08243892442;45789.31316030254;45812;7724.1889601591865;9035.63857445703;9228.723138305828;9229.861552076723;9231;7720.459567830254;10252.333598316123;10637.78724425511;10650.147988160928;10970.506327215255;10508.527116279785;10531.473426328692;10539.47302634869;10554.419506927115;10559.947200264027;10892.727681807939;10907.563697452131;10982;10999.285046471954;11001;10104.090631843095;10200.38797672142;10201.13290370312;10203.336783109075;10206.744831379201;44404.777976110236;44746.32880506795;44798;44833;44868.775656121514;3954.5847685992844;3982.7411218270718;4025.9798701006603;4051.9594804051876;4053.27041132596;31742.513839334446;31805.52291715626;31911.202219944455;32129.357412851612;33361.33277334464;3946.3291240489184;4045.2111838191563;4082.3672330788777;4098.139390727951;4146.834126634931;297703;297861;298960.99999999785;299163;299207;51716.75965364852;53914;61843.381566183765;62456.375436245966;62457.68771156115;69619;70342.29657703459;70418;71038.2896171042;71119.64440177767;16720.498385048468;16960.491185264462;16988.74516882248;16993.150342482826;17033.574160646083;12771.489140434465;12775.23348599087;12923.15999460032;12949.352532373532;13020.674483137807;18955.526111847314;18993.335233267047;19011.33460328882;19063;19128.330508432136;6500.6424646643945;6688.598684078971;6688.799336019927;6727.226368967631;6889;873.7553485024204;897.8608315711075;901.833160865242;907.7503686486269;908.3096846396654;30292;30323.545146822817;30386;31875.203119921724;32403.18992025218;1000.7190795781412;1086.684861390188;1088.314361951965;1097.4457898761234;1099.8625171853519;15288.923555382375;15864.365425383086;16200.432984845474;16345.918270408809;16492.42276520316;457330;459891;460441;460540;460720;63330;63545.682271588346;63779.68110159419;63838.68080659567;64040.35959640437;1385.7020740540831;1401.068289587413;1410.8165938428144;1422.2604245792338;1427.750143724844;29005.564916525847;29775.70224297816;29921.401571968872;31006.942372341513;31043.223919402197;53508.46491535035;54101.45898540964;54180.72909635427;54230.45769542254;54292;276873;276950;277740;277867;278094;33273.83363083266;40037.39943900786;41305.58694413018;45010.32484512669;45118.548814511436;45839.77080114578;45997.54002459932;46252.30621540747;47157.29264060973;47255.29117063316;38849.80575097106;39600.40599391069;39645.40531892081;40053.79973100233;42008;39237.607623923395;40955.1808963825;41324.58675413208;41510.79244603758;41553.37669935014;39422.80288598539;40623.79688101659;41518.79240603778;41610.79194604007;41688.79155604324;33487.83256083704;34363.828180859935;34867.65132348644;35034.270373499254;35547.64452355443;25115;25482.617760733974;25705.871470642527;25826.61260081138;26055.218343449727 19:41:26 INFO - PROCESS | 12300 | |2;jquery.html;375.94360845873115;388.2351767018973;392.82519278920876;395.40688966550175;399.75015615240477;18174.091720369353;19927.003649817507;19928.202871885143;20047.09788059537;20244.696329555067;19514.21943122277;20074.799252007477;20531.38405847827;20940.476488087807;21147.57704845902;5749.712514374285;5804.622699524528;5881.970590147043;5920.792772252972;6032;5779.306483222019;5870.295564532241;5878.088896221093;5878.529717622601;5880.882382352351;5548.167774833787;5750.424957504258;5802.332731735841;5806.44838740319;5841.094630332305;5698.1452782083015;5790.247267855173;5827.912581311284;5835.241418615574;5842.649441033552;5089.567386772129;5123.692578445305;5125.718085505296;5129.666571672867;5135.460776618476;19854.3050993216;19955.401337959884;20071.598568028705;20087.296944607016;20099.79900200994;2718.497078040569;2721.7142200068906;2730.426610411816;2734.371094648222;2736.6715994080637;14144.36350364236;14483.637909052253;14604.707905841824;14655.267236638232;15411.22943852803;1844.6310737852484;1902.8477721782224;1904.1812020831176;1926.3450426854797;1932.7487426634589;85124.14875851224;85338;85710.57144714237;86636;87726.12273877244;10924;10976.176786741027;10987;10989.450527473595;11060.723481913017;14342.569722908329;14353.425862965572;14464.349104290332;14614.926925365306;15199.164045977357;6130.29501607312;6185.041318595625;6795.218549866829;7499.400047996256;7710.113336966208;6933.757318493828;6963.895541566881;7196;7204.423646108299;7209.0988626421695;4323.329883868006;4520.683552151384;4539.409876716006;4627.699199552018;4661.930071048869;1931.1846863947844;1968.2323893681476;2026.9391918242477;2038.1847261095681;2062.9277975270793;793.9761807145795;838.455004247232;846.5851732650957;850.4174640371366;859.1537335724306;19100.23599056022;19805;19962.401127965895;20139.59720805605;20171.899140504203;831.4180073948139;846.4371193156481;850.8553545897213;851.5571902610608;864.489950928955;10444.425556594308;10711.143108551298;10770.059772684133;10951.890481095086;10977.6157834477;566211;569963;570383;585708.1429185739;587331;64209.67895160494;76503.61748191224;98213.50893245488;98597.50701246448;102103;974.8342781727123;992.5235886774389;1022.2282176956351;1026.5380578739598;1031.8452232165084;17803.732944006108;17886.5528361792;18479.353222637143;18598.721019184995;18812.717809233145;40296.597034029284;41174.79412603038;41536;43664.781676091414;44101.77949110234;57920.131198032905;57964.420355795904;58509;58746.41253587409;59308;7221.6750246238;7403.407727381689;7520;8272.751817445485;8344.58277086131;9264.258859291376;12432.875671243171;12649.177803442746;12911.289879056741;13019.934900325437;11356.716082098013;11485.942570287096;11491.597794077501;11827.17209795306;11834.704132396759;11098.778024439627;11177.273477223955;11372.18184790532;11376.37429941328;11519.366434845828;11671.299722016705;11704.239224450383;11759.76480470403;11893.82159267629;12352.505899763908;7354.852902941804;7449.366803821736;7470.514416562906;7588.696452141852;7635.045619297588;9830.311878168746;11060.281081729661;11086.334819910831;11395.316281023164;11590.478428470908 19:41:26 INFO - PROCESS | 12300 | |3;mootools.html;1394.7432744541495;1398.4056775870265;1413.9080959737619;1419.5173640962078;1423.5160045584503;8610.483370997737;8886.866696999534;8940.150685684866;8952;8956.417832840869;8642.65429382824;8778.6927457539;8837.11628837116;8888.28893688505;9057.90942090579;2174.358564223558;2211.2039665720326;2211.6240239159383;2219.212179676216;2220.0564759976946;1833.3766519383407;2124.192806733447;2171.3703026122407;2177.314146043999;2184.9781502184933;1884.3593178319368;2122.299641118427;2186.529896072344;2187.9781202187933;2188.770179131192;2107.0412962102205;2119.9046042928107;2126.8830214338127;2131.6056529542084;2132.9893350533225;2043.6934459831143;2066.2561477867957;2066.2561477867957;2069.7412823397076;2072.430081727522;8941.865872011926;8957.104289571056;8984.640614375417;8992.370534062618;9013.459192448474;5033.521815427529;5185.222216667492;5193.454687257859;5199.922001169985;5201.687898726051;2942.8822847086303;3049.6950304969546;3124.281415274477;3127.061881435583;3157.621085469735;1183.3432444993025;1205.15036898986;1220.1885745978914;1256.4094875408543;1271.3833790611545;12085.879141208563;12144.453499592451;12145.089118316073;12151.817722734255;12153.574624888086;4021.617946295097;4325.091730736518;4343.847965321199;4371.868843934687;4387.978060109679;9681.273904457054;9683;9688.806223875483;9692.352300108998;9693.273004524688;5175.792968281226;5195.168772996302;5196.844094677166;5197.58419326453;5197.792088316425;4591.471980722193;4663.090697314059;4717.127331443694;4740.905181896343;4804.327394164819;3594.227241143167;3634.6547078027547;3728.366177749789;3761.4357846322723;3859.6333348331864;1063.6224140430036;1067.9946600266949;1082.118073769875;1082.2532452607675;1085.5603480590373;686.3102581905254;725.6516871901412;746.4364404874285;749.134749364485;751.5603372027316;5014.774335154927;5103.821366252163;5627.268455100811;5638.35158956717;5731.484166425042;948.7533241357158;986.6990567876722;1007.4761124215366;1017.2574020964737;1029.156092004564;3599.8740044098854;3641.0715267606593;3788.5264341957254;3793.3551296279697;3862.1310205203604;10250.846237306447;10570.2600817942;10574.788504229873;10612;10620.09729173029;10112.443815590213;10429.843552346721;10505.52725127371;10519.52662130206;10543.683689489328;7860.213978602208;8047.275745182962;8055.395845311508;8055.516668999996;8062.919370806217;5444.373897001896;5526.419725928719;5668.943310567007;5673.77304907799;5680.9147862781265;9529.237660987243;9613.855792162984;9670.85493717609;9697.9030209697;9731.367461115005;9451.291153163404;9759.12167904892;9791.06268119547;9940.403575785476;9990;7654.349380302737;7801.141874393926;7806.570638614704;7824;7825.530468171928;8307.252347288773;8352.123027082313;8381.790455238668;8405.453645513022;8409.327253819558;7364.521306115085;7410.370118539984;7430.7399241026305;7623.199564045695;7760.88358674609;7373.29953654402;7412.147603025721;7436.96281518589;7478.326950574475;7480.962595187207;6353.68231588428;6423.582467139621;6482.092507048923;6489.1888513935755;6502.284748677736;4698.577128058354;4717.221658426459;4760.547747963938;4779.569838714532;4848.200046992207;4715.528447155394;4807.663463557657;4814;4823.348847905488;4855.198892182751 19:41:26 INFO - PROCESS | 12300 | |4;prototype.html;380.18260739410266;391.9392494163404;394.144705988006;397.28092153202687;406.6482492643862;5304.734763261841;5344.3586769587655;5386.8922621547545;5389.73051347433;5400.729963501819;5080.517350851673;5192.117340052191;5217.217417387394;5232.973835130819;5312.123499622558;4146.688998325122;4155.792210389483;4162.562930892258;4182.33082706767;4183.623473887357;4162.729422587522;4188.078622703016;4205.222033923734;4207.558206388331;4213.178430206111;3896.883093507185;4067.6542493888055;4123.855665051724;4156.91686166278;4170.186813571355;4097.44684467599;4102.671786257092;4106.301928672133;4123.2165888481095;4129.306984136505;3613.4941108244866;3620.728445366608;3624.3476174288617;3631.092226943264;3634.3639863024127;4918.688216538257;5186.377634683824;5194.766235519411;5197.246399272084;5225.686458812484;4733.692309999873;4756.809727610891;4758.928616070762;4771.976140119277;4776.976115119437;5580.665160090367;5589.714365695872;5599.220526144836;5600.52395546375;5611.775528978836;3782.829772660237;4059.2084543514025;4062.7968601569805;4068.593140685937;4079.2453396121514;5539.335279766414;5627.521660658808;5676.205331253628;5732.770689172428;5792.478676919055;4049.817758200888;4065.3128951485396;4075.6128167824604;4082.4488694026522;4099.97950010248;4140.275451795924;4141.503019637663;4148.630951785904;4149.688773342012;4154.210699966997;4494.640428765691;4582.564656357641;4592.586667199968;4700.694454860423;4716.316134160527;5524.06090964537;5534.066944519411;5551.361593416728;5562.360328562187;5574;1398.6713122416224;1399.6773049468154;1403.6911879386519;1405.9578212653637;1408.8168538089983;908.4322298563397;943.773494361362;951.571792693277;953.8616900549381;953.9046095390544;5127.820601261731;5151.356080489939;5172.586193104543;5197.58419326453;5200.63595548308;5488.862778430571;5496.361746361768;5527.640703354269;5533.197686335539;5562.582806289463;5027.74861256943;5086.618503612244;5333.786648534093;5385.7576409061685;5402.324709411324;2935.8091724038295;2952.3357244619788;2957.216337670519;2964.614600102016;2976.4195981783346;5591.496765291144;5722.484976352148;5778.913316300259;5805.738741756547;5823.505002074871;5630.859228519238;5644.57665675076;5662.432667419499;5663.943360566424;5688.488036076773;5734.0756214330995;5771.884562308815;5781.901438726629;5801.3328467225965;5804.767809287666;5317.867053323698;5536.778528858962;5541.2796336476;5576.86057848557;5577.60559860035;5442.455754424526;5516.393196748435;5532.944670553243;5551.333839939233;5566.610337276352;5755.942440575541;5881.647101173943;5924;5935.792247271324;5952.57726807079;4321.13577284538;4379.737215766937;4393.450818647669;4396.868093957187;4402.691811573159;5458.399576046552;5669.773209071591;5682.687452190169;5734.655920644775;5790.276215473066;5545.698535107885;5547.945890280834;5574.9721251393485;5577.749001295033;5585.218069470358;5390.919136212881;5573.1918871762555;5605;5624.746886390204;5635.380108188178;5534.640248384003;5561.359398977231;5579.326202139423;5580.911722214129;5585.631520277558;5569;5594.244776955059;5611.551075913999;5619.662820230799;5635.154726791015;5197.740112994411;5416.106342453451;5426.457354264542;5452.2094296327605;5470.699111548903 19:41:26 INFO - PROCESS | 12300 | |5;yui.html;672.4284358295447;690.8411065454949;731.0569365518481;755.9017327747393;757.5227606607837;14939.178345191023;15366.769498457505;15408.383664653415;15418.074915505049;15418.537443876688;14107.929460352709;14191.71616567668;14339.64150896228;14349.067310624801;14375.712485750279;767.5624893810531;770.6262462705583;779.6803310642638;780.3873958942231;780.6448066129898;775.2325198053915;775.9224077592224;776.243162916155;776.7436745873877;776.8407476467339;813.808754942588;823.7075838077486;823.7569916874536;824.0688022534528;824.431142511668;818.337146911001;820.4543978254484;820.6020080261069;820.885076089348;821.6056292979404;599.8620317327039;600.1208229943154;601.8134378342728;602.256213576233;602.3795490644643;14154.575362739135;14210.147391156564;14284.642883927985;14329.928350358181;14606.707865842729;11714.53141874324;12069.27584344942;12120.878791212062;12129.636110916686;12439.440225189888;10826.512806923707;10834;10845.0781683557;11052.005319521202;11245.15661325404;3535.8585656573705;3537.6992955598803;3636.1455058061333;3645.8177091145335;3722.013666378412;69742;71163.64418177928;71347;72221.27778722251;72493.27506724918;9336.719898403058;9414.482203478874;9650.179734722627;9854.704358869245;10192.592296308212;19086;19549.609007819763;19583.412497625093;19588.70616940747;19716.309929152696;7182.928170718331;7205.135383753983;7270.927290727131;7382.74160404394;7396.482246242711;3970.8411663533134;4135.58644135584;4141.171765646883;4141.64795992344;4156.896077598084;3365.024142998503;3471.2710330830305;3480.147363895862;3512.631173726773;3514.8594056237466;584.868404608968;588.6079422166631;590.9911351329733;603.7886739641178;605.9515238780887;732.8607564562716;734.2767374136471;754.8943147959291;773.6247919758913;778.8130848596296;10099.495025248709;10214.693559193236;10351.120154786777;10449.738756530995;10518.368897866152;762.371043888794;769.6267310354474;776.9611519424119;791.2720297326473;799.5682331540903;4627.398438203012;4728.267118596555;4814.711117332971;4844.346013288232;4879.341288926021;58688.119678204865;59022;60065.69967150136;74354.25645743473;74691.62654186695;67197.66401168061;67902.3209767906;68269.31730682729;68292.658536707;68530.65734671394;59630.70184649049;59905.101423478685;60064;60467.69766151229;60561.69719151376;8979.416337938013;9348.439093654402;9361.344705870524;9365.625374985197;9400.294977876823;43183.78408108065;43250.35124473072;43285.78357108194;43876.780616096716;45184.32223516716;49535.752321238164;51162.74418627883;52247.08146888923;52292.7385363086;53477;12014.819777703167;12131.514739410324;12242.081843861924;12412.56556020535;12644.810327844905;12760.617181484571;13039.47842086344;13207;13826.792598110835;13921.299188007495;12431.19197252212;12731.61805145847;13148.934255328662;13353.265570393722;13690.178589284276;12132.878671213528;12698.238105713317;12819.871801281868;13215.735685286048;13311.201327920357;12071.456784444897;12369.567065152676;12853.421596028014;13145.73708525805;13407.396667149807;10219.437930913871;10307.433091180057;10536.894631053592;10548.892366301734;11003.504842282277;8358.87461688063;8584.227419532272;9121.498317592595;9253.180749893365;9388.76528086776 19:41:26 INFO - PROCESS | 12300 | __end_tp_report 19:41:26 INFO - PROCESS | 12300 | __start_cc_report 19:41:26 INFO - PROCESS | 12300 | _x_x_mozilla_cycle_collect,1166 19:41:26 INFO - PROCESS | 12300 | __end_cc_report 19:41:26 INFO - PROCESS | 12300 | __startTimestamp1486352486061__endTimestamp 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | ------- Summary: start ------- 19:41:26 INFO - PROCESS | 12300 | Number of tests: 6 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#0] dojo.html Cycles:165 Average:5310.12 Median:5544.09 stddev:587.40 (10.6%) stddev-sans-first:563.26 19:41:26 INFO - PROCESS | 12300 | Values: 3109.2 3129.6 3169.3 3188.0 3212.1 5116.7 5205.0 5253.3 5335.4 5336.1 5233.1 5264.6 5283.5 5309.0 5342.7 4618.4 4812.6 4963.1 4964.4 4968.9 4778.3 4801.5 4897.1 4958.8 4963.5 4844.9 4852.0 4899.6 4941.6 4985.3 4893.3 4893.8 4894.5 4900.2 4965.6 4852.2 4929.8 4934.6 4937.9 4978.4 5227.1 5280.4 5287.8 5334.1 5340.5 5716.6 5717.9 5726.4 5731.0 5740.0 5741.1 5768.2 5786.3 5803.4 5847.4 5347.2 5353.9 5383.6 5387.5 5400.9 5729.5 5885.4 5887.8 5890.6 5897.7 5593.0 5596.0 5664.9 5701.1 5713.0 5694.8 5743.1 5743.5 5751.9 5806.1 5716.7 5722.0 5727.2 5728.5 5729.6 5561.8 5594.7 5642.7 5647.5 5727.8 4424.8 4425.8 4446.8 4461.6 4463.6 3912.3 3919.1 3922.7 3927.3 3950.3 5247.9 5303.7 5306.7 5405.0 5448.8 5638.5 5677.8 5688.5 5690.5 5716.8 5353.6 5360.3 5361.8 5369.9 5370.4 4841.4 4870.2 4873.9 4879.9 4908.2 5902.2 5923.3 5969.2 5983.8 6048.3 5702.6 5751.2 5759.8 5761.8 5770.7 5799.6 5828.2 5834.4 5875.1 5997.7 5529.6 5590.7 5614.3 5629.6 5634.7 5591.1 5638.1 5678.8 5695.9 5728.7 5576.3 5588.1 5590.5 5593.3 5594.3 5410.1 5513.0 5544.1 5571.7 5574.6 5565.6 5611.3 5611.6 5646.7 5659.5 5566.7 5613.7 5618.7 5620.2 5621.9 5300.6 5340.7 5434.3 5505.8 5553.1 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#1] ext.html Cycles:180 Average:53144.13 Median:21777.50 stddev:93427.86 (429.0%) stddev-sans-first:93606.54 19:41:26 INFO - PROCESS | 12300 | Values: 564.6 577.4 587.7 602.8 610.4 32889.5 43516.8 45032.3 45038.8 48442.3 44645.3 45673.3 45731.1 45789.3 45812.0 7724.2 9035.6 9228.7 9229.9 9231.0 7720.5 10252.3 10637.8 10650.1 10970.5 10508.5 10531.5 10539.5 10554.4 10559.9 10892.7 10907.6 10982.0 10999.3 11001.0 10104.1 10200.4 10201.1 10203.3 10206.7 44404.8 44746.3 44798.0 44833.0 44868.8 3954.6 3982.7 4026.0 4052.0 4053.3 31742.5 31805.5 31911.2 32129.4 33361.3 3946.3 4045.2 4082.4 4098.1 4146.8 297703.0 297861.0 298961.0 299163.0 299207.0 51716.8 53914.0 61843.4 62456.4 62457.7 69619.0 70342.3 70418.0 71038.3 71119.6 16720.5 16960.5 16988.7 16993.2 17033.6 12771.5 12775.2 12923.2 12949.4 13020.7 18955.5 18993.3 19011.3 19063.0 19128.3 6500.6 6688.6 6688.8 6727.2 6889.0 873.8 897.9 901.8 907.8 908.3 30292.0 30323.5 30386.0 31875.2 32403.2 1000.7 1086.7 1088.3 1097.4 1099.9 15288.9 15864.4 16200.4 16345.9 16492.4 457330.0 459891.0 460441.0 460540.0 460720.0 63330.0 63545.7 63779.7 63838.7 64040.4 1385.7 1401.1 1410.8 1422.3 1427.8 29005.6 29775.7 29921.4 31006.9 31043.2 53508.5 54101.5 54180.7 54230.5 54292.0 276873.0 276950.0 277740.0 277867.0 278094.0 33273.8 40037.4 41305.6 45010.3 45118.5 45839.8 45997.5 46252.3 47157.3 47255.3 38849.8 39600.4 39645.4 40053.8 42008.0 39237.6 40955.2 41324.6 41510.8 41553.4 39422.8 40623.8 41518.8 41610.8 41688.8 33487.8 34363.8 34867.7 35034.3 35547.6 25115.0 25482.6 25705.9 25826.6 26055.2 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#2] jquery.html Cycles:180 Average:31377.58 Median:397.58 stddev:94628.47 (23801.2%) stddev-sans-first:94865.30 19:41:26 INFO - PROCESS | 12300 | Values: 375.9 388.2 392.8 395.4 399.8 18174.1 19927.0 19928.2 20047.1 20244.7 19514.2 20074.8 20531.4 20940.5 21147.6 5749.7 5804.6 5882.0 5920.8 6032.0 5779.3 5870.3 5878.1 5878.5 5880.9 5548.2 5750.4 5802.3 5806.4 5841.1 5698.1 5790.2 5827.9 5835.2 5842.6 5089.6 5123.7 5125.7 5129.7 5135.5 19854.3 19955.4 20071.6 20087.3 20099.8 2718.5 2721.7 2730.4 2734.4 2736.7 14144.4 14483.6 14604.7 14655.3 15411.2 1844.6 1902.8 1904.2 1926.3 1932.7 85124.1 85338.0 85710.6 86636.0 87726.1 10924.0 10976.2 10987.0 10989.5 11060.7 14342.6 14353.4 14464.3 14614.9 15199.2 6130.3 6185.0 6795.2 7499.4 7710.1 6933.8 6963.9 7196.0 7204.4 7209.1 4323.3 4520.7 4539.4 4627.7 4661.9 1931.2 1968.2 2026.9 2038.2 2062.9 794.0 838.5 846.6 850.4 859.2 19100.2 19805.0 19962.4 20139.6 20171.9 831.4 846.4 850.9 851.6 864.5 10444.4 10711.1 10770.1 10951.9 10977.6 566211.0 569963.0 570383.0 585708.1 587331.0 64209.7 76503.6 98213.5 98597.5 102103.0 974.8 992.5 1022.2 1026.5 1031.8 17803.7 17886.6 18479.4 18598.7 18812.7 40296.6 41174.8 41536.0 43664.8 44101.8 57920.1 57964.4 58509.0 58746.4 59308.0 7221.7 7403.4 7520.0 8272.8 8344.6 9264.3 12432.9 12649.2 12911.3 13019.9 11356.7 11485.9 11491.6 11827.2 11834.7 11098.8 11177.3 11372.2 11376.4 11519.4 11671.3 11704.2 11759.8 11893.8 12352.5 7354.9 7449.4 7470.5 7588.7 7635.0 9830.3 11060.3 11086.3 11395.3 11590.5 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#3] mootools.html Cycles:180 Average:5582.97 Median:4835.77 stddev:3258.05 (67.4%) stddev-sans-first:3251.99 19:41:26 INFO - PROCESS | 12300 | Values: 1394.7 1398.4 1413.9 1419.5 1423.5 8610.5 8886.9 8940.2 8952.0 8956.4 8642.7 8778.7 8837.1 8888.3 9057.9 2174.4 2211.2 2211.6 2219.2 2220.1 1833.4 2124.2 2171.4 2177.3 2185.0 1884.4 2122.3 2186.5 2188.0 2188.8 2107.0 2119.9 2126.9 2131.6 2133.0 2043.7 2066.3 2066.3 2069.7 2072.4 8941.9 8957.1 8984.6 8992.4 9013.5 5033.5 5185.2 5193.5 5199.9 5201.7 2942.9 3049.7 3124.3 3127.1 3157.6 1183.3 1205.2 1220.2 1256.4 1271.4 12085.9 12144.5 12145.1 12151.8 12153.6 4021.6 4325.1 4343.8 4371.9 4388.0 9681.3 9683.0 9688.8 9692.4 9693.3 5175.8 5195.2 5196.8 5197.6 5197.8 4591.5 4663.1 4717.1 4740.9 4804.3 3594.2 3634.7 3728.4 3761.4 3859.6 1063.6 1068.0 1082.1 1082.3 1085.6 686.3 725.7 746.4 749.1 751.6 5014.8 5103.8 5627.3 5638.4 5731.5 948.8 986.7 1007.5 1017.3 1029.2 3599.9 3641.1 3788.5 3793.4 3862.1 10250.8 10570.3 10574.8 10612.0 10620.1 10112.4 10429.8 10505.5 10519.5 10543.7 7860.2 8047.3 8055.4 8055.5 8062.9 5444.4 5526.4 5668.9 5673.8 5680.9 9529.2 9613.9 9670.9 9697.9 9731.4 9451.3 9759.1 9791.1 9940.4 9990.0 7654.3 7801.1 7806.6 7824.0 7825.5 8307.3 8352.1 8381.8 8405.5 8409.3 7364.5 7410.4 7430.7 7623.2 7760.9 7373.3 7412.1 7437.0 7478.3 7481.0 6353.7 6423.6 6482.1 6489.2 6502.3 4698.6 4717.2 4760.5 4779.6 4848.2 4715.5 4807.7 4814.0 4823.3 4855.2 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#4] prototype.html Cycles:180 Average:4661.41 Median:5339.07 stddev:1350.98 (25.3%) stddev-sans-first:1316.00 19:41:26 INFO - PROCESS | 12300 | Values: 380.2 391.9 394.1 397.3 406.6 5304.7 5344.4 5386.9 5389.7 5400.7 5080.5 5192.1 5217.2 5233.0 5312.1 4146.7 4155.8 4162.6 4182.3 4183.6 4162.7 4188.1 4205.2 4207.6 4213.2 3896.9 4067.7 4123.9 4156.9 4170.2 4097.4 4102.7 4106.3 4123.2 4129.3 3613.5 3620.7 3624.3 3631.1 3634.4 4918.7 5186.4 5194.8 5197.2 5225.7 4733.7 4756.8 4758.9 4772.0 4777.0 5580.7 5589.7 5599.2 5600.5 5611.8 3782.8 4059.2 4062.8 4068.6 4079.2 5539.3 5627.5 5676.2 5732.8 5792.5 4049.8 4065.3 4075.6 4082.4 4100.0 4140.3 4141.5 4148.6 4149.7 4154.2 4494.6 4582.6 4592.6 4700.7 4716.3 5524.1 5534.1 5551.4 5562.4 5574.0 1398.7 1399.7 1403.7 1406.0 1408.8 908.4 943.8 951.6 953.9 953.9 5127.8 5151.4 5172.6 5197.6 5200.6 5488.9 5496.4 5527.6 5533.2 5562.6 5027.7 5086.6 5333.8 5385.8 5402.3 2935.8 2952.3 2957.2 2964.6 2976.4 5591.5 5722.5 5778.9 5805.7 5823.5 5630.9 5644.6 5662.4 5663.9 5688.5 5734.1 5771.9 5781.9 5801.3 5804.8 5317.9 5536.8 5541.3 5576.9 5577.6 5442.5 5516.4 5532.9 5551.3 5566.6 5755.9 5881.6 5924.0 5935.8 5952.6 4321.1 4379.7 4393.5 4396.9 4402.7 5458.4 5669.8 5682.7 5734.7 5790.3 5545.7 5547.9 5575.0 5577.7 5585.2 5390.9 5573.2 5605.0 5624.7 5635.4 5534.6 5561.4 5579.3 5580.9 5585.6 5569.0 5594.2 5611.6 5619.7 5635.2 5197.7 5416.1 5426.5 5452.2 5470.7 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - PROCESS | 12300 | [#5] yui.html Cycles:180 Average:16385.47 Median:27207.55 stddev:20686.52 (76.0%) stddev-sans-first:20710.90 19:41:26 INFO - PROCESS | 12300 | Values: 672.4 690.8 731.1 755.9 757.5 14939.2 15366.8 15408.4 15418.1 15418.5 14107.9 14191.7 14339.6 14349.1 14375.7 767.6 770.6 779.7 780.4 780.6 775.2 775.9 776.2 776.7 776.8 813.8 823.7 823.8 824.1 824.4 818.3 820.5 820.6 820.9 821.6 599.9 600.1 601.8 602.3 602.4 14154.6 14210.1 14284.6 14329.9 14606.7 11714.5 12069.3 12120.9 12129.6 12439.4 10826.5 10834.0 10845.1 11052.0 11245.2 3535.9 3537.7 3636.1 3645.8 3722.0 69742.0 71163.6 71347.0 72221.3 72493.3 9336.7 9414.5 9650.2 9854.7 10192.6 19086.0 19549.6 19583.4 19588.7 19716.3 7182.9 7205.1 7270.9 7382.7 7396.5 3970.8 4135.6 4141.2 4141.6 4156.9 3365.0 3471.3 3480.1 3512.6 3514.9 584.9 588.6 591.0 603.8 606.0 732.9 734.3 754.9 773.6 778.8 10099.5 10214.7 10351.1 10449.7 10518.4 762.4 769.6 777.0 791.3 799.6 4627.4 4728.3 4814.7 4844.3 4879.3 58688.1 59022.0 60065.7 74354.3 74691.6 67197.7 67902.3 68269.3 68292.7 68530.7 59630.7 59905.1 60064.0 60467.7 60561.7 8979.4 9348.4 9361.3 9365.6 9400.3 43183.8 43250.4 43285.8 43876.8 45184.3 49535.8 51162.7 52247.1 52292.7 53477.0 12014.8 12131.5 12242.1 12412.6 12644.8 12760.6 13039.5 13207.0 13826.8 13921.3 12431.2 12731.6 13148.9 13353.3 13690.2 12132.9 12698.2 12819.9 13215.7 13311.2 12071.5 12369.6 12853.4 13145.7 13407.4 10219.4 10307.4 10536.9 10548.9 11003.5 8358.9 8584.2 9121.5 9253.2 9388.8 19:41:26 INFO - PROCESS | 12300 | -------- Summary: end -------- 19:41:26 INFO - PROCESS | 12300 | 19:41:26 INFO - TEST-INFO | 12300: exit 0 19:41:26 INFO - TEST-OK | dromaeo_css | took 1116255ms 19:41:26 INFO - TEST-START | kraken 19:41:26 INFO - operating with platform_type : linux_ 19:41:26 INFO - Initialising browser for kraken test... 19:41:26 INFO - TEST-INFO | started process 12599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDnMTOY/profile http://localhost:40143/getInfo.html) 19:41:30 INFO - PROCESS | 12599 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 19:41:30 INFO - PROCESS | 12599 | __metrics Screen width/height:1600/1200 19:41:30 INFO - PROCESS | 12599 | colorDepth:24 19:41:30 INFO - PROCESS | 12599 | Browser inner width/height: 1024/697 19:41:30 INFO - PROCESS | 12599 | __metrics 19:41:31 INFO - PROCESS | 12599 | 1486352491326 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884: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 19:41:31 INFO - PROCESS | 12599 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:41:31 INFO - PROCESS | 12599 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:41:32 INFO - PROCESS | 12599 | console.error: PushService: 19:41:32 INFO - PROCESS | 12599 | stateChangeProcessEnqueue: Error transitioning state 19:41:32 INFO - PROCESS | 12599 | UnknownError 19:41:32 INFO - TEST-INFO | 12599: exit 0 19:41:32 INFO - Browser initialized. 19:41:32 INFO - Running cycle 1/1 for kraken test... 19:41:32 INFO - TEST-INFO | started process 12682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDnMTOY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:44 INFO - PROCESS | 12682 | RSS: Main: 149278720 19:41:44 INFO - PROCESS | 12682 | 19:41:47 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection) 19:41:48 INFO - PROCESS | 12682 | RSS: Main: 204795904 19:41:48 INFO - PROCESS | 12682 | 19:41:50 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-dft) 19:41:51 INFO - PROCESS | 12682 | RSS: Main: 183197696 19:41:51 INFO - PROCESS | 12682 | 19:41:54 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-fft) 19:41:54 INFO - PROCESS | 12682 | RSS: Main: 264867840 19:41:54 INFO - PROCESS | 12682 | 19:41:56 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator) 19:41:57 INFO - PROCESS | 12682 | RSS: Main: 176865280 19:41:57 INFO - PROCESS | 12682 | 19:41:59 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:00 INFO - PROCESS | 12682 | RSS: Main: 181010432 19:42:00 INFO - PROCESS | 12682 | 19:42:03 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom) 19:42:03 INFO - PROCESS | 12682 | RSS: Main: 220364800 19:42:03 INFO - PROCESS | 12682 | 19:42:07 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate) 19:42:07 INFO - PROCESS | 12682 | RSS: Main: 219336704 19:42:07 INFO - PROCESS | 12682 | 19:42:10 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial) 19:42:11 INFO - PROCESS | 12682 | RSS: Main: 217944064 19:42:11 INFO - PROCESS | 12682 | 19:42:12 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:42:13 INFO - PROCESS | 12682 | RSS: Main: 180719616 19:42:13 INFO - PROCESS | 12682 | 19:42:15 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:42:15 INFO - PROCESS | 12682 | RSS: Main: 187764736 19:42:15 INFO - PROCESS | 12682 | 19:42:18 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:42:18 INFO - PROCESS | 12682 | RSS: Main: 196296704 19:42:18 INFO - PROCESS | 12682 | 19:42:21 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:42:21 INFO - PROCESS | 12682 | RSS: Main: 206032896 19:42:21 INFO - PROCESS | 12682 | 19:42:24 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:42:25 INFO - PROCESS | 12682 | RSS: Main: 202964992 19:42:25 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40143/tests/kraken/driver.html?testName=ai-astar) 19:42:27 INFO - PROCESS | 12682 | RSS: Main: 253997056 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | __start_tp_report 19:42:27 INFO - PROCESS | 12682 | _x_x_mozilla_page_load 19:42:27 INFO - PROCESS | 12682 | _x_x_mozilla_page_load_details 19:42:27 INFO - PROCESS | 12682 | |i|pagename|runs| 19:42:27 INFO - PROCESS | 12682 | |0;ai-astar;111;111;112;111;112;112;112;112;112;111 19:42:27 INFO - PROCESS | 12682 | |1;audio-beat-detection;145;118;118;155;119;121;120;119;140;119 19:42:27 INFO - PROCESS | 12682 | |2;audio-dft;162;161;159;159;162;161;163;162;161;162 19:42:27 INFO - PROCESS | 12682 | |3;audio-fft;75;75;76;102;76;77;78;75;96;75 19:42:27 INFO - PROCESS | 12682 | |4;audio-oscillator;84;82;109;82;82;82;109;84;83;110 19:42:27 INFO - PROCESS | 12682 | |5;imaging-gaussian-blur;117;117;117;117;117;118;116;116;117;117 19:42:27 INFO - PROCESS | 12682 | |6;imaging-darkroom;146;147;148;146;147;146;147;147;146;146 19:42:27 INFO - PROCESS | 12682 | |7;imaging-desaturate;95;95;96;96;96;96;96;95;97;96 19:42:27 INFO - PROCESS | 12682 | |8;json-parse-financial;57;55;55;55;55;58;55;55;55;56 19:42:27 INFO - PROCESS | 12682 | |9;json-stringify-tinderbox;62;62;63;63;63;62;63;63;63;68 19:42:27 INFO - PROCESS | 12682 | |10;stanford-crypto-aes;82;83;81;82;82;89;82;82;82;87 19:42:27 INFO - PROCESS | 12682 | |11;stanford-crypto-ccm;129;126;134;127;132;137;135;124;164;153 19:42:27 INFO - PROCESS | 12682 | |12;stanford-crypto-pbkdf2;170;168;169;179;165;170;167;171;164;167 19:42:27 INFO - PROCESS | 12682 | |13;stanford-crypto-sha256-iterative;65;62;63;63;62;62;64;61;62;62 19:42:27 INFO - PROCESS | 12682 | __end_tp_report 19:42:27 INFO - PROCESS | 12682 | __start_cc_report 19:42:27 INFO - PROCESS | 12682 | _x_x_mozilla_cycle_collect,1705 19:42:27 INFO - PROCESS | 12682 | __end_cc_report 19:42:27 INFO - PROCESS | 12682 | __startTimestamp1486352547327__endTimestamp 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | ------- Summary: start ------- 19:42:27 INFO - PROCESS | 12682 | Number of tests: 14 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:42:27 INFO - PROCESS | 12682 | Values: 111.0 111.0 112.0 111.0 112.0 112.0 112.0 112.0 112.0 111.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:120.50 stddev:13.80 (11.5%) stddev-sans-first:13.09 19:42:27 INFO - PROCESS | 12682 | Values: 145.0 118.0 118.0 155.0 119.0 121.0 120.0 119.0 140.0 119.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 19:42:27 INFO - PROCESS | 12682 | Values: 162.0 161.0 159.0 159.0 162.0 161.0 163.0 162.0 161.0 162.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:9.90 (13.0%) stddev-sans-first:10.30 19:42:27 INFO - PROCESS | 12682 | Values: 75.0 75.0 76.0 102.0 76.0 77.0 78.0 75.0 96.0 75.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:12.88 (15.7%) stddev-sans-first:13.44 19:42:27 INFO - PROCESS | 12682 | Values: 84.0 82.0 109.0 82.0 82.0 82.0 109.0 84.0 83.0 110.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:42:27 INFO - PROCESS | 12682 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 116.0 116.0 117.0 117.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:42:27 INFO - PROCESS | 12682 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:42:27 INFO - PROCESS | 12682 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:1.07 (2.0%) stddev-sans-first:1.01 19:42:27 INFO - PROCESS | 12682 | Values: 57.0 55.0 55.0 55.0 55.0 58.0 55.0 55.0 55.0 56.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.80 19:42:27 INFO - PROCESS | 12682 | Values: 62.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 68.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.00 stddev:2.62 (3.2%) stddev-sans-first:2.74 19:42:27 INFO - PROCESS | 12682 | Values: 82.0 83.0 81.0 82.0 82.0 89.0 82.0 82.0 82.0 87.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:134.50 stddev:12.78 (9.5%) stddev-sans-first:13.29 19:42:27 INFO - PROCESS | 12682 | Values: 129.0 126.0 134.0 127.0 132.0 137.0 135.0 124.0 164.0 153.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:4.16 (2.5%) stddev-sans-first:4.40 19:42:27 INFO - PROCESS | 12682 | Values: 170.0 168.0 169.0 179.0 165.0 170.0 167.0 171.0 164.0 167.0 19:42:27 INFO - PROCESS | 12682 | 19:42:27 INFO - PROCESS | 12682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.17 (1.9%) stddev-sans-first:0.87 19:42:27 INFO - PROCESS | 12682 | Values: 65.0 62.0 63.0 63.0 62.0 62.0 64.0 61.0 62.0 62.0 19:42:27 INFO - PROCESS | 12682 | -------- Summary: end -------- 19:42:27 INFO - PROCESS | 12682 | 19:42:28 INFO - TEST-INFO | 12682: exit 0 19:42:28 INFO - TEST-OK | kraken | took 61639ms 19:42:28 INFO - SUITE-END | took 1177s 19:42:28 INFO - Completed test suite (00:19:37) 19:42:28 INFO - javascript benchmark 19:42:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7065.933114792469, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.2382366320253, 3129.6087989001376, 3169.2869104451493, 3187.9840600796992, 3212.132724164476, 5116.718580478072, 5204.973975130129, 5253.343332083489, 5335.439778823226, 5336.092864213078, 5233.084210263208, 5264.578833693305, 5283.471652834724, 5309.0, 5342.706151161685, 4618.399608050949, 4812.566868981791, 4963.131451995886, 4964.429090654567, 4968.875778105558, 4778.307145463906, 4801.519848015206, 4897.094037603037, 4958.776855041532, 4963.478834722357, 4844.878878028042, 4852.005338905534, 4899.6080313575185, 4941.604671626261, 4985.277134815431, 4893.266010098514, 4893.804247830119, 4894.5105489451125, 4900.17696468183, 4965.553100220997, 4852.199387101124, 4929.827456039057, 4934.629902757308, 4937.901241975141, 4978.427480839714, 5227.059129356714, 5280.3663560372615, 5287.841364759063, 5334.119870221448, 5340.465953404668, 5716.628419152742, 5717.942820571782, 5726.427357264281, 5730.997075511768, 5740.0, 5741.110127930177, 5768.221290125864, 5786.305643322786, 5803.448672376117, 5847.44449277318, 5347.197920311906, 5353.919691204596, 5383.569314454834, 5387.461253874581, 5400.91898621521, 5729.541636669056, 5885.352611212763, 5887.8233652990475, 5890.617109887844, 5897.67562784051, 5592.972035139798, 5596.0, 5664.943350566524, 5701.087825947829, 5713.0, 5694.800681976111, 5743.1385292206505, 5743.54051675865, 5751.942480575224, 5806.1000544915605, 5716.742746576414, 5721.971390143106, 5727.198192253088, 5728.455796699307, 5729.5702822288495, 5561.777528898799, 5594.692291923983, 5642.746076426571, 5647.548196144298, 5727.828165155052, 4424.75663838492, 4425.845095421645, 4446.799894004777, 4461.598456138963, 4463.598276155161, 3912.295786758354, 3919.0986073202753, 3922.666573341241, 3927.293087244266, 3950.288947989332, 5247.868803279948, 5303.655262407931, 5306.734663266821, 5404.972975135099, 5448.83653490396, 5638.520725738358, 5677.801276955287, 5688.488036076773, 5690.516306113944, 5716.828495145152, 5353.598480114007, 5360.276362690986, 5361.812336568201, 5369.919451208235, 5370.355557333145, 4841.419029716457, 4870.196417591058, 4873.926891096637, 4879.878003049952, 4908.239222920453, 5902.173695682608, 5923.348431672513, 5969.164316995624, 5983.790567330297, 6048.334683184934, 5702.6293290935955, 5751.194832723339, 5759.827205183851, 5761.769529218785, 5770.653760774367, 5799.594028417971, 5828.213191219301, 5834.416558344302, 5875.059990401515, 5997.730102145501, 5529.612927095065, 5590.720463976866, 5614.2701448811395, 5629.605927585029, 5634.661920284796, 5591.077472217039, 5638.126090455986, 5678.77284908599, 5695.8860822784145, 5728.742206600797, 5576.302962129734, 5588.105903055492, 5590.496855283044, 5593.328800543798, 5594.272744543184, 5410.053240682943, 5513.0, 5544.085225937836, 5571.66570005801, 5574.637648552831, 5565.5825813063375, 5611.298587676541, 5611.6352437091455, 5646.745896434588, 5659.490645841894, 5566.666000039849, 5613.719314034201, 5618.6628802272, 5620.156976453564, 5621.943780562142, 5300.628955973045, 5340.679559226459, 5434.2935418395355, 5505.779768809202, 5553.111502159635], "value": 5271.895377104439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6217034586826, 577.3620149734543, 587.7120211096562, 602.7823795932217, 610.3804638292137, 32889.50665740016, 43516.78241608792, 45032.324515132255, 45038.774806126006, 48442.27336589954, 44645.33032004523, 45673.31490027652, 45731.08243892442, 45789.31316030254, 45812.0, 7724.1889601591865, 9035.63857445703, 9228.723138305828, 9229.861552076723, 9231.0, 7720.459567830254, 10252.333598316123, 10637.78724425511, 10650.147988160928, 10970.506327215255, 10508.527116279785, 10531.473426328692, 10539.47302634869, 10554.419506927115, 10559.947200264027, 10892.727681807939, 10907.563697452131, 10982.0, 10999.285046471954, 11001.0, 10104.090631843095, 10200.38797672142, 10201.13290370312, 10203.336783109075, 10206.744831379201, 44404.777976110236, 44746.32880506795, 44798.0, 44833.0, 44868.775656121514, 3954.5847685992844, 3982.7411218270718, 4025.9798701006603, 4051.9594804051876, 4053.27041132596, 31742.513839334446, 31805.52291715626, 31911.202219944455, 32129.357412851612, 33361.33277334464, 3946.3291240489184, 4045.2111838191563, 4082.3672330788777, 4098.139390727951, 4146.834126634931, 297703.0, 297861.0, 298960.99999999785, 299163.0, 299207.0, 51716.75965364852, 53914.0, 61843.381566183765, 62456.375436245966, 62457.68771156115, 69619.0, 70342.29657703459, 70418.0, 71038.2896171042, 71119.64440177767, 16720.498385048468, 16960.491185264462, 16988.74516882248, 16993.150342482826, 17033.574160646083, 12771.489140434465, 12775.23348599087, 12923.15999460032, 12949.352532373532, 13020.674483137807, 18955.526111847314, 18993.335233267047, 19011.33460328882, 19063.0, 19128.330508432136, 6500.6424646643945, 6688.598684078971, 6688.799336019927, 6727.226368967631, 6889.0, 873.7553485024204, 897.8608315711075, 901.833160865242, 907.7503686486269, 908.3096846396654, 30292.0, 30323.545146822817, 30386.0, 31875.203119921724, 32403.18992025218, 1000.7190795781412, 1086.684861390188, 1088.314361951965, 1097.4457898761234, 1099.8625171853519, 15288.923555382375, 15864.365425383086, 16200.432984845474, 16345.918270408809, 16492.42276520316, 457330.0, 459891.0, 460441.0, 460540.0, 460720.0, 63330.0, 63545.682271588346, 63779.68110159419, 63838.68080659567, 64040.35959640437, 1385.7020740540831, 1401.068289587413, 1410.8165938428144, 1422.2604245792338, 1427.750143724844, 29005.564916525847, 29775.70224297816, 29921.401571968872, 31006.942372341513, 31043.223919402197, 53508.46491535035, 54101.45898540964, 54180.72909635427, 54230.45769542254, 54292.0, 276873.0, 276950.0, 277740.0, 277867.0, 278094.0, 33273.83363083266, 40037.39943900786, 41305.58694413018, 45010.32484512669, 45118.548814511436, 45839.77080114578, 45997.54002459932, 46252.30621540747, 47157.29264060973, 47255.29117063316, 38849.80575097106, 39600.40599391069, 39645.40531892081, 40053.79973100233, 42008.0, 39237.607623923395, 40955.1808963825, 41324.58675413208, 41510.79244603758, 41553.37669935014, 39422.80288598539, 40623.79688101659, 41518.79240603778, 41610.79194604007, 41688.79155604324, 33487.83256083704, 34363.828180859935, 34867.65132348644, 35034.270373499254, 35547.64452355443, 25115.0, 25482.617760733974, 25705.871470642527, 25826.61260081138, 26055.218343449727], "value": 20207.51143606317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.94360845873115, 388.2351767018973, 392.82519278920876, 395.40688966550175, 399.75015615240477, 18174.091720369353, 19927.003649817507, 19928.202871885143, 20047.09788059537, 20244.696329555067, 19514.21943122277, 20074.799252007477, 20531.38405847827, 20940.476488087807, 21147.57704845902, 5749.712514374285, 5804.622699524528, 5881.970590147043, 5920.792772252972, 6032.0, 5779.306483222019, 5870.295564532241, 5878.088896221093, 5878.529717622601, 5880.882382352351, 5548.167774833787, 5750.424957504258, 5802.332731735841, 5806.44838740319, 5841.094630332305, 5698.1452782083015, 5790.247267855173, 5827.912581311284, 5835.241418615574, 5842.649441033552, 5089.567386772129, 5123.692578445305, 5125.718085505296, 5129.666571672867, 5135.460776618476, 19854.3050993216, 19955.401337959884, 20071.598568028705, 20087.296944607016, 20099.79900200994, 2718.497078040569, 2721.7142200068906, 2730.426610411816, 2734.371094648222, 2736.6715994080637, 14144.36350364236, 14483.637909052253, 14604.707905841824, 14655.267236638232, 15411.22943852803, 1844.6310737852484, 1902.8477721782224, 1904.1812020831176, 1926.3450426854797, 1932.7487426634589, 85124.14875851224, 85338.0, 85710.57144714237, 86636.0, 87726.12273877244, 10924.0, 10976.176786741027, 10987.0, 10989.450527473595, 11060.723481913017, 14342.569722908329, 14353.425862965572, 14464.349104290332, 14614.926925365306, 15199.164045977357, 6130.29501607312, 6185.041318595625, 6795.218549866829, 7499.400047996256, 7710.113336966208, 6933.757318493828, 6963.895541566881, 7196.0, 7204.423646108299, 7209.0988626421695, 4323.329883868006, 4520.683552151384, 4539.409876716006, 4627.699199552018, 4661.930071048869, 1931.1846863947844, 1968.2323893681476, 2026.9391918242477, 2038.1847261095681, 2062.9277975270793, 793.9761807145795, 838.455004247232, 846.5851732650957, 850.4174640371366, 859.1537335724306, 19100.23599056022, 19805.0, 19962.401127965895, 20139.59720805605, 20171.899140504203, 831.4180073948139, 846.4371193156481, 850.8553545897213, 851.5571902610608, 864.489950928955, 10444.425556594308, 10711.143108551298, 10770.059772684133, 10951.890481095086, 10977.6157834477, 566211.0, 569963.0, 570383.0, 585708.1429185739, 587331.0, 64209.67895160494, 76503.61748191224, 98213.50893245488, 98597.50701246448, 102103.0, 974.8342781727123, 992.5235886774389, 1022.2282176956351, 1026.5380578739598, 1031.8452232165084, 17803.732944006108, 17886.5528361792, 18479.353222637143, 18598.721019184995, 18812.717809233145, 40296.597034029284, 41174.79412603038, 41536.0, 43664.781676091414, 44101.77949110234, 57920.131198032905, 57964.420355795904, 58509.0, 58746.41253587409, 59308.0, 7221.6750246238, 7403.407727381689, 7520.0, 8272.751817445485, 8344.58277086131, 9264.258859291376, 12432.875671243171, 12649.177803442746, 12911.289879056741, 13019.934900325437, 11356.716082098013, 11485.942570287096, 11491.597794077501, 11827.17209795306, 11834.704132396759, 11098.778024439627, 11177.273477223955, 11372.18184790532, 11376.37429941328, 11519.366434845828, 11671.299722016705, 11704.239224450383, 11759.76480470403, 11893.82159267629, 12352.505899763908, 7354.852902941804, 7449.366803821736, 7470.514416562906, 7588.696452141852, 7635.045619297588, 9830.311878168746, 11060.281081729661, 11086.334819910831, 11395.316281023164, 11590.478428470908], "value": 9120.93678354847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.7432744541495, 1398.4056775870265, 1413.9080959737619, 1419.5173640962078, 1423.5160045584503, 8610.483370997737, 8886.866696999534, 8940.150685684866, 8952.0, 8956.417832840869, 8642.65429382824, 8778.6927457539, 8837.11628837116, 8888.28893688505, 9057.90942090579, 2174.358564223558, 2211.2039665720326, 2211.6240239159383, 2219.212179676216, 2220.0564759976946, 1833.3766519383407, 2124.192806733447, 2171.3703026122407, 2177.314146043999, 2184.9781502184933, 1884.3593178319368, 2122.299641118427, 2186.529896072344, 2187.9781202187933, 2188.770179131192, 2107.0412962102205, 2119.9046042928107, 2126.8830214338127, 2131.6056529542084, 2132.9893350533225, 2043.6934459831143, 2066.2561477867957, 2066.2561477867957, 2069.7412823397076, 2072.430081727522, 8941.865872011926, 8957.104289571056, 8984.640614375417, 8992.370534062618, 9013.459192448474, 5033.521815427529, 5185.222216667492, 5193.454687257859, 5199.922001169985, 5201.687898726051, 2942.8822847086303, 3049.6950304969546, 3124.281415274477, 3127.061881435583, 3157.621085469735, 1183.3432444993025, 1205.15036898986, 1220.1885745978914, 1256.4094875408543, 1271.3833790611545, 12085.879141208563, 12144.453499592451, 12145.089118316073, 12151.817722734255, 12153.574624888086, 4021.617946295097, 4325.091730736518, 4343.847965321199, 4371.868843934687, 4387.978060109679, 9681.273904457054, 9683.0, 9688.806223875483, 9692.352300108998, 9693.273004524688, 5175.792968281226, 5195.168772996302, 5196.844094677166, 5197.58419326453, 5197.792088316425, 4591.471980722193, 4663.090697314059, 4717.127331443694, 4740.905181896343, 4804.327394164819, 3594.227241143167, 3634.6547078027547, 3728.366177749789, 3761.4357846322723, 3859.6333348331864, 1063.6224140430036, 1067.9946600266949, 1082.118073769875, 1082.2532452607675, 1085.5603480590373, 686.3102581905254, 725.6516871901412, 746.4364404874285, 749.134749364485, 751.5603372027316, 5014.774335154927, 5103.821366252163, 5627.268455100811, 5638.35158956717, 5731.484166425042, 948.7533241357158, 986.6990567876722, 1007.4761124215366, 1017.2574020964737, 1029.156092004564, 3599.8740044098854, 3641.0715267606593, 3788.5264341957254, 3793.3551296279697, 3862.1310205203604, 10250.846237306447, 10570.2600817942, 10574.788504229873, 10612.0, 10620.09729173029, 10112.443815590213, 10429.843552346721, 10505.52725127371, 10519.52662130206, 10543.683689489328, 7860.213978602208, 8047.275745182962, 8055.395845311508, 8055.516668999996, 8062.919370806217, 5444.373897001896, 5526.419725928719, 5668.943310567007, 5673.77304907799, 5680.9147862781265, 9529.237660987243, 9613.855792162984, 9670.85493717609, 9697.9030209697, 9731.367461115005, 9451.291153163404, 9759.12167904892, 9791.06268119547, 9940.403575785476, 9990.0, 7654.349380302737, 7801.141874393926, 7806.570638614704, 7824.0, 7825.530468171928, 8307.252347288773, 8352.123027082313, 8381.790455238668, 8405.453645513022, 8409.327253819558, 7364.521306115085, 7410.370118539984, 7430.7399241026305, 7623.199564045695, 7760.88358674609, 7373.29953654402, 7412.147603025721, 7436.96281518589, 7478.326950574475, 7480.962595187207, 6353.68231588428, 6423.582467139621, 6482.092507048923, 6489.1888513935755, 6502.284748677736, 4698.577128058354, 4717.221658426459, 4760.547747963938, 4779.569838714532, 4848.200046992207, 4715.528447155394, 4807.663463557657, 4814.0, 4823.348847905488, 4855.198892182751], "value": 4404.82607495791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.18260739410266, 391.9392494163404, 394.144705988006, 397.28092153202687, 406.6482492643862, 5304.734763261841, 5344.3586769587655, 5386.8922621547545, 5389.73051347433, 5400.729963501819, 5080.517350851673, 5192.117340052191, 5217.217417387394, 5232.973835130819, 5312.123499622558, 4146.688998325122, 4155.792210389483, 4162.562930892258, 4182.33082706767, 4183.623473887357, 4162.729422587522, 4188.078622703016, 4205.222033923734, 4207.558206388331, 4213.178430206111, 3896.883093507185, 4067.6542493888055, 4123.855665051724, 4156.91686166278, 4170.186813571355, 4097.44684467599, 4102.671786257092, 4106.301928672133, 4123.2165888481095, 4129.306984136505, 3613.4941108244866, 3620.728445366608, 3624.3476174288617, 3631.092226943264, 3634.3639863024127, 4918.688216538257, 5186.377634683824, 5194.766235519411, 5197.246399272084, 5225.686458812484, 4733.692309999873, 4756.809727610891, 4758.928616070762, 4771.976140119277, 4776.976115119437, 5580.665160090367, 5589.714365695872, 5599.220526144836, 5600.52395546375, 5611.775528978836, 3782.829772660237, 4059.2084543514025, 4062.7968601569805, 4068.593140685937, 4079.2453396121514, 5539.335279766414, 5627.521660658808, 5676.205331253628, 5732.770689172428, 5792.478676919055, 4049.817758200888, 4065.3128951485396, 4075.6128167824604, 4082.4488694026522, 4099.97950010248, 4140.275451795924, 4141.503019637663, 4148.630951785904, 4149.688773342012, 4154.210699966997, 4494.640428765691, 4582.564656357641, 4592.586667199968, 4700.694454860423, 4716.316134160527, 5524.06090964537, 5534.066944519411, 5551.361593416728, 5562.360328562187, 5574.0, 1398.6713122416224, 1399.6773049468154, 1403.6911879386519, 1405.9578212653637, 1408.8168538089983, 908.4322298563397, 943.773494361362, 951.571792693277, 953.8616900549381, 953.9046095390544, 5127.820601261731, 5151.356080489939, 5172.586193104543, 5197.58419326453, 5200.63595548308, 5488.862778430571, 5496.361746361768, 5527.640703354269, 5533.197686335539, 5562.582806289463, 5027.74861256943, 5086.618503612244, 5333.786648534093, 5385.7576409061685, 5402.324709411324, 2935.8091724038295, 2952.3357244619788, 2957.216337670519, 2964.614600102016, 2976.4195981783346, 5591.496765291144, 5722.484976352148, 5778.913316300259, 5805.738741756547, 5823.505002074871, 5630.859228519238, 5644.57665675076, 5662.432667419499, 5663.943360566424, 5688.488036076773, 5734.0756214330995, 5771.884562308815, 5781.901438726629, 5801.3328467225965, 5804.767809287666, 5317.867053323698, 5536.778528858962, 5541.2796336476, 5576.86057848557, 5577.60559860035, 5442.455754424526, 5516.393196748435, 5532.944670553243, 5551.333839939233, 5566.610337276352, 5755.942440575541, 5881.647101173943, 5924.0, 5935.792247271324, 5952.57726807079, 4321.13577284538, 4379.737215766937, 4393.450818647669, 4396.868093957187, 4402.691811573159, 5458.399576046552, 5669.773209071591, 5682.687452190169, 5734.655920644775, 5790.276215473066, 5545.698535107885, 5547.945890280834, 5574.9721251393485, 5577.749001295033, 5585.218069470358, 5390.919136212881, 5573.1918871762555, 5605.0, 5624.746886390204, 5635.380108188178, 5534.640248384003, 5561.359398977231, 5579.326202139423, 5580.911722214129, 5585.631520277558, 5569.0, 5594.244776955059, 5611.551075913999, 5619.662820230799, 5635.154726791015, 5197.740112994411, 5416.106342453451, 5426.457354264542, 5452.2094296327605, 5470.699111548903], "value": 4245.885360837229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.4284358295447, 690.8411065454949, 731.0569365518481, 755.9017327747393, 757.5227606607837, 14939.178345191023, 15366.769498457505, 15408.383664653415, 15418.074915505049, 15418.537443876688, 14107.929460352709, 14191.71616567668, 14339.64150896228, 14349.067310624801, 14375.712485750279, 767.5624893810531, 770.6262462705583, 779.6803310642638, 780.3873958942231, 780.6448066129898, 775.2325198053915, 775.9224077592224, 776.243162916155, 776.7436745873877, 776.8407476467339, 813.808754942588, 823.7075838077486, 823.7569916874536, 824.0688022534528, 824.431142511668, 818.337146911001, 820.4543978254484, 820.6020080261069, 820.885076089348, 821.6056292979404, 599.8620317327039, 600.1208229943154, 601.8134378342728, 602.256213576233, 602.3795490644643, 14154.575362739135, 14210.147391156564, 14284.642883927985, 14329.928350358181, 14606.707865842729, 11714.53141874324, 12069.27584344942, 12120.878791212062, 12129.636110916686, 12439.440225189888, 10826.512806923707, 10834.0, 10845.0781683557, 11052.005319521202, 11245.15661325404, 3535.8585656573705, 3537.6992955598803, 3636.1455058061333, 3645.8177091145335, 3722.013666378412, 69742.0, 71163.64418177928, 71347.0, 72221.27778722251, 72493.27506724918, 9336.719898403058, 9414.482203478874, 9650.179734722627, 9854.704358869245, 10192.592296308212, 19086.0, 19549.609007819763, 19583.412497625093, 19588.70616940747, 19716.309929152696, 7182.928170718331, 7205.135383753983, 7270.927290727131, 7382.74160404394, 7396.482246242711, 3970.8411663533134, 4135.58644135584, 4141.171765646883, 4141.64795992344, 4156.896077598084, 3365.024142998503, 3471.2710330830305, 3480.147363895862, 3512.631173726773, 3514.8594056237466, 584.868404608968, 588.6079422166631, 590.9911351329733, 603.7886739641178, 605.9515238780887, 732.8607564562716, 734.2767374136471, 754.8943147959291, 773.6247919758913, 778.8130848596296, 10099.495025248709, 10214.693559193236, 10351.120154786777, 10449.738756530995, 10518.368897866152, 762.371043888794, 769.6267310354474, 776.9611519424119, 791.2720297326473, 799.5682331540903, 4627.398438203012, 4728.267118596555, 4814.711117332971, 4844.346013288232, 4879.341288926021, 58688.119678204865, 59022.0, 60065.69967150136, 74354.25645743473, 74691.62654186695, 67197.66401168061, 67902.3209767906, 68269.31730682729, 68292.658536707, 68530.65734671394, 59630.70184649049, 59905.101423478685, 60064.0, 60467.69766151229, 60561.69719151376, 8979.416337938013, 9348.439093654402, 9361.344705870524, 9365.625374985197, 9400.294977876823, 43183.78408108065, 43250.35124473072, 43285.78357108194, 43876.780616096716, 45184.32223516716, 49535.752321238164, 51162.74418627883, 52247.08146888923, 52292.7385363086, 53477.0, 12014.819777703167, 12131.514739410324, 12242.081843861924, 12412.56556020535, 12644.810327844905, 12760.617181484571, 13039.47842086344, 13207.0, 13826.792598110835, 13921.299188007495, 12431.19197252212, 12731.61805145847, 13148.934255328662, 13353.265570393722, 13690.178589284276, 12132.878671213528, 12698.238105713317, 12819.871801281868, 13215.735685286048, 13311.201327920357, 12071.456784444897, 12369.567065152676, 12853.421596028014, 13145.73708525805, 13407.396667149807, 10219.437930913871, 10307.433091180057, 10536.894631053592, 10548.892366301734, 11003.504842282277, 8358.87461688063, 8584.227419532272, 9121.498317592595, 9253.180749893365, 9388.76528086776], "value": 6847.8469606178905, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 118.0, 155.0, 119.0, 121.0, 120.0, 119.0, 140.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 159.0, 162.0, 161.0, 163.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 102.0, 76.0, 77.0, 78.0, 75.0, 96.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 109.0, 82.0, 82.0, 82.0, 109.0, 84.0, 83.0, 110.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 58.0, 55.0, 55.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 68.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 82.0, 82.0, 89.0, 82.0, 82.0, 82.0, 87.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 134.0, 127.0, 132.0, 137.0, 135.0, 124.0, 164.0, 153.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 169.0, 179.0, 165.0, 170.0, 167.0, 171.0, 164.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 62.0, 62.0, 64.0, 61.0, 62.0, 62.0], "value": 62.6, "unit": "score"}]}]} 19:42:28 INFO - Return code: 0 19:42:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:42:28 ERROR - # TBPL SUCCESS # 19:42:28 INFO - Running post-action listener: _resource_record_post_action 19:42:28 INFO - [mozharness: 2017-02-06 03:42:28.617182Z] Finished run-tests step (success) 19:42:28 INFO - Running post-run listener: _resource_record_post_run 19:42:28 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400347136; Read time: 16; Write time: 329148 19:42:28 INFO - TinderboxPrint: CPU usage
13.0% 19:42:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:42:28 INFO - TinderboxPrint: I/O write bytes / time
400,347,136 / 329,148 19:42:28 INFO - TinderboxPrint: CPU idle
8,298.8 (86.9%) 19:42:28 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 19:42:28 INFO - TinderboxPrint: Swap in / out
0 / 0 19:42:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105689088; Read time: 0; Write time: 129176 19:42:28 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294658048; Read time: 16; Write time: 199972 19:42:29 INFO - Running post-run listener: _upload_blobber_files 19:42:29 INFO - Blob upload gear active. 19:42:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:42:29 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 19:42:29 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'] 19:42:29 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 19:42:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:30 INFO - (blobuploader) - INFO - Done attempting. 19:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:31 INFO - (blobuploader) - INFO - Done attempting. 19:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:42:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:32 INFO - (blobuploader) - INFO - Done attempting. 19:42:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:42:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:35 INFO - (blobuploader) - INFO - Done attempting. 19:42:35 INFO - (blobuploader) - INFO - Iteration through files over. 19:42:35 INFO - Return code: 0 19:42:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:42:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:42:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5e269fa4be037ee41fdf64018729c31b6845a55acbc470ff9d8b1a21152d89499ee4f39fbf64c864f24bab708fcc581942c051d6630ffe8e1fb0ca3785a7b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c16f642dfc946fe363d0a8ee871b68492898d8795246c02faf06b2f924f72542261d3add51da75a5832d51fb7318001e60f2b6ceabe7d05964d5dccea3c1bab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6ac8517c2c5a97169be840a8a3885864048c777dcea02f140787213c152dc48e43d17a240471b6bf4b3b3ba701333f97776a4c6de249a47ae5e0156c19ec85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/834acae375e44e3a79520a6e65e94bfbb958c06096ff6fa98a67dec2412cbdcb428ef126e8211a551510bcdc1ace372ec11af941621a090143e21dfe6fe5c11b"} 19:42:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:42:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:42:35 INFO - Contents: 19:42:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5e269fa4be037ee41fdf64018729c31b6845a55acbc470ff9d8b1a21152d89499ee4f39fbf64c864f24bab708fcc581942c051d6630ffe8e1fb0ca3785a7b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c16f642dfc946fe363d0a8ee871b68492898d8795246c02faf06b2f924f72542261d3add51da75a5832d51fb7318001e60f2b6ceabe7d05964d5dccea3c1bab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6ac8517c2c5a97169be840a8a3885864048c777dcea02f140787213c152dc48e43d17a240471b6bf4b3b3ba701333f97776a4c6de249a47ae5e0156c19ec85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/834acae375e44e3a79520a6e65e94bfbb958c06096ff6fa98a67dec2412cbdcb428ef126e8211a551510bcdc1ace372ec11af941621a090143e21dfe6fe5c11b"} 19:42:35 INFO - Running post-run listener: copy_logs_to_upload_dir 19:42:35 INFO - Copying logs to upload dir... 19:42:35 INFO - mkdir: /builds/slave/test/build/upload/logs 19:42:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.426340 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-05 19:42:35.061922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 19:42:35.069017) ========= 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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 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/0a5e269fa4be037ee41fdf64018729c31b6845a55acbc470ff9d8b1a21152d89499ee4f39fbf64c864f24bab708fcc581942c051d6630ffe8e1fb0ca3785a7b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c16f642dfc946fe363d0a8ee871b68492898d8795246c02faf06b2f924f72542261d3add51da75a5832d51fb7318001e60f2b6ceabe7d05964d5dccea3c1bab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6ac8517c2c5a97169be840a8a3885864048c777dcea02f140787213c152dc48e43d17a240471b6bf4b3b3ba701333f97776a4c6de249a47ae5e0156c19ec85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/834acae375e44e3a79520a6e65e94bfbb958c06096ff6fa98a67dec2412cbdcb428ef126e8211a551510bcdc1ace372ec11af941621a090143e21dfe6fe5c11b"} build_url:https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/C4a8SwiHSwGtRiwN1gQkyg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5e269fa4be037ee41fdf64018729c31b6845a55acbc470ff9d8b1a21152d89499ee4f39fbf64c864f24bab708fcc581942c051d6630ffe8e1fb0ca3785a7b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c16f642dfc946fe363d0a8ee871b68492898d8795246c02faf06b2f924f72542261d3add51da75a5832d51fb7318001e60f2b6ceabe7d05964d5dccea3c1bab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6ac8517c2c5a97169be840a8a3885864048c777dcea02f140787213c152dc48e43d17a240471b6bf4b3b3ba701333f97776a4c6de249a47ae5e0156c19ec85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/834acae375e44e3a79520a6e65e94bfbb958c06096ff6fa98a67dec2412cbdcb428ef126e8211a551510bcdc1ace372ec11af941621a090143e21dfe6fe5c11b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 19:42:35.097085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:42:35.097425) ========= 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=7de08804244eb36560b44971000001c3-1486350314.835098-771563047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:42:35.179432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 19:42:35.179760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 19:42:35.180046) ========= ========= Total master_lag: 0.18 =========