builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1490293538.22 results: success (0) revision: 200182ef115692c4ed2909f1a8beae8a6f19d127 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.217791) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.218639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.219116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.234791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.235173) ========= 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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 11:25:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-03-23 11:25:38 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.370104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.370428) ========= 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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.420524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:38.420867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 200182ef115692c4ed2909f1a8beae8a6f19d127 --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 200182ef115692c4ed2909f1a8beae8a6f19d127 --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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 11:25:38,469 truncating revision to first 12 chars 2017-03-23 11:25:38,469 Setting DEBUG logging. 2017-03-23 11:25:38,469 attempt 1/10 2017-03-23 11:25:38,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/200182ef1156?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 11:25:38,840 unpacking tar archive at: mozilla-central-200182ef1156/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:39.117558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:39.117905) ========= script_repo_revision: 200182ef115692c4ed2909f1a8beae8a6f19d127 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:39.118281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:39.118578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 11:25:39.127835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 11:25:39.128206) ========= /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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:39 INFO - MultiFileLogger online at 20170323 11:25:39 in /builds/slave/test 11:25:39 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 11:25:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:39 INFO - {'append_to_log': False, 11:25:39 INFO - 'base_work_dir': '/builds/slave/test', 11:25:39 INFO - 'blob_upload_branch': 'Firefox', 11:25:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:39 INFO - 'branch': 'Firefox', 11:25:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:39 INFO - 'config_files': ('talos/linux_config.py',), 11:25:39 INFO - 'default_actions': ('clobber', 11:25:39 INFO - 'read-buildbot-config', 11:25:39 INFO - 'download-and-extract', 11:25:39 INFO - 'populate-webroot', 11:25:39 INFO - 'create-virtualenv', 11:25:39 INFO - 'install', 11:25:39 INFO - 'run-tests'), 11:25:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:39 INFO - 'download_minidump_stackwalk': True, 11:25:39 INFO - 'download_symbols': 'ondemand', 11:25:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:39 INFO - 'gecko_profile': False, 11:25:39 INFO - 'gecko_profile_interval': 0, 11:25:39 INFO - 'installer_path': 'installer.exe', 11:25:39 INFO - 'log_level': 'info', 11:25:39 INFO - 'log_name': 'talos', 11:25:39 INFO - 'log_to_console': True, 11:25:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:39 INFO - 'opt_config_files': (), 11:25:39 INFO - 'pip_index': False, 11:25:39 INFO - 'suite': 'dromaeojs', 11:25:39 INFO - 'system_bits': '32', 11:25:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:39 INFO - 'title': 'talos-linux64-ix-032', 11:25:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:39 INFO - 'use_talos_json': True, 11:25:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:39 INFO - 'work_dir': 'build'} 11:25:39 INFO - [mozharness: 2017-03-23 18:25:39.278129Z] Running clobber step. 11:25:39 INFO - Running pre-action listener: _resource_record_pre_action 11:25:39 INFO - Running main action method: clobber 11:25:39 INFO - rmtree: /builds/slave/test/build 11:25:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:40 INFO - Running post-action listener: _resource_record_post_action 11:25:40 INFO - [mozharness: 2017-03-23 18:25:40.869720Z] Finished clobber step (success) 11:25:40 INFO - [mozharness: 2017-03-23 18:25:40.869818Z] Running read-buildbot-config step. 11:25:40 INFO - Running pre-action listener: _resource_record_pre_action 11:25:40 INFO - Running main action method: read_buildbot_config 11:25:40 INFO - Using buildbot properties: 11:25:40 INFO - { 11:25:40 INFO - "project": "", 11:25:40 INFO - "product": "firefox", 11:25:40 INFO - "who": "kwierso@gmail.com", 11:25:40 INFO - "installer_path": "public/build/target.tar.bz2", 11:25:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:25:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:25:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:25:40 INFO - "stage_platform": "linux64-pgo", 11:25:40 INFO - "basedir": "/builds/slave/test", 11:25:40 INFO - "buildnumber": 92, 11:25:40 INFO - "platform": "ubuntu64_hw", 11:25:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:25:40 INFO - "slavebuilddir": "test", 11:25:40 INFO - "taskId": "c4ZDttT3TRWjYtQP_sej2A", 11:25:40 INFO - "branch": "mozilla-central", 11:25:40 INFO - "script_repo_revision": "production", 11:25:40 INFO - "revision": "200182ef115692c4ed2909f1a8beae8a6f19d127", 11:25:40 INFO - "slavename": "talos-linux64-ix-032", 11:25:40 INFO - "repo_path": "mozilla-central" 11:25:40 INFO - } 11:25:40 INFO - Finding installer, test and symbols from parent task. 11:25:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c4ZDttT3TRWjYtQP_sej2A'}, attempt #1 11:25:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c4ZDttT3TRWjYtQP_sej2A'}, attempt #1 11:25:41 INFO - Task dependencies: X9l3OtrWT7u7gafyCBgssg 11:25:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg'}, attempt #1 11:25:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 11:25:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/test_packages.json 11:25:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.crashreporter-symbols.zip 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - [mozharness: 2017-03-23 18:25:42.313018Z] Finished read-buildbot-config step (success) 11:25:42 INFO - [mozharness: 2017-03-23 18:25:42.313233Z] Running download-and-extract step. 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: download_and_extract 11:25:42 INFO - mkdir: /builds/slave/test/build/tests 11:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:42 INFO - trying https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.test_packages.json 11:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:25:42 INFO - Downloaded 986 bytes. 11:25:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:25:42 INFO - Using the following test package requirements: 11:25:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:25:42 INFO - u'common': [u'target.common.tests.zip'], 11:25:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:25:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:25:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:25:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:25:42 INFO - u'mozbase': [u'target.common.tests.zip'], 11:25:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:25:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:25:42 INFO - u'web-platform': [u'target.common.tests.zip', 11:25:42 INFO - u'target.web-platform.tests.zip'], 11:25:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:25:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:25:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip 11:25:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:42 INFO - Fetch https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip into memory 11:25:44 INFO - Expected file size: 60248755 11:25:44 INFO - Obtained file size: 60248755 11:25:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:25:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip 11:25:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:54 INFO - Fetch https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.common.tests.zip into memory 11:25:55 INFO - Expected file size: 60248755 11:25:55 INFO - Obtained file size: 60248755 11:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.talos.tests.zip 11:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.talos.tests.zip into memory 11:26:06 INFO - Expected file size: 14404171 11:26:06 INFO - Obtained file size: 14404171 11:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:06 INFO - trying https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 11:26:06 INFO - Downloading https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:26:08 INFO - Downloaded 67921889 bytes. 11:26:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 11:26:08 INFO - mkdir: /builds/slave/test/properties 11:26:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:08 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:08 INFO - Contents: 11:26:08 INFO - build_url:https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 11:26:08 INFO - Running post-action listener: _resource_record_post_action 11:26:08 INFO - Running post-action listener: set_extra_try_arguments 11:26:08 INFO - [mozharness: 2017-03-23 18:26:08.159611Z] Finished download-and-extract step (success) 11:26:08 INFO - [mozharness: 2017-03-23 18:26:08.159708Z] Running populate-webroot step. 11:26:08 INFO - Running pre-action listener: _resource_record_pre_action 11:26:08 INFO - Running main action method: populate_webroot 11:26:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:08 INFO - '--tppagecycles', 11:26:08 INFO - '7'], 11:26:08 INFO - 'tests': ['tsvgm']}}, 11:26:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['damp', 'tps']}, 11:26:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'tests': ['damp', 'tps']}, 11:26:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['dromaeo_dom']}, 11:26:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['basic_compositor_video']}, 11:26:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:26:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['a11yr', 11:26:08 INFO - 'ts_paint', 11:26:08 INFO - 'tpaint', 11:26:08 INFO - 'sessionrestore', 11:26:08 INFO - 'sessionrestore_no_auto_restore', 11:26:08 INFO - 'tabpaint']}, 11:26:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['tsvgx', 11:26:08 INFO - 'tsvgr_opacity', 11:26:08 INFO - 'tart', 11:26:08 INFO - 'tscrollx', 11:26:08 INFO - 'cart', 11:26:08 INFO - 'tsvg_static']}, 11:26:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:08 INFO - 'tsvgr_opacity', 11:26:08 INFO - 'tart', 11:26:08 INFO - 'tscrollx', 11:26:08 INFO - 'cart', 11:26:08 INFO - 'tsvg_static']}, 11:26:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'talos_options': ['--disable-e10s'], 11:26:08 INFO - 'tests': ['tp5o']}, 11:26:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'talos_options': ['--disable-e10s', 11:26:08 INFO - '--xperf_path', 11:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:08 INFO - 'tests': ['tp5n']}, 11:26:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:08 INFO - 'talos_options': ['--xperf_path', 11:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:08 INFO - 'tests': ['tp5n']}}, 11:26:08 INFO - 'talos.zip': {'path': '', 11:26:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:08 INFO - Running post-action listener: _resource_record_post_action 11:26:08 INFO - [mozharness: 2017-03-23 18:26:08.172797Z] Finished populate-webroot step (success) 11:26:08 INFO - [mozharness: 2017-03-23 18:26:08.172887Z] Running create-virtualenv step. 11:26:08 INFO - Running pre-action listener: _resource_record_pre_action 11:26:08 INFO - Running main action method: create_virtualenv 11:26:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:26:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:08 INFO - Using real prefix '/usr' 11:26:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:10 INFO - Installing pip.................done. 11:26:10 INFO - Return code: 0 11:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:26:11 INFO - Reading from file tmpfile_stdout 11:26:11 INFO - Output received: 11:26:11 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) 11:26:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:26:11 INFO - Using env: {'DISPLAY': ':0', 11:26:11 INFO - 'HOME': '/home/cltbld', 11:26:11 INFO - 'LANG': 'en_US.UTF-8', 11:26:11 INFO - 'LANGUAGE': 'en_US:en', 11:26:11 INFO - 'LOGNAME': 'cltbld', 11:26:11 INFO - 'MAIL': '/var/mail/cltbld', 11:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:11 INFO - 'MOZ_NO_REMOTE': '1', 11:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:11 INFO - 'NO_EM_RESTART': '1', 11:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:11 INFO - 'PWD': '/builds/slave/test', 11:26:11 INFO - 'SHELL': '/bin/bash', 11:26:11 INFO - 'SHLVL': '1', 11:26:11 INFO - 'TERM': 'linux', 11:26:11 INFO - 'TMOUT': '86400', 11:26:11 INFO - 'USER': 'cltbld', 11:26:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:11 INFO - '_': '/tools/buildbot/bin/python'} 11:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:26:11 INFO - Cleaning up... 11:26:11 INFO - Return code: 0 11:26:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:26:11 INFO - Using env: {'DISPLAY': ':0', 11:26:11 INFO - 'HOME': '/home/cltbld', 11:26:11 INFO - 'LANG': 'en_US.UTF-8', 11:26:11 INFO - 'LANGUAGE': 'en_US:en', 11:26:11 INFO - 'LOGNAME': 'cltbld', 11:26:11 INFO - 'MAIL': '/var/mail/cltbld', 11:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:11 INFO - 'MOZ_NO_REMOTE': '1', 11:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:11 INFO - 'NO_EM_RESTART': '1', 11:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:11 INFO - 'PWD': '/builds/slave/test', 11:26:11 INFO - 'SHELL': '/bin/bash', 11:26:11 INFO - 'SHLVL': '1', 11:26:11 INFO - 'TERM': 'linux', 11:26:11 INFO - 'TMOUT': '86400', 11:26:11 INFO - 'USER': 'cltbld', 11:26:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:11 INFO - '_': '/tools/buildbot/bin/python'} 11:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:11 INFO - Downloading/unpacking psutil>=3.1.1 11:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:13 INFO - Installing collected packages: psutil 11:26:13 INFO - Running setup.py install for psutil 11:26:13 INFO - building 'psutil._psutil_linux' extension 11:26:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:26:13 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 11:26:13 INFO - building 'psutil._psutil_posix' extension 11:26:13 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 11:26:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:14 INFO - Successfully installed psutil 11:26:14 INFO - Cleaning up... 11:26:14 INFO - Return code: 0 11:26:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:26:14 INFO - Using env: {'DISPLAY': ':0', 11:26:14 INFO - 'HOME': '/home/cltbld', 11:26:14 INFO - 'LANG': 'en_US.UTF-8', 11:26:14 INFO - 'LANGUAGE': 'en_US:en', 11:26:14 INFO - 'LOGNAME': 'cltbld', 11:26:14 INFO - 'MAIL': '/var/mail/cltbld', 11:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:14 INFO - 'MOZ_NO_REMOTE': '1', 11:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:14 INFO - 'NO_EM_RESTART': '1', 11:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:14 INFO - 'PWD': '/builds/slave/test', 11:26:14 INFO - 'SHELL': '/bin/bash', 11:26:14 INFO - 'SHLVL': '1', 11:26:14 INFO - 'TERM': 'linux', 11:26:14 INFO - 'TMOUT': '86400', 11:26:14 INFO - 'USER': 'cltbld', 11:26:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:14 INFO - '_': '/tools/buildbot/bin/python'} 11:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:16 INFO - Installing collected packages: mozsystemmonitor 11:26:16 INFO - Running setup.py install for mozsystemmonitor 11:26:17 INFO - Successfully installed mozsystemmonitor 11:26:17 INFO - Cleaning up... 11:26:17 INFO - Return code: 0 11:26:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:17 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:17 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 11:26:17 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 11:26:17 INFO - Using env: {'DISPLAY': ':0', 11:26:17 INFO - 'HOME': '/home/cltbld', 11:26:17 INFO - 'LANG': 'en_US.UTF-8', 11:26:17 INFO - 'LANGUAGE': 'en_US:en', 11:26:17 INFO - 'LOGNAME': 'cltbld', 11:26:17 INFO - 'MAIL': '/var/mail/cltbld', 11:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:17 INFO - 'MOZ_NO_REMOTE': '1', 11:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:17 INFO - 'NO_EM_RESTART': '1', 11:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:17 INFO - 'PWD': '/builds/slave/test', 11:26:17 INFO - 'SHELL': '/bin/bash', 11:26:17 INFO - 'SHLVL': '1', 11:26:17 INFO - 'TERM': 'linux', 11:26:17 INFO - 'TMOUT': '86400', 11:26:17 INFO - 'USER': 'cltbld', 11:26:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:17 INFO - '_': '/tools/buildbot/bin/python'} 11:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:17 INFO - Downloading/unpacking jsonschema==2.5.1 11:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:19 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:20 INFO - warning: no files found matching '*.txt' 11:26:20 INFO - no previously-included directories found matching 'build' 11:26:20 INFO - no previously-included directories found matching 'dist' 11:26:20 INFO - no previously-included directories found matching '.git*' 11:26:20 INFO - Installing collected packages: jsonschema, functools32 11:26:20 INFO - Running setup.py install for functools32 11:26:20 INFO - warning: no files found matching '*.txt' 11:26:20 INFO - no previously-included directories found matching 'build' 11:26:20 INFO - no previously-included directories found matching 'dist' 11:26:20 INFO - no previously-included directories found matching '.git*' 11:26:20 INFO - Successfully installed jsonschema functools32 11:26:20 INFO - Cleaning up... 11:26:20 INFO - Return code: 0 11:26:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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', '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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:26: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 functools32==3.2.3-2 11:26:21 INFO - Using env: {'DISPLAY': ':0', 11:26:21 INFO - 'HOME': '/home/cltbld', 11:26:21 INFO - 'LANG': 'en_US.UTF-8', 11:26:21 INFO - 'LANGUAGE': 'en_US:en', 11:26:21 INFO - 'LOGNAME': 'cltbld', 11:26:21 INFO - 'MAIL': '/var/mail/cltbld', 11:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:21 INFO - 'MOZ_NO_REMOTE': '1', 11:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:21 INFO - 'NO_EM_RESTART': '1', 11:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:21 INFO - 'PWD': '/builds/slave/test', 11:26:21 INFO - 'SHELL': '/bin/bash', 11:26:21 INFO - 'SHLVL': '1', 11:26:21 INFO - 'TERM': 'linux', 11:26:21 INFO - 'TMOUT': '86400', 11:26:21 INFO - 'USER': 'cltbld', 11:26:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:21 INFO - '_': '/tools/buildbot/bin/python'} 11:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:26:21 INFO - Cleaning up... 11:26:21 INFO - Return code: 0 11:26:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:22 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:22 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 11:26:22 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 11:26:22 INFO - Using env: {'DISPLAY': ':0', 11:26:22 INFO - 'HOME': '/home/cltbld', 11:26:22 INFO - 'LANG': 'en_US.UTF-8', 11:26:22 INFO - 'LANGUAGE': 'en_US:en', 11:26:22 INFO - 'LOGNAME': 'cltbld', 11:26:22 INFO - 'MAIL': '/var/mail/cltbld', 11:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:22 INFO - 'MOZ_NO_REMOTE': '1', 11:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:22 INFO - 'NO_EM_RESTART': '1', 11:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:22 INFO - 'PWD': '/builds/slave/test', 11:26:22 INFO - 'SHELL': '/bin/bash', 11:26:22 INFO - 'SHLVL': '1', 11:26:22 INFO - 'TERM': 'linux', 11:26:22 INFO - 'TMOUT': '86400', 11:26:22 INFO - 'USER': 'cltbld', 11:26:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:22 INFO - '_': '/tools/buildbot/bin/python'} 11:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:24 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 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 11:26:25 INFO - Downloading docopt-0.6.1.tar.gz 11:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:25 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:25 INFO - Running setup.py install for blobuploader 11:26:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:25 INFO - Running setup.py install for requests 11:26:26 INFO - Running setup.py install for docopt 11:26:26 INFO - Successfully installed blobuploader requests docopt 11:26:26 INFO - Cleaning up... 11:26:26 INFO - Return code: 0 11:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:27 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:27 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 11:26:27 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 11:26:27 INFO - Using env: {'DISPLAY': ':0', 11:26:27 INFO - 'HOME': '/home/cltbld', 11:26:27 INFO - 'LANG': 'en_US.UTF-8', 11:26:27 INFO - 'LANGUAGE': 'en_US:en', 11:26:27 INFO - 'LOGNAME': 'cltbld', 11:26:27 INFO - 'MAIL': '/var/mail/cltbld', 11:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:27 INFO - 'MOZ_NO_REMOTE': '1', 11:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:27 INFO - 'NO_EM_RESTART': '1', 11:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:27 INFO - 'PWD': '/builds/slave/test', 11:26:27 INFO - 'SHELL': '/bin/bash', 11:26:27 INFO - 'SHLVL': '1', 11:26:27 INFO - 'TERM': 'linux', 11:26:27 INFO - 'TMOUT': '86400', 11:26:27 INFO - 'USER': 'cltbld', 11:26:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:27 INFO - '_': '/tools/buildbot/bin/python'} 11:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:27 INFO - Running setup.py (path:/tmp/pip-bTI7KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:27 INFO - Running setup.py (path:/tmp/pip-ait8Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:27 INFO - Running setup.py (path:/tmp/pip-NcXsXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:27 INFO - Running setup.py (path:/tmp/pip-Zx7XC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:27 INFO - Running setup.py (path:/tmp/pip-IXzxWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:27 INFO - Running setup.py (path:/tmp/pip-6nnBTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:27 INFO - Running setup.py (path:/tmp/pip-KwqETD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:27 INFO - Running setup.py (path:/tmp/pip-yHzYSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:27 INFO - Running setup.py (path:/tmp/pip-mTnWPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:28 INFO - Running setup.py (path:/tmp/pip-Vw_te0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:28 INFO - Running setup.py (path:/tmp/pip-jZdEdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:28 INFO - Running setup.py (path:/tmp/pip-lqisAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:28 INFO - Running setup.py (path:/tmp/pip-h9M6Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:28 INFO - Running setup.py (path:/tmp/pip-E4bg88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:28 INFO - Running setup.py (path:/tmp/pip-cweJWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:28 INFO - Running setup.py (path:/tmp/pip-rFNNs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:28 INFO - Running setup.py (path:/tmp/pip-VDJq6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:28 INFO - Running setup.py install for manifestparser 11:26:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:28 INFO - Running setup.py install for mozcrash 11:26:28 INFO - Running setup.py install for mozdebug 11:26:28 INFO - Running setup.py install for mozdevice 11:26:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozfile 11:26:29 INFO - Running setup.py install for mozhttpd 11:26:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozinfo 11:26:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozInstall 11:26:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozleak 11:26:29 INFO - Running setup.py install for mozlog 11:26:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for moznetwork 11:26:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozprocess 11:26:29 INFO - Running setup.py install for mozprofile 11:26:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:29 INFO - Running setup.py install for mozrunner 11:26:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:30 INFO - Running setup.py install for mozscreenshot 11:26:30 INFO - Running setup.py install for moztest 11:26:30 INFO - Running setup.py install for mozversion 11:26:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:30 INFO - Cleaning up... 11:26:30 INFO - Return code: 0 11:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:30 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:30 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 11:26:30 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 11:26:30 INFO - Using env: {'DISPLAY': ':0', 11:26:30 INFO - 'HOME': '/home/cltbld', 11:26:30 INFO - 'LANG': 'en_US.UTF-8', 11:26:30 INFO - 'LANGUAGE': 'en_US:en', 11:26:30 INFO - 'LOGNAME': 'cltbld', 11:26:30 INFO - 'MAIL': '/var/mail/cltbld', 11:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:30 INFO - 'MOZ_NO_REMOTE': '1', 11:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:30 INFO - 'NO_EM_RESTART': '1', 11:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:30 INFO - 'PWD': '/builds/slave/test', 11:26:30 INFO - 'SHELL': '/bin/bash', 11:26:30 INFO - 'SHLVL': '1', 11:26:30 INFO - 'TERM': 'linux', 11:26:30 INFO - 'TMOUT': '86400', 11:26:30 INFO - 'USER': 'cltbld', 11:26:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:30 INFO - '_': '/tools/buildbot/bin/python'} 11:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:31 INFO - Running setup.py (path:/tmp/pip-hkUnBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:31 INFO - Running setup.py (path:/tmp/pip-UKzv3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:31 INFO - Running setup.py (path:/tmp/pip-hZkXbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:31 INFO - Running setup.py (path:/tmp/pip-8r05t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:31 INFO - Running setup.py (path:/tmp/pip-3kukGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:31 INFO - Running setup.py (path:/tmp/pip-Ian4gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:31 INFO - Running setup.py (path:/tmp/pip-GhZEtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:31 INFO - Running setup.py (path:/tmp/pip-MC_jLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:31 INFO - Running setup.py (path:/tmp/pip-S4qEd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:31 INFO - Running setup.py (path:/tmp/pip-DT5T6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:31 INFO - Running setup.py (path:/tmp/pip-EmIdtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:31 INFO - Running setup.py (path:/tmp/pip-nsw4qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:31 INFO - Running setup.py (path:/tmp/pip-oZLdnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:31 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)) 11:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:31 INFO - Running setup.py (path:/tmp/pip-2XxZ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:32 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)) 11:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:32 INFO - Running setup.py (path:/tmp/pip-fPaY41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:32 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)) 11:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:32 INFO - Running setup.py (path:/tmp/pip-FbgG_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:32 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)) 11:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:32 INFO - Running setup.py (path:/tmp/pip-Lnia1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:32 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)) 11:26:32 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)) 11:26:32 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)) 11:26:32 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)) 11:26:32 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)) 11:26:32 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)) 11:26:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:34 INFO - Downloading blessings-1.6.tar.gz 11:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:35 INFO - Installing collected packages: blessings 11:26:35 INFO - Running setup.py install for blessings 11:26:35 INFO - Successfully installed blessings 11:26:35 INFO - Cleaning up... 11:26:35 INFO - Return code: 0 11:26:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:35 INFO - Reading from file tmpfile_stdout 11:26:35 INFO - Current package versions: 11:26:35 INFO - argparse == 1.2.1 11:26:35 INFO - blessings == 1.6 11:26:35 INFO - blobuploader == 1.2.4 11:26:35 INFO - docopt == 0.6.1 11:26:35 INFO - functools32 == 3.2.3-2 11:26:35 INFO - jsonschema == 2.5.1 11:26:35 INFO - manifestparser == 1.1 11:26:35 INFO - mozInstall == 1.12 11:26:35 INFO - mozcrash == 1.0 11:26:35 INFO - mozdebug == 0.1 11:26:35 INFO - mozdevice == 0.49 11:26:35 INFO - mozfile == 1.2 11:26:35 INFO - mozhttpd == 0.7 11:26:35 INFO - mozinfo == 0.9 11:26:35 INFO - mozleak == 0.1 11:26:35 INFO - mozlog == 3.4 11:26:35 INFO - moznetwork == 0.27 11:26:35 INFO - mozprocess == 0.25 11:26:35 INFO - mozprofile == 0.28 11:26:35 INFO - mozrunner == 6.13 11:26:35 INFO - mozscreenshot == 0.1 11:26:35 INFO - mozsystemmonitor == 0.3 11:26:35 INFO - moztest == 0.8 11:26:35 INFO - mozversion == 1.4 11:26:35 INFO - psutil == 3.1.1 11:26:35 INFO - requests == 1.2.3 11:26:35 INFO - wsgiref == 0.1.2 11:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:35 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 11:26:35 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 11:26:35 INFO - Using env: {'DISPLAY': ':0', 11:26:35 INFO - 'HOME': '/home/cltbld', 11:26:35 INFO - 'LANG': 'en_US.UTF-8', 11:26:35 INFO - 'LANGUAGE': 'en_US:en', 11:26:35 INFO - 'LOGNAME': 'cltbld', 11:26:35 INFO - 'MAIL': '/var/mail/cltbld', 11:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:35 INFO - 'MOZ_NO_REMOTE': '1', 11:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:35 INFO - 'NO_EM_RESTART': '1', 11:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:35 INFO - 'PWD': '/builds/slave/test', 11:26:35 INFO - 'SHELL': '/bin/bash', 11:26:35 INFO - 'SHLVL': '1', 11:26:35 INFO - 'TERM': 'linux', 11:26:35 INFO - 'TMOUT': '86400', 11:26:35 INFO - 'USER': 'cltbld', 11:26:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:35 INFO - '_': '/tools/buildbot/bin/python'} 11:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 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)) 11:26:36 INFO - Cleaning up... 11:26:36 INFO - Return code: 0 11:26:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:36 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')]} 11:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:36 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')]} 11:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:36 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d80310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, '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': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', '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 11:26:36 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 11:26:36 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 11:26:36 INFO - Using env: {'DISPLAY': ':0', 11:26:36 INFO - 'HOME': '/home/cltbld', 11:26:36 INFO - 'LANG': 'en_US.UTF-8', 11:26:36 INFO - 'LANGUAGE': 'en_US:en', 11:26:36 INFO - 'LOGNAME': 'cltbld', 11:26:36 INFO - 'MAIL': '/var/mail/cltbld', 11:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:36 INFO - 'MOZ_NO_REMOTE': '1', 11:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:36 INFO - 'NO_EM_RESTART': '1', 11:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:36 INFO - 'PWD': '/builds/slave/test', 11:26:36 INFO - 'SHELL': '/bin/bash', 11:26:36 INFO - 'SHLVL': '1', 11:26:36 INFO - 'TERM': 'linux', 11:26:36 INFO - 'TMOUT': '86400', 11:26:36 INFO - 'USER': 'cltbld', 11:26:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:36 INFO - '_': '/tools/buildbot/bin/python'} 11:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:26:37 INFO - Cleaning up... 11:26:37 INFO - Return code: 0 11:26:37 INFO - Running post-action listener: _resource_record_post_action 11:26:37 INFO - Running post-action listener: _start_resource_monitoring 11:26:37 INFO - Starting resource monitoring. 11:26:37 INFO - [mozharness: 2017-03-23 18:26:37.154090Z] Finished create-virtualenv step (success) 11:26:37 INFO - [mozharness: 2017-03-23 18:26:37.154549Z] Running install step. 11:26:37 INFO - Running pre-action listener: _resource_record_pre_action 11:26:37 INFO - Running main action method: install 11:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:37 INFO - Reading from file tmpfile_stdout 11:26:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:37 INFO - Reading from file tmpfile_stdout 11:26:37 INFO - Output received: 11:26:37 INFO - Usage: mozinstall [options] installer 11:26:37 INFO - Options: 11:26:37 INFO - -h, --help show this help message and exit 11:26:37 INFO - -d DEST, --destination=DEST 11:26:37 INFO - Directory to install application into. [default: 11:26:37 INFO - "/builds/slave/test"] 11:26:37 INFO - --app=APP Application being installed. [default: firefox] 11:26:37 INFO - mkdir: /builds/slave/test/build/application 11:26:37 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'] 11:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:26:54 INFO - Reading from file tmpfile_stdout 11:26:54 INFO - Output received: 11:26:54 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:54 INFO - Running post-action listener: _resource_record_post_action 11:26:54 INFO - [mozharness: 2017-03-23 18:26:54.328651Z] Finished install step (success) 11:26:54 INFO - [mozharness: 2017-03-23 18:26:54.328930Z] Running run-tests step. 11:26:54 INFO - Running pre-action listener: _resource_record_pre_action 11:26:54 INFO - Running main action method: run_tests 11:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:54 INFO - Python 2.7.3 11:26:54 INFO - Return code: 0 11:26:54 INFO - grabbing minidump binary from tooltool 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:54 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 0x1d7d400>, '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 0x1d7e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:54 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 11:26:54 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 11:26:54 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 11:26:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:54 INFO - Return code: 0 11:26:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:54 INFO - ENV: RUST_BACKTRACE is now 1 11:26:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:54 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/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:26:54 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/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 11:26:54 INFO - Using env: {'DISPLAY': ':0', 11:26:54 INFO - 'HOME': '/home/cltbld', 11:26:54 INFO - 'LANG': 'en_US.UTF-8', 11:26:54 INFO - 'LANGUAGE': 'en_US:en', 11:26:54 INFO - 'LOGNAME': 'cltbld', 11:26:54 INFO - 'MAIL': '/var/mail/cltbld', 11:26:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:54 INFO - 'MOZ_NO_REMOTE': '1', 11:26:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:54 INFO - 'NO_EM_RESTART': '1', 11:26:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:54 INFO - 'PWD': '/builds/slave/test', 11:26:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:54 INFO - 'RUST_BACKTRACE': '1', 11:26:54 INFO - 'SHELL': '/bin/bash', 11:26:54 INFO - 'SHLVL': '1', 11:26:54 INFO - 'TERM': 'linux', 11:26:54 INFO - 'TMOUT': '86400', 11:26:54 INFO - 'USER': 'cltbld', 11:26:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1490293537.225690-437163732', 11:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:54 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 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/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:26:54 INFO - mozversion application_buildid: 20170323173725 11:26:54 INFO - mozversion application_changeset: 200182ef115692c4ed2909f1a8beae8a6f19d127 11:26:54 INFO - mozversion application_display_name: Nightly 11:26:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:54 INFO - mozversion application_name: Firefox 11:26:54 INFO - mozversion application_remotingname: firefox 11:26:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:26:54 INFO - mozversion application_vendor: Mozilla 11:26:54 INFO - mozversion application_version: 55.0a1 11:26:54 INFO - mozversion platform_buildid: 20170323173725 11:26:54 INFO - mozversion platform_changeset: 200182ef115692c4ed2909f1a8beae8a6f19d127 11:26:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:26:54 INFO - mozversion platform_version: 55.0a1 11:26:54 INFO - using testdate: 1490293614 11:26:54 INFO - actual date: 1490293614 11:26:54 INFO - starting webserver on 'localhost:58333' 11:26:54 INFO - SUITE-START | Running 2 tests 11:26:54 INFO - TEST-START | dromaeo_css 11:26:54 INFO - operating with platform_type : linux_ 11:26:54 INFO - Initialising browser for dromaeo_css test... 11:26:54 INFO - TEST-INFO | started process 22236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiFlLX1/profile http://localhost:58333/getInfo.html) 11:26:58 INFO - PID 22236 | __metrics Screen width/height:1600/1200 11:26:58 INFO - PID 22236 | colorDepth:24 11:26:58 INFO - PID 22236 | Browser inner width/height: 1024/697 11:26:58 INFO - PID 22236 | __metrics 11:26:59 INFO - PID 22236 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:26:59 INFO - PID 22236 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:00 INFO - TEST-INFO | 22236: exit 0 11:27:00 INFO - Browser initialized. 11:27:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:00 INFO - TEST-INFO | started process 22334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiFlLX1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:12 INFO - PID 22334 | RSS: Main: 145260544 11:27:12 INFO - PID 22334 | 11:30:15 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58333/tests/dromaeo/cssquery-ext.html) 11:30:17 INFO - PID 22334 | RSS: Main: 299769856 11:30:17 INFO - PID 22334 | 11:32:02 INFO - PID 22334 | ************************* 11:32:02 INFO - PID 22334 | A coding exception was thrown and uncaught in a Task. 11:32:02 INFO - PID 22334 | 11:32:02 ERROR - PID 22334 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:32:02 INFO - PID 22334 | Full stack: 11:32:02 INFO - PID 22334 | ************************* 11:33:19 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-ext.html (next: http://localhost:58333/tests/dromaeo/cssquery-jquery.html) 11:33:19 INFO - PID 22334 | RSS: Main: 236937216 11:33:19 INFO - PID 22334 | 11:36:21 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58333/tests/dromaeo/cssquery-mootools.html) 11:36:22 INFO - PID 22334 | RSS: Main: 177131520 11:36:22 INFO - PID 22334 | 11:39:24 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58333/tests/dromaeo/cssquery-prototype.html) 11:39:24 INFO - PID 22334 | RSS: Main: 180277248 11:39:24 INFO - PID 22334 | 11:42:27 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58333/tests/dromaeo/cssquery-yui.html) 11:42:28 INFO - PID 22334 | RSS: Main: 185880576 11:42:28 INFO - PID 22334 | 11:45:30 INFO - PID 22334 | Cycle 1(1): loaded http://localhost:58333/tests/dromaeo/cssquery-yui.html (next: http://localhost:58333/tests/dromaeo/cssquery-dojo.html) 11:45:31 INFO - PID 22334 | RSS: Main: 280858624 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | __start_tp_report 11:45:31 INFO - PID 22334 | _x_x_mozilla_page_load 11:45:31 INFO - PID 22334 | _x_x_mozilla_page_load_details 11:45:31 INFO - PID 22334 | |i|pagename|runs| 11:45:31 INFO - PID 22334 | |0;dojo.html;3295.0444371132367;3316.0880757791606;3330.350581636582;3335.5163501292323;3363.966360336396;5695.145728140781;5712.857178570538;5717.3710891801975;5739.483446489815;5782.3061232652035;5709.2292540507015;5753.280839895013;5756.942430575693;5781.13283007549;5803.825885223439;5072.4673909239555;5139.871503212412;5164.380274367081;5186.222066689989;5237.031149237403;5155.149400348938;5220.895582088356;5228.241904923784;5233.058049551079;5285.445028272034;5068.797248110071;5126.077306084903;5135.948640513584;5148.897022059576;5172.818951336704;5113.156329205676;5152.046871328816;5178.870528236786;5190.143626301656;5238.659487133362;5062.11413002723;5108.693478391271;5127.743612819344;5147.279380886679;5168.173092305213;5643.125315576092;5703.743331550048;5753.252077229975;5770.913436298417;5772.3938986406665;6062.514998800086;6142.358785722137;6179.969100154471;6197.411245931629;6208.81373558794;6306.590071645328;6309.684515774193;6329.905051424233;6337.366263373672;6339.1442155308905;5825.941740582624;5882.47057764799;5887.941120588739;5891.293044834647;5946.494547963472;6189.35011823761;6275.278342990523;6358.268799088164;6385.106085148083;6413.551051426449;6013.759449621966;6105.945000794801;6117.510599152057;6117.724702388403;6131.233595800525;6184.969075154595;6275.937240627535;6304.527160462983;6307.432331090132;6311.842203944938;6268;6271.560990730696;6281.654509001957;6287.591306565058;6292.905606415908;5986.551008674367;6065.090236464477;6189;6241.500679945593;6245.875082498324;4752;4752.928706069411;4754.263089221176;4769.475357710649;4786.353842231324;4178.331466965271;4186.748795072305;4194.958050419517;4199.454070970754;4230.238557059697;5733.3406658234835;5796.681182534917;5797.420257974253;5851.093080572518;5888.793892213752;6222.408871157233;6237.033259844731;6239.032949892774;6240.7503699851495;6292.716827742763;5829.038208695602;5839.416058394211;5840.415958404125;5840.649561026352;5841.824745257649;5191.610629202825;5258.106121959276;5258.92111618326;5259.947400525945;5317.680939143664;6434.903476447857;6511.869762604816;6514.771982980573;6515.804525864231;6517.7067031984625;6325.936740632535;6344.333844946214;6347.079673447232;6349.809505714836;6350.174477317919;6209.316975132822;6479.902801458076;6558.901616475661;6572.934270657232;6578.342165783383;6054.63672179653;6058.212432383938;6104.755809767559;6147.385261473817;6161.599496032743;6328.746850125944;6334.904976425265;6341.904871427025;6343.682815859096;6347;5900.586958913007;5966.731497082555;6026.306974697791;6153.876922461436;6166.537509686702;6010.068439391901;6013.87972240544;6019.849503762266;6022.90965635507;6030.155778190969;5962.672053037125;6001;6004.39956004396;6012.488938440281;6013.729382177725;6129.785457508966;6135.785247516315;6152.938470615237;6153.784617538365;6155.1075094112;5752.654840709571;5843.795467158629;5877.500412464989;5882.676452795137;5952.464278214981 11:45:31 INFO - PID 22334 | |1;ext.html;670.966451677416;739.0503203383652;758.9734359297424;1140.1164097824185;1147.2772153543267;29008.274793130182;35674.46488302674;36530.45204321934;36582;36619.084522886944;38315.61684383155;38706.806465967704;38722.8063859681;38747.806260968726;38791.120887911195;5791.478766910977;5886.293644762634;7919.722809701676;8114.8782768258525;8125.065617454009;7520.811979700524;7662.463627546074;7662.693492260303;7665.69337226513;7670.348020418243;7945.801354966143;7980.521168729866;7983.321417679475;8009;8010.479318844256;7914.841703165933;7947.324477419426;7949.96025019877;7956.641951112214;8013.839723205561;8004.159563245834;8068.71759488421;8072.636731347104;8077.798055048671;8088.636011379502;35416.82291588551;38818.80590597029;38942.610573894184;38959.220815583816;38994;2906.5058939980045;2907.1278616414993;2908.418316336741;2933.8093023953375;2959.0974752700417;27875.58186627182;27909.720902790916;27992.860035699894;28279.434411311864;28356.432871342662;3204.102851201644;3218.436773564617;3238.0933338665213;3239.1092449576317;3243.2702641905385;204390;205276;205606;205627;205668;48832;48880.51119488759;48916.51083489191;48932.51067489351;48971;50974;51473.22790158151;51494.2459781838;51544.74227628838;51546;14661.193634350213;14990.62523436901;14996;15002.474913377979;15003.77494337564;10451.372917624967;10621.415822129702;10667.786644267226;12156.635300940987;12171.330576818184;12846.229226246454;12957.805632915513;13066.738665226641;13362.665933351549;13369.866301337057;5457.454254574511;5458.4814442627885;5484.314460692413;5545.057340252167;5549.944500555023;1022.4529876516028;1046.9685909422728;1047.9685609431729;1059.1315121600214;1099.4667586220676;24047.27858164223;24087.470815564113;24383.51232975366;24447.26658200257;24521.509569808502;1131.12337938097;1135.432283858071;1140.293018328625;1149.0233301693493;1155.7457359380924;12417.254964702146;12468.189567678071;12535.059870509749;12549.93725031369;12786.168899021533;290283;292484;292571;293525;293830;51159.488405116215;51294.74352628213;51323.48676513262;51382.22926656103;51417;1412.4915030589186;1465.1213645309247;1468.8310844252835;1478.0688166455066;1508.8340282568909;22991.08035678554;23442.413939651644;23771.286861394186;23795.167169148997;23870;38935.61064389433;38963;38967.415488767125;38997.22005559816;39044.6095539041;294779;295044;295190;296160;296395;32440.675593243766;32731.509027364133;32824.67175328312;32882;32996.83501582477;39914;39957.40063898986;40552.391714123725;41474.585254147074;41994;30203.244918877204;30302;30703;31486.52770208403;31714.674922600618;30813.8459307711;31494.877483361535;31764.04707858768;31803.68196318007;32292.67707322991;36146.819265903505;37066.258674826895;37149.25701486009;37158;37239.62760372362;29853.701462985093;30036.549451758678;30216;30507.694923050487;31560.684393156695;23753.16863909755;23791.762082379646;24647;25001.874990624932;25061.624075638516 11:45:31 INFO - PID 22334 | |2;jquery.html;391.61621610821413;428.06467867709057;433.3867577378009;447.1548772819371;448.48648297699117;16737.748933765986;19120;21224.89387553064;21406.25078122266;21516.677249841265;21285.467863303424;21464.141434342608;21643.67534486984;21817.345479635598;21870.343889683336;5614.466625670555;5627.971860140694;5844.590878638497;6015.969920150393;6021.036634138539;5903.940960590404;6012.3687012863675;6026.789062382817;6030.366811484797;6036.63780173191;5740.655560666352;5848.853778655546;5868.2664666916635;5986.341502434729;5991.3109992351;5869.706514674271;5906.084556893646;5928.229330187091;5929.436703513203;5931.88136237275;5158.148905430599;5177.275181474596;5208.427073021964;5209.2446595243855;5370.650907690988;23109.19117830868;24726.505469890682;24742.628860567107;24959.5008099837;25135.24594262175;1993.6411445939725;2005.7593088829433;2010.4873257319437;2047.4267205182573;2094;15035.849641503664;15608.843911560965;15761.921190394089;16210.432634857842;16363.59091022722;1883.133758471105;1890.253349926785;1890.5935223926922;1891.0828248299563;1892.6877065284211;97002;98607.50696246473;99100.50449747777;99498.50250748772;100167;10590.364578125183;11857.229280096766;12207.572734954412;12276.815847762291;12626.305553194663;15143;15930.123843188736;16475.6704865902;16477.752833707505;16489.587760306087;7922.801929951797;7977.48146370484;8137.216194469482;8155.184481551797;8213;7238.131424229126;7264.527805692613;7290.890636640454;7474.289942455458;7487.513311634726;7655.234476552411;7664.770056898191;7754.728584499516;7775.844483110419;7872;2256.3600587312885;2260.446190683293;2261.943451413728;2264.399934017487;2290.061074959259;990.108901988202;1000.7398076500162;1005.1305620638095;1005.653049697853;1017.2726500552141;18985.43043708691;19618.43340055501;19814;19832.60334793325;20008.49978750543;1021.2544842265188;1033.9224558158169;1036.3729943384294;1039.4906495817147;1059.1685526861377;10069.54687039085;10748.140148788078;10775.461226938622;10781.676549703521;10850.348979061124;539635;574478;587875;594706;595952;106075.46962265293;106967;107560.46219768851;107646.46176769066;111223.44388278006;1175.2424734002186;1179.4869231884159;1192.3382522699985;1196.5034510677972;1206.1556910162747;15983.840161598235;15985.44050958211;16869.15654217309;16886.831131688527;17112.31546250914;44282.3357649629;44353.55646443623;45532.31701524546;45591.77204114091;46069.53930460652;57702;60457.39542604693;60688;60840.08739868817;61473.38526614856;6525.8694826104165;8140.633671484916;8145.144759800136;8426.915730842613;8613.181747733955;12434.129610927148;12800.871991279968;13096.476140954255;13183.736325273248;13419.261940593362;9992.950035249778;10168.542415591168;10393.42836143989;10561.419121948367;10602.575896964343;10562.947185264025;10866.402347870942;10927.344359338465;11082.778344433227;11235.494402751732;11146.832797508207;11256.380899050631;11534.942325288655;11598.420078995847;11915.2255103418;7948.284654381134;8026.197380261927;8105.594720263845;8223.342132629256;8261.586920654063;9818.410895346016;9936.751581210528;9961.850572241567;10472.424016679155;11283.943580282046 11:45:31 INFO - PID 22334 | |3;mootools.html;1289.63890110769;1333.7465881482517;1342.7448784730902;1353.7630914589956;1358.6467518445208;10107.949460252697;10466.790664186712;10478.633247836327;10494.68515944522;10506.789864202721;10290.794184116314;10372.429516376615;10574.735631609214;10589.15286777058;10608.257421980465;2374.430136767172;2413.9275821725287;2417.9637305440347;2420.9757902420924;2421.7699318564796;2242.697235873161;2376.0377047295874;2376.4177776444794;2384.213209640823;2396.412878844677;2060.629086764382;2117.692934524493;2122.713433686448;2124.044180118945;2329.394357467054;2346.5072334809624;2376.1089591403224;2380.4405964598304;2380.7262164851004;2384.3681424422457;2303.953920921589;2360.386299562109;2364.054378248697;2372;2372.9525409491885;10341.276110672256;10443.164546836235;10461.215408844368;10755;10758.408287544182;6060.848478788022;6235.127082208494;6242.719077641472;6248.96875515624;6250;3590.533230680021;3727.5713292971113;3743.9438408423894;3793.1275806564367;3933.095388060762;1181.994090029553;1231.7536492701495;1237.900967922564;1269.397036407699;1290.4128621477205;16132.677346453005;16147.95038322517;16255.674886502204;16276.75584866228;16288.26702798377;4979.278004689372;5136.743162841843;5229.843104706865;5347.358317001985;5357.651752636066;11819.88180118205;11839.88160118405;11856.407179640983;11870.287782733063;11875.584354547549;6113.052476866093;6118.694065296718;6123.173371594867;6126.571140020156;6128.417800308964;5598.188262701886;5730.828075157752;5769.336526299446;5819.039858423397;5824.621399609012;4018.9732694302616;4117.3206420940205;4125.566815484331;4187.20443115807;4187.330027195634;1158.6871544682888;1168.6727716239466;1169.3334799164566;1180.533689192764;1184.7334349771234;787.2953706432711;806.2421323955463;816.1389733830747;816.608028146493;818.5211651184125;5956.255468066492;6655.767048153291;6675.1322328098;6748.93251067483;6962.895556566656;909.2998391238841;913.9314551408671;929.1730359979489;933.1601558597316;941.7033634405141;3744.981275093607;4328.783560822009;4381.802818873095;4408.55914408563;4421.624161946206;13366.39851206698;13780;13792.379342929593;13793.379297931617;13804.654883627989;13318.467261309634;13443.596692099058;13555.59333220005;13603.931980340036;13661.590152295446;9993.450360230258;10140.718338373807;10262.076413122855;10337.63818266372;10371.792564148524;6635.071090047494;6651.63416012124;6668.966655166693;6674.466042716668;6677.165354330708;12599;12703.36483175856;12748.61754147377;12750.68123296925;12883.613491595268;12741.17182383142;12770.169938953939;12850.222244418994;12919.806202907152;13030;8731.650733970824;8823.250023748053;8882.067382924959;8897.866532001895;8906.064863189531;9619.422834629944;9642.42145471274;9645.855312170183;9750.80498390014;9772.169365604002;8417.62120704582;8430.36772242072;8558.52928088961;8646.048934617062;8758.343124265833;8264.669413223644;8467.788305292417;8482.830343393221;8511.361647876558;8622.353323500636;7252.166000909963;7325.560466372035;7413.184549699637;7423.331900128798;7470.215627359049;5612.8877422450505;5687.374388817309;5723.771049157987;5765;5864.530837533072;5754.971225143848;5820.185174075548;5848.824535263949;6091.238595175603;6096.390360963868 11:45:31 INFO - PID 22334 | |4;prototype.html;406.16735691831775;413.7993073359422;414.5357199936072;417.2926888923274;420.38623609530083;5705;5820.9126863097035;5902.88194236115;5947.405259474051;5948.643081415113;5683.209788916489;5797.144913627641;5805.303363596375;5821.3305469870975;5851.4148585141465;4378.095528445137;4478.552144785528;4502.4371953505815;4521.638268938494;4525.275955847065;4507.909841803162;4509.368688383613;4509.571590698894;4515.254982927813;4530.093981203756;4473.2171869922795;4479.820807167709;4482.327650852366;4490.259107247317;4504.536025791631;4412.492563355223;4480.865574032784;4503.887402814923;4509.880356232566;4518.073794872076;3931.6068393160454;3933.9213215735526;3941.3102707026155;3950.249452603996;3958.1885713428965;5634.605577609569;5652.943470565283;5655.519280861132;5670.5747068969995;5692.0608099663505;5129.5383415492415;5226.660267082628;5228.607854410934;5240.161574148156;5272.367315922113;6099.420555047263;6127.877442451126;6142.464383904024;6147.78482753106;6165.506759459233;4413.977930110361;4420.977895110536;4425.5353187915125;4436.735530373828;4439.400680908068;6000.449808831273;6213.502919766408;6321.589096708745;6407.13503677007;6505.918106206016;4335.393044973706;4448.421705178371;4448.733076015449;4511.842085526991;4543.4775000875325;4578.404807375086;4588.311753237042;4596.4254468191475;4598.701084429501;4603.8618841434145;5163.526528187002;5225.425203227642;5233.267342572043;5238.71187084714;5254.605904557174;6145.754169833157;6154.692265386713;6182.1345011698395;6192.473639740582;6199.473044791153;1568.7176308264393;1582.9263664599412;1594.6970075685583;1595.840415958395;1600.8079030516412;1048.9929667519114;1053.3100818963592;1069.5775168808277;1073.120041565924;1090.51472094917;5840.941590584125;5841.4450627190345;5844.824655260349;5858.853528661817;5889.8233053007625;6334.461570766536;6340.936590634127;6361.491080713532;6364.07720880479;6373.968130159412;5639.787445699194;5763;5809.767609295581;5827.79602713903;5860.736266867916;3339.9499007514905;3382.6109997350127;3386.0519054664733;3387.7628566000635;3392.2028323343993;6236.75052997875;6550.870966935765;6580.835479112965;6607.867842643216;6635.8009259722285;6506.739730410825;6528.771492997722;6530.118434011442;6537;6547.607143571401;6356.523260755369;6538.057873956834;6572.737090516422;6573;6586;6323.525735569759;6377.107204991212;6378.649174295459;6385.329540398191;6401.455876250571;6202.534809889186;6315.96842015787;6317.4630156437215;6344.936550634435;6360.173177486897;6572.211334639683;6596.901046484402;6601.141851559267;6613.107230523818;6632.1709786276715;4458.041521072855;4466.4640243171025;4475.865724028285;4488.551144885485;4493.528179541101;6169.383061693795;6345.1434056401795;6392.712327945161;6393.776217832354;6399.7440102395385;6177.301242158443;6185.165002724574;6229.5327850410495;6232.719527621177;6247.812565623039;5906.438888305604;6228.626282423069;6235.501159907106;6262.029385445263;6272.937270627235;6146.661933593696;6188.164597779242;6204.751809927552;6215.906761398673;6238.563300568917;6203.937960620336;6260.624362538262;6279.560430769802;6288.1135659302945;6303.180586523723;5962.850928726643;6052.939470605237;6081.878362432815;6082.9695851520455;6084.11780291864 11:45:31 INFO - PID 22334 | |5;yui.html;651.2510612795286;658.2866674609792;659.5745743995124;676.2189670930078;678.9626570538621;14504.63738406539;16605.750913736305;16855.241514131863;16958.152092395394;16960.915195424022;14251.790972399294;14980.850191498082;15678.451254206106;15714.057156570614;15731.92134039331;791.8297566023318;806.0086094104255;807.9555624440653;810.5339429827873;811.4482152136545;790.3716545346434;814.242754238558;820.729159377404;828.7638023163399;831.3764676492631;702.5854745700036;708.1325376413903;710.5168485429906;710.605613884294;711.4166383565479;694.3299715774302;694.3854688600575;698.6122701900443;698.9545679530814;702.1188408547266;516.5273774496369;521.2207749414612;521.3014560488925;523.9685618862881;524.960627952905;15400.537983860502;15774.290156942965;16756.916215418965;16814.32742690291;16836.07401592912;15300.311485983157;15519.767203491956;15986.28061737213;16256.674866502604;16796.83203167965;12338.629841104781;12340.876591234062;12548;12583.622491325183;12681.23912565249;3047.3143542702937;3078.7536997040406;3103.5034394496997;3213.212762873111;3219.146926064595;84308.57845710794;86769;87301.56349218277;88348.55825720831;88637.55681221616;11137.443127843575;11219;11340.149488788375;11406.942965285121;11733.941330293464;23049.078036878338;23051.423714407272;23138.884305578365;23144.53710925772;23149.074037038667;6145.600535965148;6200.751969921243;6236.844078898064;6389.648569328731;6400.7119679614525;3977.3636218204947;4095.9795201023803;4131;4141.6065473779945;4148.211839750437;4196.706230563892;4217.40956266123;4272.252355837716;4279.828806847691;4288.228118938621;747.4132805747462;748.4050180106829;756.6595032235516;773.6673230510935;784.4861615641764;569.7977218087602;579.5161040531119;597.2444857255575;606.1937622961451;625.780976658166;9603.327767056378;9780.364276322016;9887.357321774205;9946.691130891928;9974.293059125936;530.4721801807226;532.6351449257271;553.914143307788;555.6800358503233;556.3879732294444;4170.3514542076155;4227.915441691149;4450.154470650566;4556.134334476439;4567.543245675406;75212;75426.62286688531;77596.61201694068;78980;80852.19147808565;69701;70641.29358706347;71466;71975;72883.63558182282;59961.700191499636;61766;61874.69062654658;61886;62289.377106229265;8788.868166977372;8893.977103036337;9005.81988360216;9083.636654533744;9171.908280917105;32002.83998579992;32299.192520186243;32568.837155814068;33072;33878.661213388536;39262.41106383464;39484;39971;40321;41119.38320925129;12179.391030448265;12285.815712764137;12381.876181238073;12552.184108032949;12837.037222208184;11997.280163190237;12088.637340879788;12257.264564125824;12532.561360352709;12990.545330913372;11601.941990289995;11616.247196611013;11722.648320550397;11749.412529373669;11932.463039163085;12292.139550231397;12399.628011159679;12414.379281036092;12432.316222607844;12546.874531254936;11167.218294719292;11395.943020284845;11581.710457238636;11966.46150923193;11977;8248.876266856121;8311.546570755301;8519.148085191431;8565.95717021411;8581.313494920516;8212.876806848022;9363.719088427359;9530.761730956505;9557.330986830855;9700.90299097 11:45:31 INFO - PID 22334 | __end_tp_report 11:45:31 INFO - PID 22334 | __start_cc_report 11:45:31 INFO - PID 22334 | _x_x_mozilla_cycle_collect,1646 11:45:31 INFO - PID 22334 | __end_cc_report 11:45:31 INFO - PID 22334 | __startTimestamp1490294731196__endTimestamp 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | ------- Summary: start ------- 11:45:31 INFO - PID 22334 | Number of tests: 6 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#0] dojo.html Cycles:165 Average:5751.67 Median:5966.73 stddev:688.67 (11.5%) stddev-sans-first:663.26 11:45:31 INFO - PID 22334 | Values: 3295.0 3316.1 3330.4 3335.5 3364.0 5695.1 5712.9 5717.4 5739.5 5782.3 5709.2 5753.3 5756.9 5781.1 5803.8 5072.5 5139.9 5164.4 5186.2 5237.0 5155.1 5220.9 5228.2 5233.1 5285.4 5068.8 5126.1 5135.9 5148.9 5172.8 5113.2 5152.0 5178.9 5190.1 5238.7 5062.1 5108.7 5127.7 5147.3 5168.2 5643.1 5703.7 5753.3 5770.9 5772.4 6062.5 6142.4 6180.0 6197.4 6208.8 6306.6 6309.7 6329.9 6337.4 6339.1 5825.9 5882.5 5887.9 5891.3 5946.5 6189.4 6275.3 6358.3 6385.1 6413.6 6013.8 6105.9 6117.5 6117.7 6131.2 6185.0 6275.9 6304.5 6307.4 6311.8 6268.0 6271.6 6281.7 6287.6 6292.9 5986.6 6065.1 6189.0 6241.5 6245.9 4752.0 4752.9 4754.3 4769.5 4786.4 4178.3 4186.7 4195.0 4199.5 4230.2 5733.3 5796.7 5797.4 5851.1 5888.8 6222.4 6237.0 6239.0 6240.8 6292.7 5829.0 5839.4 5840.4 5840.6 5841.8 5191.6 5258.1 5258.9 5259.9 5317.7 6434.9 6511.9 6514.8 6515.8 6517.7 6325.9 6344.3 6347.1 6349.8 6350.2 6209.3 6479.9 6558.9 6572.9 6578.3 6054.6 6058.2 6104.8 6147.4 6161.6 6328.7 6334.9 6341.9 6343.7 6347.0 5900.6 5966.7 6026.3 6153.9 6166.5 6010.1 6013.9 6019.8 6022.9 6030.2 5962.7 6001.0 6004.4 6012.5 6013.7 6129.8 6135.8 6152.9 6153.8 6155.1 5752.7 5843.8 5877.5 5882.7 5952.5 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#1] ext.html Cycles:180 Average:41845.40 Median:31783.86 stddev:70105.85 (220.6%) stddev-sans-first:70234.35 11:45:31 INFO - PID 22334 | Values: 671.0 739.1 759.0 1140.1 1147.3 29008.3 35674.5 36530.5 36582.0 36619.1 38315.6 38706.8 38722.8 38747.8 38791.1 5791.5 5886.3 7919.7 8114.9 8125.1 7520.8 7662.5 7662.7 7665.7 7670.3 7945.8 7980.5 7983.3 8009.0 8010.5 7914.8 7947.3 7950.0 7956.6 8013.8 8004.2 8068.7 8072.6 8077.8 8088.6 35416.8 38818.8 38942.6 38959.2 38994.0 2906.5 2907.1 2908.4 2933.8 2959.1 27875.6 27909.7 27992.9 28279.4 28356.4 3204.1 3218.4 3238.1 3239.1 3243.3 204390.0 205276.0 205606.0 205627.0 205668.0 48832.0 48880.5 48916.5 48932.5 48971.0 50974.0 51473.2 51494.2 51544.7 51546.0 14661.2 14990.6 14996.0 15002.5 15003.8 10451.4 10621.4 10667.8 12156.6 12171.3 12846.2 12957.8 13066.7 13362.7 13369.9 5457.5 5458.5 5484.3 5545.1 5549.9 1022.5 1047.0 1048.0 1059.1 1099.5 24047.3 24087.5 24383.5 24447.3 24521.5 1131.1 1135.4 1140.3 1149.0 1155.7 12417.3 12468.2 12535.1 12549.9 12786.2 290283.0 292484.0 292571.0 293525.0 293830.0 51159.5 51294.7 51323.5 51382.2 51417.0 1412.5 1465.1 1468.8 1478.1 1508.8 22991.1 23442.4 23771.3 23795.2 23870.0 38935.6 38963.0 38967.4 38997.2 39044.6 294779.0 295044.0 295190.0 296160.0 296395.0 32440.7 32731.5 32824.7 32882.0 32996.8 39914.0 39957.4 40552.4 41474.6 41994.0 30203.2 30302.0 30703.0 31486.5 31714.7 30813.8 31494.9 31764.0 31803.7 32292.7 36146.8 37066.3 37149.3 37158.0 37239.6 29853.7 30036.5 30216.0 30507.7 31560.7 23753.2 23791.8 24647.0 25001.9 25061.6 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#2] jquery.html Cycles:180 Average:32820.41 Median:12063.35 stddev:95641.28 (792.8%) stddev-sans-first:95878.59 11:45:31 INFO - PID 22334 | Values: 391.6 428.1 433.4 447.2 448.5 16737.7 19120.0 21224.9 21406.3 21516.7 21285.5 21464.1 21643.7 21817.3 21870.3 5614.5 5628.0 5844.6 6016.0 6021.0 5903.9 6012.4 6026.8 6030.4 6036.6 5740.7 5848.9 5868.3 5986.3 5991.3 5869.7 5906.1 5928.2 5929.4 5931.9 5158.1 5177.3 5208.4 5209.2 5370.7 23109.2 24726.5 24742.6 24959.5 25135.2 1993.6 2005.8 2010.5 2047.4 2094.0 15035.8 15608.8 15761.9 16210.4 16363.6 1883.1 1890.3 1890.6 1891.1 1892.7 97002.0 98607.5 99100.5 99498.5 100167.0 10590.4 11857.2 12207.6 12276.8 12626.3 15143.0 15930.1 16475.7 16477.8 16489.6 7922.8 7977.5 8137.2 8155.2 8213.0 7238.1 7264.5 7290.9 7474.3 7487.5 7655.2 7664.8 7754.7 7775.8 7872.0 2256.4 2260.4 2261.9 2264.4 2290.1 990.1 1000.7 1005.1 1005.7 1017.3 18985.4 19618.4 19814.0 19832.6 20008.5 1021.3 1033.9 1036.4 1039.5 1059.2 10069.5 10748.1 10775.5 10781.7 10850.3 539635.0 574478.0 587875.0 594706.0 595952.0 106075.5 106967.0 107560.5 107646.5 111223.4 1175.2 1179.5 1192.3 1196.5 1206.2 15983.8 15985.4 16869.2 16886.8 17112.3 44282.3 44353.6 45532.3 45591.8 46069.5 57702.0 60457.4 60688.0 60840.1 61473.4 6525.9 8140.6 8145.1 8426.9 8613.2 12434.1 12800.9 13096.5 13183.7 13419.3 9993.0 10168.5 10393.4 10561.4 10602.6 10562.9 10866.4 10927.3 11082.8 11235.5 11146.8 11256.4 11534.9 11598.4 11915.2 7948.3 8026.2 8105.6 8223.3 8261.6 9818.4 9936.8 9961.9 10472.4 11283.9 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#3] mootools.html Cycles:180 Average:6749.54 Median:3735.76 stddev:4237.18 (113.4%) stddev-sans-first:4229.20 11:45:31 INFO - PID 22334 | Values: 1289.6 1333.7 1342.7 1353.8 1358.6 10107.9 10466.8 10478.6 10494.7 10506.8 10290.8 10372.4 10574.7 10589.2 10608.3 2374.4 2413.9 2418.0 2421.0 2421.8 2242.7 2376.0 2376.4 2384.2 2396.4 2060.6 2117.7 2122.7 2124.0 2329.4 2346.5 2376.1 2380.4 2380.7 2384.4 2304.0 2360.4 2364.1 2372.0 2373.0 10341.3 10443.2 10461.2 10755.0 10758.4 6060.8 6235.1 6242.7 6249.0 6250.0 3590.5 3727.6 3743.9 3793.1 3933.1 1182.0 1231.8 1237.9 1269.4 1290.4 16132.7 16148.0 16255.7 16276.8 16288.3 4979.3 5136.7 5229.8 5347.4 5357.7 11819.9 11839.9 11856.4 11870.3 11875.6 6113.1 6118.7 6123.2 6126.6 6128.4 5598.2 5730.8 5769.3 5819.0 5824.6 4019.0 4117.3 4125.6 4187.2 4187.3 1158.7 1168.7 1169.3 1180.5 1184.7 787.3 806.2 816.1 816.6 818.5 5956.3 6655.8 6675.1 6748.9 6962.9 909.3 913.9 929.2 933.2 941.7 3745.0 4328.8 4381.8 4408.6 4421.6 13366.4 13780.0 13792.4 13793.4 13804.7 13318.5 13443.6 13555.6 13603.9 13661.6 9993.5 10140.7 10262.1 10337.6 10371.8 6635.1 6651.6 6669.0 6674.5 6677.2 12599.0 12703.4 12748.6 12750.7 12883.6 12741.2 12770.2 12850.2 12919.8 13030.0 8731.7 8823.3 8882.1 8897.9 8906.1 9619.4 9642.4 9645.9 9750.8 9772.2 8417.6 8430.4 8558.5 8646.0 8758.3 8264.7 8467.8 8482.8 8511.4 8622.4 7252.2 7325.6 7413.2 7423.3 7470.2 5612.9 5687.4 5723.8 5765.0 5864.5 5755.0 5820.2 5848.8 6091.2 6096.4 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#4] prototype.html Cycles:180 Average:5188.36 Median:5841.19 stddev:1533.80 (26.3%) stddev-sans-first:1495.51 11:45:31 INFO - PID 22334 | Values: 406.2 413.8 414.5 417.3 420.4 5705.0 5820.9 5902.9 5947.4 5948.6 5683.2 5797.1 5805.3 5821.3 5851.4 4378.1 4478.6 4502.4 4521.6 4525.3 4507.9 4509.4 4509.6 4515.3 4530.1 4473.2 4479.8 4482.3 4490.3 4504.5 4412.5 4480.9 4503.9 4509.9 4518.1 3931.6 3933.9 3941.3 3950.2 3958.2 5634.6 5652.9 5655.5 5670.6 5692.1 5129.5 5226.7 5228.6 5240.2 5272.4 6099.4 6127.9 6142.5 6147.8 6165.5 4414.0 4421.0 4425.5 4436.7 4439.4 6000.4 6213.5 6321.6 6407.1 6505.9 4335.4 4448.4 4448.7 4511.8 4543.5 4578.4 4588.3 4596.4 4598.7 4603.9 5163.5 5225.4 5233.3 5238.7 5254.6 6145.8 6154.7 6182.1 6192.5 6199.5 1568.7 1582.9 1594.7 1595.8 1600.8 1049.0 1053.3 1069.6 1073.1 1090.5 5840.9 5841.4 5844.8 5858.9 5889.8 6334.5 6340.9 6361.5 6364.1 6374.0 5639.8 5763.0 5809.8 5827.8 5860.7 3339.9 3382.6 3386.1 3387.8 3392.2 6236.8 6550.9 6580.8 6607.9 6635.8 6506.7 6528.8 6530.1 6537.0 6547.6 6356.5 6538.1 6572.7 6573.0 6586.0 6323.5 6377.1 6378.6 6385.3 6401.5 6202.5 6316.0 6317.5 6344.9 6360.2 6572.2 6596.9 6601.1 6613.1 6632.2 4458.0 4466.5 4475.9 4488.6 4493.5 6169.4 6345.1 6392.7 6393.8 6399.7 6177.3 6185.2 6229.5 6232.7 6247.8 5906.4 6228.6 6235.5 6262.0 6272.9 6146.7 6188.2 6204.8 6215.9 6238.6 6203.9 6260.6 6279.6 6288.1 6303.2 5962.9 6052.9 6081.9 6083.0 6084.1 11:45:31 INFO - PID 22334 | 11:45:31 INFO - PID 22334 | [#5] yui.html Cycles:180 Average:16852.13 Median:518.87 stddev:22402.46 (4317.5%) stddev-sans-first:22432.27 11:45:31 INFO - PID 22334 | Values: 651.3 658.3 659.6 676.2 679.0 14504.6 16605.8 16855.2 16958.2 16960.9 14251.8 14980.9 15678.5 15714.1 15731.9 791.8 806.0 808.0 810.5 811.4 790.4 814.2 820.7 828.8 831.4 702.6 708.1 710.5 710.6 711.4 694.3 694.4 698.6 699.0 702.1 516.5 521.2 521.3 524.0 525.0 15400.5 15774.3 16756.9 16814.3 16836.1 15300.3 15519.8 15986.3 16256.7 16796.8 12338.6 12340.9 12548.0 12583.6 12681.2 3047.3 3078.8 3103.5 3213.2 3219.1 84308.6 86769.0 87301.6 88348.6 88637.6 11137.4 11219.0 11340.1 11406.9 11733.9 23049.1 23051.4 23138.9 23144.5 23149.1 6145.6 6200.8 6236.8 6389.6 6400.7 3977.4 4096.0 4131.0 4141.6 4148.2 4196.7 4217.4 4272.3 4279.8 4288.2 747.4 748.4 756.7 773.7 784.5 569.8 579.5 597.2 606.2 625.8 9603.3 9780.4 9887.4 9946.7 9974.3 530.5 532.6 553.9 555.7 556.4 4170.4 4227.9 4450.2 4556.1 4567.5 75212.0 75426.6 77596.6 78980.0 80852.2 69701.0 70641.3 71466.0 71975.0 72883.6 59961.7 61766.0 61874.7 61886.0 62289.4 8788.9 8894.0 9005.8 9083.6 9171.9 32002.8 32299.2 32568.8 33072.0 33878.7 39262.4 39484.0 39971.0 40321.0 41119.4 12179.4 12285.8 12381.9 12552.2 12837.0 11997.3 12088.6 12257.3 12532.6 12990.5 11601.9 11616.2 11722.6 11749.4 11932.5 12292.1 12399.6 12414.4 12432.3 12546.9 11167.2 11395.9 11581.7 11966.5 11977.0 8248.9 8311.5 8519.1 8566.0 8581.3 8212.9 9363.7 9530.8 9557.3 9700.9 11:45:31 INFO - PID 22334 | -------- Summary: end -------- 11:45:31 INFO - PID 22334 | 11:45:32 INFO - TEST-INFO | 22334: exit 0 11:45:32 INFO - TEST-OK | dromaeo_css | took 1117458ms 11:45:32 INFO - TEST-START | kraken 11:45:32 INFO - operating with platform_type : linux_ 11:45:32 INFO - Initialising browser for kraken test... 11:45:32 INFO - TEST-INFO | started process 22659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwyzSCp/profile http://localhost:58333/getInfo.html) 11:45:36 INFO - PID 22659 | __metrics Screen width/height:1600/1200 11:45:36 INFO - PID 22659 | colorDepth:24 11:45:36 INFO - PID 22659 | Browser inner width/height: 1024/697 11:45:36 INFO - PID 22659 | __metrics 11:45:37 INFO - PID 22659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:45:37 INFO - PID 22659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:45:38 INFO - TEST-INFO | 22659: exit 0 11:45:38 INFO - Browser initialized. 11:45:38 INFO - Running cycle 1/1 for kraken test... 11:45:38 INFO - TEST-INFO | started process 22757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwyzSCp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:50 INFO - PID 22757 | RSS: Main: 145444864 11:45:50 INFO - PID 22757 | 11:45:52 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58333/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:53 INFO - PID 22757 | RSS: Main: 200609792 11:45:53 INFO - PID 22757 | 11:45:56 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58333/tests/kraken/driver.html?testName=audio-dft) 11:45:56 INFO - PID 22757 | RSS: Main: 179904512 11:45:56 INFO - PID 22757 | 11:45:59 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58333/tests/kraken/driver.html?testName=audio-fft) 11:46:00 INFO - PID 22757 | RSS: Main: 261955584 11:46:00 INFO - PID 22757 | 11:46:02 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58333/tests/kraken/driver.html?testName=audio-oscillator) 11:46:02 INFO - PID 22757 | RSS: Main: 172982272 11:46:02 INFO - PID 22757 | 11:46:05 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:05 INFO - PID 22757 | RSS: Main: 176427008 11:46:05 INFO - PID 22757 | 11:46:08 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58333/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:09 INFO - PID 22757 | RSS: Main: 215961600 11:46:09 INFO - PID 22757 | 11:46:12 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58333/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:13 INFO - PID 22757 | RSS: Main: 226373632 11:46:13 INFO - PID 22757 | 11:46:16 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58333/tests/kraken/driver.html?testName=json-parse-financial) 11:46:16 INFO - PID 22757 | RSS: Main: 234266624 11:46:16 INFO - PID 22757 | 11:46:18 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:18 INFO - PID 22757 | RSS: Main: 179167232 11:46:18 INFO - PID 22757 | 11:46:20 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:21 INFO - PID 22757 | RSS: Main: 185630720 11:46:21 INFO - PID 22757 | 11:46:23 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:23 INFO - PID 22757 | RSS: Main: 194424832 11:46:23 INFO - PID 22757 | 11:46:26 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:27 INFO - PID 22757 | RSS: Main: 204447744 11:46:27 INFO - PID 22757 | 11:46:30 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:30 INFO - PID 22757 | RSS: Main: 200822784 11:46:30 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | Cycle 1(1): loaded http://localhost:58333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58333/tests/kraken/driver.html?testName=ai-astar) 11:46:32 INFO - PID 22757 | RSS: Main: 269570048 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | __start_tp_report 11:46:32 INFO - PID 22757 | _x_x_mozilla_page_load 11:46:32 INFO - PID 22757 | _x_x_mozilla_page_load_details 11:46:32 INFO - PID 22757 | |i|pagename|runs| 11:46:32 INFO - PID 22757 | |0;ai-astar;102;109;110;109;110;109;110;110;110;109 11:46:32 INFO - PID 22757 | |1;audio-beat-detection;146;115;122;157;117;117;121;121;136;117 11:46:32 INFO - PID 22757 | |2;audio-dft;162;162;163;160;162;162;163;165;163;163 11:46:32 INFO - PID 22757 | |3;audio-fft;72;74;73;106;74;78;73;75;95;76 11:46:32 INFO - PID 22757 | |4;audio-oscillator;83;83;115;83;82;82;103;83;82;101 11:46:32 INFO - PID 22757 | |5;imaging-gaussian-blur;113;112;113;113;113;113;112;114;113;113 11:46:32 INFO - PID 22757 | |6;imaging-darkroom;147;146;146;146;147;146;147;146;147;146 11:46:32 INFO - PID 22757 | |7;imaging-desaturate;94;94;93;93;94;94;93;93;95;94 11:46:32 INFO - PID 22757 | |8;json-parse-financial;58;56;57;58;57;58;58;59;59;59 11:46:32 INFO - PID 22757 | |9;json-stringify-tinderbox;54;55;57;55;55;56;54;54;54;57 11:46:32 INFO - PID 22757 | |10;stanford-crypto-aes;79;79;79;79;83;79;87;88;81;81 11:46:32 INFO - PID 22757 | |11;stanford-crypto-ccm;128;125;129;129;136;129;125;131;171;129 11:46:32 INFO - PID 22757 | |12;stanford-crypto-pbkdf2;194;188;185;189;189;177;186;193;185;184 11:46:32 INFO - PID 22757 | |13;stanford-crypto-sha256-iterative;68;67;65;65;66;65;65;67;65;71 11:46:32 INFO - PID 22757 | __end_tp_report 11:46:32 INFO - PID 22757 | __start_cc_report 11:46:32 INFO - PID 22757 | _x_x_mozilla_cycle_collect,1733 11:46:32 INFO - PID 22757 | __end_cc_report 11:46:32 INFO - PID 22757 | __startTimestamp1490294792671__endTimestamp 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | ------- Summary: start ------- 11:46:32 INFO - PID 22757 | Number of tests: 14 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.44 (2.2%) stddev-sans-first:0.53 11:46:32 INFO - PID 22757 | Values: 102.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:121.50 stddev:14.46 (11.9%) stddev-sans-first:13.59 11:46:32 INFO - PID 22757 | Values: 146.0 115.0 122.0 157.0 117.0 117.0 121.0 121.0 136.0 117.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 11:46:32 INFO - PID 22757 | Values: 162.0 162.0 163.0 160.0 162.0 162.0 163.0 165.0 163.0 163.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.50 stddev:11.44 (15.4%) stddev-sans-first:11.80 11:46:32 INFO - PID 22757 | Values: 72.0 74.0 73.0 106.0 74.0 78.0 73.0 75.0 95.0 76.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.50 stddev:12.03 (14.6%) stddev-sans-first:12.51 11:46:32 INFO - PID 22757 | Values: 83.0 83.0 115.0 83.0 82.0 82.0 103.0 83.0 82.0 101.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:46:32 INFO - PID 22757 | Values: 113.0 112.0 113.0 113.0 113.0 113.0 112.0 114.0 113.0 113.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:46:32 INFO - PID 22757 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:46:32 INFO - PID 22757 | Values: 94.0 94.0 93.0 93.0 94.0 94.0 93.0 93.0 95.0 94.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 11:46:32 INFO - PID 22757 | Values: 58.0 56.0 57.0 58.0 57.0 58.0 58.0 59.0 59.0 59.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.20 11:46:32 INFO - PID 22757 | Values: 54.0 55.0 57.0 55.0 55.0 56.0 54.0 54.0 54.0 57.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:3.44 (4.2%) stddev-sans-first:3.53 11:46:32 INFO - PID 22757 | Values: 79.0 79.0 79.0 79.0 83.0 79.0 87.0 88.0 81.0 81.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:129.00 stddev:13.64 (10.6%) stddev-sans-first:14.33 11:46:32 INFO - PID 22757 | Values: 128.0 125.0 129.0 129.0 136.0 129.0 125.0 131.0 171.0 129.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:188.50 stddev:4.85 (2.6%) stddev-sans-first:4.44 11:46:32 INFO - PID 22757 | Values: 194.0 188.0 185.0 189.0 189.0 177.0 186.0 193.0 185.0 184.0 11:46:32 INFO - PID 22757 | 11:46:32 INFO - PID 22757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.96 (2.9%) stddev-sans-first:1.99 11:46:32 INFO - PID 22757 | Values: 68.0 67.0 65.0 65.0 66.0 65.0 65.0 67.0 65.0 71.0 11:46:32 INFO - PID 22757 | -------- Summary: end -------- 11:46:32 INFO - PID 22757 | 11:46:33 INFO - TEST-INFO | 22757: exit 0 11:46:33 INFO - TEST-OK | kraken | took 61681ms 11:46:33 INFO - SUITE-END | took 1179s 11:46:33 INFO - Completed test suite (00:19:39) 11:46:33 INFO - javascript benchmark 11:46:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7301.962660682339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.0444371132367, 3316.0880757791606, 3330.350581636582, 3335.5163501292323, 3363.966360336396, 5695.145728140781, 5712.857178570538, 5717.3710891801975, 5739.483446489815, 5782.3061232652035, 5709.2292540507015, 5753.280839895013, 5756.942430575693, 5781.13283007549, 5803.825885223439, 5072.4673909239555, 5139.871503212412, 5164.380274367081, 5186.222066689989, 5237.031149237403, 5155.149400348938, 5220.895582088356, 5228.241904923784, 5233.058049551079, 5285.445028272034, 5068.797248110071, 5126.077306084903, 5135.948640513584, 5148.897022059576, 5172.818951336704, 5113.156329205676, 5152.046871328816, 5178.870528236786, 5190.143626301656, 5238.659487133362, 5062.11413002723, 5108.693478391271, 5127.743612819344, 5147.279380886679, 5168.173092305213, 5643.125315576092, 5703.743331550048, 5753.252077229975, 5770.913436298417, 5772.3938986406665, 6062.514998800086, 6142.358785722137, 6179.969100154471, 6197.411245931629, 6208.81373558794, 6306.590071645328, 6309.684515774193, 6329.905051424233, 6337.366263373672, 6339.1442155308905, 5825.941740582624, 5882.47057764799, 5887.941120588739, 5891.293044834647, 5946.494547963472, 6189.35011823761, 6275.278342990523, 6358.268799088164, 6385.106085148083, 6413.551051426449, 6013.759449621966, 6105.945000794801, 6117.510599152057, 6117.724702388403, 6131.233595800525, 6184.969075154595, 6275.937240627535, 6304.527160462983, 6307.432331090132, 6311.842203944938, 6268.0, 6271.560990730696, 6281.654509001957, 6287.591306565058, 6292.905606415908, 5986.551008674367, 6065.090236464477, 6189.0, 6241.500679945593, 6245.875082498324, 4752.0, 4752.928706069411, 4754.263089221176, 4769.475357710649, 4786.353842231324, 4178.331466965271, 4186.748795072305, 4194.958050419517, 4199.454070970754, 4230.238557059697, 5733.3406658234835, 5796.681182534917, 5797.420257974253, 5851.093080572518, 5888.793892213752, 6222.408871157233, 6237.033259844731, 6239.032949892774, 6240.7503699851495, 6292.716827742763, 5829.038208695602, 5839.416058394211, 5840.415958404125, 5840.649561026352, 5841.824745257649, 5191.610629202825, 5258.106121959276, 5258.92111618326, 5259.947400525945, 5317.680939143664, 6434.903476447857, 6511.869762604816, 6514.771982980573, 6515.804525864231, 6517.7067031984625, 6325.936740632535, 6344.333844946214, 6347.079673447232, 6349.809505714836, 6350.174477317919, 6209.316975132822, 6479.902801458076, 6558.901616475661, 6572.934270657232, 6578.342165783383, 6054.63672179653, 6058.212432383938, 6104.755809767559, 6147.385261473817, 6161.599496032743, 6328.746850125944, 6334.904976425265, 6341.904871427025, 6343.682815859096, 6347.0, 5900.586958913007, 5966.731497082555, 6026.306974697791, 6153.876922461436, 6166.537509686702, 6010.068439391901, 6013.87972240544, 6019.849503762266, 6022.90965635507, 6030.155778190969, 5962.672053037125, 6001.0, 6004.39956004396, 6012.488938440281, 6013.729382177725, 6129.785457508966, 6135.785247516315, 6152.938470615237, 6153.784617538365, 6155.1075094112, 5752.654840709571, 5843.795467158629, 5877.500412464989, 5882.676452795137, 5952.464278214981], "value": 5703.1933471468765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.966451677416, 739.0503203383652, 758.9734359297424, 1140.1164097824185, 1147.2772153543267, 29008.274793130182, 35674.46488302674, 36530.45204321934, 36582.0, 36619.084522886944, 38315.61684383155, 38706.806465967704, 38722.8063859681, 38747.806260968726, 38791.120887911195, 5791.478766910977, 5886.293644762634, 7919.722809701676, 8114.8782768258525, 8125.065617454009, 7520.811979700524, 7662.463627546074, 7662.693492260303, 7665.69337226513, 7670.348020418243, 7945.801354966143, 7980.521168729866, 7983.321417679475, 8009.0, 8010.479318844256, 7914.841703165933, 7947.324477419426, 7949.96025019877, 7956.641951112214, 8013.839723205561, 8004.159563245834, 8068.71759488421, 8072.636731347104, 8077.798055048671, 8088.636011379502, 35416.82291588551, 38818.80590597029, 38942.610573894184, 38959.220815583816, 38994.0, 2906.5058939980045, 2907.1278616414993, 2908.418316336741, 2933.8093023953375, 2959.0974752700417, 27875.58186627182, 27909.720902790916, 27992.860035699894, 28279.434411311864, 28356.432871342662, 3204.102851201644, 3218.436773564617, 3238.0933338665213, 3239.1092449576317, 3243.2702641905385, 204390.0, 205276.0, 205606.0, 205627.0, 205668.0, 48832.0, 48880.51119488759, 48916.51083489191, 48932.51067489351, 48971.0, 50974.0, 51473.22790158151, 51494.2459781838, 51544.74227628838, 51546.0, 14661.193634350213, 14990.62523436901, 14996.0, 15002.474913377979, 15003.77494337564, 10451.372917624967, 10621.415822129702, 10667.786644267226, 12156.635300940987, 12171.330576818184, 12846.229226246454, 12957.805632915513, 13066.738665226641, 13362.665933351549, 13369.866301337057, 5457.454254574511, 5458.4814442627885, 5484.314460692413, 5545.057340252167, 5549.944500555023, 1022.4529876516028, 1046.9685909422728, 1047.9685609431729, 1059.1315121600214, 1099.4667586220676, 24047.27858164223, 24087.470815564113, 24383.51232975366, 24447.26658200257, 24521.509569808502, 1131.12337938097, 1135.432283858071, 1140.293018328625, 1149.0233301693493, 1155.7457359380924, 12417.254964702146, 12468.189567678071, 12535.059870509749, 12549.93725031369, 12786.168899021533, 290283.0, 292484.0, 292571.0, 293525.0, 293830.0, 51159.488405116215, 51294.74352628213, 51323.48676513262, 51382.22926656103, 51417.0, 1412.4915030589186, 1465.1213645309247, 1468.8310844252835, 1478.0688166455066, 1508.8340282568909, 22991.08035678554, 23442.413939651644, 23771.286861394186, 23795.167169148997, 23870.0, 38935.61064389433, 38963.0, 38967.415488767125, 38997.22005559816, 39044.6095539041, 294779.0, 295044.0, 295190.0, 296160.0, 296395.0, 32440.675593243766, 32731.509027364133, 32824.67175328312, 32882.0, 32996.83501582477, 39914.0, 39957.40063898986, 40552.391714123725, 41474.585254147074, 41994.0, 30203.244918877204, 30302.0, 30703.0, 31486.52770208403, 31714.674922600618, 30813.8459307711, 31494.877483361535, 31764.04707858768, 31803.68196318007, 32292.67707322991, 36146.819265903505, 37066.258674826895, 37149.25701486009, 37158.0, 37239.62760372362, 29853.701462985093, 30036.549451758678, 30216.0, 30507.694923050487, 31560.684393156695, 23753.16863909755, 23791.762082379646, 24647.0, 25001.874990624932, 25061.624075638516], "value": 16924.892773594245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.61621610821413, 428.06467867709057, 433.3867577378009, 447.1548772819371, 448.48648297699117, 16737.748933765986, 19120.0, 21224.89387553064, 21406.25078122266, 21516.677249841265, 21285.467863303424, 21464.141434342608, 21643.67534486984, 21817.345479635598, 21870.343889683336, 5614.466625670555, 5627.971860140694, 5844.590878638497, 6015.969920150393, 6021.036634138539, 5903.940960590404, 6012.3687012863675, 6026.789062382817, 6030.366811484797, 6036.63780173191, 5740.655560666352, 5848.853778655546, 5868.2664666916635, 5986.341502434729, 5991.3109992351, 5869.706514674271, 5906.084556893646, 5928.229330187091, 5929.436703513203, 5931.88136237275, 5158.148905430599, 5177.275181474596, 5208.427073021964, 5209.2446595243855, 5370.650907690988, 23109.19117830868, 24726.505469890682, 24742.628860567107, 24959.5008099837, 25135.24594262175, 1993.6411445939725, 2005.7593088829433, 2010.4873257319437, 2047.4267205182573, 2094.0, 15035.849641503664, 15608.843911560965, 15761.921190394089, 16210.432634857842, 16363.59091022722, 1883.133758471105, 1890.253349926785, 1890.5935223926922, 1891.0828248299563, 1892.6877065284211, 97002.0, 98607.50696246473, 99100.50449747777, 99498.50250748772, 100167.0, 10590.364578125183, 11857.229280096766, 12207.572734954412, 12276.815847762291, 12626.305553194663, 15143.0, 15930.123843188736, 16475.6704865902, 16477.752833707505, 16489.587760306087, 7922.801929951797, 7977.48146370484, 8137.216194469482, 8155.184481551797, 8213.0, 7238.131424229126, 7264.527805692613, 7290.890636640454, 7474.289942455458, 7487.513311634726, 7655.234476552411, 7664.770056898191, 7754.728584499516, 7775.844483110419, 7872.0, 2256.3600587312885, 2260.446190683293, 2261.943451413728, 2264.399934017487, 2290.061074959259, 990.108901988202, 1000.7398076500162, 1005.1305620638095, 1005.653049697853, 1017.2726500552141, 18985.43043708691, 19618.43340055501, 19814.0, 19832.60334793325, 20008.49978750543, 1021.2544842265188, 1033.9224558158169, 1036.3729943384294, 1039.4906495817147, 1059.1685526861377, 10069.54687039085, 10748.140148788078, 10775.461226938622, 10781.676549703521, 10850.348979061124, 539635.0, 574478.0, 587875.0, 594706.0, 595952.0, 106075.46962265293, 106967.0, 107560.46219768851, 107646.46176769066, 111223.44388278006, 1175.2424734002186, 1179.4869231884159, 1192.3382522699985, 1196.5034510677972, 1206.1556910162747, 15983.840161598235, 15985.44050958211, 16869.15654217309, 16886.831131688527, 17112.31546250914, 44282.3357649629, 44353.55646443623, 45532.31701524546, 45591.77204114091, 46069.53930460652, 57702.0, 60457.39542604693, 60688.0, 60840.08739868817, 61473.38526614856, 6525.8694826104165, 8140.633671484916, 8145.144759800136, 8426.915730842613, 8613.181747733955, 12434.129610927148, 12800.871991279968, 13096.476140954255, 13183.736325273248, 13419.261940593362, 9992.950035249778, 10168.542415591168, 10393.42836143989, 10561.419121948367, 10602.575896964343, 10562.947185264025, 10866.402347870942, 10927.344359338465, 11082.778344433227, 11235.494402751732, 11146.832797508207, 11256.380899050631, 11534.942325288655, 11598.420078995847, 11915.2255103418, 7948.284654381134, 8026.197380261927, 8105.594720263845, 8223.342132629256, 8261.586920654063, 9818.410895346016, 9936.751581210528, 9961.850572241567, 10472.424016679155, 11283.943580282046], "value": 9658.610793466429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.63890110769, 1333.7465881482517, 1342.7448784730902, 1353.7630914589956, 1358.6467518445208, 10107.949460252697, 10466.790664186712, 10478.633247836327, 10494.68515944522, 10506.789864202721, 10290.794184116314, 10372.429516376615, 10574.735631609214, 10589.15286777058, 10608.257421980465, 2374.430136767172, 2413.9275821725287, 2417.9637305440347, 2420.9757902420924, 2421.7699318564796, 2242.697235873161, 2376.0377047295874, 2376.4177776444794, 2384.213209640823, 2396.412878844677, 2060.629086764382, 2117.692934524493, 2122.713433686448, 2124.044180118945, 2329.394357467054, 2346.5072334809624, 2376.1089591403224, 2380.4405964598304, 2380.7262164851004, 2384.3681424422457, 2303.953920921589, 2360.386299562109, 2364.054378248697, 2372.0, 2372.9525409491885, 10341.276110672256, 10443.164546836235, 10461.215408844368, 10755.0, 10758.408287544182, 6060.848478788022, 6235.127082208494, 6242.719077641472, 6248.96875515624, 6250.0, 3590.533230680021, 3727.5713292971113, 3743.9438408423894, 3793.1275806564367, 3933.095388060762, 1181.994090029553, 1231.7536492701495, 1237.900967922564, 1269.397036407699, 1290.4128621477205, 16132.677346453005, 16147.95038322517, 16255.674886502204, 16276.75584866228, 16288.26702798377, 4979.278004689372, 5136.743162841843, 5229.843104706865, 5347.358317001985, 5357.651752636066, 11819.88180118205, 11839.88160118405, 11856.407179640983, 11870.287782733063, 11875.584354547549, 6113.052476866093, 6118.694065296718, 6123.173371594867, 6126.571140020156, 6128.417800308964, 5598.188262701886, 5730.828075157752, 5769.336526299446, 5819.039858423397, 5824.621399609012, 4018.9732694302616, 4117.3206420940205, 4125.566815484331, 4187.20443115807, 4187.330027195634, 1158.6871544682888, 1168.6727716239466, 1169.3334799164566, 1180.533689192764, 1184.7334349771234, 787.2953706432711, 806.2421323955463, 816.1389733830747, 816.608028146493, 818.5211651184125, 5956.255468066492, 6655.767048153291, 6675.1322328098, 6748.93251067483, 6962.895556566656, 909.2998391238841, 913.9314551408671, 929.1730359979489, 933.1601558597316, 941.7033634405141, 3744.981275093607, 4328.783560822009, 4381.802818873095, 4408.55914408563, 4421.624161946206, 13366.39851206698, 13780.0, 13792.379342929593, 13793.379297931617, 13804.654883627989, 13318.467261309634, 13443.596692099058, 13555.59333220005, 13603.931980340036, 13661.590152295446, 9993.450360230258, 10140.718338373807, 10262.076413122855, 10337.63818266372, 10371.792564148524, 6635.071090047494, 6651.63416012124, 6668.966655166693, 6674.466042716668, 6677.165354330708, 12599.0, 12703.36483175856, 12748.61754147377, 12750.68123296925, 12883.613491595268, 12741.17182383142, 12770.169938953939, 12850.222244418994, 12919.806202907152, 13030.0, 8731.650733970824, 8823.250023748053, 8882.067382924959, 8897.866532001895, 8906.064863189531, 9619.422834629944, 9642.42145471274, 9645.855312170183, 9750.80498390014, 9772.169365604002, 8417.62120704582, 8430.36772242072, 8558.52928088961, 8646.048934617062, 8758.343124265833, 8264.669413223644, 8467.788305292417, 8482.830343393221, 8511.361647876558, 8622.353323500636, 7252.166000909963, 7325.560466372035, 7413.184549699637, 7423.331900128798, 7470.215627359049, 5612.8877422450505, 5687.374388817309, 5723.771049157987, 5765.0, 5864.530837533072, 5754.971225143848, 5820.185174075548, 5848.824535263949, 6091.238595175603, 6096.390360963868], "value": 5124.285678432698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.16735691831775, 413.7993073359422, 414.5357199936072, 417.2926888923274, 420.38623609530083, 5705.0, 5820.9126863097035, 5902.88194236115, 5947.405259474051, 5948.643081415113, 5683.209788916489, 5797.144913627641, 5805.303363596375, 5821.3305469870975, 5851.4148585141465, 4378.095528445137, 4478.552144785528, 4502.4371953505815, 4521.638268938494, 4525.275955847065, 4507.909841803162, 4509.368688383613, 4509.571590698894, 4515.254982927813, 4530.093981203756, 4473.2171869922795, 4479.820807167709, 4482.327650852366, 4490.259107247317, 4504.536025791631, 4412.492563355223, 4480.865574032784, 4503.887402814923, 4509.880356232566, 4518.073794872076, 3931.6068393160454, 3933.9213215735526, 3941.3102707026155, 3950.249452603996, 3958.1885713428965, 5634.605577609569, 5652.943470565283, 5655.519280861132, 5670.5747068969995, 5692.0608099663505, 5129.5383415492415, 5226.660267082628, 5228.607854410934, 5240.161574148156, 5272.367315922113, 6099.420555047263, 6127.877442451126, 6142.464383904024, 6147.78482753106, 6165.506759459233, 4413.977930110361, 4420.977895110536, 4425.5353187915125, 4436.735530373828, 4439.400680908068, 6000.449808831273, 6213.502919766408, 6321.589096708745, 6407.13503677007, 6505.918106206016, 4335.393044973706, 4448.421705178371, 4448.733076015449, 4511.842085526991, 4543.4775000875325, 4578.404807375086, 4588.311753237042, 4596.4254468191475, 4598.701084429501, 4603.8618841434145, 5163.526528187002, 5225.425203227642, 5233.267342572043, 5238.71187084714, 5254.605904557174, 6145.754169833157, 6154.692265386713, 6182.1345011698395, 6192.473639740582, 6199.473044791153, 1568.7176308264393, 1582.9263664599412, 1594.6970075685583, 1595.840415958395, 1600.8079030516412, 1048.9929667519114, 1053.3100818963592, 1069.5775168808277, 1073.120041565924, 1090.51472094917, 5840.941590584125, 5841.4450627190345, 5844.824655260349, 5858.853528661817, 5889.8233053007625, 6334.461570766536, 6340.936590634127, 6361.491080713532, 6364.07720880479, 6373.968130159412, 5639.787445699194, 5763.0, 5809.767609295581, 5827.79602713903, 5860.736266867916, 3339.9499007514905, 3382.6109997350127, 3386.0519054664733, 3387.7628566000635, 3392.2028323343993, 6236.75052997875, 6550.870966935765, 6580.835479112965, 6607.867842643216, 6635.8009259722285, 6506.739730410825, 6528.771492997722, 6530.118434011442, 6537.0, 6547.607143571401, 6356.523260755369, 6538.057873956834, 6572.737090516422, 6573.0, 6586.0, 6323.525735569759, 6377.107204991212, 6378.649174295459, 6385.329540398191, 6401.455876250571, 6202.534809889186, 6315.96842015787, 6317.4630156437215, 6344.936550634435, 6360.173177486897, 6572.211334639683, 6596.901046484402, 6601.141851559267, 6613.107230523818, 6632.1709786276715, 4458.041521072855, 4466.4640243171025, 4475.865724028285, 4488.551144885485, 4493.528179541101, 6169.383061693795, 6345.1434056401795, 6392.712327945161, 6393.776217832354, 6399.7440102395385, 6177.301242158443, 6185.165002724574, 6229.5327850410495, 6232.719527621177, 6247.812565623039, 5906.438888305604, 6228.626282423069, 6235.501159907106, 6262.029385445263, 6272.937270627235, 6146.661933593696, 6188.164597779242, 6204.751809927552, 6215.906761398673, 6238.563300568917, 6203.937960620336, 6260.624362538262, 6279.560430769802, 6288.1135659302945, 6303.180586523723, 5962.850928726643, 6052.939470605237, 6081.878362432815, 6082.9695851520455, 6084.11780291864], "value": 4714.982324754606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.2510612795286, 658.2866674609792, 659.5745743995124, 676.2189670930078, 678.9626570538621, 14504.63738406539, 16605.750913736305, 16855.241514131863, 16958.152092395394, 16960.915195424022, 14251.790972399294, 14980.850191498082, 15678.451254206106, 15714.057156570614, 15731.92134039331, 791.8297566023318, 806.0086094104255, 807.9555624440653, 810.5339429827873, 811.4482152136545, 790.3716545346434, 814.242754238558, 820.729159377404, 828.7638023163399, 831.3764676492631, 702.5854745700036, 708.1325376413903, 710.5168485429906, 710.605613884294, 711.4166383565479, 694.3299715774302, 694.3854688600575, 698.6122701900443, 698.9545679530814, 702.1188408547266, 516.5273774496369, 521.2207749414612, 521.3014560488925, 523.9685618862881, 524.960627952905, 15400.537983860502, 15774.290156942965, 16756.916215418965, 16814.32742690291, 16836.07401592912, 15300.311485983157, 15519.767203491956, 15986.28061737213, 16256.674866502604, 16796.83203167965, 12338.629841104781, 12340.876591234062, 12548.0, 12583.622491325183, 12681.23912565249, 3047.3143542702937, 3078.7536997040406, 3103.5034394496997, 3213.212762873111, 3219.146926064595, 84308.57845710794, 86769.0, 87301.56349218277, 88348.55825720831, 88637.55681221616, 11137.443127843575, 11219.0, 11340.149488788375, 11406.942965285121, 11733.941330293464, 23049.078036878338, 23051.423714407272, 23138.884305578365, 23144.53710925772, 23149.074037038667, 6145.600535965148, 6200.751969921243, 6236.844078898064, 6389.648569328731, 6400.7119679614525, 3977.3636218204947, 4095.9795201023803, 4131.0, 4141.6065473779945, 4148.211839750437, 4196.706230563892, 4217.40956266123, 4272.252355837716, 4279.828806847691, 4288.228118938621, 747.4132805747462, 748.4050180106829, 756.6595032235516, 773.6673230510935, 784.4861615641764, 569.7977218087602, 579.5161040531119, 597.2444857255575, 606.1937622961451, 625.780976658166, 9603.327767056378, 9780.364276322016, 9887.357321774205, 9946.691130891928, 9974.293059125936, 530.4721801807226, 532.6351449257271, 553.914143307788, 555.6800358503233, 556.3879732294444, 4170.3514542076155, 4227.915441691149, 4450.154470650566, 4556.134334476439, 4567.543245675406, 75212.0, 75426.62286688531, 77596.61201694068, 78980.0, 80852.19147808565, 69701.0, 70641.29358706347, 71466.0, 71975.0, 72883.63558182282, 59961.700191499636, 61766.0, 61874.69062654658, 61886.0, 62289.377106229265, 8788.868166977372, 8893.977103036337, 9005.81988360216, 9083.636654533744, 9171.908280917105, 32002.83998579992, 32299.192520186243, 32568.837155814068, 33072.0, 33878.661213388536, 39262.41106383464, 39484.0, 39971.0, 40321.0, 41119.38320925129, 12179.391030448265, 12285.815712764137, 12381.876181238073, 12552.184108032949, 12837.037222208184, 11997.280163190237, 12088.637340879788, 12257.264564125824, 12532.561360352709, 12990.545330913372, 11601.941990289995, 11616.247196611013, 11722.648320550397, 11749.412529373669, 11932.463039163085, 12292.139550231397, 12399.628011159679, 12414.379281036092, 12432.316222607844, 12546.874531254936, 11167.218294719292, 11395.943020284845, 11581.710457238636, 11966.46150923193, 11977.0, 8248.876266856121, 8311.546570755301, 8519.148085191431, 8565.95717021411, 8581.313494920516, 8212.876806848022, 9363.719088427359, 9530.761730956505, 9557.330986830855, 9700.90299097], "value": 6728.747711223066, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 122.0, 157.0, 117.0, 117.0, 121.0, 121.0, 136.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 160.0, 162.0, 162.0, 163.0, 165.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 106.0, 74.0, 78.0, 73.0, 75.0, 95.0, 76.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 82.0, 82.0, 103.0, 83.0, 82.0, 101.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 95.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 58.0, 57.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 55.0, 55.0, 56.0, 54.0, 54.0, 54.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 83.0, 79.0, 87.0, 88.0, 81.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 129.0, 129.0, 136.0, 129.0, 125.0, 131.0, 171.0, 129.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 188.0, 185.0, 189.0, 189.0, 177.0, 186.0, 193.0, 185.0, 184.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 71.0], "value": 66.4, "unit": "score"}]}]} 11:46:33 INFO - Return code: 0 11:46:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:46:33 ERROR - # TBPL SUCCESS # 11:46:33 INFO - Running post-action listener: _resource_record_post_action 11:46:33 INFO - [mozharness: 2017-03-23 18:46:33.978231Z] Finished run-tests step (success) 11:46:33 INFO - Running post-run listener: _resource_record_post_run 11:46:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370319360; Read time: 16; Write time: 490636 11:46:34 INFO - TinderboxPrint: CPU usage
12.9% 11:46:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:46:34 INFO - TinderboxPrint: I/O write bytes / time
370,319,360 / 490,636 11:46:34 INFO - TinderboxPrint: CPU idle
8,312.9 (87.1%) 11:46:34 INFO - TinderboxPrint: CPU user
1,185.2 (12.4%) 11:46:34 INFO - TinderboxPrint: Swap in / out
0 / 0 11:46:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114663424; Read time: 0; Write time: 131260 11:46:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 255655936; Read time: 0; Write time: 359376 11:46:34 INFO - Running post-run listener: _upload_blobber_files 11:46:34 INFO - Blob upload gear active. 11:46:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:34 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 11:46:34 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'] 11:46:34 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 11:46:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:46:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:36 INFO - (blobuploader) - INFO - Done attempting. 11:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:39 INFO - (blobuploader) - INFO - Done attempting. 11:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:40 INFO - (blobuploader) - INFO - Done attempting. 11:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:40 INFO - (blobuploader) - INFO - Done attempting. 11:46:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:40 INFO - Return code: 0 11:46:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:46:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e7fe626a96f1eeb7559387b8181281cb07b3c63db43914b8c2d5ba49f45db0da4fa4fb7e8df5f9f2ec60e065538d3842520556fe9a22d406adb9a1edc1047b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7de15ced4842254486df4ccc2e5c15e90c1a8b41e2bab8168c95c2091d42dab4e82f76069b855b24078376c40baa7e79f62bfd65c344111cb16cbb26e071da15", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/590b1d4ae1e72bbd3efb86ec49917257cbfcbf28b9270d0551ca7ef61b62843d7b52f444b2d40e106fb1e2765e7b18e00efbf37667524a14e54542817a15ca62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62268948568467fa5df5f5fb402e897be72e0e9ece270286f2e4c6724a41687a26dc07ba0735eafc2ffb1be254c5da390444dadad2b8176546c5299de027a2df"} 11:46:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:46:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:46:40 INFO - Contents: 11:46:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e7fe626a96f1eeb7559387b8181281cb07b3c63db43914b8c2d5ba49f45db0da4fa4fb7e8df5f9f2ec60e065538d3842520556fe9a22d406adb9a1edc1047b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7de15ced4842254486df4ccc2e5c15e90c1a8b41e2bab8168c95c2091d42dab4e82f76069b855b24078376c40baa7e79f62bfd65c344111cb16cbb26e071da15", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/590b1d4ae1e72bbd3efb86ec49917257cbfcbf28b9270d0551ca7ef61b62843d7b52f444b2d40e106fb1e2765e7b18e00efbf37667524a14e54542817a15ca62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62268948568467fa5df5f5fb402e897be72e0e9ece270286f2e4c6724a41687a26dc07ba0735eafc2ffb1be254c5da390444dadad2b8176546c5299de027a2df"} 11:46:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:40 INFO - Copying logs to upload dir... 11:46:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:46:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.868829 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 11:46:41.024602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 11:46:41.027886) ========= 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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e7fe626a96f1eeb7559387b8181281cb07b3c63db43914b8c2d5ba49f45db0da4fa4fb7e8df5f9f2ec60e065538d3842520556fe9a22d406adb9a1edc1047b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7de15ced4842254486df4ccc2e5c15e90c1a8b41e2bab8168c95c2091d42dab4e82f76069b855b24078376c40baa7e79f62bfd65c344111cb16cbb26e071da15", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/590b1d4ae1e72bbd3efb86ec49917257cbfcbf28b9270d0551ca7ef61b62843d7b52f444b2d40e106fb1e2765e7b18e00efbf37667524a14e54542817a15ca62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62268948568467fa5df5f5fb402e897be72e0e9ece270286f2e4c6724a41687a26dc07ba0735eafc2ffb1be254c5da390444dadad2b8176546c5299de027a2df"} build_url:https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/X9l3OtrWT7u7gafyCBgssg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e7fe626a96f1eeb7559387b8181281cb07b3c63db43914b8c2d5ba49f45db0da4fa4fb7e8df5f9f2ec60e065538d3842520556fe9a22d406adb9a1edc1047b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7de15ced4842254486df4ccc2e5c15e90c1a8b41e2bab8168c95c2091d42dab4e82f76069b855b24078376c40baa7e79f62bfd65c344111cb16cbb26e071da15", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/590b1d4ae1e72bbd3efb86ec49917257cbfcbf28b9270d0551ca7ef61b62843d7b52f444b2d40e106fb1e2765e7b18e00efbf37667524a14e54542817a15ca62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62268948568467fa5df5f5fb402e897be72e0e9ece270286f2e4c6724a41687a26dc07ba0735eafc2ffb1be254c5da390444dadad2b8176546c5299de027a2df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 11:46:41.053197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:46:41.053526) ========= 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=745a4373a2a16df560f216e000000264-1490293537.225690-437163732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 11:46:41.136798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 11:46:41.137122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 11:46:41.137532) ========= ========= Total master_lag: 0.18 =========