builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1490403348.54 results: success (0) revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.541941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.542402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.542675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.557821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.558211) ========= 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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-24 17:55:49-- 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% 24.5M=0s 2017-03-24 17:55:49 (24.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.344492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.916753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.917093) ========= 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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014025 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:48.967099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 17:55:48.967469) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --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 f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-24 17:55:49,471 truncating revision to first 12 chars 2017-03-24 17:55:49,471 Setting DEBUG logging. 2017-03-24 17:55:49,472 attempt 1/10 2017-03-24 17:55:49,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9acfdca68a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 17:55:50,904 unpacking tar archive at: mozilla-central-f9acfdca68a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.800900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 17:55:50.781863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:50.782195) ========= script_repo_revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:50.782554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:50.782816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 17:55:50.792546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-24 17:55:50.792977) ========= /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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:51 INFO - MultiFileLogger online at 20170324 17:55:51 in /builds/slave/test 17:55:51 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 17:55:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:51 INFO - {'append_to_log': False, 17:55:51 INFO - 'base_work_dir': '/builds/slave/test', 17:55:51 INFO - 'blob_upload_branch': 'Firefox', 17:55:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:51 INFO - 'branch': 'Firefox', 17:55:51 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:51 INFO - 'config_files': ('talos/linux_config.py',), 17:55:51 INFO - 'default_actions': ('clobber', 17:55:51 INFO - 'read-buildbot-config', 17:55:51 INFO - 'download-and-extract', 17:55:51 INFO - 'populate-webroot', 17:55:51 INFO - 'create-virtualenv', 17:55:51 INFO - 'install', 17:55:51 INFO - 'run-tests'), 17:55:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:51 INFO - 'download_minidump_stackwalk': True, 17:55:51 INFO - 'download_symbols': 'ondemand', 17:55:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:51 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:51 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:51 INFO - 'gecko_profile': False, 17:55:51 INFO - 'gecko_profile_interval': 0, 17:55:51 INFO - 'installer_path': 'installer.exe', 17:55:51 INFO - 'log_level': 'info', 17:55:51 INFO - 'log_name': 'talos', 17:55:51 INFO - 'log_to_console': True, 17:55:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:51 INFO - 'opt_config_files': (), 17:55:51 INFO - 'pip_index': False, 17:55:51 INFO - 'suite': 'dromaeojs', 17:55:51 INFO - 'system_bits': '32', 17:55:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:51 INFO - 'title': 'talos-linux64-ix-002', 17:55:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:51 INFO - 'use_talos_json': True, 17:55:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:51 INFO - 'work_dir': 'build'} 17:55:51 INFO - [mozharness: 2017-03-25 00:55:51.388711Z] Running clobber step. 17:55:51 INFO - Running pre-action listener: _resource_record_pre_action 17:55:51 INFO - Running main action method: clobber 17:55:51 INFO - rmtree: /builds/slave/test/build 17:55:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:52 INFO - Running post-action listener: _resource_record_post_action 17:55:52 INFO - [mozharness: 2017-03-25 00:55:52.444997Z] Finished clobber step (success) 17:55:52 INFO - [mozharness: 2017-03-25 00:55:52.445098Z] Running read-buildbot-config step. 17:55:52 INFO - Running pre-action listener: _resource_record_pre_action 17:55:52 INFO - Running main action method: read_buildbot_config 17:55:52 INFO - Using buildbot properties: 17:55:52 INFO - { 17:55:52 INFO - "project": "", 17:55:52 INFO - "product": "firefox", 17:55:52 INFO - "who": "kwierso@gmail.com", 17:55:52 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:55:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:55:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 17:55:52 INFO - "stage_platform": "linux64-pgo", 17:55:52 INFO - "basedir": "/builds/slave/test", 17:55:52 INFO - "buildnumber": 94, 17:55:52 INFO - "platform": "ubuntu64_hw", 17:55:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:55:52 INFO - "slavebuilddir": "test", 17:55:52 INFO - "taskId": "Rm52lrSERcmZyjWtr2bx4Q", 17:55:52 INFO - "branch": "mozilla-central", 17:55:52 INFO - "script_repo_revision": "production", 17:55:52 INFO - "revision": "f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3", 17:55:52 INFO - "slavename": "talos-linux64-ix-002", 17:55:52 INFO - "repo_path": "mozilla-central" 17:55:52 INFO - } 17:55:52 INFO - Finding installer, test and symbols from parent task. 17:55:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm52lrSERcmZyjWtr2bx4Q'}, attempt #1 17:55:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm52lrSERcmZyjWtr2bx4Q'}, attempt #1 17:55:53 INFO - Task dependencies: eHLX15FISYq77Kt-IEwxug 17:55:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug'}, attempt #1 17:55:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 17:55:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/test_packages.json 17:55:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.crashreporter-symbols.zip 17:55:53 INFO - Running post-action listener: _resource_record_post_action 17:55:53 INFO - [mozharness: 2017-03-25 00:55:53.821568Z] Finished read-buildbot-config step (success) 17:55:53 INFO - [mozharness: 2017-03-25 00:55:53.821787Z] Running download-and-extract step. 17:55:53 INFO - Running pre-action listener: _resource_record_pre_action 17:55:53 INFO - Running main action method: download_and_extract 17:55:53 INFO - mkdir: /builds/slave/test/build/tests 17:55:53 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')]} 17:55:53 INFO - trying https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.test_packages.json 17:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:55:54 INFO - Downloaded 986 bytes. 17:55:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:55:54 INFO - Using the following test package requirements: 17:55:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:55:54 INFO - u'common': [u'target.common.tests.zip'], 17:55:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:55:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:55:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:55:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:55:54 INFO - u'mozbase': [u'target.common.tests.zip'], 17:55:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:55:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:55:54 INFO - u'web-platform': [u'target.common.tests.zip', 17:55:54 INFO - u'target.web-platform.tests.zip'], 17:55:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:55:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip 17:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip into memory 17:55:55 INFO - Expected file size: 60251953 17:55:55 INFO - Obtained file size: 60251953 17:56:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:56:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip 17:56:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:05 INFO - Fetch https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.common.tests.zip into memory 17:56:06 INFO - Expected file size: 60251953 17:56:06 INFO - Obtained file size: 60251953 17:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.talos.tests.zip 17:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.talos.tests.zip into memory 17:56:18 INFO - Expected file size: 14404171 17:56:18 INFO - Obtained file size: 14404171 17:56:19 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')]} 17:56:19 INFO - trying https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 17:56:19 INFO - Downloading https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:56:20 INFO - Downloaded 68044719 bytes. 17:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 17:56:20 INFO - mkdir: /builds/slave/test/properties 17:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:20 INFO - Contents: 17:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - Running post-action listener: set_extra_try_arguments 17:56:20 INFO - [mozharness: 2017-03-25 00:56:20.257027Z] Finished download-and-extract step (success) 17:56:20 INFO - [mozharness: 2017-03-25 00:56:20.257123Z] Running populate-webroot step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running main action method: populate_webroot 17:56:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:56:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:56:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:56:20 INFO - '--tppagecycles', 17:56:20 INFO - '7'], 17:56:20 INFO - 'tests': ['tsvgm']}}, 17:56:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['damp', 'tps']}, 17:56:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'tests': ['damp', 'tps']}, 17:56:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['dromaeo_dom']}, 17:56:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['basic_compositor_video']}, 17:56:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:56:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['tsvgx', 17:56:20 INFO - 'tsvgr_opacity', 17:56:20 INFO - 'tart', 17:56:20 INFO - 'tscrollx', 17:56:20 INFO - 'cart', 17:56:20 INFO - 'tsvg_static']}, 17:56:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:20 INFO - 'tsvgr_opacity', 17:56:20 INFO - 'tart', 17:56:20 INFO - 'tscrollx', 17:56:20 INFO - 'cart', 17:56:20 INFO - 'tsvg_static']}, 17:56:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--disable-e10s'], 17:56:20 INFO - 'tests': ['tp5o']}, 17:56:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:56:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--disable-e10s', 17:56:20 INFO - '--xperf_path', 17:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:20 INFO - 'tests': ['tp5n']}, 17:56:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--xperf_path', 17:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:20 INFO - 'tests': ['tp5n']}}, 17:56:20 INFO - 'talos.zip': {'path': '', 17:56:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - [mozharness: 2017-03-25 00:56:20.270265Z] Finished populate-webroot step (success) 17:56:20 INFO - [mozharness: 2017-03-25 00:56:20.270355Z] Running create-virtualenv step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running main action method: create_virtualenv 17:56:20 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:20 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 17:56:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:20 INFO - Using real prefix '/usr' 17:56:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:20 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:22 INFO - Installing pip.................done. 17:56:22 INFO - Return code: 0 17:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:56:23 INFO - Reading from file tmpfile_stdout 17:56:23 INFO - Output received: 17:56:23 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) 17:56:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:23 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 17:56:23 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 17:56:23 INFO - Using env: {'DISPLAY': ':0', 17:56:23 INFO - 'HOME': '/home/cltbld', 17:56:23 INFO - 'LANG': 'en_US.UTF-8', 17:56:23 INFO - 'LANGUAGE': 'en_US:en', 17:56:23 INFO - 'LOGNAME': 'cltbld', 17:56:23 INFO - 'MAIL': '/var/mail/cltbld', 17:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:23 INFO - 'MOZ_NO_REMOTE': '1', 17:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:23 INFO - 'NO_EM_RESTART': '1', 17:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:23 INFO - 'PWD': '/builds/slave/test', 17:56:23 INFO - 'SHELL': '/bin/bash', 17:56:23 INFO - 'SHLVL': '1', 17:56:23 INFO - 'TERM': 'linux', 17:56:23 INFO - 'TMOUT': '86400', 17:56:23 INFO - 'USER': 'cltbld', 17:56:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:23 INFO - '_': '/tools/buildbot/bin/python'} 17:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:23 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 17:56:23 INFO - Cleaning up... 17:56:23 INFO - Return code: 0 17:56:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:23 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:23 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 17:56:23 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 17:56:23 INFO - Using env: {'DISPLAY': ':0', 17:56:23 INFO - 'HOME': '/home/cltbld', 17:56:23 INFO - 'LANG': 'en_US.UTF-8', 17:56:23 INFO - 'LANGUAGE': 'en_US:en', 17:56:23 INFO - 'LOGNAME': 'cltbld', 17:56:23 INFO - 'MAIL': '/var/mail/cltbld', 17:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:23 INFO - 'MOZ_NO_REMOTE': '1', 17:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:23 INFO - 'NO_EM_RESTART': '1', 17:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:23 INFO - 'PWD': '/builds/slave/test', 17:56:23 INFO - 'SHELL': '/bin/bash', 17:56:23 INFO - 'SHLVL': '1', 17:56:23 INFO - 'TERM': 'linux', 17:56:23 INFO - 'TMOUT': '86400', 17:56:23 INFO - 'USER': 'cltbld', 17:56:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:23 INFO - '_': '/tools/buildbot/bin/python'} 17:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:23 INFO - Downloading/unpacking psutil>=3.1.1 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:25 INFO - Installing collected packages: psutil 17:56:25 INFO - Running setup.py install for psutil 17:56:25 INFO - building 'psutil._psutil_linux' extension 17:56:25 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 17:56:25 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 17:56:25 INFO - building 'psutil._psutil_posix' extension 17:56:25 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 17:56:26 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 17:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:26 INFO - Successfully installed psutil 17:56:26 INFO - Cleaning up... 17:56:26 INFO - Return code: 0 17:56:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:56:26 INFO - Using env: {'DISPLAY': ':0', 17:56:26 INFO - 'HOME': '/home/cltbld', 17:56:26 INFO - 'LANG': 'en_US.UTF-8', 17:56:26 INFO - 'LANGUAGE': 'en_US:en', 17:56:26 INFO - 'LOGNAME': 'cltbld', 17:56:26 INFO - 'MAIL': '/var/mail/cltbld', 17:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:26 INFO - 'MOZ_NO_REMOTE': '1', 17:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:26 INFO - 'NO_EM_RESTART': '1', 17:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:26 INFO - 'PWD': '/builds/slave/test', 17:56:26 INFO - 'SHELL': '/bin/bash', 17:56:26 INFO - 'SHLVL': '1', 17:56:26 INFO - 'TERM': 'linux', 17:56:26 INFO - 'TMOUT': '86400', 17:56:26 INFO - 'USER': 'cltbld', 17:56:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:26 INFO - '_': '/tools/buildbot/bin/python'} 17:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:26 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 17:56:26 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 17:56:26 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 17:56:26 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 17:56:26 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 17:56:26 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 17:56:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:28 INFO - Installing collected packages: mozsystemmonitor 17:56:28 INFO - Running setup.py install for mozsystemmonitor 17:56:28 INFO - Successfully installed mozsystemmonitor 17:56:28 INFO - Cleaning up... 17:56:28 INFO - Return code: 0 17:56:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:28 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:28 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 17:56:28 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 17:56:28 INFO - Using env: {'DISPLAY': ':0', 17:56:28 INFO - 'HOME': '/home/cltbld', 17:56:28 INFO - 'LANG': 'en_US.UTF-8', 17:56:28 INFO - 'LANGUAGE': 'en_US:en', 17:56:28 INFO - 'LOGNAME': 'cltbld', 17:56:28 INFO - 'MAIL': '/var/mail/cltbld', 17:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:28 INFO - 'MOZ_NO_REMOTE': '1', 17:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:28 INFO - 'NO_EM_RESTART': '1', 17:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:28 INFO - 'PWD': '/builds/slave/test', 17:56:28 INFO - 'SHELL': '/bin/bash', 17:56:28 INFO - 'SHLVL': '1', 17:56:28 INFO - 'TERM': 'linux', 17:56:28 INFO - 'TMOUT': '86400', 17:56:28 INFO - 'USER': 'cltbld', 17:56:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:28 INFO - '_': '/tools/buildbot/bin/python'} 17:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:28 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 17:56:28 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 17:56:28 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 17:56:28 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 17:56:28 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 17:56:28 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 17:56:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:31 INFO - warning: no files found matching '*.txt' 17:56:31 INFO - no previously-included directories found matching 'build' 17:56:31 INFO - no previously-included directories found matching 'dist' 17:56:31 INFO - no previously-included directories found matching '.git*' 17:56:31 INFO - Installing collected packages: jsonschema, functools32 17:56:31 INFO - Running setup.py install for functools32 17:56:31 INFO - warning: no files found matching '*.txt' 17:56:31 INFO - no previously-included directories found matching 'build' 17:56:31 INFO - no previously-included directories found matching 'dist' 17:56:31 INFO - no previously-included directories found matching '.git*' 17:56:31 INFO - Successfully installed jsonschema functools32 17:56:31 INFO - Cleaning up... 17:56:31 INFO - Return code: 0 17:56:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:31 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 17:56:31 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 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:31 INFO - Cleaning up... 17:56:31 INFO - Return code: 0 17:56:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:31 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:31 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 17:56:31 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 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:31 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 17:56:31 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 17:56:31 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 17:56:31 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 17:56:31 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 17:56:31 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 17:56:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:33 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 17:56:33 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 17:56:33 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 17:56:33 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 17:56:33 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 17:56:33 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 17:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:34 INFO - Downloading docopt-0.6.1.tar.gz 17:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:34 INFO - Running setup.py install for blobuploader 17:56:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:34 INFO - Running setup.py install for requests 17:56:35 INFO - Running setup.py install for docopt 17:56:35 INFO - Successfully installed blobuploader requests docopt 17:56:35 INFO - Cleaning up... 17:56:35 INFO - Return code: 0 17:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:35 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:35 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 17:56:35 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 17:56:35 INFO - Using env: {'DISPLAY': ':0', 17:56:35 INFO - 'HOME': '/home/cltbld', 17:56:35 INFO - 'LANG': 'en_US.UTF-8', 17:56:35 INFO - 'LANGUAGE': 'en_US:en', 17:56:35 INFO - 'LOGNAME': 'cltbld', 17:56:35 INFO - 'MAIL': '/var/mail/cltbld', 17:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:35 INFO - 'MOZ_NO_REMOTE': '1', 17:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:35 INFO - 'NO_EM_RESTART': '1', 17:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:35 INFO - 'PWD': '/builds/slave/test', 17:56:35 INFO - 'SHELL': '/bin/bash', 17:56:35 INFO - 'SHLVL': '1', 17:56:35 INFO - 'TERM': 'linux', 17:56:35 INFO - 'TMOUT': '86400', 17:56:35 INFO - 'USER': 'cltbld', 17:56:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:35 INFO - '_': '/tools/buildbot/bin/python'} 17:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:35 INFO - Running setup.py (path:/tmp/pip-WKgUP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:35 INFO - Running setup.py (path:/tmp/pip-ijptmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:35 INFO - Running setup.py (path:/tmp/pip-Z4vFdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:35 INFO - Running setup.py (path:/tmp/pip-dEF7sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:35 INFO - Running setup.py (path:/tmp/pip-fIhdWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:35 INFO - Running setup.py (path:/tmp/pip-XyRp8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:35 INFO - Running setup.py (path:/tmp/pip-MLNmtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:35 INFO - Running setup.py (path:/tmp/pip-kBnR3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:35 INFO - Running setup.py (path:/tmp/pip-2rBle4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:36 INFO - Running setup.py (path:/tmp/pip-u2w5ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:36 INFO - Running setup.py (path:/tmp/pip-aPxDWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:36 INFO - Running setup.py (path:/tmp/pip-hWgJvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:36 INFO - Running setup.py (path:/tmp/pip-Xqma2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:36 INFO - Running setup.py (path:/tmp/pip-yoZZBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:36 INFO - Running setup.py (path:/tmp/pip-WxVWjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:36 INFO - Running setup.py (path:/tmp/pip-CSTW3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:36 INFO - Running setup.py (path:/tmp/pip-e2Rwmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:36 INFO - Running setup.py install for manifestparser 17:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:36 INFO - Running setup.py install for mozcrash 17:56:36 INFO - Running setup.py install for mozdebug 17:56:36 INFO - Running setup.py install for mozdevice 17:56:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:36 INFO - Running setup.py install for mozfile 17:56:37 INFO - Running setup.py install for mozhttpd 17:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for mozinfo 17:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for mozInstall 17:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for mozleak 17:56:37 INFO - Running setup.py install for mozlog 17:56:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for moznetwork 17:56:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for mozprocess 17:56:37 INFO - Running setup.py install for mozprofile 17:56:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:37 INFO - Running setup.py install for mozrunner 17:56:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:38 INFO - Running setup.py install for mozscreenshot 17:56:38 INFO - Running setup.py install for moztest 17:56:38 INFO - Running setup.py install for mozversion 17:56:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:38 INFO - Cleaning up... 17:56:38 INFO - Return code: 0 17:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:38 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:38 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 17:56:38 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 17:56:38 INFO - Using env: {'DISPLAY': ':0', 17:56:38 INFO - 'HOME': '/home/cltbld', 17:56:38 INFO - 'LANG': 'en_US.UTF-8', 17:56:38 INFO - 'LANGUAGE': 'en_US:en', 17:56:38 INFO - 'LOGNAME': 'cltbld', 17:56:38 INFO - 'MAIL': '/var/mail/cltbld', 17:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:38 INFO - 'MOZ_NO_REMOTE': '1', 17:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:38 INFO - 'NO_EM_RESTART': '1', 17:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:38 INFO - 'PWD': '/builds/slave/test', 17:56:38 INFO - 'SHELL': '/bin/bash', 17:56:38 INFO - 'SHLVL': '1', 17:56:38 INFO - 'TERM': 'linux', 17:56:38 INFO - 'TMOUT': '86400', 17:56:38 INFO - 'USER': 'cltbld', 17:56:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:38 INFO - '_': '/tools/buildbot/bin/python'} 17:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:38 INFO - Running setup.py (path:/tmp/pip-zQoGBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:38 INFO - Running setup.py (path:/tmp/pip-8vZml9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:38 INFO - Running setup.py (path:/tmp/pip-C8YMKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:38 INFO - Running setup.py (path:/tmp/pip-3YJK_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:38 INFO - Running setup.py (path:/tmp/pip-CYA7El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:38 INFO - Running setup.py (path:/tmp/pip-2PkpkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:38 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)) 17:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:39 INFO - Running setup.py (path:/tmp/pip-DInuIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:39 INFO - Running setup.py (path:/tmp/pip-JnVkgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:39 INFO - Running setup.py (path:/tmp/pip-XTP9dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:39 INFO - Running setup.py (path:/tmp/pip-b_zS3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:39 INFO - Running setup.py (path:/tmp/pip-yBD6DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:39 INFO - Running setup.py (path:/tmp/pip-BeuWFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:39 INFO - Running setup.py (path:/tmp/pip-qSpzX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:39 INFO - Running setup.py (path:/tmp/pip-Uw6YWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:39 INFO - Running setup.py (path:/tmp/pip-nFB932-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:39 INFO - Running setup.py (path:/tmp/pip-NWZgi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:39 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)) 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:39 INFO - Running setup.py (path:/tmp/pip-hL745U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:39 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)) 17:56:39 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)) 17:56:39 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)) 17:56:39 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)) 17:56:39 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)) 17:56:39 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)) 17:56:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:39 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 17:56:41 INFO - Downloading blessings-1.6.tar.gz 17:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:41 INFO - Installing collected packages: blessings 17:56:41 INFO - Running setup.py install for blessings 17:56:41 INFO - Successfully installed blessings 17:56:41 INFO - Cleaning up... 17:56:42 INFO - Return code: 0 17:56:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:42 INFO - Reading from file tmpfile_stdout 17:56:42 INFO - Current package versions: 17:56:42 INFO - argparse == 1.2.1 17:56:42 INFO - blessings == 1.6 17:56:42 INFO - blobuploader == 1.2.4 17:56:42 INFO - docopt == 0.6.1 17:56:42 INFO - functools32 == 3.2.3-2 17:56:42 INFO - jsonschema == 2.5.1 17:56:42 INFO - manifestparser == 1.1 17:56:42 INFO - mozInstall == 1.12 17:56:42 INFO - mozcrash == 1.0 17:56:42 INFO - mozdebug == 0.1 17:56:42 INFO - mozdevice == 0.49 17:56:42 INFO - mozfile == 1.2 17:56:42 INFO - mozhttpd == 0.7 17:56:42 INFO - mozinfo == 0.9 17:56:42 INFO - mozleak == 0.1 17:56:42 INFO - mozlog == 3.4 17:56:42 INFO - moznetwork == 0.27 17:56:42 INFO - mozprocess == 0.25 17:56:42 INFO - mozprofile == 0.28 17:56:42 INFO - mozrunner == 6.13 17:56:42 INFO - mozscreenshot == 0.1 17:56:42 INFO - mozsystemmonitor == 0.3 17:56:42 INFO - moztest == 0.8 17:56:42 INFO - mozversion == 1.4 17:56:42 INFO - psutil == 3.1.1 17:56:42 INFO - requests == 1.2.3 17:56:42 INFO - wsgiref == 0.1.2 17:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:42 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:42 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 17:56:42 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 17:56:42 INFO - Using env: {'DISPLAY': ':0', 17:56:42 INFO - 'HOME': '/home/cltbld', 17:56:42 INFO - 'LANG': 'en_US.UTF-8', 17:56:42 INFO - 'LANGUAGE': 'en_US:en', 17:56:42 INFO - 'LOGNAME': 'cltbld', 17:56:42 INFO - 'MAIL': '/var/mail/cltbld', 17:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:42 INFO - 'MOZ_NO_REMOTE': '1', 17:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:42 INFO - 'NO_EM_RESTART': '1', 17:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:42 INFO - 'PWD': '/builds/slave/test', 17:56:42 INFO - 'SHELL': '/bin/bash', 17:56:42 INFO - 'SHLVL': '1', 17:56:42 INFO - 'TERM': 'linux', 17:56:42 INFO - 'TMOUT': '86400', 17:56:42 INFO - 'USER': 'cltbld', 17:56:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:42 INFO - '_': '/tools/buildbot/bin/python'} 17:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 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)) 17:56:42 INFO - Cleaning up... 17:56:42 INFO - Return code: 0 17:56:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56: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')]} 17:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:42 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 0xec01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, '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': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', '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 17:56:42 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 17:56:42 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 17:56:42 INFO - Using env: {'DISPLAY': ':0', 17:56:42 INFO - 'HOME': '/home/cltbld', 17:56:42 INFO - 'LANG': 'en_US.UTF-8', 17:56:42 INFO - 'LANGUAGE': 'en_US:en', 17:56:42 INFO - 'LOGNAME': 'cltbld', 17:56:42 INFO - 'MAIL': '/var/mail/cltbld', 17:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:42 INFO - 'MOZ_NO_REMOTE': '1', 17:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:42 INFO - 'NO_EM_RESTART': '1', 17:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:42 INFO - 'PWD': '/builds/slave/test', 17:56:42 INFO - 'SHELL': '/bin/bash', 17:56:42 INFO - 'SHLVL': '1', 17:56:42 INFO - 'TERM': 'linux', 17:56:42 INFO - 'TMOUT': '86400', 17:56:42 INFO - 'USER': 'cltbld', 17:56:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:42 INFO - '_': '/tools/buildbot/bin/python'} 17:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:42 INFO - Cleaning up... 17:56:42 INFO - Return code: 0 17:56:42 INFO - Running post-action listener: _resource_record_post_action 17:56:42 INFO - Running post-action listener: _start_resource_monitoring 17:56:42 INFO - Starting resource monitoring. 17:56:42 INFO - [mozharness: 2017-03-25 00:56:42.774613Z] Finished create-virtualenv step (success) 17:56:42 INFO - [mozharness: 2017-03-25 00:56:42.775129Z] Running install step. 17:56:42 INFO - Running pre-action listener: _resource_record_pre_action 17:56:42 INFO - Running main action method: install 17:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:42 INFO - Reading from file tmpfile_stdout 17:56:42 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:43 INFO - Reading from file tmpfile_stdout 17:56:43 INFO - Output received: 17:56:43 INFO - Usage: mozinstall [options] installer 17:56:43 INFO - Options: 17:56:43 INFO - -h, --help show this help message and exit 17:56:43 INFO - -d DEST, --destination=DEST 17:56:43 INFO - Directory to install application into. [default: 17:56:43 INFO - "/builds/slave/test"] 17:56:43 INFO - --app=APP Application being installed. [default: firefox] 17:56:43 INFO - mkdir: /builds/slave/test/build/application 17:56:43 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'] 17:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:57:00 INFO - Reading from file tmpfile_stdout 17:57:00 INFO - Output received: 17:57:00 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:00 INFO - Running post-action listener: _resource_record_post_action 17:57:00 INFO - [mozharness: 2017-03-25 00:57:00.002562Z] Finished install step (success) 17:57:00 INFO - [mozharness: 2017-03-25 00:57:00.002902Z] Running run-tests step. 17:57:00 INFO - Running pre-action listener: _resource_record_pre_action 17:57:00 INFO - Running main action method: run_tests 17:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:00 INFO - Python 2.7.3 17:57:00 INFO - Return code: 0 17:57:00 INFO - grabbing minidump binary from tooltool 17:57:00 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')]} 17:57:00 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 0x115b400>, '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 0x115c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115c840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:00 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 17:57:00 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 17:57:00 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 17:57:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:00 INFO - Return code: 0 17:57:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:00 INFO - ENV: RUST_BACKTRACE is now 1 17:57:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:00 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/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:57:00 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/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 17:57:00 INFO - Using env: {'DISPLAY': ':0', 17:57:00 INFO - 'HOME': '/home/cltbld', 17:57:00 INFO - 'LANG': 'en_US.UTF-8', 17:57:00 INFO - 'LANGUAGE': 'en_US:en', 17:57:00 INFO - 'LOGNAME': 'cltbld', 17:57:00 INFO - 'MAIL': '/var/mail/cltbld', 17:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:00 INFO - 'MOZ_NO_REMOTE': '1', 17:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:00 INFO - 'NO_EM_RESTART': '1', 17:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:00 INFO - 'PWD': '/builds/slave/test', 17:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:00 INFO - 'RUST_BACKTRACE': '1', 17:57:00 INFO - 'SHELL': '/bin/bash', 17:57:00 INFO - 'SHLVL': '1', 17:57:00 INFO - 'TERM': 'linux', 17:57:00 INFO - 'TMOUT': '86400', 17:57:00 INFO - 'USER': 'cltbld', 17:57:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307', 17:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:00 INFO - '_': '/tools/buildbot/bin/python'} 17:57:00 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/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:57:00 INFO - mozversion application_buildid: 20170325000333 17:57:00 INFO - mozversion application_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 17:57:00 INFO - mozversion application_display_name: Nightly 17:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:00 INFO - mozversion application_name: Firefox 17:57:00 INFO - mozversion application_remotingname: firefox 17:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:57:00 INFO - mozversion application_vendor: Mozilla 17:57:00 INFO - mozversion application_version: 55.0a1 17:57:00 INFO - mozversion platform_buildid: 20170325000333 17:57:00 INFO - mozversion platform_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 17:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:57:00 INFO - mozversion platform_version: 55.0a1 17:57:00 INFO - using testdate: 1490403420 17:57:00 INFO - actual date: 1490403420 17:57:00 INFO - starting webserver on 'localhost:47016' 17:57:00 INFO - SUITE-START | Running 2 tests 17:57:00 INFO - TEST-START | dromaeo_css 17:57:00 INFO - operating with platform_type : linux_ 17:57:00 INFO - Initialising browser for dromaeo_css test... 17:57:00 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsC4a4/profile http://localhost:47016/getInfo.html) 17:57:04 INFO - PID 2197 | __metrics Screen width/height:1600/1200 17:57:04 INFO - PID 2197 | colorDepth:24 17:57:04 INFO - PID 2197 | Browser inner width/height: 1024/697 17:57:04 INFO - PID 2197 | __metrics 17:57:05 INFO - PID 2197 | 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" 17:57:05 INFO - PID 2197 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:57:06 INFO - TEST-INFO | 2197: exit 0 17:57:06 INFO - Browser initialized. 17:57:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:06 INFO - TEST-INFO | started process 2293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsC4a4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:18 INFO - PID 2293 | RSS: Main: 145534976 17:57:18 INFO - PID 2293 | 18:00:20 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47016/tests/dromaeo/cssquery-ext.html) 18:00:22 INFO - PID 2293 | RSS: Main: 247570432 18:00:22 INFO - PID 2293 | 18:02:07 INFO - PID 2293 | ************************* 18:02:07 INFO - PID 2293 | A coding exception was thrown and uncaught in a Task. 18:02:07 INFO - PID 2293 | 18:02:07 ERROR - PID 2293 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:02:07 INFO - PID 2293 | Full stack: 18:02:07 INFO - PID 2293 | ************************* 18:03:24 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-ext.html (next: http://localhost:47016/tests/dromaeo/cssquery-jquery.html) 18:03:25 INFO - PID 2293 | RSS: Main: 237412352 18:03:25 INFO - PID 2293 | 18:06:27 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47016/tests/dromaeo/cssquery-mootools.html) 18:06:27 INFO - PID 2293 | RSS: Main: 176631808 18:06:27 INFO - PID 2293 | 18:09:29 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47016/tests/dromaeo/cssquery-prototype.html) 18:09:30 INFO - PID 2293 | RSS: Main: 177004544 18:09:30 INFO - PID 2293 | 18:12:33 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47016/tests/dromaeo/cssquery-yui.html) 18:12:33 INFO - PID 2293 | RSS: Main: 181760000 18:12:33 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | Cycle 1(1): loaded http://localhost:47016/tests/dromaeo/cssquery-yui.html (next: http://localhost:47016/tests/dromaeo/cssquery-dojo.html) 18:15:36 INFO - PID 2293 | RSS: Main: 279506944 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | __start_tp_report 18:15:36 INFO - PID 2293 | _x_x_mozilla_page_load 18:15:36 INFO - PID 2293 | _x_x_mozilla_page_load_details 18:15:36 INFO - PID 2293 | |i|pagename|runs| 18:15:36 INFO - PID 2293 | |0;dojo.html;3316.253842885351;3329.4007078725836;3351.363240984211;3358.680925312095;3380.66193380662;5576.581756368279;5713.257276554053;5743.253377060982;5784.132380142975;5787.421257874215;5662.235598194243;5709.942900570993;5719.19931209631;5731.340895796985;5750.424957504248;5049.621278404116;5111.514406131411;5140.640155189139;5162.896742065156;5188.11801993662;5166.689998600096;5229.084910140729;5231.032259032091;5240.79036838526;5277.234800953859;5050.545450909436;5096.923546146811;5100.795968161269;5119.87200319995;5139.640225184238;5160.8967820643375;5186.325777648919;5188.040212560688;5192.71440070796;5213.4004589472315;5057.165567681328;5112.335396398445;5113.642045056848;5126.2054381570915;5128.589712822965;5679.233303504016;5698.202251684767;5701.287339082614;5707.200991861143;5733.684647344395;6033.879322413527;6045.939540604581;6060.030395136757;6104.830217171004;6154.26148862135;6133.1106989486725;6161.106639537242;6161.229846269216;6163.198784158076;6164.815055548341;5685.0619647758485;5687.459691329317;5732.426757324318;5736.196932429463;5786.363500014995;6091.456100873274;6161.921663708833;6216.129741836146;6227.314995350508;6231.158793562901;6003.3996600339615;6030.638161710312;6085.604435711664;6093.908591371133;6098.512119030467;6174.320824709278;6180.845478862974;6182.536309776785;6187.041008643668;6198.504119670415;6008.789692360834;6089.060601836121;6099.980162666156;6139.907901381483;6140.478059364915;5945.40545945402;5960.225170727865;6062.545309101835;6101.359357267512;6111.908321375183;4703.764811759398;4711.175544279738;4714.127886341038;4737.976310118427;4749.3588365570895;4177.394277829698;4183.163367326547;4186.979065104655;4201.7268877522865;4216.072464057902;5671.489565939085;5700.771969121189;5705.7147142643535;5799.768009279666;5804.825855224266;6128.479079278222;6130.642739936431;6180;6185.597936134227;6192.969035154795;5789.681567513827;5797.826065218051;5800.970995144998;5808.07070868659;5841.912371314434;5188.507091826271;5239.816606418757;5240.475952404805;5241.135212689864;5243.056249874983;6230.50155987529;6258.15514905491;6285.811425657238;6312.873742525216;6320.747170113236;6068.7269072892705;6248.094026366242;6265.906011409924;6266.310705822265;6271.404216599416;6215;6232.439080482778;6307.842303942438;6368.203974503187;6381.042843573501;6063.514918806573;6065.2418447694035;6066.211392518944;6072.1498990140535;6086.939130608815;6039.969800150971;6081.118237855575;6125.877482450415;6184.969075154595;6196.132541444292;5989.610675306266;6005.789797357072;6019.277686677627;6057.151998720271;6070;5985.311689155628;5995.490383317292;5999.820005399845;6005.129256257731;6007;5810.244668193108;5860.179574859609;5991.490723288569;5996.130561068708;5996.730147143302;5976.850578735566;5989.490893274121;6047.909281360871;6050.515958723379;6064.090386442069;5836.883262334814;5845.795397161249;5907.675077870758;5908.734106965111;5912.379200183918 18:15:36 INFO - PID 2293 | |1;ext.html;738.8780851159559;780.1418439716311;804.091376744279;1098.9175811814112;1111.1222134513735;29753.702462975365;30240.092797216064;30290.545641815334;30311.99999999997;30319;36384.818075909585;37173.62826371736;37302.44046339307;37313;37323.44014839779;8008.479448835822;8357.289630381425;8358;8359.916400835975;8364.498130112182;5947.524198064145;6049.909251361233;7865.174156713549;8180.263776260135;8315.875261871046;8123.065847427532;8176.754697359059;8181.304589109903;8185.8362832743305;8187.058488273865;8050.879236811453;8250.5462199579;8287.668493260262;8319.542425166583;8326.167383261625;5841.240638716982;5921.940780592182;7816.491928024717;8161.102278749333;8223.629936652866;36390.63609363899;36645.63354366449;36813;36859;36873.63126368729;2937.6181096457326;2967.1988563087843;2971.628546431696;2978.7468065214266;2981.3142977115167;26616.33459163517;26724.599131013052;27025.1892443227;27105.1868443947;27446.862765686044;3518.454639530851;3579.329570143172;3634.582023067355;3653.214558869856;3666.9633303667156;206229;206885;206909;207053;207461;48160.27759583609;48167.51832481701;48193.277100843516;48504.5149548507;48552.5144748555;50568.24147637789;50911.490885091414;50954.23568646473;50979;50986;15226.619334516505;15444.5366639001;15470.5358839235;15479.845201548065;15480.148591827332;12515.937420312841;12524.937375313066;12527.18573292733;12531.122821402596;12534.373281336078;11237.920984617871;11421.486033128529;12598.181118227287;12971.481140754453;13409.932950335186;5204.635675502755;5333.919991200135;5345.786168553214;5386.13821788512;5450;1030.9432981186108;1034.0900007992918;1035.808375450544;1044.8902865199045;1052.952617132231;25180.87409562977;25701.228963131136;25803.74196258051;25815.483690326088;25845.483090338086;1126.5099681638515;1132.750794825137;1177.652592485219;1178.8467499225046;1189.7263629365295;12521.874781252252;13051.34743262833;13116.606501804961;13324.866751332556;13344;289249;291256;291912;291927;292096;53318.466815332125;53477;53492;53500.73249633727;53538.46461535335;1441.8990670652954;1457.9708405832037;1500.1674070890542;1507.77383392492;1516.2494565190082;23710.40723981845;24265.63601545943;24420.63369049501;24589.262322130366;24607.507849842546;39595.80202098971;39682;39692.603073968894;39757.80121099376;39775.403368950065;286781;286782;287345;288027;288038;32744.34511309808;33453.83273083619;33724.156896077795;33744;33806.49290260599;41443.37834932539;41698.58301416947;41754.791226044894;41880.3717944225;42908.35637465503;31590.684093158776;31648.683513165495;31747.36505269928;32068.35863282768;33098.5035224467;31689;31763.52354714635;31810.204744881565;32101.518477223326;32111;37226.255474890895;37391.43912841255;37582.81208594049;37965.81017094897;38066.80966595149;30177.547336790405;30441.238969025064;30989;31152.376952461276;31431.528527071656;24491.26526204217;25478.363040924127;25517.10690125837;25695.871520643024;25809.225723228334 18:15:36 INFO - PID 2293 | |2;jquery.html;403.8021369528932;423.6302539307048;433.5469434441007;439.46165946715274;441.562852775752;16610.501684949442;19704.507387315323;21182.57634847302;21374;21411.250606228805;21226.89386553069;21412.25057123001;21548.13807447704;21610.459738506546;21785.128594856225;4778.900852803858;5883.146943693173;6069.3930606939175;6070.96964515179;6085.904537183305;5890.941090589104;6021.518278537728;6030.125631783389;6031.155638210654;6036.667983260919;5902.203202567663;5975;5988.401159883999;5998.460138587527;6012.969935150318;5874.383189765077;5911;5915.1718759373725;5916.615419997686;5916.852078698024;5197.376314842243;5330.760115794798;5375.865603359908;5377.81177658784;5382.596305277119;25459.363515912064;25987.350316242246;26059.869700651565;26296.86851565749;26339.868300658374;2001.4796153000325;2010.6380851446734;2017.4149496645955;2023.2412845183057;2041.6631255842767;15327.233638318039;15946;16484;16556;16779.83220167795;1883.896385698786;1890.2816929566814;1899.582091939771;1913.4546654203625;1951.4633475794128;99471.50264248704;101677;102401;102881.48559257155;103635;10581.259311848251;12169.20900141488;12403.565875194325;12586.370681466073;12837.871621283854;14482.493112741004;14513.201773902536;14514.491992780202;14514.85485145135;14529.055611385225;7507.099148102263;7834.647440865061;8502.06477287498;8831.381803273838;8885.06706795777;8047.758567242875;8081.878771818428;8107.038630855291;8337.374696897758;8370.372222083368;7522.833960736095;7589.279018493235;7768.922310776933;7882.172371900868;8087.433879628369;2123.2886982860605;2195.890205489719;2247.4718441166315;2266.1275408967335;2275.806556442721;979.3829887171037;985.2413641496008;987.6395115782831;991.3853410885297;1006.6527048168371;20195.495112622302;20216.59566808685;20231.190752370036;20231.797682023287;20332.288369906983;1045.3675526306627;1051.085555566662;1053.9314944528735;1058.7776566921034;1065.9946700266448;10269.845952310721;10945.865556216462;11032.724181895517;11043.503042363112;11066.833997490045;581926;589842;613401;619726;625986;94752;95897.52051239839;101485;101911.4904425473;104128;1228.9385530723428;1235.5304984105983;1261.2243470265903;1282.0128501054137;1284.9357532123543;18201;18750.624987500447;19302.4209273722;20535.178592856715;20709;36075;38716.80641596774;40477.595224047385;42380.36429453499;47427.62861856824;55572.444275558344;56449.43550564606;57480.71259643675;58355.70822145862;63247.6837615809;9115.453072815651;9343.383852521305;9472.147506724428;9740.366876153028;9776.608935642495;13766.449342026206;14106.36521356562;14275.21486318221;14430.855691442952;14448.205348705922;11554.364509952033;12017.939910300393;12085.51657933708;12521;12731.55439559611;11012.669619911416;11486.253393529394;11502.654920352403;11698.2981021139;11862.822057669315;12654.367281636065;12720.554780582635;12917.870821291666;13217.867821321664;13469.528566500125;9321.30090243221;9330.673426430043;9416;9488.193503552275;9802;12302.384880756106;12414.937925310316;12649.430775614936;12688.809667854805;13192.406341714453 18:15:36 INFO - PID 2293 | |3;mootools.html;1311.4033114932706;1356.4980957045896;1373.99313003435;1389.3678376338767;1389.7776355783076;10304.175665946725;10673.786524269519;10677.039066484014;10693.091087257593;10706.19703522235;10480.947595262012;10499.68500944971;10796.946015269932;10804.837927431096;10815.35107893527;2307.273208939183;2338.2166974063707;2349.119080344871;2351.130081869702;2351.611984022643;2208.2823082498253;2330.2776139396756;2336.077249486452;2340.941476463085;2344.202970989863;1879.0886420086315;1922.9230830766753;1924.2303078768534;1928.6528424883516;1929.7008963610663;2226.4322597737555;2286.0969916882905;2291.0721157931066;2292.793648571628;2297.9655305170268;2262.8981695823563;2271.8750468724215;2278.4076140203665;2287.8627282363113;2291.255342013852;10427.843582346271;10554.788904221949;10637.989391007843;10666.786664266749;10666.893331066745;6137.171481849938;6328.936710632881;6372.235331760172;6386.13787138735;6399.968000159969;3642;3664.120611053355;3830.9233815323814;3845.730798844082;3856.3444214483325;1330.8003799430066;1384.813050238215;1398.1191849135082;1425.40845549097;1437.647776294804;15059.774103388458;15316.463923762614;15437.614059648486;15448.613784655474;15533.611659708598;5199.948000520022;5201.245819356248;5344.43883392246;5399.271098401744;5401.567874570025;11406.262497000826;11417.885821141848;11421.657350279505;11436.142289328167;11459.885401145882;6220.34686357935;6224.159738435344;6224.439800417894;6226.719797609027;6230.501559875199;5722.284714410699;5805.7387417566315;5814.796482123105;5859.062549991981;5934.13954976526;3897.6881849451975;4012.137390461065;4012.137390461065;4069.1658210066867;4145.502539695256;1225.4669218889633;1229.1273196030918;1232.3099064523894;1245.3275231374955;1246.3017566967594;696.4428457234294;830.0869044051495;845.6701886264361;848.5757121439281;864.3690106222493;6095.75616975316;6132;6142.938570614326;6277.466415354655;6423.03654451836;926.9582868770922;933.6218831373304;933.8412469880137;937.8358787212211;960.7406000379858;3882.262370149719;4028.2144981728284;4074.083331250445;4148.170365926827;4170.270202714512;13958.651033724034;14072.616097833841;14106.365213565414;14393.496227631982;14451.566453006426;13979.510717124851;14147.504837330644;14163.079399838978;14262.928685356506;14288.214148221947;10269.537870795832;10318.329308594917;10400.635977740743;10406.687799366031;10447.425391603383;6573.82114549269;6750.32496750321;6866.965665171642;6953.304669533209;6960.060391847238;12180.33008184523;12337.074719395901;12463.813042804184;12534.811977820158;12666.113372063866;12559.309237991998;12752.553660621834;12795.744085118431;12860.356982150668;12905.548305809252;9200.539973001458;9356.766080848034;9408.529573521433;9488.383255088396;9531.904680953101;10218.489075546342;10281.794364112826;10361.533730981973;10371.27401081917;10399.428031458343;8508.74473765788;8577.485350878967;8693.826123477369;8736.825263494822;8983.595738191927;8451.915480845359;8759.781005474913;8907.73276801697;8929.464232146092;8951.149640784115;7855.803604909923;7892.408069394934;8044.2760151586635;8047.1550487198;8053.959730201312;6117.296510901303;6159.1069294951085;6207.6275423474735;6235.844103897258;6308.14839996613;6110.541709371726;6139.938600614116;6151.292601350902;6274.247090349188;6280.5289603279025 18:15:36 INFO - PID 2293 | |4;prototype.html;411.7303166425991;411.900226395524;421.04212915616966;424.29143330637834;429.77651621156997;5975.551833612481;5977.4919131873785;5981.235535517022;5988.940110598893;5991.340952495222;5802.709864506779;5864.618799778012;5901.616394934326;5906.173135760986;5935.347111817697;4405.6475481961525;4535.818567257305;4540.97729511352;4544.2501987172245;4668.696534725241;4523.932141017887;4526.637868970491;4528.592426681598;4533.229351010336;4554.567316104964;4511.345854851044;4520.954790452086;4527.456705195381;4528.162289976349;4554.681172317939;4452.287633978548;4457.064016556511;4507.729536227804;4520.367148599166;4533.863984080483;3952.1502876881323;3960.5445373782095;3965.781881996489;3965.9008524786823;3981.7610943343493;5759.740811663485;5760.350238890115;5766.740496677618;5766.855828604276;5793.826185214451;5120.820771273025;5243.10867152585;5259.8422047338645;5267.631265811357;5291.920621190685;6214.875702485971;6215.533834962351;6222.782202622931;6243;6247.406496382836;4392.297232442826;4393.143337049277;4402.647788176938;4419.292913133915;4434.800433980478;6178.227721534809;6296.8665640184745;6415.967920160369;6524.380183882524;6550.344965503459;4396.824127034947;4466.419365482467;4510.323451482238;4520.52534483881;4527.818887244539;4567.200739870509;4585.9770701146945;4586.8165273388695;4589.816407343736;4602.539746025371;4908.735690765672;4973.602111831045;5256.737163141904;5262.947370526245;5278.261043453919;6220.160278362454;6270.623762574261;6271.811845644638;6285.271550323698;6286.787852139078;1569.3330334607747;1570.8900376973731;1581.897176683535;1586.4606033948512;1588.0709784776036;1046.1160319529986;1057.5558265528496;1059.9576016959236;1062.5006247063868;1077.6906059138184;6008.789692360747;6036.366181550874;6037.486813620803;6043.244594425697;6046.667433291212;6288.9056664150075;6426.164598602245;6426.264908474685;6447.161868957006;6449.129367535416;6000.129981152709;6025.457708806229;6035.577509574376;6050.818475445743;6064.878702426015;3402.1154499829727;3431.6225215226304;3432.2105915639545;3433.759636825398;3444.534987776618;6538.313477084837;6589.308122647053;6676.83307917306;6688.163979502562;6718.49611279156;6535;6557.672116394161;6561.245456772437;6568.737250510022;6591.802245932629;6388.776392826228;6742;6761.053452516651;6778.42383397397;6782.9321706783285;6443.935560644333;6451.483881289391;6464.159659244268;6474.838129046811;6485.124508191334;6086.178365920721;6354.23749150105;6377.202849643794;6382.074599183;6413.518986075969;6385.329540398191;6541.378569035934;6551.44312733423;6731.730730770911;6754.6622668865375;4465.709728867613;4478.641708663365;4489.371487991619;4497.2129877272;4505.189065968026;6318.273398559225;6403.391677790602;6416.358364163733;6428.678566071584;6443.194600674916;6203.503719702323;6248.937680594219;6271.498280137487;6272.905906411499;6298.905516417166;6222.502199823913;6240.157578726814;6257.468115210076;6262.15460912771;6265.624062556261;6050.606710563799;6198;6209.410106039919;6212.751489940351;6220.471259942956;6229.750809967551;6244.068135271601;6269.780557680459;6279.905801413074;6324.019776934582;5817.621854579439;6113.174721412553;6144.2319710036245;6150.661713605795;6153.107799369156 18:15:36 INFO - PID 2293 | |5;yui.html;694.1531331775233;706.2161001288572;717.5622870049269;743;757.8219118507146;15055.397784088636;15352.385904563818;15847.920760396197;16080.919595402007;16167.353305867751;14687;15057.472988445406;15248.00887942283;15578.766318505202;15671;803.6504120707497;829.5271695133777;833.3041910005153;833.6582001379436;833.9749807505784;822.4284122534841;829.3821103278066;843.7932706486889;848.4824257203101;848.5545088828353;862.7756783236372;863.6674880171116;863.7063398444527;866.2766589897411;881.5063564403922;874.8337815814975;875.934304927133;878.4026861734018;878.5124256037865;879.5118709116438;633.2907143998751;639.5746828359136;640.1486023588616;640.8782331357028;643.269888676351;16617.50147495577;16638.168091595493;16993.320267189298;17359.913200433915;17443.825561744346;14098.647533811634;15674;15893.443729469413;16171.83828161715;16587.087710175936;11585.305279052642;11867.703307417298;12018.69953251167;12297.3236471994;12324;3189.1548739584027;3235.466148085563;3277.2789986202997;3290.851911663957;3356.865725370982;85735;87848.56075719645;88187.55906220428;89332.10667893302;91091.54454227752;11819.527218911147;12294.631161065183;12537.43581538833;12547.435365408579;12756.872431275568;23897.163599273943;24272.63591046136;24292.27123186272;24324.635130473056;24325.756742432703;7838.882416763753;7979.3217576505485;8585.441946273471;8697.826043479095;8701.608427620773;4021.718479706451;4028.21848370555;4128.525219599785;4168.374743788456;4306.720063195882;4226.070264541796;4302.182585308781;4308.375285583636;4324.17840610283;4348;835.2816577743137;837.2381133168909;846.3060290561681;862.5385418801037;865.5066612031208;593.519249407981;594.7353427724621;603.5774957529746;610.2463457629824;617.527591392585;10129.784425868944;10422.739431514272;10502.212334074975;10798.838017429745;10986.176036797273;606.475398780052;607.3076692570473;636.6498425865756;636.7834936121741;641.6503005861816;4754.286856971482;4938.58022068121;4958.3720628067185;4972.453030166679;4982.7259500727805;69399.95900061502;73058.63470682612;73553.63223183957;73975.26024739792;75416.62291688507;60955;64172;64228.67885660542;64499.67750161313;64635;60135;60632.69683651553;60889.08666370008;61129.694351527956;61172.69413652903;9958.651447199314;10058.54736536843;10434.748048825248;10816.729581760519;11385.772284554429;29597.704022959493;29820.552691709207;30577.694223058374;31022.53466198054;32125.839370802998;52791.20813187728;54180.458195419116;56020.43979560315;56820.14769778374;57143.42856571381;13361.66595835112;13420.328983550979;13534.661633459242;13567.389467474184;13693.178409295475;15301.464448744686;15331;15429.074255544703;15504.457343992906;15639.452619158275;13690.38393272325;14128.222947737562;14137.858621414065;14319;14575.489857854924;14033.368498417392;14119.576412707635;14786;14792.778108328599;15136.697266054396;13901.961270486803;14252.287385630885;14659.70680586361;14822.40710371573;14886.404543818126;10311.742206444898;10387.2209584283;10439.843402349123;10505.894941050798;10657.786844262917;9568.61725530971;10389.636362727268;10813.189010824062;11105;11386.829197562209 18:15:36 INFO - PID 2293 | __end_tp_report 18:15:36 INFO - PID 2293 | __start_cc_report 18:15:36 INFO - PID 2293 | _x_x_mozilla_cycle_collect,1573 18:15:36 INFO - PID 2293 | __end_cc_report 18:15:36 INFO - PID 2293 | __startTimestamp1490404536687__endTimestamp 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | ------- Summary: start ------- 18:15:36 INFO - PID 2293 | Number of tests: 6 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#0] dojo.html Cycles:165 Average:5681.63 Median:5945.41 stddev:645.83 (10.9%) stddev-sans-first:620.58 18:15:36 INFO - PID 2293 | Values: 3316.3 3329.4 3351.4 3358.7 3380.7 5576.6 5713.3 5743.3 5784.1 5787.4 5662.2 5709.9 5719.2 5731.3 5750.4 5049.6 5111.5 5140.6 5162.9 5188.1 5166.7 5229.1 5231.0 5240.8 5277.2 5050.5 5096.9 5100.8 5119.9 5139.6 5160.9 5186.3 5188.0 5192.7 5213.4 5057.2 5112.3 5113.6 5126.2 5128.6 5679.2 5698.2 5701.3 5707.2 5733.7 6033.9 6045.9 6060.0 6104.8 6154.3 6133.1 6161.1 6161.2 6163.2 6164.8 5685.1 5687.5 5732.4 5736.2 5786.4 6091.5 6161.9 6216.1 6227.3 6231.2 6003.4 6030.6 6085.6 6093.9 6098.5 6174.3 6180.8 6182.5 6187.0 6198.5 6008.8 6089.1 6100.0 6139.9 6140.5 5945.4 5960.2 6062.5 6101.4 6111.9 4703.8 4711.2 4714.1 4738.0 4749.4 4177.4 4183.2 4187.0 4201.7 4216.1 5671.5 5700.8 5705.7 5799.8 5804.8 6128.5 6130.6 6180.0 6185.6 6193.0 5789.7 5797.8 5801.0 5808.1 5841.9 5188.5 5239.8 5240.5 5241.1 5243.1 6230.5 6258.2 6285.8 6312.9 6320.7 6068.7 6248.1 6265.9 6266.3 6271.4 6215.0 6232.4 6307.8 6368.2 6381.0 6063.5 6065.2 6066.2 6072.1 6086.9 6040.0 6081.1 6125.9 6185.0 6196.1 5989.6 6005.8 6019.3 6057.2 6070.0 5985.3 5995.5 5999.8 6005.1 6007.0 5810.2 5860.2 5991.5 5996.1 5996.7 5976.9 5989.5 6047.9 6050.5 6064.1 5836.9 5845.8 5907.7 5908.7 5912.4 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#1] ext.html Cycles:180 Average:41699.88 Median:31755.44 stddev:69244.21 (218.1%) stddev-sans-first:69370.16 18:15:36 INFO - PID 2293 | Values: 738.9 780.1 804.1 1098.9 1111.1 29753.7 30240.1 30290.5 30312.0 30319.0 36384.8 37173.6 37302.4 37313.0 37323.4 8008.5 8357.3 8358.0 8359.9 8364.5 5947.5 6049.9 7865.2 8180.3 8315.9 8123.1 8176.8 8181.3 8185.8 8187.1 8050.9 8250.5 8287.7 8319.5 8326.2 5841.2 5921.9 7816.5 8161.1 8223.6 36390.6 36645.6 36813.0 36859.0 36873.6 2937.6 2967.2 2971.6 2978.7 2981.3 26616.3 26724.6 27025.2 27105.2 27446.9 3518.5 3579.3 3634.6 3653.2 3667.0 206229.0 206885.0 206909.0 207053.0 207461.0 48160.3 48167.5 48193.3 48504.5 48552.5 50568.2 50911.5 50954.2 50979.0 50986.0 15226.6 15444.5 15470.5 15479.8 15480.1 12515.9 12524.9 12527.2 12531.1 12534.4 11237.9 11421.5 12598.2 12971.5 13409.9 5204.6 5333.9 5345.8 5386.1 5450.0 1030.9 1034.1 1035.8 1044.9 1053.0 25180.9 25701.2 25803.7 25815.5 25845.5 1126.5 1132.8 1177.7 1178.8 1189.7 12521.9 13051.3 13116.6 13324.9 13344.0 289249.0 291256.0 291912.0 291927.0 292096.0 53318.5 53477.0 53492.0 53500.7 53538.5 1441.9 1458.0 1500.2 1507.8 1516.2 23710.4 24265.6 24420.6 24589.3 24607.5 39595.8 39682.0 39692.6 39757.8 39775.4 286781.0 286782.0 287345.0 288027.0 288038.0 32744.3 33453.8 33724.2 33744.0 33806.5 41443.4 41698.6 41754.8 41880.4 42908.4 31590.7 31648.7 31747.4 32068.4 33098.5 31689.0 31763.5 31810.2 32101.5 32111.0 37226.3 37391.4 37582.8 37965.8 38066.8 30177.5 30441.2 30989.0 31152.4 31431.5 24491.3 25478.4 25517.1 25695.9 25809.2 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#2] jquery.html Cycles:180 Average:33715.94 Median:21480.19 stddev:99820.57 (464.7%) stddev-sans-first:100069.25 18:15:36 INFO - PID 2293 | Values: 403.8 423.6 433.5 439.5 441.6 16610.5 19704.5 21182.6 21374.0 21411.3 21226.9 21412.3 21548.1 21610.5 21785.1 4778.9 5883.1 6069.4 6071.0 6085.9 5890.9 6021.5 6030.1 6031.2 6036.7 5902.2 5975.0 5988.4 5998.5 6013.0 5874.4 5911.0 5915.2 5916.6 5916.9 5197.4 5330.8 5375.9 5377.8 5382.6 25459.4 25987.4 26059.9 26296.9 26339.9 2001.5 2010.6 2017.4 2023.2 2041.7 15327.2 15946.0 16484.0 16556.0 16779.8 1883.9 1890.3 1899.6 1913.5 1951.5 99471.5 101677.0 102401.0 102881.5 103635.0 10581.3 12169.2 12403.6 12586.4 12837.9 14482.5 14513.2 14514.5 14514.9 14529.1 7507.1 7834.6 8502.1 8831.4 8885.1 8047.8 8081.9 8107.0 8337.4 8370.4 7522.8 7589.3 7768.9 7882.2 8087.4 2123.3 2195.9 2247.5 2266.1 2275.8 979.4 985.2 987.6 991.4 1006.7 20195.5 20216.6 20231.2 20231.8 20332.3 1045.4 1051.1 1053.9 1058.8 1066.0 10269.8 10945.9 11032.7 11043.5 11066.8 581926.0 589842.0 613401.0 619726.0 625986.0 94752.0 95897.5 101485.0 101911.5 104128.0 1228.9 1235.5 1261.2 1282.0 1284.9 18201.0 18750.6 19302.4 20535.2 20709.0 36075.0 38716.8 40477.6 42380.4 47427.6 55572.4 56449.4 57480.7 58355.7 63247.7 9115.5 9343.4 9472.1 9740.4 9776.6 13766.4 14106.4 14275.2 14430.9 14448.2 11554.4 12017.9 12085.5 12521.0 12731.6 11012.7 11486.3 11502.7 11698.3 11862.8 12654.4 12720.6 12917.9 13217.9 13469.5 9321.3 9330.7 9416.0 9488.2 9802.0 12302.4 12414.9 12649.4 12688.8 13192.4 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#3] mootools.html Cycles:180 Average:6824.08 Median:2342.57 stddev:4261.61 (181.9%) stddev-sans-first:4253.43 18:15:36 INFO - PID 2293 | Values: 1311.4 1356.5 1374.0 1389.4 1389.8 10304.2 10673.8 10677.0 10693.1 10706.2 10480.9 10499.7 10796.9 10804.8 10815.4 2307.3 2338.2 2349.1 2351.1 2351.6 2208.3 2330.3 2336.1 2340.9 2344.2 1879.1 1922.9 1924.2 1928.7 1929.7 2226.4 2286.1 2291.1 2292.8 2298.0 2262.9 2271.9 2278.4 2287.9 2291.3 10427.8 10554.8 10638.0 10666.8 10666.9 6137.2 6328.9 6372.2 6386.1 6400.0 3642.0 3664.1 3830.9 3845.7 3856.3 1330.8 1384.8 1398.1 1425.4 1437.6 15059.8 15316.5 15437.6 15448.6 15533.6 5199.9 5201.2 5344.4 5399.3 5401.6 11406.3 11417.9 11421.7 11436.1 11459.9 6220.3 6224.2 6224.4 6226.7 6230.5 5722.3 5805.7 5814.8 5859.1 5934.1 3897.7 4012.1 4012.1 4069.2 4145.5 1225.5 1229.1 1232.3 1245.3 1246.3 696.4 830.1 845.7 848.6 864.4 6095.8 6132.0 6142.9 6277.5 6423.0 927.0 933.6 933.8 937.8 960.7 3882.3 4028.2 4074.1 4148.2 4170.3 13958.7 14072.6 14106.4 14393.5 14451.6 13979.5 14147.5 14163.1 14262.9 14288.2 10269.5 10318.3 10400.6 10406.7 10447.4 6573.8 6750.3 6867.0 6953.3 6960.1 12180.3 12337.1 12463.8 12534.8 12666.1 12559.3 12752.6 12795.7 12860.4 12905.5 9200.5 9356.8 9408.5 9488.4 9531.9 10218.5 10281.8 10361.5 10371.3 10399.4 8508.7 8577.5 8693.8 8736.8 8983.6 8451.9 8759.8 8907.7 8929.5 8951.1 7855.8 7892.4 8044.3 8047.2 8054.0 6117.3 6159.1 6207.6 6235.8 6308.1 6110.5 6139.9 6151.3 6274.2 6280.5 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#4] prototype.html Cycles:180 Average:5238.85 Median:5995.74 stddev:1559.64 (26.0%) stddev-sans-first:1521.35 18:15:36 INFO - PID 2293 | Values: 411.7 411.9 421.0 424.3 429.8 5975.6 5977.5 5981.2 5988.9 5991.3 5802.7 5864.6 5901.6 5906.2 5935.3 4405.6 4535.8 4541.0 4544.3 4668.7 4523.9 4526.6 4528.6 4533.2 4554.6 4511.3 4521.0 4527.5 4528.2 4554.7 4452.3 4457.1 4507.7 4520.4 4533.9 3952.2 3960.5 3965.8 3965.9 3981.8 5759.7 5760.4 5766.7 5766.9 5793.8 5120.8 5243.1 5259.8 5267.6 5291.9 6214.9 6215.5 6222.8 6243.0 6247.4 4392.3 4393.1 4402.6 4419.3 4434.8 6178.2 6296.9 6416.0 6524.4 6550.3 4396.8 4466.4 4510.3 4520.5 4527.8 4567.2 4586.0 4586.8 4589.8 4602.5 4908.7 4973.6 5256.7 5262.9 5278.3 6220.2 6270.6 6271.8 6285.3 6286.8 1569.3 1570.9 1581.9 1586.5 1588.1 1046.1 1057.6 1060.0 1062.5 1077.7 6008.8 6036.4 6037.5 6043.2 6046.7 6288.9 6426.2 6426.3 6447.2 6449.1 6000.1 6025.5 6035.6 6050.8 6064.9 3402.1 3431.6 3432.2 3433.8 3444.5 6538.3 6589.3 6676.8 6688.2 6718.5 6535.0 6557.7 6561.2 6568.7 6591.8 6388.8 6742.0 6761.1 6778.4 6782.9 6443.9 6451.5 6464.2 6474.8 6485.1 6086.2 6354.2 6377.2 6382.1 6413.5 6385.3 6541.4 6551.4 6731.7 6754.7 4465.7 4478.6 4489.4 4497.2 4505.2 6318.3 6403.4 6416.4 6428.7 6443.2 6203.5 6248.9 6271.5 6272.9 6298.9 6222.5 6240.2 6257.5 6262.2 6265.6 6050.6 6198.0 6209.4 6212.8 6220.5 6229.8 6244.1 6269.8 6279.9 6324.0 5817.6 6113.2 6144.2 6150.7 6153.1 18:15:36 INFO - PID 2293 | 18:15:36 INFO - PID 2293 | [#5] yui.html Cycles:180 Average:17515.57 Median:4148.45 stddev:22063.57 (531.9%) stddev-sans-first:22089.30 18:15:36 INFO - PID 2293 | Values: 694.2 706.2 717.6 743.0 757.8 15055.4 15352.4 15847.9 16080.9 16167.4 14687.0 15057.5 15248.0 15578.8 15671.0 803.7 829.5 833.3 833.7 834.0 822.4 829.4 843.8 848.5 848.6 862.8 863.7 863.7 866.3 881.5 874.8 875.9 878.4 878.5 879.5 633.3 639.6 640.1 640.9 643.3 16617.5 16638.2 16993.3 17359.9 17443.8 14098.6 15674.0 15893.4 16171.8 16587.1 11585.3 11867.7 12018.7 12297.3 12324.0 3189.2 3235.5 3277.3 3290.9 3356.9 85735.0 87848.6 88187.6 89332.1 91091.5 11819.5 12294.6 12537.4 12547.4 12756.9 23897.2 24272.6 24292.3 24324.6 24325.8 7838.9 7979.3 8585.4 8697.8 8701.6 4021.7 4028.2 4128.5 4168.4 4306.7 4226.1 4302.2 4308.4 4324.2 4348.0 835.3 837.2 846.3 862.5 865.5 593.5 594.7 603.6 610.2 617.5 10129.8 10422.7 10502.2 10798.8 10986.2 606.5 607.3 636.6 636.8 641.7 4754.3 4938.6 4958.4 4972.5 4982.7 69400.0 73058.6 73553.6 73975.3 75416.6 60955.0 64172.0 64228.7 64499.7 64635.0 60135.0 60632.7 60889.1 61129.7 61172.7 9958.7 10058.5 10434.7 10816.7 11385.8 29597.7 29820.6 30577.7 31022.5 32125.8 52791.2 54180.5 56020.4 56820.1 57143.4 13361.7 13420.3 13534.7 13567.4 13693.2 15301.5 15331.0 15429.1 15504.5 15639.5 13690.4 14128.2 14137.9 14319.0 14575.5 14033.4 14119.6 14786.0 14792.8 15136.7 13902.0 14252.3 14659.7 14822.4 14886.4 10311.7 10387.2 10439.8 10505.9 10657.8 9568.6 10389.6 10813.2 11105.0 11386.8 18:15:36 INFO - PID 2293 | -------- Summary: end -------- 18:15:36 INFO - PID 2293 | 18:15:37 INFO - TEST-INFO | 2293: exit 0 18:15:37 INFO - TEST-OK | dromaeo_css | took 1117221ms 18:15:37 INFO - TEST-START | kraken 18:15:37 INFO - operating with platform_type : linux_ 18:15:37 INFO - Initialising browser for kraken test... 18:15:37 INFO - TEST-INFO | started process 2715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS31cZA/profile http://localhost:47016/getInfo.html) 18:15:41 INFO - PID 2715 | __metrics Screen width/height:1600/1200 18:15:41 INFO - PID 2715 | colorDepth:24 18:15:41 INFO - PID 2715 | Browser inner width/height: 1024/697 18:15:41 INFO - PID 2715 | __metrics 18:15:42 INFO - PID 2715 | 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" 18:15:42 INFO - PID 2715 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:15:43 INFO - TEST-INFO | 2715: exit 0 18:15:43 INFO - Browser initialized. 18:15:43 INFO - Running cycle 1/1 for kraken test... 18:15:43 INFO - TEST-INFO | started process 2890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS31cZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:55 INFO - PID 2890 | RSS: Main: 145383424 18:15:55 INFO - PID 2890 | 18:15:57 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47016/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:58 INFO - PID 2890 | RSS: Main: 200835072 18:15:58 INFO - PID 2890 | 18:16:01 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47016/tests/kraken/driver.html?testName=audio-dft) 18:16:01 INFO - PID 2890 | RSS: Main: 179486720 18:16:01 INFO - PID 2890 | 18:16:04 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47016/tests/kraken/driver.html?testName=audio-fft) 18:16:05 INFO - PID 2890 | RSS: Main: 261226496 18:16:05 INFO - PID 2890 | 18:16:07 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47016/tests/kraken/driver.html?testName=audio-oscillator) 18:16:07 INFO - PID 2890 | RSS: Main: 172785664 18:16:07 INFO - PID 2890 | 18:16:10 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:10 INFO - PID 2890 | RSS: Main: 176848896 18:16:10 INFO - PID 2890 | 18:16:13 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47016/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:14 INFO - PID 2890 | RSS: Main: 215191552 18:16:14 INFO - PID 2890 | 18:16:17 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47016/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:18 INFO - PID 2890 | RSS: Main: 229404672 18:16:18 INFO - PID 2890 | 18:16:21 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47016/tests/kraken/driver.html?testName=json-parse-financial) 18:16:21 INFO - PID 2890 | RSS: Main: 240726016 18:16:21 INFO - PID 2890 | 18:16:23 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:23 INFO - PID 2890 | RSS: Main: 177770496 18:16:23 INFO - PID 2890 | 18:16:25 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:26 INFO - PID 2890 | RSS: Main: 186019840 18:16:26 INFO - PID 2890 | 18:16:28 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:28 INFO - PID 2890 | RSS: Main: 193835008 18:16:28 INFO - PID 2890 | 18:16:31 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:32 INFO - PID 2890 | RSS: Main: 202969088 18:16:32 INFO - PID 2890 | 18:16:35 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:35 INFO - PID 2890 | RSS: Main: 199397376 18:16:35 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | Cycle 1(1): loaded http://localhost:47016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47016/tests/kraken/driver.html?testName=ai-astar) 18:16:37 INFO - PID 2890 | RSS: Main: 267378688 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | __start_tp_report 18:16:37 INFO - PID 2890 | _x_x_mozilla_page_load 18:16:37 INFO - PID 2890 | _x_x_mozilla_page_load_details 18:16:37 INFO - PID 2890 | |i|pagename|runs| 18:16:37 INFO - PID 2890 | |0;ai-astar;101;108;109;109;109;108;108;110;109;107 18:16:37 INFO - PID 2890 | |1;audio-beat-detection;146;120;119;171;117;116;117;116;138;118 18:16:37 INFO - PID 2890 | |2;audio-dft;162;162;161;160;160;161;161;161;162;161 18:16:37 INFO - PID 2890 | |3;audio-fft;75;77;75;108;74;75;75;74;99;75 18:16:37 INFO - PID 2890 | |4;audio-oscillator;84;83;107;83;82;83;95;83;82;106 18:16:37 INFO - PID 2890 | |5;imaging-gaussian-blur;112;114;113;113;113;113;113;112;113;113 18:16:37 INFO - PID 2890 | |6;imaging-darkroom;147;147;146;146;147;147;148;146;147;146 18:16:37 INFO - PID 2890 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 18:16:37 INFO - PID 2890 | |8;json-parse-financial;57;56;57;55;57;57;56;58;56;56 18:16:37 INFO - PID 2890 | |9;json-stringify-tinderbox;54;53;54;53;55;57;54;54;54;55 18:16:37 INFO - PID 2890 | |10;stanford-crypto-aes;80;87;88;79;78;79;79;79;78;79 18:16:37 INFO - PID 2890 | |11;stanford-crypto-ccm;129;123;132;125;134;127;126;137;179;130 18:16:37 INFO - PID 2890 | |12;stanford-crypto-pbkdf2;182;182;185;183;188;179;175;185;175;180 18:16:37 INFO - PID 2890 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;63;65;65;70;66 18:16:37 INFO - PID 2890 | __end_tp_report 18:16:37 INFO - PID 2890 | __start_cc_report 18:16:37 INFO - PID 2890 | _x_x_mozilla_cycle_collect,1749 18:16:37 INFO - PID 2890 | __end_cc_report 18:16:37 INFO - PID 2890 | __startTimestamp1490404597696__endTimestamp 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | ------- Summary: start ------- 18:16:37 INFO - PID 2890 | Number of tests: 14 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:2.53 (2.3%) stddev-sans-first:0.88 18:16:37 INFO - PID 2890 | Values: 101.0 108.0 109.0 109.0 109.0 108.0 108.0 110.0 109.0 107.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:119.50 stddev:18.40 (15.4%) stddev-sans-first:18.30 18:16:37 INFO - PID 2890 | Values: 146.0 120.0 119.0 171.0 117.0 116.0 117.0 116.0 138.0 118.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 18:16:37 INFO - PID 2890 | Values: 162.0 162.0 161.0 160.0 160.0 161.0 161.0 161.0 162.0 161.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.23 (16.3%) stddev-sans-first:12.80 18:16:37 INFO - PID 2890 | Values: 75.0 77.0 75.0 108.0 74.0 75.0 75.0 74.0 99.0 75.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.00 stddev:10.09 (12.2%) stddev-sans-first:10.55 18:16:37 INFO - PID 2890 | Values: 84.0 83.0 107.0 83.0 82.0 83.0 95.0 83.0 82.0 106.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 18:16:37 INFO - PID 2890 | Values: 112.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 18:16:37 INFO - PID 2890 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 148.0 146.0 147.0 146.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:16:37 INFO - PID 2890 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 18:16:37 INFO - PID 2890 | Values: 57.0 56.0 57.0 55.0 57.0 57.0 56.0 58.0 56.0 56.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 18:16:37 INFO - PID 2890 | Values: 54.0 53.0 54.0 53.0 55.0 57.0 54.0 54.0 54.0 55.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.00 stddev:3.69 (4.7%) stddev-sans-first:3.91 18:16:37 INFO - PID 2890 | Values: 80.0 87.0 88.0 79.0 78.0 79.0 79.0 79.0 78.0 79.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:131.00 stddev:16.31 (12.4%) stddev-sans-first:17.19 18:16:37 INFO - PID 2890 | Values: 129.0 123.0 132.0 125.0 134.0 127.0 126.0 137.0 179.0 130.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:182.50 stddev:4.25 (2.3%) stddev-sans-first:4.50 18:16:37 INFO - PID 2890 | Values: 182.0 182.0 185.0 183.0 188.0 179.0 175.0 185.0 175.0 180.0 18:16:37 INFO - PID 2890 | 18:16:37 INFO - PID 2890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.73 (2.6%) stddev-sans-first:1.83 18:16:37 INFO - PID 2890 | Values: 66.0 66.0 66.0 66.0 66.0 63.0 65.0 65.0 70.0 66.0 18:16:37 INFO - PID 2890 | -------- Summary: end -------- 18:16:37 INFO - PID 2890 | 18:16:38 INFO - TEST-INFO | 2890: exit 0 18:16:38 INFO - TEST-OK | kraken | took 61232ms 18:16:38 INFO - SUITE-END | took 1178s 18:16:38 INFO - Completed test suite (00:19:38) 18:16:38 INFO - javascript benchmark 18:16:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7468.891789703429, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.253842885351, 3329.4007078725836, 3351.363240984211, 3358.680925312095, 3380.66193380662, 5576.581756368279, 5713.257276554053, 5743.253377060982, 5784.132380142975, 5787.421257874215, 5662.235598194243, 5709.942900570993, 5719.19931209631, 5731.340895796985, 5750.424957504248, 5049.621278404116, 5111.514406131411, 5140.640155189139, 5162.896742065156, 5188.11801993662, 5166.689998600096, 5229.084910140729, 5231.032259032091, 5240.79036838526, 5277.234800953859, 5050.545450909436, 5096.923546146811, 5100.795968161269, 5119.87200319995, 5139.640225184238, 5160.8967820643375, 5186.325777648919, 5188.040212560688, 5192.71440070796, 5213.4004589472315, 5057.165567681328, 5112.335396398445, 5113.642045056848, 5126.2054381570915, 5128.589712822965, 5679.233303504016, 5698.202251684767, 5701.287339082614, 5707.200991861143, 5733.684647344395, 6033.879322413527, 6045.939540604581, 6060.030395136757, 6104.830217171004, 6154.26148862135, 6133.1106989486725, 6161.106639537242, 6161.229846269216, 6163.198784158076, 6164.815055548341, 5685.0619647758485, 5687.459691329317, 5732.426757324318, 5736.196932429463, 5786.363500014995, 6091.456100873274, 6161.921663708833, 6216.129741836146, 6227.314995350508, 6231.158793562901, 6003.3996600339615, 6030.638161710312, 6085.604435711664, 6093.908591371133, 6098.512119030467, 6174.320824709278, 6180.845478862974, 6182.536309776785, 6187.041008643668, 6198.504119670415, 6008.789692360834, 6089.060601836121, 6099.980162666156, 6139.907901381483, 6140.478059364915, 5945.40545945402, 5960.225170727865, 6062.545309101835, 6101.359357267512, 6111.908321375183, 4703.764811759398, 4711.175544279738, 4714.127886341038, 4737.976310118427, 4749.3588365570895, 4177.394277829698, 4183.163367326547, 4186.979065104655, 4201.7268877522865, 4216.072464057902, 5671.489565939085, 5700.771969121189, 5705.7147142643535, 5799.768009279666, 5804.825855224266, 6128.479079278222, 6130.642739936431, 6180.0, 6185.597936134227, 6192.969035154795, 5789.681567513827, 5797.826065218051, 5800.970995144998, 5808.07070868659, 5841.912371314434, 5188.507091826271, 5239.816606418757, 5240.475952404805, 5241.135212689864, 5243.056249874983, 6230.50155987529, 6258.15514905491, 6285.811425657238, 6312.873742525216, 6320.747170113236, 6068.7269072892705, 6248.094026366242, 6265.906011409924, 6266.310705822265, 6271.404216599416, 6215.0, 6232.439080482778, 6307.842303942438, 6368.203974503187, 6381.042843573501, 6063.514918806573, 6065.2418447694035, 6066.211392518944, 6072.1498990140535, 6086.939130608815, 6039.969800150971, 6081.118237855575, 6125.877482450415, 6184.969075154595, 6196.132541444292, 5989.610675306266, 6005.789797357072, 6019.277686677627, 6057.151998720271, 6070.0, 5985.311689155628, 5995.490383317292, 5999.820005399845, 6005.129256257731, 6007.0, 5810.244668193108, 5860.179574859609, 5991.490723288569, 5996.130561068708, 5996.730147143302, 5976.850578735566, 5989.490893274121, 6047.909281360871, 6050.515958723379, 6064.090386442069, 5836.883262334814, 5845.795397161249, 5907.675077870758, 5908.734106965111, 5912.379200183918], "value": 5638.237586075544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.8780851159559, 780.1418439716311, 804.091376744279, 1098.9175811814112, 1111.1222134513735, 29753.702462975365, 30240.092797216064, 30290.545641815334, 30311.99999999997, 30319.0, 36384.818075909585, 37173.62826371736, 37302.44046339307, 37313.0, 37323.44014839779, 8008.479448835822, 8357.289630381425, 8358.0, 8359.916400835975, 8364.498130112182, 5947.524198064145, 6049.909251361233, 7865.174156713549, 8180.263776260135, 8315.875261871046, 8123.065847427532, 8176.754697359059, 8181.304589109903, 8185.8362832743305, 8187.058488273865, 8050.879236811453, 8250.5462199579, 8287.668493260262, 8319.542425166583, 8326.167383261625, 5841.240638716982, 5921.940780592182, 7816.491928024717, 8161.102278749333, 8223.629936652866, 36390.63609363899, 36645.63354366449, 36813.0, 36859.0, 36873.63126368729, 2937.6181096457326, 2967.1988563087843, 2971.628546431696, 2978.7468065214266, 2981.3142977115167, 26616.33459163517, 26724.599131013052, 27025.1892443227, 27105.1868443947, 27446.862765686044, 3518.454639530851, 3579.329570143172, 3634.582023067355, 3653.214558869856, 3666.9633303667156, 206229.0, 206885.0, 206909.0, 207053.0, 207461.0, 48160.27759583609, 48167.51832481701, 48193.277100843516, 48504.5149548507, 48552.5144748555, 50568.24147637789, 50911.490885091414, 50954.23568646473, 50979.0, 50986.0, 15226.619334516505, 15444.5366639001, 15470.5358839235, 15479.845201548065, 15480.148591827332, 12515.937420312841, 12524.937375313066, 12527.18573292733, 12531.122821402596, 12534.373281336078, 11237.920984617871, 11421.486033128529, 12598.181118227287, 12971.481140754453, 13409.932950335186, 5204.635675502755, 5333.919991200135, 5345.786168553214, 5386.13821788512, 5450.0, 1030.9432981186108, 1034.0900007992918, 1035.808375450544, 1044.8902865199045, 1052.952617132231, 25180.87409562977, 25701.228963131136, 25803.74196258051, 25815.483690326088, 25845.483090338086, 1126.5099681638515, 1132.750794825137, 1177.652592485219, 1178.8467499225046, 1189.7263629365295, 12521.874781252252, 13051.34743262833, 13116.606501804961, 13324.866751332556, 13344.0, 289249.0, 291256.0, 291912.0, 291927.0, 292096.0, 53318.466815332125, 53477.0, 53492.0, 53500.73249633727, 53538.46461535335, 1441.8990670652954, 1457.9708405832037, 1500.1674070890542, 1507.77383392492, 1516.2494565190082, 23710.40723981845, 24265.63601545943, 24420.63369049501, 24589.262322130366, 24607.507849842546, 39595.80202098971, 39682.0, 39692.603073968894, 39757.80121099376, 39775.403368950065, 286781.0, 286782.0, 287345.0, 288027.0, 288038.0, 32744.34511309808, 33453.83273083619, 33724.156896077795, 33744.0, 33806.49290260599, 41443.37834932539, 41698.58301416947, 41754.791226044894, 41880.3717944225, 42908.35637465503, 31590.684093158776, 31648.683513165495, 31747.36505269928, 32068.35863282768, 33098.5035224467, 31689.0, 31763.52354714635, 31810.204744881565, 32101.518477223326, 32111.0, 37226.255474890895, 37391.43912841255, 37582.81208594049, 37965.81017094897, 38066.80966595149, 30177.547336790405, 30441.238969025064, 30989.0, 31152.376952461276, 31431.528527071656, 24491.26526204217, 25478.363040924127, 25517.10690125837, 25695.871520643024, 25809.225723228334], "value": 17060.95934765053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.8021369528932, 423.6302539307048, 433.5469434441007, 439.46165946715274, 441.562852775752, 16610.501684949442, 19704.507387315323, 21182.57634847302, 21374.0, 21411.250606228805, 21226.89386553069, 21412.25057123001, 21548.13807447704, 21610.459738506546, 21785.128594856225, 4778.900852803858, 5883.146943693173, 6069.3930606939175, 6070.96964515179, 6085.904537183305, 5890.941090589104, 6021.518278537728, 6030.125631783389, 6031.155638210654, 6036.667983260919, 5902.203202567663, 5975.0, 5988.401159883999, 5998.460138587527, 6012.969935150318, 5874.383189765077, 5911.0, 5915.1718759373725, 5916.615419997686, 5916.852078698024, 5197.376314842243, 5330.760115794798, 5375.865603359908, 5377.81177658784, 5382.596305277119, 25459.363515912064, 25987.350316242246, 26059.869700651565, 26296.86851565749, 26339.868300658374, 2001.4796153000325, 2010.6380851446734, 2017.4149496645955, 2023.2412845183057, 2041.6631255842767, 15327.233638318039, 15946.0, 16484.0, 16556.0, 16779.83220167795, 1883.896385698786, 1890.2816929566814, 1899.582091939771, 1913.4546654203625, 1951.4633475794128, 99471.50264248704, 101677.0, 102401.0, 102881.48559257155, 103635.0, 10581.259311848251, 12169.20900141488, 12403.565875194325, 12586.370681466073, 12837.871621283854, 14482.493112741004, 14513.201773902536, 14514.491992780202, 14514.85485145135, 14529.055611385225, 7507.099148102263, 7834.647440865061, 8502.06477287498, 8831.381803273838, 8885.06706795777, 8047.758567242875, 8081.878771818428, 8107.038630855291, 8337.374696897758, 8370.372222083368, 7522.833960736095, 7589.279018493235, 7768.922310776933, 7882.172371900868, 8087.433879628369, 2123.2886982860605, 2195.890205489719, 2247.4718441166315, 2266.1275408967335, 2275.806556442721, 979.3829887171037, 985.2413641496008, 987.6395115782831, 991.3853410885297, 1006.6527048168371, 20195.495112622302, 20216.59566808685, 20231.190752370036, 20231.797682023287, 20332.288369906983, 1045.3675526306627, 1051.085555566662, 1053.9314944528735, 1058.7776566921034, 1065.9946700266448, 10269.845952310721, 10945.865556216462, 11032.724181895517, 11043.503042363112, 11066.833997490045, 581926.0, 589842.0, 613401.0, 619726.0, 625986.0, 94752.0, 95897.52051239839, 101485.0, 101911.4904425473, 104128.0, 1228.9385530723428, 1235.5304984105983, 1261.2243470265903, 1282.0128501054137, 1284.9357532123543, 18201.0, 18750.624987500447, 19302.4209273722, 20535.178592856715, 20709.0, 36075.0, 38716.80641596774, 40477.595224047385, 42380.36429453499, 47427.62861856824, 55572.444275558344, 56449.43550564606, 57480.71259643675, 58355.70822145862, 63247.6837615809, 9115.453072815651, 9343.383852521305, 9472.147506724428, 9740.366876153028, 9776.608935642495, 13766.449342026206, 14106.36521356562, 14275.21486318221, 14430.855691442952, 14448.205348705922, 11554.364509952033, 12017.939910300393, 12085.51657933708, 12521.0, 12731.55439559611, 11012.669619911416, 11486.253393529394, 11502.654920352403, 11698.2981021139, 11862.822057669315, 12654.367281636065, 12720.554780582635, 12917.870821291666, 13217.867821321664, 13469.528566500125, 9321.30090243221, 9330.673426430043, 9416.0, 9488.193503552275, 9802.0, 12302.384880756106, 12414.937925310316, 12649.430775614936, 12688.809667854805, 13192.406341714453], "value": 9998.787775041255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.4033114932706, 1356.4980957045896, 1373.99313003435, 1389.3678376338767, 1389.7776355783076, 10304.175665946725, 10673.786524269519, 10677.039066484014, 10693.091087257593, 10706.19703522235, 10480.947595262012, 10499.68500944971, 10796.946015269932, 10804.837927431096, 10815.35107893527, 2307.273208939183, 2338.2166974063707, 2349.119080344871, 2351.130081869702, 2351.611984022643, 2208.2823082498253, 2330.2776139396756, 2336.077249486452, 2340.941476463085, 2344.202970989863, 1879.0886420086315, 1922.9230830766753, 1924.2303078768534, 1928.6528424883516, 1929.7008963610663, 2226.4322597737555, 2286.0969916882905, 2291.0721157931066, 2292.793648571628, 2297.9655305170268, 2262.8981695823563, 2271.8750468724215, 2278.4076140203665, 2287.8627282363113, 2291.255342013852, 10427.843582346271, 10554.788904221949, 10637.989391007843, 10666.786664266749, 10666.893331066745, 6137.171481849938, 6328.936710632881, 6372.235331760172, 6386.13787138735, 6399.968000159969, 3642.0, 3664.120611053355, 3830.9233815323814, 3845.730798844082, 3856.3444214483325, 1330.8003799430066, 1384.813050238215, 1398.1191849135082, 1425.40845549097, 1437.647776294804, 15059.774103388458, 15316.463923762614, 15437.614059648486, 15448.613784655474, 15533.611659708598, 5199.948000520022, 5201.245819356248, 5344.43883392246, 5399.271098401744, 5401.567874570025, 11406.262497000826, 11417.885821141848, 11421.657350279505, 11436.142289328167, 11459.885401145882, 6220.34686357935, 6224.159738435344, 6224.439800417894, 6226.719797609027, 6230.501559875199, 5722.284714410699, 5805.7387417566315, 5814.796482123105, 5859.062549991981, 5934.13954976526, 3897.6881849451975, 4012.137390461065, 4012.137390461065, 4069.1658210066867, 4145.502539695256, 1225.4669218889633, 1229.1273196030918, 1232.3099064523894, 1245.3275231374955, 1246.3017566967594, 696.4428457234294, 830.0869044051495, 845.6701886264361, 848.5757121439281, 864.3690106222493, 6095.75616975316, 6132.0, 6142.938570614326, 6277.466415354655, 6423.03654451836, 926.9582868770922, 933.6218831373304, 933.8412469880137, 937.8358787212211, 960.7406000379858, 3882.262370149719, 4028.2144981728284, 4074.083331250445, 4148.170365926827, 4170.270202714512, 13958.651033724034, 14072.616097833841, 14106.365213565414, 14393.496227631982, 14451.566453006426, 13979.510717124851, 14147.504837330644, 14163.079399838978, 14262.928685356506, 14288.214148221947, 10269.537870795832, 10318.329308594917, 10400.635977740743, 10406.687799366031, 10447.425391603383, 6573.82114549269, 6750.32496750321, 6866.965665171642, 6953.304669533209, 6960.060391847238, 12180.33008184523, 12337.074719395901, 12463.813042804184, 12534.811977820158, 12666.113372063866, 12559.309237991998, 12752.553660621834, 12795.744085118431, 12860.356982150668, 12905.548305809252, 9200.539973001458, 9356.766080848034, 9408.529573521433, 9488.383255088396, 9531.904680953101, 10218.489075546342, 10281.794364112826, 10361.533730981973, 10371.27401081917, 10399.428031458343, 8508.74473765788, 8577.485350878967, 8693.826123477369, 8736.825263494822, 8983.595738191927, 8451.915480845359, 8759.781005474913, 8907.73276801697, 8929.464232146092, 8951.149640784115, 7855.803604909923, 7892.408069394934, 8044.2760151586635, 8047.1550487198, 8053.959730201312, 6117.296510901303, 6159.1069294951085, 6207.6275423474735, 6235.844103897258, 6308.14839996613, 6110.541709371726, 6139.938600614116, 6151.292601350902, 6274.247090349188, 6280.5289603279025], "value": 5172.308275851006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7303166425991, 411.900226395524, 421.04212915616966, 424.29143330637834, 429.77651621156997, 5975.551833612481, 5977.4919131873785, 5981.235535517022, 5988.940110598893, 5991.340952495222, 5802.709864506779, 5864.618799778012, 5901.616394934326, 5906.173135760986, 5935.347111817697, 4405.6475481961525, 4535.818567257305, 4540.97729511352, 4544.2501987172245, 4668.696534725241, 4523.932141017887, 4526.637868970491, 4528.592426681598, 4533.229351010336, 4554.567316104964, 4511.345854851044, 4520.954790452086, 4527.456705195381, 4528.162289976349, 4554.681172317939, 4452.287633978548, 4457.064016556511, 4507.729536227804, 4520.367148599166, 4533.863984080483, 3952.1502876881323, 3960.5445373782095, 3965.781881996489, 3965.9008524786823, 3981.7610943343493, 5759.740811663485, 5760.350238890115, 5766.740496677618, 5766.855828604276, 5793.826185214451, 5120.820771273025, 5243.10867152585, 5259.8422047338645, 5267.631265811357, 5291.920621190685, 6214.875702485971, 6215.533834962351, 6222.782202622931, 6243.0, 6247.406496382836, 4392.297232442826, 4393.143337049277, 4402.647788176938, 4419.292913133915, 4434.800433980478, 6178.227721534809, 6296.8665640184745, 6415.967920160369, 6524.380183882524, 6550.344965503459, 4396.824127034947, 4466.419365482467, 4510.323451482238, 4520.52534483881, 4527.818887244539, 4567.200739870509, 4585.9770701146945, 4586.8165273388695, 4589.816407343736, 4602.539746025371, 4908.735690765672, 4973.602111831045, 5256.737163141904, 5262.947370526245, 5278.261043453919, 6220.160278362454, 6270.623762574261, 6271.811845644638, 6285.271550323698, 6286.787852139078, 1569.3330334607747, 1570.8900376973731, 1581.897176683535, 1586.4606033948512, 1588.0709784776036, 1046.1160319529986, 1057.5558265528496, 1059.9576016959236, 1062.5006247063868, 1077.6906059138184, 6008.789692360747, 6036.366181550874, 6037.486813620803, 6043.244594425697, 6046.667433291212, 6288.9056664150075, 6426.164598602245, 6426.264908474685, 6447.161868957006, 6449.129367535416, 6000.129981152709, 6025.457708806229, 6035.577509574376, 6050.818475445743, 6064.878702426015, 3402.1154499829727, 3431.6225215226304, 3432.2105915639545, 3433.759636825398, 3444.534987776618, 6538.313477084837, 6589.308122647053, 6676.83307917306, 6688.163979502562, 6718.49611279156, 6535.0, 6557.672116394161, 6561.245456772437, 6568.737250510022, 6591.802245932629, 6388.776392826228, 6742.0, 6761.053452516651, 6778.42383397397, 6782.9321706783285, 6443.935560644333, 6451.483881289391, 6464.159659244268, 6474.838129046811, 6485.124508191334, 6086.178365920721, 6354.23749150105, 6377.202849643794, 6382.074599183, 6413.518986075969, 6385.329540398191, 6541.378569035934, 6551.44312733423, 6731.730730770911, 6754.6622668865375, 4465.709728867613, 4478.641708663365, 4489.371487991619, 4497.2129877272, 4505.189065968026, 6318.273398559225, 6403.391677790602, 6416.358364163733, 6428.678566071584, 6443.194600674916, 6203.503719702323, 6248.937680594219, 6271.498280137487, 6272.905906411499, 6298.905516417166, 6222.502199823913, 6240.157578726814, 6257.468115210076, 6262.15460912771, 6265.624062556261, 6050.606710563799, 6198.0, 6209.410106039919, 6212.751489940351, 6220.471259942956, 6229.750809967551, 6244.068135271601, 6269.780557680459, 6279.905801413074, 6324.019776934582, 5817.621854579439, 6113.174721412553, 6144.2319710036245, 6150.661713605795, 6153.107799369156], "value": 4756.152378488917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.1531331775233, 706.2161001288572, 717.5622870049269, 743.0, 757.8219118507146, 15055.397784088636, 15352.385904563818, 15847.920760396197, 16080.919595402007, 16167.353305867751, 14687.0, 15057.472988445406, 15248.00887942283, 15578.766318505202, 15671.0, 803.6504120707497, 829.5271695133777, 833.3041910005153, 833.6582001379436, 833.9749807505784, 822.4284122534841, 829.3821103278066, 843.7932706486889, 848.4824257203101, 848.5545088828353, 862.7756783236372, 863.6674880171116, 863.7063398444527, 866.2766589897411, 881.5063564403922, 874.8337815814975, 875.934304927133, 878.4026861734018, 878.5124256037865, 879.5118709116438, 633.2907143998751, 639.5746828359136, 640.1486023588616, 640.8782331357028, 643.269888676351, 16617.50147495577, 16638.168091595493, 16993.320267189298, 17359.913200433915, 17443.825561744346, 14098.647533811634, 15674.0, 15893.443729469413, 16171.83828161715, 16587.087710175936, 11585.305279052642, 11867.703307417298, 12018.69953251167, 12297.3236471994, 12324.0, 3189.1548739584027, 3235.466148085563, 3277.2789986202997, 3290.851911663957, 3356.865725370982, 85735.0, 87848.56075719645, 88187.55906220428, 89332.10667893302, 91091.54454227752, 11819.527218911147, 12294.631161065183, 12537.43581538833, 12547.435365408579, 12756.872431275568, 23897.163599273943, 24272.63591046136, 24292.27123186272, 24324.635130473056, 24325.756742432703, 7838.882416763753, 7979.3217576505485, 8585.441946273471, 8697.826043479095, 8701.608427620773, 4021.718479706451, 4028.21848370555, 4128.525219599785, 4168.374743788456, 4306.720063195882, 4226.070264541796, 4302.182585308781, 4308.375285583636, 4324.17840610283, 4348.0, 835.2816577743137, 837.2381133168909, 846.3060290561681, 862.5385418801037, 865.5066612031208, 593.519249407981, 594.7353427724621, 603.5774957529746, 610.2463457629824, 617.527591392585, 10129.784425868944, 10422.739431514272, 10502.212334074975, 10798.838017429745, 10986.176036797273, 606.475398780052, 607.3076692570473, 636.6498425865756, 636.7834936121741, 641.6503005861816, 4754.286856971482, 4938.58022068121, 4958.3720628067185, 4972.453030166679, 4982.7259500727805, 69399.95900061502, 73058.63470682612, 73553.63223183957, 73975.26024739792, 75416.62291688507, 60955.0, 64172.0, 64228.67885660542, 64499.67750161313, 64635.0, 60135.0, 60632.69683651553, 60889.08666370008, 61129.694351527956, 61172.69413652903, 9958.651447199314, 10058.54736536843, 10434.748048825248, 10816.729581760519, 11385.772284554429, 29597.704022959493, 29820.552691709207, 30577.694223058374, 31022.53466198054, 32125.839370802998, 52791.20813187728, 54180.458195419116, 56020.43979560315, 56820.14769778374, 57143.42856571381, 13361.66595835112, 13420.328983550979, 13534.661633459242, 13567.389467474184, 13693.178409295475, 15301.464448744686, 15331.0, 15429.074255544703, 15504.457343992906, 15639.452619158275, 13690.38393272325, 14128.222947737562, 14137.858621414065, 14319.0, 14575.489857854924, 14033.368498417392, 14119.576412707635, 14786.0, 14792.778108328599, 15136.697266054396, 13901.961270486803, 14252.287385630885, 14659.70680586361, 14822.40710371573, 14886.404543818126, 10311.742206444898, 10387.2209584283, 10439.843402349123, 10505.894941050798, 10657.786844262917, 9568.61725530971, 10389.636362727268, 10813.189010824062, 11105.0, 11386.829197562209], "value": 7336.200111869377, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 109.0, 109.0, 108.0, 108.0, 110.0, 109.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 119.0, 171.0, 117.0, 116.0, 117.0, 116.0, 138.0, 118.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 108.0, 74.0, 75.0, 75.0, 74.0, 99.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 83.0, 82.0, 83.0, 95.0, 83.0, 82.0, 106.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 55.0, 57.0, 57.0, 56.0, 58.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 55.0, 57.0, 54.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 88.0, 79.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 132.0, 125.0, 134.0, 127.0, 126.0, 137.0, 179.0, 130.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 185.0, 183.0, 188.0, 179.0, 175.0, 185.0, 175.0, 180.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 63.0, 65.0, 65.0, 70.0, 66.0], "value": 65.9, "unit": "score"}]}]} 18:16:38 INFO - Return code: 0 18:16:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:38 ERROR - # TBPL SUCCESS # 18:16:38 INFO - Running post-action listener: _resource_record_post_action 18:16:38 INFO - [mozharness: 2017-03-25 01:16:38.999304Z] Finished run-tests step (success) 18:16:38 INFO - Running post-run listener: _resource_record_post_run 18:16:39 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 372117504; Read time: 12; Write time: 269436 18:16:39 INFO - TinderboxPrint: CPU usage
12.9% 18:16:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:16:39 INFO - TinderboxPrint: I/O write bytes / time
372,117,504 / 269,436 18:16:39 INFO - TinderboxPrint: CPU idle
8,314.5 (87.1%) 18:16:39 INFO - TinderboxPrint: CPU user
1,186.1 (12.4%) 18:16:39 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112328704; Read time: 0; Write time: 120284 18:16:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 259788800; Read time: 0; Write time: 149152 18:16:39 INFO - Running post-run listener: _upload_blobber_files 18:16:39 INFO - Blob upload gear active. 18:16:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:16:39 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'] 18:16:39 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 18:16:40 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:40 INFO - (blobuploader) - INFO - Done attempting. 18:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:41 INFO - (blobuploader) - INFO - Done attempting. 18:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:45 INFO - (blobuploader) - INFO - Done attempting. 18:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:45 INFO - (blobuploader) - INFO - Done attempting. 18:16:45 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:45 INFO - Return code: 0 18:16:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ac3264487ccedf9f87bdd4b168554a8c04dd236ac6e93a6650feba5e4f21537b3e8e3849cc87416c7ed1dc3a1fd1362f79be0a06a9b43ff3d1bd7c9df754512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e821530cb15ef48528c525149d30b35a5e6dd3122a590c89b98d6fdb154659f7c10ea6797e20f41bd228b9d51882febe275cbb83a8e61f6c7ffece126fd710", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58fe715730fe4a14d44964ef0b6cca48eea6f2fe94fff33882e99acb651c2fa25a9dd77aa10f2256de89c403ee81aae3b705cb5ad20d4a376406127b7bf15a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2b531146d5934a302d8647c1da744e1b2d7ff962d9b12f3612634bf03e21b2d3482974b6cc2fe47f85cf26a81c914519aa0a0014d24ce1e23649eec636579d"} 18:16:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:45 INFO - Contents: 18:16:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ac3264487ccedf9f87bdd4b168554a8c04dd236ac6e93a6650feba5e4f21537b3e8e3849cc87416c7ed1dc3a1fd1362f79be0a06a9b43ff3d1bd7c9df754512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e821530cb15ef48528c525149d30b35a5e6dd3122a590c89b98d6fdb154659f7c10ea6797e20f41bd228b9d51882febe275cbb83a8e61f6c7ffece126fd710", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58fe715730fe4a14d44964ef0b6cca48eea6f2fe94fff33882e99acb651c2fa25a9dd77aa10f2256de89c403ee81aae3b705cb5ad20d4a376406127b7bf15a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2b531146d5934a302d8647c1da744e1b2d7ff962d9b12f3612634bf03e21b2d3482974b6cc2fe47f85cf26a81c914519aa0a0014d24ce1e23649eec636579d"} 18:16:45 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:45 INFO - Copying logs to upload dir... 18:16:45 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.693496 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-24 18:16:45.496244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:16:45.499651) ========= 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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 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/6ac3264487ccedf9f87bdd4b168554a8c04dd236ac6e93a6650feba5e4f21537b3e8e3849cc87416c7ed1dc3a1fd1362f79be0a06a9b43ff3d1bd7c9df754512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e821530cb15ef48528c525149d30b35a5e6dd3122a590c89b98d6fdb154659f7c10ea6797e20f41bd228b9d51882febe275cbb83a8e61f6c7ffece126fd710", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58fe715730fe4a14d44964ef0b6cca48eea6f2fe94fff33882e99acb651c2fa25a9dd77aa10f2256de89c403ee81aae3b705cb5ad20d4a376406127b7bf15a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2b531146d5934a302d8647c1da744e1b2d7ff962d9b12f3612634bf03e21b2d3482974b6cc2fe47f85cf26a81c914519aa0a0014d24ce1e23649eec636579d"} build_url:https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/eHLX15FISYq77Kt-IEwxug/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ac3264487ccedf9f87bdd4b168554a8c04dd236ac6e93a6650feba5e4f21537b3e8e3849cc87416c7ed1dc3a1fd1362f79be0a06a9b43ff3d1bd7c9df754512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e821530cb15ef48528c525149d30b35a5e6dd3122a590c89b98d6fdb154659f7c10ea6797e20f41bd228b9d51882febe275cbb83a8e61f6c7ffece126fd710", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58fe715730fe4a14d44964ef0b6cca48eea6f2fe94fff33882e99acb651c2fa25a9dd77aa10f2256de89c403ee81aae3b705cb5ad20d4a376406127b7bf15a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2b531146d5934a302d8647c1da744e1b2d7ff962d9b12f3612634bf03e21b2d3482974b6cc2fe47f85cf26a81c914519aa0a0014d24ce1e23649eec636579d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:16:45.525431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:16:45.525764) ========= 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=a0d2d2de893abaa8702a9954000001a7-1490403348.372638-1272583307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:16:45.611152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:16:45.611479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:16:45.611788) ========= ========= Total master_lag: 0.17 =========