builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1493917519.15 results: success (0) revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.153074) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.153523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.153796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.175927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.176259) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 10:05:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 135M=0s 2017-05-04 10:05:20 (135 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.309808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.310148) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018867 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.359185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:05:19.359531) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --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 0b255199db9d6a6f189b89b7906f99155bde3726 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 10:05:21,022 truncating revision to first 12 chars 2017-05-04 10:05:21,022 Setting DEBUG logging. 2017-05-04 10:05:21,022 attempt 1/10 2017-05-04 10:05:21,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:05:22,005 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:05:20.644742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:20.645059) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:20.645437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:20.645699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:20.656347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-04 10:05:20.656634) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:22 INFO - MultiFileLogger online at 20170504 10:05:22 in /builds/slave/test 10:05:22 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 10:05:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:22 INFO - {'append_to_log': False, 10:05:22 INFO - 'base_work_dir': '/builds/slave/test', 10:05:22 INFO - 'blob_upload_branch': 'Firefox', 10:05:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:22 INFO - 'branch': 'Firefox', 10:05:22 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:22 INFO - 'config_files': ('talos/linux_config.py',), 10:05:22 INFO - 'default_actions': ('clobber', 10:05:22 INFO - 'read-buildbot-config', 10:05:22 INFO - 'download-and-extract', 10:05:22 INFO - 'populate-webroot', 10:05:22 INFO - 'create-virtualenv', 10:05:22 INFO - 'install', 10:05:22 INFO - 'run-tests'), 10:05:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:22 INFO - 'download_minidump_stackwalk': True, 10:05:22 INFO - 'download_symbols': 'ondemand', 10:05:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:22 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:22 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:22 INFO - 'gecko_profile': False, 10:05:22 INFO - 'gecko_profile_interval': 0, 10:05:22 INFO - 'installer_path': 'installer.exe', 10:05:22 INFO - 'log_level': 'info', 10:05:22 INFO - 'log_name': 'talos', 10:05:22 INFO - 'log_to_console': True, 10:05:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:22 INFO - 'opt_config_files': (), 10:05:22 INFO - 'pip_index': False, 10:05:22 INFO - 'suite': 'dromaeojs', 10:05:22 INFO - 'system_bits': '32', 10:05:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:22 INFO - 'title': 'talos-linux64-ix-069', 10:05:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:22 INFO - 'use_talos_json': True, 10:05:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:22 INFO - 'work_dir': 'build'} 10:05:22 INFO - [mozharness: 2017-05-04 17:05:22.417539Z] Running clobber step. 10:05:22 INFO - Running pre-action listener: _resource_record_pre_action 10:05:22 INFO - Running main action method: clobber 10:05:22 INFO - rmtree: /builds/slave/test/build 10:05:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:23 INFO - Running post-action listener: _resource_record_post_action 10:05:23 INFO - [mozharness: 2017-05-04 17:05:23.349047Z] Finished clobber step (success) 10:05:23 INFO - [mozharness: 2017-05-04 17:05:23.349148Z] Running read-buildbot-config step. 10:05:23 INFO - Running pre-action listener: _resource_record_pre_action 10:05:23 INFO - Running main action method: read_buildbot_config 10:05:23 INFO - Using buildbot properties: 10:05:23 INFO - { 10:05:23 INFO - "project": "", 10:05:23 INFO - "product": "firefox", 10:05:23 INFO - "who": "archaeopteryx@coole-files.de", 10:05:23 INFO - "installer_path": "public/build/target.tar.bz2", 10:05:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:05:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:05:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:05:23 INFO - "stage_platform": "linux64-pgo", 10:05:23 INFO - "basedir": "/builds/slave/test", 10:05:23 INFO - "buildnumber": 179, 10:05:23 INFO - "platform": "ubuntu64_hw", 10:05:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:05:23 INFO - "slavebuilddir": "test", 10:05:23 INFO - "taskId": "drABN6RgQlG5fuwbbzmlZA", 10:05:23 INFO - "branch": "mozilla-central", 10:05:23 INFO - "script_repo_revision": "production", 10:05:23 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:05:23 INFO - "slavename": "talos-linux64-ix-069", 10:05:23 INFO - "repo_path": "mozilla-central" 10:05:23 INFO - } 10:05:23 INFO - Finding installer, test and symbols from parent task. 10:05:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drABN6RgQlG5fuwbbzmlZA'}, attempt #1 10:05:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drABN6RgQlG5fuwbbzmlZA'}, attempt #1 10:05:31 INFO - Task dependencies: ArH1QPTVQzy70sA-Zlw7xw 10:05:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw'}, attempt #1 10:05:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/test_packages.json 10:05:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.crashreporter-symbols.zip 10:05:31 INFO - Running post-action listener: _resource_record_post_action 10:05:31 INFO - [mozharness: 2017-05-04 17:05:31.747215Z] Finished read-buildbot-config step (success) 10:05:31 INFO - [mozharness: 2017-05-04 17:05:31.747436Z] Running download-and-extract step. 10:05:31 INFO - Running pre-action listener: _resource_record_pre_action 10:05:31 INFO - Running main action method: download_and_extract 10:05:31 INFO - mkdir: /builds/slave/test/build/tests 10:05: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')]} 10:05:31 INFO - trying https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json 10:05:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:05:32 INFO - Downloaded 986 bytes. 10:05:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:05:32 INFO - Using the following test package requirements: 10:05:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:05:32 INFO - u'common': [u'target.common.tests.zip'], 10:05:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:05:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:05:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:05:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:05:32 INFO - u'mozbase': [u'target.common.tests.zip'], 10:05:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:05:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:05:32 INFO - u'web-platform': [u'target.common.tests.zip', 10:05:32 INFO - u'target.web-platform.tests.zip'], 10:05:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:05:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:05:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip 10:05:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:32 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip into memory 10:05:34 INFO - Content-Length response header: 60559924 10:05:34 INFO - Bytes received: 60559924 10:05:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip 10:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip into memory 10:05:45 INFO - Content-Length response header: 60559924 10:05:45 INFO - Bytes received: 60559924 10:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip 10:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip into memory 10:05:57 INFO - Content-Length response header: 14408809 10:05:57 INFO - Bytes received: 14408809 10:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:57 INFO - trying https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:05:58 INFO - Downloaded 64065221 bytes. 10:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:58 INFO - mkdir: /builds/slave/test/properties 10:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:58 INFO - Contents: 10:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:58 INFO - Running post-action listener: _resource_record_post_action 10:05:58 INFO - Running post-action listener: set_extra_try_arguments 10:05:58 INFO - [mozharness: 2017-05-04 17:05:58.533411Z] Finished download-and-extract step (success) 10:05:58 INFO - [mozharness: 2017-05-04 17:05:58.533507Z] Running populate-webroot step. 10:05:58 INFO - Running pre-action listener: _resource_record_pre_action 10:05:58 INFO - Running main action method: populate_webroot 10:05:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:58 INFO - '--tppagecycles', 10:05:58 INFO - '7'], 10:05:58 INFO - 'tests': ['tsvgm']}}, 10:05:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['damp', 'tps']}, 10:05:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'tests': ['damp', 'tps']}, 10:05:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['dromaeo_dom']}, 10:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:05:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:05:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['a11yr', 10:05:58 INFO - 'ts_paint', 10:05:58 INFO - 'tpaint', 10:05:58 INFO - 'sessionrestore', 10:05:58 INFO - 'sessionrestore_no_auto_restore', 10:05:58 INFO - 'tabpaint']}, 10:05:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:05:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:05:58 INFO - 'bloom_basic_ref']}, 10:05:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['tsvgx', 10:05:58 INFO - 'tsvgr_opacity', 10:05:58 INFO - 'tart', 10:05:58 INFO - 'tscrollx', 10:05:58 INFO - 'cart', 10:05:58 INFO - 'tsvg_static']}, 10:05:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:58 INFO - 'tsvgr_opacity', 10:05:58 INFO - 'tart', 10:05:58 INFO - 'tscrollx', 10:05:58 INFO - 'cart', 10:05:58 INFO - 'tsvg_static']}, 10:05:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'talos_options': ['--disable-e10s'], 10:05:58 INFO - 'tests': ['tp5o']}, 10:05:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:05:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'talos_options': ['--disable-e10s', 10:05:58 INFO - '--xperf_path', 10:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:58 INFO - 'tests': ['tp5n']}, 10:05:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:05:58 INFO - 'talos_options': ['--xperf_path', 10:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:58 INFO - 'tests': ['tp5n']}}, 10:05:58 INFO - 'talos.zip': {'path': '', 10:05:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:58 INFO - Running post-action listener: _resource_record_post_action 10:05:58 INFO - [mozharness: 2017-05-04 17:05:58.547207Z] Finished populate-webroot step (success) 10:05:58 INFO - [mozharness: 2017-05-04 17:05:58.547297Z] Running create-virtualenv step. 10:05:58 INFO - Running pre-action listener: _resource_record_pre_action 10:05:58 INFO - Running main action method: create_virtualenv 10:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:58 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 10:05:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:58 INFO - Using real prefix '/usr' 10:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:01 INFO - Installing pip.................done. 10:06:01 INFO - Return code: 0 10:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:06:01 INFO - Reading from file tmpfile_stdout 10:06:01 INFO - Output received: 10:06:01 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) 10:06:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06:01 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')]} 10:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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')]} 10:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:01 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 10:06:01 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 10:06:01 INFO - Using env: {'DISPLAY': ':0', 10:06:01 INFO - 'HOME': '/home/cltbld', 10:06:01 INFO - 'LANG': 'en_US.UTF-8', 10:06:01 INFO - 'LANGUAGE': 'en_US:en', 10:06:01 INFO - 'LOGNAME': 'cltbld', 10:06:01 INFO - 'MAIL': '/var/mail/cltbld', 10:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:01 INFO - 'MOZ_NO_REMOTE': '1', 10:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:01 INFO - 'NO_EM_RESTART': '1', 10:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:01 INFO - 'PWD': '/builds/slave/test', 10:06:01 INFO - 'SHELL': '/bin/bash', 10:06:01 INFO - 'SHLVL': '1', 10:06:01 INFO - 'TERM': 'linux', 10:06:01 INFO - 'TMOUT': '86400', 10:06:01 INFO - 'USER': 'cltbld', 10:06:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:01 INFO - '_': '/tools/buildbot/bin/python'} 10:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:01 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 10:06:01 INFO - Cleaning up... 10:06:01 INFO - Return code: 0 10:06:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06:01 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')]} 10:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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')]} 10:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:01 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 10:06:01 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 10:06:01 INFO - Using env: {'DISPLAY': ':0', 10:06:01 INFO - 'HOME': '/home/cltbld', 10:06:01 INFO - 'LANG': 'en_US.UTF-8', 10:06:01 INFO - 'LANGUAGE': 'en_US:en', 10:06:01 INFO - 'LOGNAME': 'cltbld', 10:06:01 INFO - 'MAIL': '/var/mail/cltbld', 10:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:01 INFO - 'MOZ_NO_REMOTE': '1', 10:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:01 INFO - 'NO_EM_RESTART': '1', 10:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:01 INFO - 'PWD': '/builds/slave/test', 10:06:01 INFO - 'SHELL': '/bin/bash', 10:06:01 INFO - 'SHLVL': '1', 10:06:01 INFO - 'TERM': 'linux', 10:06:01 INFO - 'TMOUT': '86400', 10:06:01 INFO - 'USER': 'cltbld', 10:06:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:01 INFO - '_': '/tools/buildbot/bin/python'} 10:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:01 INFO - Downloading/unpacking psutil>=3.1.1 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:03 INFO - Installing collected packages: psutil 10:06:03 INFO - Running setup.py install for psutil 10:06:03 INFO - building 'psutil._psutil_linux' extension 10:06:03 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 10:06:03 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 10:06:03 INFO - building 'psutil._psutil_posix' extension 10:06:03 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 10:06:03 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 10:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:03 INFO - Successfully installed psutil 10:06:03 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:03 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 10:06:03 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 10:06:03 INFO - Using env: {'DISPLAY': ':0', 10:06:03 INFO - 'HOME': '/home/cltbld', 10:06:03 INFO - 'LANG': 'en_US.UTF-8', 10:06:03 INFO - 'LANGUAGE': 'en_US:en', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MAIL': '/var/mail/cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SHLVL': '1', 10:06:03 INFO - 'TERM': 'linux', 10:06:03 INFO - 'TMOUT': '86400', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - '_': '/tools/buildbot/bin/python'} 10:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:03 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 10:06:03 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 10:06:03 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 10:06:03 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 10:06:03 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 10:06:03 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 10:06:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:04 INFO - Installing collected packages: mozsystemmonitor 10:06:04 INFO - Running setup.py install for mozsystemmonitor 10:06:04 INFO - Successfully installed mozsystemmonitor 10:06:04 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06:05 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')]} 10:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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')]} 10:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:05 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 10:06:05 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 10:06:05 INFO - Using env: {'DISPLAY': ':0', 10:06:05 INFO - 'HOME': '/home/cltbld', 10:06:05 INFO - 'LANG': 'en_US.UTF-8', 10:06:05 INFO - 'LANGUAGE': 'en_US:en', 10:06:05 INFO - 'LOGNAME': 'cltbld', 10:06:05 INFO - 'MAIL': '/var/mail/cltbld', 10:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:05 INFO - 'MOZ_NO_REMOTE': '1', 10:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:05 INFO - 'NO_EM_RESTART': '1', 10:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:05 INFO - 'PWD': '/builds/slave/test', 10:06:05 INFO - 'SHELL': '/bin/bash', 10:06:05 INFO - 'SHLVL': '1', 10:06:05 INFO - 'TERM': 'linux', 10:06:05 INFO - 'TMOUT': '86400', 10:06:05 INFO - 'USER': 'cltbld', 10:06:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:05 INFO - '_': '/tools/buildbot/bin/python'} 10:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:06:05 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 10:06:05 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 10:06:05 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 10:06:05 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 10:06:05 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 10:06:05 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 10:06:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:06 INFO - warning: no files found matching '*.txt' 10:06:06 INFO - no previously-included directories found matching 'build' 10:06:06 INFO - no previously-included directories found matching 'dist' 10:06:06 INFO - no previously-included directories found matching '.git*' 10:06:06 INFO - Installing collected packages: jsonschema, functools32 10:06:06 INFO - Running setup.py install for functools32 10:06:06 INFO - warning: no files found matching '*.txt' 10:06:06 INFO - no previously-included directories found matching 'build' 10:06:06 INFO - no previously-included directories found matching 'dist' 10:06:06 INFO - no previously-included directories found matching '.git*' 10:06:06 INFO - Successfully installed jsonschema functools32 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 INFO - Downloading docopt-0.6.1.tar.gz 10:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:08 INFO - Running setup.py install for blobuploader 10:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:08 INFO - Running setup.py install for requests 10:06:09 INFO - Running setup.py install for docopt 10:06:09 INFO - Successfully installed blobuploader requests docopt 10:06:09 INFO - Cleaning up... 10:06:09 INFO - Return code: 0 10:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:09 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')]} 10:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:09 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')]} 10:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:09 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:09 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 10:06:09 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 10:06:09 INFO - Using env: {'DISPLAY': ':0', 10:06:09 INFO - 'HOME': '/home/cltbld', 10:06:09 INFO - 'LANG': 'en_US.UTF-8', 10:06:09 INFO - 'LANGUAGE': 'en_US:en', 10:06:09 INFO - 'LOGNAME': 'cltbld', 10:06:09 INFO - 'MAIL': '/var/mail/cltbld', 10:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:09 INFO - 'MOZ_NO_REMOTE': '1', 10:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:09 INFO - 'NO_EM_RESTART': '1', 10:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:09 INFO - 'PWD': '/builds/slave/test', 10:06:09 INFO - 'SHELL': '/bin/bash', 10:06:09 INFO - 'SHLVL': '1', 10:06:09 INFO - 'TERM': 'linux', 10:06:09 INFO - 'TMOUT': '86400', 10:06:09 INFO - 'USER': 'cltbld', 10:06:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:09 INFO - '_': '/tools/buildbot/bin/python'} 10:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:09 INFO - Running setup.py (path:/tmp/pip-8G_lqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:09 INFO - Running setup.py (path:/tmp/pip-d7xPc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:09 INFO - Running setup.py (path:/tmp/pip-v2NPqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:09 INFO - Running setup.py (path:/tmp/pip-hUxPZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:09 INFO - Running setup.py (path:/tmp/pip-Hk0Lxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:09 INFO - Running setup.py (path:/tmp/pip-GCWIKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:10 INFO - Running setup.py (path:/tmp/pip-q598hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:10 INFO - Running setup.py (path:/tmp/pip-FZKE9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:10 INFO - Running setup.py (path:/tmp/pip-8m9Zhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:10 INFO - Running setup.py (path:/tmp/pip-auuK6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:10 INFO - Running setup.py (path:/tmp/pip-_7uNPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:10 INFO - Running setup.py (path:/tmp/pip-HcGKSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:10 INFO - Running setup.py (path:/tmp/pip-vdowqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:10 INFO - Running setup.py (path:/tmp/pip-Pb5px5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:10 INFO - Running setup.py (path:/tmp/pip-cmobJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:10 INFO - Running setup.py (path:/tmp/pip-KNgO8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:10 INFO - Running setup.py (path:/tmp/pip-_U49LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:10 INFO - Running setup.py install for manifestparser 10:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:10 INFO - Running setup.py install for mozcrash 10:06:11 INFO - Running setup.py install for mozdebug 10:06:11 INFO - Running setup.py install for mozdevice 10:06:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for mozfile 10:06:11 INFO - Running setup.py install for mozhttpd 10:06:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for mozinfo 10:06:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for mozInstall 10:06:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for mozleak 10:06:11 INFO - Running setup.py install for mozlog 10:06:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for moznetwork 10:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:11 INFO - Running setup.py install for mozprocess 10:06:12 INFO - Running setup.py install for mozprofile 10:06:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:12 INFO - Running setup.py install for mozrunner 10:06:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:12 INFO - Running setup.py install for mozscreenshot 10:06:12 INFO - Running setup.py install for moztest 10:06:12 INFO - Running setup.py install for mozversion 10:06:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:12 INFO - Cleaning up... 10:06:12 INFO - Return code: 0 10:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:12 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 10:06:12 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 10:06:12 INFO - Using env: {'DISPLAY': ':0', 10:06:12 INFO - 'HOME': '/home/cltbld', 10:06:12 INFO - 'LANG': 'en_US.UTF-8', 10:06:12 INFO - 'LANGUAGE': 'en_US:en', 10:06:12 INFO - 'LOGNAME': 'cltbld', 10:06:12 INFO - 'MAIL': '/var/mail/cltbld', 10:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:12 INFO - 'MOZ_NO_REMOTE': '1', 10:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:12 INFO - 'NO_EM_RESTART': '1', 10:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:12 INFO - 'PWD': '/builds/slave/test', 10:06:12 INFO - 'SHELL': '/bin/bash', 10:06:12 INFO - 'SHLVL': '1', 10:06:12 INFO - 'TERM': 'linux', 10:06:12 INFO - 'TMOUT': '86400', 10:06:12 INFO - 'USER': 'cltbld', 10:06:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:12 INFO - '_': '/tools/buildbot/bin/python'} 10:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 INFO - Running setup.py (path:/tmp/pip-069ovW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 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)) 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:12 INFO - Running setup.py (path:/tmp/pip-_48XRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:13 INFO - Running setup.py (path:/tmp/pip-8denmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:13 INFO - Running setup.py (path:/tmp/pip-mjECBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:13 INFO - Running setup.py (path:/tmp/pip-OOErYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:13 INFO - Running setup.py (path:/tmp/pip-4mLWN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:13 INFO - Running setup.py (path:/tmp/pip-yv0w0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:13 INFO - Running setup.py (path:/tmp/pip-SsyJ3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:13 INFO - Running setup.py (path:/tmp/pip-uiXyLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:13 INFO - Running setup.py (path:/tmp/pip-0pRr09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 INFO - Running setup.py (path:/tmp/pip-w45jS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 INFO - Running setup.py (path:/tmp/pip-s3LT3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 INFO - Running setup.py (path:/tmp/pip-1nMMwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:13 INFO - Running setup.py (path:/tmp/pip-Sxlyel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:13 INFO - Running setup.py (path:/tmp/pip-_GQKBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:13 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)) 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:13 INFO - Running setup.py (path:/tmp/pip-NhwlVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:14 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)) 10:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:14 INFO - Running setup.py (path:/tmp/pip-2CHy6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:14 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)) 10:06:14 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)) 10:06:14 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)) 10:06:14 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)) 10:06:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:15 INFO - Downloading blessings-1.6.tar.gz 10:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:15 INFO - Installing collected packages: blessings 10:06:15 INFO - Running setup.py install for blessings 10:06:15 INFO - Successfully installed blessings 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:15 INFO - Reading from file tmpfile_stdout 10:06:15 INFO - Current package versions: 10:06:15 INFO - argparse == 1.2.1 10:06:15 INFO - blessings == 1.6 10:06:15 INFO - blobuploader == 1.2.4 10:06:15 INFO - docopt == 0.6.1 10:06:15 INFO - functools32 == 3.2.3-2 10:06:15 INFO - jsonschema == 2.5.1 10:06:15 INFO - manifestparser == 1.1 10:06:15 INFO - mozInstall == 1.12 10:06:15 INFO - mozcrash == 1.0 10:06:15 INFO - mozdebug == 0.1 10:06:15 INFO - mozdevice == 0.50 10:06:15 INFO - mozfile == 1.2 10:06:15 INFO - mozhttpd == 0.7 10:06:15 INFO - mozinfo == 0.9 10:06:15 INFO - mozleak == 0.1 10:06:15 INFO - mozlog == 3.4 10:06:15 INFO - moznetwork == 0.27 10:06:15 INFO - mozprocess == 0.25 10:06:15 INFO - mozprofile == 0.28 10:06:15 INFO - mozrunner == 6.13 10:06:15 INFO - mozscreenshot == 0.1 10:06:15 INFO - mozsystemmonitor == 0.3 10:06:15 INFO - moztest == 0.8 10:06:15 INFO - mozversion == 1.4 10:06:15 INFO - psutil == 3.1.1 10:06:15 INFO - requests == 1.2.3 10:06:15 INFO - wsgiref == 0.1.2 10:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 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 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:15 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 10:06:15 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 10:06:15 INFO - Using env: {'DISPLAY': ':0', 10:06:15 INFO - 'HOME': '/home/cltbld', 10:06:15 INFO - 'LANG': 'en_US.UTF-8', 10:06:15 INFO - 'LANGUAGE': 'en_US:en', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MAIL': '/var/mail/cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SHLVL': '1', 10:06:15 INFO - 'TERM': 'linux', 10:06:15 INFO - 'TMOUT': '86400', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - '_': '/tools/buildbot/bin/python'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 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)) 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', '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 10:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:15 INFO - Using env: {'DISPLAY': ':0', 10:06:15 INFO - 'HOME': '/home/cltbld', 10:06:15 INFO - 'LANG': 'en_US.UTF-8', 10:06:15 INFO - 'LANGUAGE': 'en_US:en', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MAIL': '/var/mail/cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SHLVL': '1', 10:06:15 INFO - 'TERM': 'linux', 10:06:15 INFO - 'TMOUT': '86400', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - '_': '/tools/buildbot/bin/python'} 10:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:16 INFO - Cleaning up... 10:06:16 INFO - Return code: 0 10:06:16 INFO - Running post-action listener: _resource_record_post_action 10:06:16 INFO - Running post-action listener: _start_resource_monitoring 10:06:16 INFO - Starting resource monitoring. 10:06:16 INFO - [mozharness: 2017-05-04 17:06:16.109049Z] Finished create-virtualenv step (success) 10:06:16 INFO - [mozharness: 2017-05-04 17:06:16.109523Z] Running install step. 10:06:16 INFO - Running pre-action listener: _resource_record_pre_action 10:06:16 INFO - Running main action method: install 10:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:16 INFO - Reading from file tmpfile_stdout 10:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:16 INFO - Reading from file tmpfile_stdout 10:06:16 INFO - Output received: 10:06:16 INFO - Usage: mozinstall [options] installer 10:06:16 INFO - Options: 10:06:16 INFO - -h, --help show this help message and exit 10:06:16 INFO - -d DEST, --destination=DEST 10:06:16 INFO - Directory to install application into. [default: 10:06:16 INFO - "/builds/slave/test"] 10:06:16 INFO - --app=APP Application being installed. [default: firefox] 10:06:16 INFO - mkdir: /builds/slave/test/build/application 10:06:16 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'] 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:06:32 INFO - Reading from file tmpfile_stdout 10:06:32 INFO - Output received: 10:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:32 INFO - Running post-action listener: _resource_record_post_action 10:06:32 INFO - [mozharness: 2017-05-04 17:06:32.570260Z] Finished install step (success) 10:06:32 INFO - [mozharness: 2017-05-04 17:06:32.570536Z] Running run-tests step. 10:06:32 INFO - Running pre-action listener: _resource_record_pre_action 10:06:32 INFO - Running main action method: run_tests 10:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:32 INFO - Python 2.7.3 10:06:32 INFO - Return code: 0 10:06:32 INFO - grabbing minidump binary from tooltool 10:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:32 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 0x2684400>, '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 0x26853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:32 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 10:06:32 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 10:06:32 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 10:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:32 INFO - Return code: 0 10:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:32 INFO - ENV: RUST_BACKTRACE is now 1 10:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:32 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/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 10:06:32 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/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 10:06:32 INFO - Using env: {'DISPLAY': ':0', 10:06:32 INFO - 'HOME': '/home/cltbld', 10:06:32 INFO - 'LANG': 'en_US.UTF-8', 10:06:32 INFO - 'LANGUAGE': 'en_US:en', 10:06:32 INFO - 'LOGNAME': 'cltbld', 10:06:32 INFO - 'MAIL': '/var/mail/cltbld', 10:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:32 INFO - 'MOZ_NO_REMOTE': '1', 10:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:32 INFO - 'NO_EM_RESTART': '1', 10:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:32 INFO - 'PWD': '/builds/slave/test', 10:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:32 INFO - 'RUST_BACKTRACE': '1', 10:06:32 INFO - 'SHELL': '/bin/bash', 10:06:32 INFO - 'SHLVL': '1', 10:06:32 INFO - 'TERM': 'linux', 10:06:32 INFO - 'TMOUT': '86400', 10:06:32 INFO - 'USER': 'cltbld', 10:06:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741', 10:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:32 INFO - '_': '/tools/buildbot/bin/python'} 10:06:32 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/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 10:06:32 INFO - mozversion application_buildid: 20170504160921 10:06:32 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:06:32 INFO - mozversion application_display_name: Nightly 10:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:32 INFO - mozversion application_name: Firefox 10:06:32 INFO - mozversion application_remotingname: firefox 10:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:32 INFO - mozversion application_vendor: Mozilla 10:06:32 INFO - mozversion application_version: 55.0a1 10:06:32 INFO - mozversion platform_buildid: 20170504160921 10:06:32 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:32 INFO - mozversion platform_version: 55.0a1 10:06:32 INFO - using testdate: 1493917592 10:06:32 INFO - actual date: 1493917592 10:06:32 INFO - starting webserver on 'localhost:40768' 10:06:32 INFO - SUITE-START | Running 2 tests 10:06:32 INFO - TEST-START | dromaeo_css 10:06:32 INFO - operating with platform_type : linux_ 10:06:32 INFO - Initialising browser for dromaeo_css test... 10:06:32 INFO - TEST-INFO | started process 25761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm14qsx/profile http://localhost:40768/getInfo.html) 10:06:37 INFO - PID 25761 | __metrics Screen width/height:1600/1200 10:06:37 INFO - PID 25761 | colorDepth:24 10:06:37 INFO - PID 25761 | Browser inner width/height: 1024/695 10:06:37 INFO - PID 25761 | __metrics 10:06:38 INFO - PID 25761 | 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" 10:06:38 INFO - PID 25761 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:39 INFO - TEST-INFO | 25761: exit 0 10:06:39 INFO - Browser initialized. 10:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:39 INFO - TEST-INFO | started process 25863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm14qsx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:51 INFO - PID 25863 | RSS: Main: 149614592 10:06:51 INFO - PID 25863 | 10:09:53 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40768/tests/dromaeo/cssquery-ext.html) 10:09:54 INFO - PID 25863 | RSS: Main: 262336512 10:09:54 INFO - PID 25863 | 10:12:57 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-ext.html (next: http://localhost:40768/tests/dromaeo/cssquery-jquery.html) 10:12:57 INFO - PID 25863 | RSS: Main: 224419840 10:12:57 INFO - PID 25863 | 10:15:59 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40768/tests/dromaeo/cssquery-mootools.html) 10:15:59 INFO - PID 25863 | RSS: Main: 224591872 10:15:59 INFO - PID 25863 | 10:19:01 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40768/tests/dromaeo/cssquery-prototype.html) 10:19:02 INFO - PID 25863 | RSS: Main: 189054976 10:19:02 INFO - PID 25863 | 10:22:04 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40768/tests/dromaeo/cssquery-yui.html) 10:22:05 INFO - PID 25863 | RSS: Main: 176128000 10:22:05 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | Cycle 1(1): loaded http://localhost:40768/tests/dromaeo/cssquery-yui.html (next: http://localhost:40768/tests/dromaeo/cssquery-dojo.html) 10:25:07 INFO - PID 25863 | RSS: Main: 272719872 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | __start_tp_report 10:25:07 INFO - PID 25863 | _x_x_mozilla_page_load 10:25:07 INFO - PID 25863 | _x_x_mozilla_page_load_details 10:25:07 INFO - PID 25863 | |i|pagename|runs| 10:25:07 INFO - PID 25863 | |0;dojo.html;3296.077098412444;3303.587051618548;3318.4026875162476;3344.9331013379747;3353.4131526982774;5744.109663002231;5805.158252053455;5819.301683797945;5867.853303667411;5897.616654917428;5795.768169273224;5814.883702325951;5844.415558444153;5897.144913987469;5922.940770592293;4785.497522760113;5072.492750724917;5113.539781419671;5194.039102765982;5249.028929648028;5209.348831396057;5221.008008478396;5277.050130976423;5278.340207474066;5298.947010529884;5122;5148.7940482380845;5203.219517072451;5228.973855130738;5245.134552798783;5172.456892026321;5184.818531351422;5195.402528709209;5196.636235463519;5243.737813109329;5134.614903882224;5161.200013997799;5191.740412979336;5193.065248255312;5222.477752224785;5650.434956504317;5720.342160651537;5741.110127930177;5781.739821708034;5846;6276.215473065867;6300.086487459339;6302.275238347603;6302.4958003359625;6304.117423560705;6318.968405157991;6334.809955701337;6337.524685648595;6338.524610654219;6344.175257216579;5790.681512516852;5818.825435236908;5846.269216347957;5858.824235272906;5881.088431293157;6370.968145159244;6409.455196308273;6413.486921046305;6418.550701450854;6429.260635026938;6067.969660151671;6094.325681954534;6098.038923863779;6107.46959931229;6184.226971628546;6162.322144564095;6181.134641150243;6231.096491008779;6263.217097862767;6284.937150628435;6135.306216178427;6264.404881536247;6277.372262773686;6280.2777680566405;6286.937130628635;6114.975470440207;6191.721372538246;6214.316425193225;6215.627062376272;6232.189815323979;4831.4202295724735;4840.104580652591;4840.273958906192;4868.9756551217015;4879.170541008037;4260.041490664637;4264.87205383839;4271.466066741657;4274.081072569413;4304.504981927118;5799.768009279582;5878.941210587925;5884.352721200665;5884.6469211847425;5885.146653735184;6130.7650488535955;6205.348438413992;6236.937630623726;6255.218097737783;6297.464715499143;5872.265966754156;5878.882422351615;5880.882382352329;5896.764129434775;5900;5455.5908306877145;5478.561715062785;5503.036968530491;5514.310711161105;5516.172574113915;6505.0567667688865;6512.381323774234;6600.273969863407;6648.102506161703;6649.301823308483;6343.714532845941;6375.7449702013255;6387.201599800025;6388.9041664376;6391.648459334781;6619.238787539494;6663.633500157538;6678.2320033194865;6685.431738302299;6687.331266873273;6096.556923351527;6097.4036925702085;6189.442950134329;6252.718627661675;6262.279837818709;6309.179806625109;6332.968335158294;6346.650934198663;6350.301466838737;6357.205349331333;6047.244094488189;6051.062085376773;6119.296280927751;6121.387861213843;6124.0201567748945;6078.787242446493;6123.601965872204;6140.078988151813;6145.293291271382;6158.3841615838055;6003.129546215687;6086.391360863879;6117.265928088658;6135.907961380493;6184.103305020837;6116.274903966807;6162.26052873658;6172.753089876354;6174.506039516738;6177.722002509808;5963.970180149245;5966.820995370146;5968.313643931004;5969.283685957713;6023.066424704178 10:25:07 INFO - PID 25863 | |1;ext.html;720.1646090534978;765.3876898481216;792.4611264340247;1128.8137457319542;1156.1791128298908;29534.704652953464;30122.849385753067;36549.26901461973;37673;37809.24381512368;38983;39303.803480982555;39316;39360;39405;5696.943030569703;7258.782236532912;7399.260073992611;7408.3332500074985;7409.333160015598;5768.942310576883;7133.251008644095;7249;7293.161286452073;7301.744438944638;7370.262973702614;7416.40668746499;7437.553746775211;7440.888386674204;7444.181140074587;5709.457601527848;7340.596267205302;7398.075240594926;7408.222136675652;7412.073490813648;5767;7092.397146242575;7249.057622509093;7258.818529536751;7268.6729097190755;36625.45061824075;36926;37044.814775926214;37049;37085.81457092724;3572.1069732566857;3619.2218672985437;3620.583632882226;3622.094476380905;3622.130688634735;27990;27991.580126298122;28002.159935201773;28036.439271214665;28040.85979570089;3815.7138214633737;3829.5213098362706;3862.053796819769;3871.477350557695;3871.5547712012917;191171;191240;191377;191663;192813;49345;49392.30773076552;49434.50565494371;49435.75282123566;49486;51763;51792.48207517876;51796;51821.7408912953;51937;15854.128022958617;15916.840831591768;15941;15942.28259728315;15958;11413.42932853354;11612.361320127306;13020.47918083266;13032.739345213042;13043.086983911035;15081.265654449659;15191.392344306325;15317.540473785804;15345.30946107428;15498.767518487231;5907.1434641976675;6075.605085669417;6082.452579267887;6114.510839132948;6134.110553969738;1068.3803394031443;1093.0654290581597;1097.1935627313917;1109.173665619119;1115.0912006714502;28004.43991120166;28075.719242807718;28118.578221326698;28182.2954426141;28309.43381132366;1163.5752950173296;1174.3247632611112;1175.4468836238007;1184.763047390508;1193.146899966528;14120.71758564823;14122.71754564903;14292.571222863331;14303.427862885575;14330.641733956734;261827;263240;263362;263599;264321;53442.198367024524;53740.73129634405;53797.1930421044;53861;53944.73027634837;1460.4450308882556;1498.9100653960797;1511.168857128575;1524.1312451902531;1532.7930729351617;24370.26889193327;25616.615750764126;25708.015257635096;25756.742432575433;25958.610620841082;36520.81739591285;36542;36560;36576.63423365732;36581.26837463289;217241;217436;217528;218317;218739;29977.100686979426;30178.24554386158;35757;36196.027655436556;36313.818430907675;45375;47584.286235707186;47613.76193119012;47950.28074578954;48340.16598340138;33227.667723322455;35493;36103.81948090243;36455.81772091229;36992.6300737;35838.283234334645;36361.63638363582;36705;36870.446943295334;37870.81064594659;40468.595314046484;43324;43357.56642433535;43585.56414435815;43614.345784813886;34486.65513344935;36010;36014.4597831038;36398.63601363952;36637.81681091578;27684.723152768216;28731.707073182177;28739.994100206393;28801.135965921058;28840.711592884643 10:25:07 INFO - PID 25863 | |2;jquery.html;436.82090342959356;452.84376889972947;452.8777230147859;454.22554544501605;471.6274143426693;18005.27978880843;20040;20668.68996965043;20809.791902080975;20818.687719684218;21547.353579392606;22210.444738881535;22402.551948961052;22528.09887604494;22689.20587779428;5491.780328786854;5692.459216374438;5699.515541179005;5702.287214098238;5703.914441283384;5335.573154147659;5494.587905907073;5515.751791169407;5522;5532.6680399175975;5483.588730845203;5510.201020851974;5512.972435137819;5517.944820551803;5519;5363.222332761748;5588.245586845765;5615.157726341041;5625.40933202012;5629.859253518674;5015;5122.129238029544;5130.256112863613;5130.461301563357;5131.3329267195395;24224.757752422604;24300.39249018771;24514;24557.754422455724;24716.752832471626;2215.0586000949534;2245.7305123385136;2250.437390652337;2250.6173950428465;2251.482159103399;16200.27098780546;16891.070991095487;16901.323947042103;16931.661366772594;17014.574635634086;2152.4502358301997;2163.350994701583;2205.6250437425674;2227.3318004598555;2233.508628101815;93539.53230233873;100596;118947.2684275528;119064.40467797693;119428.40285798516;12155;12198.14612977083;12518.687032824253;12596.81104783429;12759.170653907651;17687.911560442117;17696.29214831418;17718.822811771974;17730.20214090369;17751.201195946214;8939.642414303486;9186.173244407903;9330.673426430043;9367.156955874005;9405.811883762422;8423.957880210559;8517.36119791018;8531.786705332292;8807.735767926972;8835.55822208887;7656.549904030657;7657.46397752152;7851.508213439428;7885.530366638661;7934.127246002935;2130.8706385615646;2165.263810304504;2174.1086154676505;2203.316971738766;2243.5176437065784;1050.3382868792764;1083.918706097046;1087.6573879228017;1092.2354351953663;1092.5902786455079;20356.491087722927;20395.79604203939;20431.591368172554;20557.69163462549;20726.481837954172;1111.0944580167138;1111.4109521953378;1114.4761961877905;1118.8825173356681;1119.5074167366333;10721.463926803628;11059.834102488468;11231.98650693269;11330.09359251258;11392.886071139348;458191;461469;470332.45013247605;473487;483374;80534;89218;95946.52026739821;96395;100770.49614751879;1200.8558972923306;1245.3088535862503;1248.1013670157472;1280.2830414967461;1289.6324547503916;17620;18771.249150033847;20258;20269;20389.89805050965;44616.77691611651;45376.77311613421;45529.77235113803;45683.31475027811;46654.97093560894;57472;58413;58867.41132588619;59110;59379;9339.813203735752;9666.613335466502;9800.803983920425;10064.44645544502;10136.290459667753;13299.135556188818;15125.848741512444;15190.696186076437;15194.772078418611;15406.229688515305;13073.477060917457;13149.60551183466;13176;13547.525836595672;13897.791533127214;11315.321080735182;11463.656090317303;11677;11699;11803.586874459354;13438.664033399244;13531.526396576073;13544.525941591997;13827.377768000666;14182.361793719101;12554.246745195318;12860.678483037998;12924.547640832525;12980.805287920877;13060.085793994329;12763.617091487271;12776.74446511046;12855.935720321339;12877.420516076987;13221.405036773176 10:25:07 INFO - PID 25863 | |3;mootools.html;1335.7862741961285;1386.3899884051016;1398.4476131927895;1401.6285684293664;1405.2552147361898;10350.896491035088;10719.19606029547;10727.35635861848;10730.302530335523;10735.033846953773;10520.631777887775;11237.325760454358;11407.600733974292;11516.596919107833;11517;2207.2274703853645;2231.716762861353;2233.352327824929;2240.316703405461;2241.69737085493;1860.6278744251135;2170.1536400803698;2222.0778376973535;2241.618924782783;2246.5843818893477;1934.516370907273;2167.9024443899984;2235.9938027887433;2245;2249.4263962689574;2105.9262925797525;2140.8501404901663;2141.207753131351;2149.494868705861;2151.128792838895;2146.291723731165;2152.042341158185;2162.8702277863376;2165.4153378587853;2174.5433458973635;11119.499622517005;11247.943760281229;11248.38133902635;11248.550057997752;11254.831177532344;6522.836929076763;6728.091707619457;6738.124043874265;6746.595204287759;6751.054852320679;3845.769253844778;3972.1459886124335;4205.306124489455;4212.4523811904255;4217.072244106292;1345.8250427444468;1364.2019418640107;1393.1849867827334;1425.4227038049607;1449.5071675630336;17364.479065628053;17447.825521744748;17508.562285942826;17610.471685849574;17618.91190544052;5234.398044224887;5292.761825717775;5389.730513474311;5631.070873305859;5641.492265696025;12448.31534265624;12494.187877787916;12553.246805191535;12556.183848049848;12571.497140114476;6589.17635295588;6591.505637077238;6593.769218077345;6598.60408375499;6598.901016484757;6024.277086749618;6248.156498872685;6253.5622506425025;6286.685665716695;6291.370862913672;4214.599613036757;4247.915041699149;4264.786760662017;4336;4373.584509471595;1090.7218659241842;1214.2107630040368;1223.2843786385065;1230.138902768066;1246.8940140088014;735.543962743092;852.6887685994567;871.1810897756089;881.8324518341494;901.9143181397887;6442.130312407765;7301.744438944612;7314.45141614381;7342.48602597813;7403.51877127985;915.839728047589;954.513198268874;988.8220120378401;1004.196642685863;1021.8722659667542;4718.197906355927;4731.29030645406;4839.95160048395;4857.7085374876915;4861.416630004422;14946.476873309382;15442.45951391696;15503.767443488357;15534.533963980872;15711.21443927799;14473.27633618315;15162.166080865658;15209;15519.379224831106;15533.378664853506;9210.401323913924;9396.107369799858;9438.716838494856;9473.715788526355;9475.905240947503;6823.522353435212;7181.210066892533;7186.856262874818;7227.349538541556;7276.308750668678;13237.338133093113;13667.248301343125;13978.30108494551;13988.720225595634;14017.158970461805;13401.53094641683;13881.375338109607;13933.372998215307;14197.787033194716;14277.857221428068;9590.328676992543;9615;9762.80474390494;9828.459434731158;9841.163501102486;10909.727256818644;11148.275362101438;11186.440677966231;11252.549898003988;11255.943720281346;8883.645833854163;8983.730488085368;9040.41237319572;9468;9703.07820757027;8831.470111793313;8854.335924805537;8874.245689116497;8887.466751994902;8951.194392504705;8043.316318112792;8105.230003149692;8193.46742461738;8221.095679475133;8230.62962166716;6376.266729326187;6477.902831457626;6487.416132548094;6551.639659818756;6738.59568425896;6388.936110638834;6446.613203207822;6450.451711604378;6610.9669451652435;6771.830704232433 10:25:07 INFO - PID 25863 | |4;prototype.html;395.51944387569097;413.80757947554383;416.3879097726342;426.24767285740654;430.9741415515068;5937.88124237515;5966.284045914496;5986.132010858423;5993.48273725036;6015.789447369338;5655.604107712462;5862.76548938043;5874.327181132585;5884.176215329857;5888.263967004124;4448.310511870649;4468.597826195633;4471;4471.4857791353925;4474.843380481684;4469.106178764244;4474.709143905636;4475.30632751924;4483.14820184164;4487.227545119676;4319.624206686326;4400.823967041314;4441.444819397575;4450.287953927373;4450.554944505539;4420.916875365556;4427.9557204427865;4433.733975961452;4438.7114837535455;4438.844640437569;3864.787436691009;3879.515060617423;3889.3388124018984;3895.376739721631;3910.863119790822;5601.831945041656;5696.6866822324755;5737.598368114233;5740.741666625012;5813.09896965971;5219.347581552306;5238.528532432099;5245.895082098336;5247.763850626731;5272.92090618641;5965.313988891289;6189.38106189382;6201.72092255845;6202.72087756052;6216.2851272103835;4348.195583817004;4348.782560871944;4351.0862718829085;4360.629346505519;4373.453318335208;6221.377862213788;6357.872842543169;6398.968005159944;6486.740530378779;6578.111954886077;4461.464624245112;4473.083017981306;4481.551844815493;4490.348899409567;4492.595666390041;4525.253333200051;4526.23054080807;4529.365888775574;4533.252013417815;4536.500984891659;5090.287359769635;5174.146265866165;5209.661372010807;5214.217867319857;5230.424653288135;6252.280987686383;6264.655443950535;6273.686315684289;6275.96862015687;6289.433950944345;1528.205333226716;1541.9691606167814;1551.83705710901;1552.7190068193786;1552.9689406211812;1022.7136401807505;1038.4288641247283;1039.740064983754;1040;1044.2794471814423;5956.493698035629;5964.7315870785915;5968.22413086296;5968.671723055187;5976.641401515923;6312.5581209314905;6422.261439934374;6443.7744678936015;6445.967770161119;6449.484041276686;5936;5941.732622032019;5956.136360227742;5959.957007523666;5961.880762384728;3360.1431634932937;3379.4086034943784;3404.3361544498584;3404.4552871540436;3419.6580341965605;6631.905735553676;6665.833354166185;6682.525086954854;6718.798436046926;6746.255828015401;6579.80260592183;6580.243272023683;6585.2426970898005;6586;6601.603903765694;6606.471482281406;6738.561993470409;6771.796846094625;6778.661066946732;6800.455963522906;6403.647799370893;6419.679016049272;6421;6426.871462570629;6431.163948686828;6081.726322315418;6127.724252408563;6357.523185761179;6374.203224596926;6400;6562.573432726857;6567.719294737672;6704.932950670431;6731.697073631601;6741.662916854039;4456.153330867125;4466.798994045211;4472.664550158686;4479.686421950432;4491.820327186876;6195.504359651307;6392.137061496825;6428.710708018057;6438.903416448663;6479.611223326616;6169.383061693974;6240;6244.750209991549;6283.528735344776;6295.5907865988565;6054.941319951237;6200.937990620036;6214.564980451325;6226.1359774504235;6259.123722678738;6224.319433752771;6278.46633036197;6286.591371560834;6310.6213627182515;6325.57674523247;6248.187735594343;6307.873842523032;6312.305646378986;6324.841878953063;6342.39747224013;6082.513398928164;6112.144299797943;6118.20463339763;6120.9693951531735;6140.201773769381 10:25:07 INFO - PID 25863 | |5;yui.html;853.2747164909831;868.331384833678;874.8775171475999;875.4178471316573;887.5074333744773;15791.368345266175;15796.921015394935;16766.497005089837;17113.22990465429;17194;15105.169215693133;15302;15323.080615163099;15332.61668458289;15336.923315383436;989.45579931038;1019.5310157327638;1022.6574097677287;1022.6625213679505;1022.9079382855541;977.3842479238106;1008.8890222075565;1020.8111499372603;1025.4565080507343;1031.4275577054732;1069.12331887852;1078.417654466587;1079.2067830144838;1079.5357996061691;1079.881213066562;1064.6167379743285;1070.6734445993968;1071.7749272652752;1072.8819829818713;1072.8980746829038;780.7501599488166;785.8389030248785;786.3119770201074;788.3181048393157;789.2423273657296;15020.474283400028;15159.924200378928;15267.847321526753;16192.271347789378;16986.320547178097;17885;18038.188281527233;18231.817681823144;18319.35882244115;18411.72382414265;13980.815347721782;13992.720145597134;14094;14370.425182992773;14399.424023039066;3354.5639066921144;3381.628020917697;3384.4077286474767;3385.3906296866553;3389;89366.55316723375;93317.06682933151;94539.52730236374;95287.52356238174;95550.65572704922;14408.783868241984;14646.414143434144;14658.633534161518;14692.191929443983;14782.408703651734;26033;26589.86705066501;26803.06189283366;26841.194764157106;26948.191554253404;7973.920260797434;8024.398170137263;8037.919620803717;8060.234277743605;8070.717524886601;4118.855840045584;4160.063985603215;4212.705110642287;4226.830926762957;4275.978620106879;4677.836275730333;4757.429108506932;4773.856784296477;4776.880577985578;4785.641076919245;871.3639043498282;888.7733627924838;890.1187824054269;891.3537685178194;892.6518657723493;719.1765428584242;739.0909181706531;748.3938010211637;757.0839284465748;757.4508481351087;11193.328400296008;11351.829722554168;12262.26426414418;13185.60443186706;13287.867121328856;741.0514541387033;746.7983644415978;750.816050067726;752.4206361102031;766.0615745711459;5209.791608335624;5365.678059316453;5408.486193811582;5411.945880541223;5530.723463826873;74443.25556744363;74648.62675686696;75485;77070;79248.60375698084;67372.32627673759;67616.66191669011;68788.3121168792;68991;69618;57400.712996435585;57676;57840.0347946069;59223;61920;13065.804012940003;13869.861301386856;14030.088044277089;14103;14137.858621414065;33473.49789753204;33482.497762533094;33658.66341336555;34036.659633403346;34975;52886;55685.721571391885;56320.718396407756;56450.71774641101;60032.699836500535;17542.561435963693;17607.29570817153;17735.3151450612;17836.55408614795;18030.72953905666;18578.721319179953;19404.417867464;19821.504462388555;19907;19947.700784488534;18031.459056228334;18132.093395330445;18198.272069117087;18338.358157464423;18445.169967351234;17414.30342786325;17954.551136221176;17988.100594969936;18144.274229030692;18568;16619;17557.036059588216;17777.644447111245;17846.5538361542;18337.174827133076;11185.440727963733;11602.70993225176;12752.936235318764;12807.231566106064;12838.871611283768;13156.539521117098;13959.720805584035;14078.225697586731;14514.782278265624;15184.696306074038 10:25:07 INFO - PID 25863 | __end_tp_report 10:25:07 INFO - PID 25863 | __start_cc_report 10:25:07 INFO - PID 25863 | _x_x_mozilla_cycle_collect,1060 10:25:07 INFO - PID 25863 | __end_cc_report 10:25:07 INFO - PID 25863 | __startTimestamp1493918707538__endTimestamp 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | ------- Summary: start ------- 10:25:07 INFO - PID 25863 | Number of tests: 6 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#0] dojo.html Cycles:165 Average:5803.91 Median:6051.06 stddev:693.42 (11.5%) stddev-sans-first:667.05 10:25:07 INFO - PID 25863 | Values: 3296.1 3303.6 3318.4 3344.9 3353.4 5744.1 5805.2 5819.3 5867.9 5897.6 5795.8 5814.9 5844.4 5897.1 5922.9 4785.5 5072.5 5113.5 5194.0 5249.0 5209.3 5221.0 5277.1 5278.3 5298.9 5122.0 5148.8 5203.2 5229.0 5245.1 5172.5 5184.8 5195.4 5196.6 5243.7 5134.6 5161.2 5191.7 5193.1 5222.5 5650.4 5720.3 5741.1 5781.7 5846.0 6276.2 6300.1 6302.3 6302.5 6304.1 6319.0 6334.8 6337.5 6338.5 6344.2 5790.7 5818.8 5846.3 5858.8 5881.1 6371.0 6409.5 6413.5 6418.6 6429.3 6068.0 6094.3 6098.0 6107.5 6184.2 6162.3 6181.1 6231.1 6263.2 6284.9 6135.3 6264.4 6277.4 6280.3 6286.9 6115.0 6191.7 6214.3 6215.6 6232.2 4831.4 4840.1 4840.3 4869.0 4879.2 4260.0 4264.9 4271.5 4274.1 4304.5 5799.8 5878.9 5884.4 5884.6 5885.1 6130.8 6205.3 6236.9 6255.2 6297.5 5872.3 5878.9 5880.9 5896.8 5900.0 5455.6 5478.6 5503.0 5514.3 5516.2 6505.1 6512.4 6600.3 6648.1 6649.3 6343.7 6375.7 6387.2 6388.9 6391.6 6619.2 6663.6 6678.2 6685.4 6687.3 6096.6 6097.4 6189.4 6252.7 6262.3 6309.2 6333.0 6346.7 6350.3 6357.2 6047.2 6051.1 6119.3 6121.4 6124.0 6078.8 6123.6 6140.1 6145.3 6158.4 6003.1 6086.4 6117.3 6135.9 6184.1 6116.3 6162.3 6172.8 6174.5 6177.7 5964.0 5966.8 5968.3 5969.3 6023.1 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#1] ext.html Cycles:180 Average:39688.06 Median:36337.73 stddev:58758.47 (161.7%) stddev-sans-first:58850.45 10:25:07 INFO - PID 25863 | Values: 720.2 765.4 792.5 1128.8 1156.2 29534.7 30122.8 36549.3 37673.0 37809.2 38983.0 39303.8 39316.0 39360.0 39405.0 5696.9 7258.8 7399.3 7408.3 7409.3 5768.9 7133.3 7249.0 7293.2 7301.7 7370.3 7416.4 7437.6 7440.9 7444.2 5709.5 7340.6 7398.1 7408.2 7412.1 5767.0 7092.4 7249.1 7258.8 7268.7 36625.5 36926.0 37044.8 37049.0 37085.8 3572.1 3619.2 3620.6 3622.1 3622.1 27990.0 27991.6 28002.2 28036.4 28040.9 3815.7 3829.5 3862.1 3871.5 3871.6 191171.0 191240.0 191377.0 191663.0 192813.0 49345.0 49392.3 49434.5 49435.8 49486.0 51763.0 51792.5 51796.0 51821.7 51937.0 15854.1 15916.8 15941.0 15942.3 15958.0 11413.4 11612.4 13020.5 13032.7 13043.1 15081.3 15191.4 15317.5 15345.3 15498.8 5907.1 6075.6 6082.5 6114.5 6134.1 1068.4 1093.1 1097.2 1109.2 1115.1 28004.4 28075.7 28118.6 28182.3 28309.4 1163.6 1174.3 1175.4 1184.8 1193.1 14120.7 14122.7 14292.6 14303.4 14330.6 261827.0 263240.0 263362.0 263599.0 264321.0 53442.2 53740.7 53797.2 53861.0 53944.7 1460.4 1498.9 1511.2 1524.1 1532.8 24370.3 25616.6 25708.0 25756.7 25958.6 36520.8 36542.0 36560.0 36576.6 36581.3 217241.0 217436.0 217528.0 218317.0 218739.0 29977.1 30178.2 35757.0 36196.0 36313.8 45375.0 47584.3 47613.8 47950.3 48340.2 33227.7 35493.0 36103.8 36455.8 36992.6 35838.3 36361.6 36705.0 36870.4 37870.8 40468.6 43324.0 43357.6 43585.6 43614.3 34486.7 36010.0 36014.5 36398.6 36637.8 27684.7 28731.7 28740.0 28801.1 28840.7 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#2] jquery.html Cycles:180 Average:30387.03 Median:2164.31 stddev:78086.27 (3607.9%) stddev-sans-first:78272.94 10:25:07 INFO - PID 25863 | Values: 436.8 452.8 452.9 454.2 471.6 18005.3 20040.0 20668.7 20809.8 20818.7 21547.4 22210.4 22402.6 22528.1 22689.2 5491.8 5692.5 5699.5 5702.3 5703.9 5335.6 5494.6 5515.8 5522.0 5532.7 5483.6 5510.2 5513.0 5517.9 5519.0 5363.2 5588.2 5615.2 5625.4 5629.9 5015.0 5122.1 5130.3 5130.5 5131.3 24224.8 24300.4 24514.0 24557.8 24716.8 2215.1 2245.7 2250.4 2250.6 2251.5 16200.3 16891.1 16901.3 16931.7 17014.6 2152.5 2163.4 2205.6 2227.3 2233.5 93539.5 100596.0 118947.3 119064.4 119428.4 12155.0 12198.1 12518.7 12596.8 12759.2 17687.9 17696.3 17718.8 17730.2 17751.2 8939.6 9186.2 9330.7 9367.2 9405.8 8424.0 8517.4 8531.8 8807.7 8835.6 7656.5 7657.5 7851.5 7885.5 7934.1 2130.9 2165.3 2174.1 2203.3 2243.5 1050.3 1083.9 1087.7 1092.2 1092.6 20356.5 20395.8 20431.6 20557.7 20726.5 1111.1 1111.4 1114.5 1118.9 1119.5 10721.5 11059.8 11232.0 11330.1 11392.9 458191.0 461469.0 470332.5 473487.0 483374.0 80534.0 89218.0 95946.5 96395.0 100770.5 1200.9 1245.3 1248.1 1280.3 1289.6 17620.0 18771.2 20258.0 20269.0 20389.9 44616.8 45376.8 45529.8 45683.3 46655.0 57472.0 58413.0 58867.4 59110.0 59379.0 9339.8 9666.6 9800.8 10064.4 10136.3 13299.1 15125.8 15190.7 15194.8 15406.2 13073.5 13149.6 13176.0 13547.5 13897.8 11315.3 11463.7 11677.0 11699.0 11803.6 13438.7 13531.5 13544.5 13827.4 14182.4 12554.2 12860.7 12924.5 12980.8 13060.1 12763.6 12776.7 12855.9 12877.4 13221.4 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#3] mootools.html Cycles:180 Average:7226.31 Median:2248.01 stddev:4647.88 (206.8%) stddev-sans-first:4639.84 10:25:07 INFO - PID 25863 | Values: 1335.8 1386.4 1398.4 1401.6 1405.3 10350.9 10719.2 10727.4 10730.3 10735.0 10520.6 11237.3 11407.6 11516.6 11517.0 2207.2 2231.7 2233.4 2240.3 2241.7 1860.6 2170.2 2222.1 2241.6 2246.6 1934.5 2167.9 2236.0 2245.0 2249.4 2105.9 2140.9 2141.2 2149.5 2151.1 2146.3 2152.0 2162.9 2165.4 2174.5 11119.5 11247.9 11248.4 11248.6 11254.8 6522.8 6728.1 6738.1 6746.6 6751.1 3845.8 3972.1 4205.3 4212.5 4217.1 1345.8 1364.2 1393.2 1425.4 1449.5 17364.5 17447.8 17508.6 17610.5 17618.9 5234.4 5292.8 5389.7 5631.1 5641.5 12448.3 12494.2 12553.2 12556.2 12571.5 6589.2 6591.5 6593.8 6598.6 6598.9 6024.3 6248.2 6253.6 6286.7 6291.4 4214.6 4247.9 4264.8 4336.0 4373.6 1090.7 1214.2 1223.3 1230.1 1246.9 735.5 852.7 871.2 881.8 901.9 6442.1 7301.7 7314.5 7342.5 7403.5 915.8 954.5 988.8 1004.2 1021.9 4718.2 4731.3 4840.0 4857.7 4861.4 14946.5 15442.5 15503.8 15534.5 15711.2 14473.3 15162.2 15209.0 15519.4 15533.4 9210.4 9396.1 9438.7 9473.7 9475.9 6823.5 7181.2 7186.9 7227.3 7276.3 13237.3 13667.2 13978.3 13988.7 14017.2 13401.5 13881.4 13933.4 14197.8 14277.9 9590.3 9615.0 9762.8 9828.5 9841.2 10909.7 11148.3 11186.4 11252.5 11255.9 8883.6 8983.7 9040.4 9468.0 9703.1 8831.5 8854.3 8874.2 8887.5 8951.2 8043.3 8105.2 8193.5 8221.1 8230.6 6376.3 6477.9 6487.4 6551.6 6738.6 6388.9 6446.6 6450.5 6611.0 6771.8 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#4] prototype.html Cycles:180 Average:5220.40 Median:5960.92 stddev:1572.64 (26.4%) stddev-sans-first:1534.79 10:25:07 INFO - PID 25863 | Values: 395.5 413.8 416.4 426.2 431.0 5937.9 5966.3 5986.1 5993.5 6015.8 5655.6 5862.8 5874.3 5884.2 5888.3 4448.3 4468.6 4471.0 4471.5 4474.8 4469.1 4474.7 4475.3 4483.1 4487.2 4319.6 4400.8 4441.4 4450.3 4450.6 4420.9 4428.0 4433.7 4438.7 4438.8 3864.8 3879.5 3889.3 3895.4 3910.9 5601.8 5696.7 5737.6 5740.7 5813.1 5219.3 5238.5 5245.9 5247.8 5272.9 5965.3 6189.4 6201.7 6202.7 6216.3 4348.2 4348.8 4351.1 4360.6 4373.5 6221.4 6357.9 6399.0 6486.7 6578.1 4461.5 4473.1 4481.6 4490.3 4492.6 4525.3 4526.2 4529.4 4533.3 4536.5 5090.3 5174.1 5209.7 5214.2 5230.4 6252.3 6264.7 6273.7 6276.0 6289.4 1528.2 1542.0 1551.8 1552.7 1553.0 1022.7 1038.4 1039.7 1040.0 1044.3 5956.5 5964.7 5968.2 5968.7 5976.6 6312.6 6422.3 6443.8 6446.0 6449.5 5936.0 5941.7 5956.1 5960.0 5961.9 3360.1 3379.4 3404.3 3404.5 3419.7 6631.9 6665.8 6682.5 6718.8 6746.3 6579.8 6580.2 6585.2 6586.0 6601.6 6606.5 6738.6 6771.8 6778.7 6800.5 6403.6 6419.7 6421.0 6426.9 6431.2 6081.7 6127.7 6357.5 6374.2 6400.0 6562.6 6567.7 6704.9 6731.7 6741.7 4456.2 4466.8 4472.7 4479.7 4491.8 6195.5 6392.1 6428.7 6438.9 6479.6 6169.4 6240.0 6244.8 6283.5 6295.6 6054.9 6200.9 6214.6 6226.1 6259.1 6224.3 6278.5 6286.6 6310.6 6325.6 6248.2 6307.9 6312.3 6324.8 6342.4 6082.5 6112.1 6118.2 6121.0 6140.2 10:25:07 INFO - PID 25863 | 10:25:07 INFO - PID 25863 | [#5] yui.html Cycles:180 Average:19057.73 Median:19864.25 stddev:22853.22 (115.0%) stddev-sans-first:22876.44 10:25:07 INFO - PID 25863 | Values: 853.3 868.3 874.9 875.4 887.5 15791.4 15796.9 16766.5 17113.2 17194.0 15105.2 15302.0 15323.1 15332.6 15336.9 989.5 1019.5 1022.7 1022.7 1022.9 977.4 1008.9 1020.8 1025.5 1031.4 1069.1 1078.4 1079.2 1079.5 1079.9 1064.6 1070.7 1071.8 1072.9 1072.9 780.8 785.8 786.3 788.3 789.2 15020.5 15159.9 15267.8 16192.3 16986.3 17885.0 18038.2 18231.8 18319.4 18411.7 13980.8 13992.7 14094.0 14370.4 14399.4 3354.6 3381.6 3384.4 3385.4 3389.0 89366.6 93317.1 94539.5 95287.5 95550.7 14408.8 14646.4 14658.6 14692.2 14782.4 26033.0 26589.9 26803.1 26841.2 26948.2 7973.9 8024.4 8037.9 8060.2 8070.7 4118.9 4160.1 4212.7 4226.8 4276.0 4677.8 4757.4 4773.9 4776.9 4785.6 871.4 888.8 890.1 891.4 892.7 719.2 739.1 748.4 757.1 757.5 11193.3 11351.8 12262.3 13185.6 13287.9 741.1 746.8 750.8 752.4 766.1 5209.8 5365.7 5408.5 5411.9 5530.7 74443.3 74648.6 75485.0 77070.0 79248.6 67372.3 67616.7 68788.3 68991.0 69618.0 57400.7 57676.0 57840.0 59223.0 61920.0 13065.8 13869.9 14030.1 14103.0 14137.9 33473.5 33482.5 33658.7 34036.7 34975.0 52886.0 55685.7 56320.7 56450.7 60032.7 17542.6 17607.3 17735.3 17836.6 18030.7 18578.7 19404.4 19821.5 19907.0 19947.7 18031.5 18132.1 18198.3 18338.4 18445.2 17414.3 17954.6 17988.1 18144.3 18568.0 16619.0 17557.0 17777.6 17846.6 18337.2 11185.4 11602.7 12752.9 12807.2 12838.9 13156.5 13959.7 14078.2 14514.8 15184.7 10:25:07 INFO - PID 25863 | -------- Summary: end -------- 10:25:07 INFO - PID 25863 | 10:25:08 INFO - TEST-INFO | 25863: exit 0 10:25:08 INFO - TEST-OK | dromaeo_css | took 1115512ms 10:25:08 INFO - TEST-START | kraken 10:25:08 INFO - operating with platform_type : linux_ 10:25:08 INFO - Initialising browser for kraken test... 10:25:08 INFO - TEST-INFO | started process 26198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrjYH9/profile http://localhost:40768/getInfo.html) 10:25:12 INFO - PID 26198 | __metrics Screen width/height:1600/1200 10:25:12 INFO - PID 26198 | colorDepth:24 10:25:12 INFO - PID 26198 | Browser inner width/height: 1024/695 10:25:12 INFO - PID 26198 | __metrics 10:25:13 INFO - PID 26198 | 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" 10:25:13 INFO - PID 26198 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:14 INFO - TEST-INFO | 26198: exit 0 10:25:14 INFO - Browser initialized. 10:25:14 INFO - Running cycle 1/1 for kraken test... 10:25:14 INFO - TEST-INFO | started process 26296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrjYH9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:26 INFO - PID 26296 | RSS: Main: 150007808 10:25:26 INFO - PID 26296 | 10:25:28 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40768/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:29 INFO - PID 26296 | RSS: Main: 222302208 10:25:29 INFO - PID 26296 | 10:25:32 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40768/tests/kraken/driver.html?testName=audio-dft) 10:25:32 INFO - PID 26296 | RSS: Main: 182870016 10:25:32 INFO - PID 26296 | 10:25:35 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40768/tests/kraken/driver.html?testName=audio-fft) 10:25:36 INFO - PID 26296 | RSS: Main: 263766016 10:25:36 INFO - PID 26296 | 10:25:38 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40768/tests/kraken/driver.html?testName=audio-oscillator) 10:25:38 INFO - PID 26296 | RSS: Main: 175886336 10:25:38 INFO - PID 26296 | 10:25:40 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:41 INFO - PID 26296 | RSS: Main: 178810880 10:25:41 INFO - PID 26296 | 10:25:44 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40768/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:44 INFO - PID 26296 | RSS: Main: 239841280 10:25:44 INFO - PID 26296 | 10:25:48 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40768/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:48 INFO - PID 26296 | RSS: Main: 259112960 10:25:48 INFO - PID 26296 | 10:25:51 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40768/tests/kraken/driver.html?testName=json-parse-financial) 10:25:52 INFO - PID 26296 | RSS: Main: 275734528 10:25:52 INFO - PID 26296 | 10:25:53 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:54 INFO - PID 26296 | RSS: Main: 202981376 10:25:54 INFO - PID 26296 | 10:25:55 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:56 INFO - PID 26296 | RSS: Main: 209162240 10:25:56 INFO - PID 26296 | 10:25:58 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:59 INFO - PID 26296 | RSS: Main: 218058752 10:25:59 INFO - PID 26296 | 10:26:01 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:02 INFO - PID 26296 | RSS: Main: 226902016 10:26:02 INFO - PID 26296 | 10:26:05 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:05 INFO - PID 26296 | RSS: Main: 222109696 10:26:05 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | Cycle 1(1): loaded http://localhost:40768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40768/tests/kraken/driver.html?testName=ai-astar) 10:26:07 INFO - PID 26296 | RSS: Main: 271933440 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | __start_tp_report 10:26:07 INFO - PID 26296 | _x_x_mozilla_page_load 10:26:07 INFO - PID 26296 | _x_x_mozilla_page_load_details 10:26:07 INFO - PID 26296 | |i|pagename|runs| 10:26:07 INFO - PID 26296 | |0;ai-astar;107;110;109;107;109;109;109;108;109;109 10:26:07 INFO - PID 26296 | |1;audio-beat-detection;140;117;117;171;119;119;116;117;154;118 10:26:07 INFO - PID 26296 | |2;audio-dft;161;161;163;161;161;162;162;162;161;163 10:26:07 INFO - PID 26296 | |3;audio-fft;74;74;74;105;74;74;76;74;96;74 10:26:07 INFO - PID 26296 | |4;audio-oscillator;82;82;109;82;82;82;96;82;81;110 10:26:07 INFO - PID 26296 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;113;113;113 10:26:07 INFO - PID 26296 | |6;imaging-darkroom;147;146;149;146;148;147;146;148;146;147 10:26:07 INFO - PID 26296 | |7;imaging-desaturate;95;93;93;94;93;94;94;93;94;93 10:26:07 INFO - PID 26296 | |8;json-parse-financial;48;46;46;46;47;48;47;47;47;46 10:26:07 INFO - PID 26296 | |9;json-stringify-tinderbox;53;54;53;54;54;53;54;53;53;53 10:26:07 INFO - PID 26296 | |10;stanford-crypto-aes;80;88;89;82;82;81;80;80;81;80 10:26:07 INFO - PID 26296 | |11;stanford-crypto-ccm;125;125;126;123;131;125;129;124;173;130 10:26:07 INFO - PID 26296 | |12;stanford-crypto-pbkdf2;184;186;183;182;185;185;177;179;192;187 10:26:07 INFO - PID 26296 | |13;stanford-crypto-sha256-iterative;66;66;63;67;64;64;64;64;62;65 10:26:07 INFO - PID 26296 | __end_tp_report 10:26:07 INFO - PID 26296 | __start_cc_report 10:26:07 INFO - PID 26296 | _x_x_mozilla_cycle_collect,1682 10:26:07 INFO - PID 26296 | __end_cc_report 10:26:07 INFO - PID 26296 | __startTimestamp1493918767898__endTimestamp 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | ------- Summary: start ------- 10:26:07 INFO - PID 26296 | Number of tests: 14 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 10:26:07 INFO - PID 26296 | Values: 107.0 110.0 109.0 107.0 109.0 109.0 109.0 108.0 109.0 109.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:119.00 stddev:19.53 (16.4%) stddev-sans-first:20.29 10:26:07 INFO - PID 26296 | Values: 140.0 117.0 117.0 171.0 119.0 119.0 116.0 117.0 154.0 118.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 10:26:07 INFO - PID 26296 | Values: 161.0 161.0 163.0 161.0 161.0 162.0 162.0 162.0 161.0 163.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#3] audio-fft Cycles:10 Average:79.50 Median:74.00 stddev:11.29 (15.3%) stddev-sans-first:11.79 10:26:07 INFO - PID 26296 | Values: 74.0 74.0 74.0 105.0 74.0 74.0 76.0 74.0 96.0 74.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.77 (14.4%) stddev-sans-first:12.23 10:26:07 INFO - PID 26296 | Values: 82.0 82.0 109.0 82.0 82.0 82.0 96.0 82.0 81.0 110.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:26:07 INFO - PID 26296 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 10:26:07 INFO - PID 26296 | Values: 147.0 146.0 149.0 146.0 148.0 147.0 146.0 148.0 146.0 147.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 10:26:07 INFO - PID 26296 | Values: 95.0 93.0 93.0 94.0 93.0 94.0 94.0 93.0 94.0 93.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:47.00 stddev:0.79 (1.7%) stddev-sans-first:0.71 10:26:07 INFO - PID 26296 | Values: 48.0 46.0 46.0 46.0 47.0 48.0 47.0 47.0 47.0 46.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 10:26:07 INFO - PID 26296 | Values: 53.0 54.0 53.0 54.0 54.0 53.0 54.0 53.0 53.0 53.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.50 stddev:3.37 (4.1%) stddev-sans-first:3.47 10:26:07 INFO - PID 26296 | Values: 80.0 88.0 89.0 82.0 82.0 81.0 80.0 80.0 81.0 80.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:127.50 stddev:14.96 (11.7%) stddev-sans-first:15.71 10:26:07 INFO - PID 26296 | Values: 125.0 125.0 126.0 123.0 131.0 125.0 129.0 124.0 173.0 130.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:185.00 stddev:4.19 (2.3%) stddev-sans-first:4.44 10:26:07 INFO - PID 26296 | Values: 184.0 186.0 183.0 182.0 185.0 185.0 177.0 179.0 192.0 187.0 10:26:07 INFO - PID 26296 | 10:26:07 INFO - PID 26296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.51 (2.3%) stddev-sans-first:1.50 10:26:07 INFO - PID 26296 | Values: 66.0 66.0 63.0 67.0 64.0 64.0 64.0 64.0 62.0 65.0 10:26:07 INFO - PID 26296 | -------- Summary: end -------- 10:26:07 INFO - PID 26296 | 10:26:09 INFO - TEST-INFO | 26296: exit 0 10:26:09 INFO - TEST-OK | kraken | took 60805ms 10:26:09 INFO - SUITE-END | took 1176s 10:26:09 INFO - Completed test suite (00:19:36) 10:26:09 INFO - javascript benchmark 10:26:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7775.313070971818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.077098412444, 3303.587051618548, 3318.4026875162476, 3344.9331013379747, 3353.4131526982774, 5744.109663002231, 5805.158252053455, 5819.301683797945, 5867.853303667411, 5897.616654917428, 5795.768169273224, 5814.883702325951, 5844.415558444153, 5897.144913987469, 5922.940770592293, 4785.497522760113, 5072.492750724917, 5113.539781419671, 5194.039102765982, 5249.028929648028, 5209.348831396057, 5221.008008478396, 5277.050130976423, 5278.340207474066, 5298.947010529884, 5122.0, 5148.7940482380845, 5203.219517072451, 5228.973855130738, 5245.134552798783, 5172.456892026321, 5184.818531351422, 5195.402528709209, 5196.636235463519, 5243.737813109329, 5134.614903882224, 5161.200013997799, 5191.740412979336, 5193.065248255312, 5222.477752224785, 5650.434956504317, 5720.342160651537, 5741.110127930177, 5781.739821708034, 5846.0, 6276.215473065867, 6300.086487459339, 6302.275238347603, 6302.4958003359625, 6304.117423560705, 6318.968405157991, 6334.809955701337, 6337.524685648595, 6338.524610654219, 6344.175257216579, 5790.681512516852, 5818.825435236908, 5846.269216347957, 5858.824235272906, 5881.088431293157, 6370.968145159244, 6409.455196308273, 6413.486921046305, 6418.550701450854, 6429.260635026938, 6067.969660151671, 6094.325681954534, 6098.038923863779, 6107.46959931229, 6184.226971628546, 6162.322144564095, 6181.134641150243, 6231.096491008779, 6263.217097862767, 6284.937150628435, 6135.306216178427, 6264.404881536247, 6277.372262773686, 6280.2777680566405, 6286.937130628635, 6114.975470440207, 6191.721372538246, 6214.316425193225, 6215.627062376272, 6232.189815323979, 4831.4202295724735, 4840.104580652591, 4840.273958906192, 4868.9756551217015, 4879.170541008037, 4260.041490664637, 4264.87205383839, 4271.466066741657, 4274.081072569413, 4304.504981927118, 5799.768009279582, 5878.941210587925, 5884.352721200665, 5884.6469211847425, 5885.146653735184, 6130.7650488535955, 6205.348438413992, 6236.937630623726, 6255.218097737783, 6297.464715499143, 5872.265966754156, 5878.882422351615, 5880.882382352329, 5896.764129434775, 5900.0, 5455.5908306877145, 5478.561715062785, 5503.036968530491, 5514.310711161105, 5516.172574113915, 6505.0567667688865, 6512.381323774234, 6600.273969863407, 6648.102506161703, 6649.301823308483, 6343.714532845941, 6375.7449702013255, 6387.201599800025, 6388.9041664376, 6391.648459334781, 6619.238787539494, 6663.633500157538, 6678.2320033194865, 6685.431738302299, 6687.331266873273, 6096.556923351527, 6097.4036925702085, 6189.442950134329, 6252.718627661675, 6262.279837818709, 6309.179806625109, 6332.968335158294, 6346.650934198663, 6350.301466838737, 6357.205349331333, 6047.244094488189, 6051.062085376773, 6119.296280927751, 6121.387861213843, 6124.0201567748945, 6078.787242446493, 6123.601965872204, 6140.078988151813, 6145.293291271382, 6158.3841615838055, 6003.129546215687, 6086.391360863879, 6117.265928088658, 6135.907961380493, 6184.103305020837, 6116.274903966807, 6162.26052873658, 6172.753089876354, 6174.506039516738, 6177.722002509808, 5963.970180149245, 5966.820995370146, 5968.313643931004, 5969.283685957713, 6023.066424704178], "value": 5754.951591941017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.1646090534978, 765.3876898481216, 792.4611264340247, 1128.8137457319542, 1156.1791128298908, 29534.704652953464, 30122.849385753067, 36549.26901461973, 37673.0, 37809.24381512368, 38983.0, 39303.803480982555, 39316.0, 39360.0, 39405.0, 5696.943030569703, 7258.782236532912, 7399.260073992611, 7408.3332500074985, 7409.333160015598, 5768.942310576883, 7133.251008644095, 7249.0, 7293.161286452073, 7301.744438944638, 7370.262973702614, 7416.40668746499, 7437.553746775211, 7440.888386674204, 7444.181140074587, 5709.457601527848, 7340.596267205302, 7398.075240594926, 7408.222136675652, 7412.073490813648, 5767.0, 7092.397146242575, 7249.057622509093, 7258.818529536751, 7268.6729097190755, 36625.45061824075, 36926.0, 37044.814775926214, 37049.0, 37085.81457092724, 3572.1069732566857, 3619.2218672985437, 3620.583632882226, 3622.094476380905, 3622.130688634735, 27990.0, 27991.580126298122, 28002.159935201773, 28036.439271214665, 28040.85979570089, 3815.7138214633737, 3829.5213098362706, 3862.053796819769, 3871.477350557695, 3871.5547712012917, 191171.0, 191240.0, 191377.0, 191663.0, 192813.0, 49345.0, 49392.30773076552, 49434.50565494371, 49435.75282123566, 49486.0, 51763.0, 51792.48207517876, 51796.0, 51821.7408912953, 51937.0, 15854.128022958617, 15916.840831591768, 15941.0, 15942.28259728315, 15958.0, 11413.42932853354, 11612.361320127306, 13020.47918083266, 13032.739345213042, 13043.086983911035, 15081.265654449659, 15191.392344306325, 15317.540473785804, 15345.30946107428, 15498.767518487231, 5907.1434641976675, 6075.605085669417, 6082.452579267887, 6114.510839132948, 6134.110553969738, 1068.3803394031443, 1093.0654290581597, 1097.1935627313917, 1109.173665619119, 1115.0912006714502, 28004.43991120166, 28075.719242807718, 28118.578221326698, 28182.2954426141, 28309.43381132366, 1163.5752950173296, 1174.3247632611112, 1175.4468836238007, 1184.763047390508, 1193.146899966528, 14120.71758564823, 14122.71754564903, 14292.571222863331, 14303.427862885575, 14330.641733956734, 261827.0, 263240.0, 263362.0, 263599.0, 264321.0, 53442.198367024524, 53740.73129634405, 53797.1930421044, 53861.0, 53944.73027634837, 1460.4450308882556, 1498.9100653960797, 1511.168857128575, 1524.1312451902531, 1532.7930729351617, 24370.26889193327, 25616.615750764126, 25708.015257635096, 25756.742432575433, 25958.610620841082, 36520.81739591285, 36542.0, 36560.0, 36576.63423365732, 36581.26837463289, 217241.0, 217436.0, 217528.0, 218317.0, 218739.0, 29977.100686979426, 30178.24554386158, 35757.0, 36196.027655436556, 36313.818430907675, 45375.0, 47584.286235707186, 47613.76193119012, 47950.28074578954, 48340.16598340138, 33227.667723322455, 35493.0, 36103.81948090243, 36455.81772091229, 36992.6300737, 35838.283234334645, 36361.63638363582, 36705.0, 36870.446943295334, 37870.81064594659, 40468.595314046484, 43324.0, 43357.56642433535, 43585.56414435815, 43614.345784813886, 34486.65513344935, 36010.0, 36014.4597831038, 36398.63601363952, 36637.81681091578, 27684.723152768216, 28731.707073182177, 28739.994100206393, 28801.135965921058, 28840.711592884643], "value": 17518.175163031563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.82090342959356, 452.84376889972947, 452.8777230147859, 454.22554544501605, 471.6274143426693, 18005.27978880843, 20040.0, 20668.68996965043, 20809.791902080975, 20818.687719684218, 21547.353579392606, 22210.444738881535, 22402.551948961052, 22528.09887604494, 22689.20587779428, 5491.780328786854, 5692.459216374438, 5699.515541179005, 5702.287214098238, 5703.914441283384, 5335.573154147659, 5494.587905907073, 5515.751791169407, 5522.0, 5532.6680399175975, 5483.588730845203, 5510.201020851974, 5512.972435137819, 5517.944820551803, 5519.0, 5363.222332761748, 5588.245586845765, 5615.157726341041, 5625.40933202012, 5629.859253518674, 5015.0, 5122.129238029544, 5130.256112863613, 5130.461301563357, 5131.3329267195395, 24224.757752422604, 24300.39249018771, 24514.0, 24557.754422455724, 24716.752832471626, 2215.0586000949534, 2245.7305123385136, 2250.437390652337, 2250.6173950428465, 2251.482159103399, 16200.27098780546, 16891.070991095487, 16901.323947042103, 16931.661366772594, 17014.574635634086, 2152.4502358301997, 2163.350994701583, 2205.6250437425674, 2227.3318004598555, 2233.508628101815, 93539.53230233873, 100596.0, 118947.2684275528, 119064.40467797693, 119428.40285798516, 12155.0, 12198.14612977083, 12518.687032824253, 12596.81104783429, 12759.170653907651, 17687.911560442117, 17696.29214831418, 17718.822811771974, 17730.20214090369, 17751.201195946214, 8939.642414303486, 9186.173244407903, 9330.673426430043, 9367.156955874005, 9405.811883762422, 8423.957880210559, 8517.36119791018, 8531.786705332292, 8807.735767926972, 8835.55822208887, 7656.549904030657, 7657.46397752152, 7851.508213439428, 7885.530366638661, 7934.127246002935, 2130.8706385615646, 2165.263810304504, 2174.1086154676505, 2203.316971738766, 2243.5176437065784, 1050.3382868792764, 1083.918706097046, 1087.6573879228017, 1092.2354351953663, 1092.5902786455079, 20356.491087722927, 20395.79604203939, 20431.591368172554, 20557.69163462549, 20726.481837954172, 1111.0944580167138, 1111.4109521953378, 1114.4761961877905, 1118.8825173356681, 1119.5074167366333, 10721.463926803628, 11059.834102488468, 11231.98650693269, 11330.09359251258, 11392.886071139348, 458191.0, 461469.0, 470332.45013247605, 473487.0, 483374.0, 80534.0, 89218.0, 95946.52026739821, 96395.0, 100770.49614751879, 1200.8558972923306, 1245.3088535862503, 1248.1013670157472, 1280.2830414967461, 1289.6324547503916, 17620.0, 18771.249150033847, 20258.0, 20269.0, 20389.89805050965, 44616.77691611651, 45376.77311613421, 45529.77235113803, 45683.31475027811, 46654.97093560894, 57472.0, 58413.0, 58867.41132588619, 59110.0, 59379.0, 9339.813203735752, 9666.613335466502, 9800.803983920425, 10064.44645544502, 10136.290459667753, 13299.135556188818, 15125.848741512444, 15190.696186076437, 15194.772078418611, 15406.229688515305, 13073.477060917457, 13149.60551183466, 13176.0, 13547.525836595672, 13897.791533127214, 11315.321080735182, 11463.656090317303, 11677.0, 11699.0, 11803.586874459354, 13438.664033399244, 13531.526396576073, 13544.525941591997, 13827.377768000666, 14182.361793719101, 12554.246745195318, 12860.678483037998, 12924.547640832525, 12980.805287920877, 13060.085793994329, 12763.617091487271, 12776.74446511046, 12855.935720321339, 12877.420516076987, 13221.405036773176], "value": 10273.832047504677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.7862741961285, 1386.3899884051016, 1398.4476131927895, 1401.6285684293664, 1405.2552147361898, 10350.896491035088, 10719.19606029547, 10727.35635861848, 10730.302530335523, 10735.033846953773, 10520.631777887775, 11237.325760454358, 11407.600733974292, 11516.596919107833, 11517.0, 2207.2274703853645, 2231.716762861353, 2233.352327824929, 2240.316703405461, 2241.69737085493, 1860.6278744251135, 2170.1536400803698, 2222.0778376973535, 2241.618924782783, 2246.5843818893477, 1934.516370907273, 2167.9024443899984, 2235.9938027887433, 2245.0, 2249.4263962689574, 2105.9262925797525, 2140.8501404901663, 2141.207753131351, 2149.494868705861, 2151.128792838895, 2146.291723731165, 2152.042341158185, 2162.8702277863376, 2165.4153378587853, 2174.5433458973635, 11119.499622517005, 11247.943760281229, 11248.38133902635, 11248.550057997752, 11254.831177532344, 6522.836929076763, 6728.091707619457, 6738.124043874265, 6746.595204287759, 6751.054852320679, 3845.769253844778, 3972.1459886124335, 4205.306124489455, 4212.4523811904255, 4217.072244106292, 1345.8250427444468, 1364.2019418640107, 1393.1849867827334, 1425.4227038049607, 1449.5071675630336, 17364.479065628053, 17447.825521744748, 17508.562285942826, 17610.471685849574, 17618.91190544052, 5234.398044224887, 5292.761825717775, 5389.730513474311, 5631.070873305859, 5641.492265696025, 12448.31534265624, 12494.187877787916, 12553.246805191535, 12556.183848049848, 12571.497140114476, 6589.17635295588, 6591.505637077238, 6593.769218077345, 6598.60408375499, 6598.901016484757, 6024.277086749618, 6248.156498872685, 6253.5622506425025, 6286.685665716695, 6291.370862913672, 4214.599613036757, 4247.915041699149, 4264.786760662017, 4336.0, 4373.584509471595, 1090.7218659241842, 1214.2107630040368, 1223.2843786385065, 1230.138902768066, 1246.8940140088014, 735.543962743092, 852.6887685994567, 871.1810897756089, 881.8324518341494, 901.9143181397887, 6442.130312407765, 7301.744438944612, 7314.45141614381, 7342.48602597813, 7403.51877127985, 915.839728047589, 954.513198268874, 988.8220120378401, 1004.196642685863, 1021.8722659667542, 4718.197906355927, 4731.29030645406, 4839.95160048395, 4857.7085374876915, 4861.416630004422, 14946.476873309382, 15442.45951391696, 15503.767443488357, 15534.533963980872, 15711.21443927799, 14473.27633618315, 15162.166080865658, 15209.0, 15519.379224831106, 15533.378664853506, 9210.401323913924, 9396.107369799858, 9438.716838494856, 9473.715788526355, 9475.905240947503, 6823.522353435212, 7181.210066892533, 7186.856262874818, 7227.349538541556, 7276.308750668678, 13237.338133093113, 13667.248301343125, 13978.30108494551, 13988.720225595634, 14017.158970461805, 13401.53094641683, 13881.375338109607, 13933.372998215307, 14197.787033194716, 14277.857221428068, 9590.328676992543, 9615.0, 9762.80474390494, 9828.459434731158, 9841.163501102486, 10909.727256818644, 11148.275362101438, 11186.440677966231, 11252.549898003988, 11255.943720281346, 8883.645833854163, 8983.730488085368, 9040.41237319572, 9468.0, 9703.07820757027, 8831.470111793313, 8854.335924805537, 8874.245689116497, 8887.466751994902, 8951.194392504705, 8043.316318112792, 8105.230003149692, 8193.46742461738, 8221.095679475133, 8230.62962166716, 6376.266729326187, 6477.902831457626, 6487.416132548094, 6551.639659818756, 6738.59568425896, 6388.936110638834, 6446.613203207822, 6450.451711604378, 6610.9669451652435, 6771.830704232433], "value": 5397.957835677138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.51944387569097, 413.80757947554383, 416.3879097726342, 426.24767285740654, 430.9741415515068, 5937.88124237515, 5966.284045914496, 5986.132010858423, 5993.48273725036, 6015.789447369338, 5655.604107712462, 5862.76548938043, 5874.327181132585, 5884.176215329857, 5888.263967004124, 4448.310511870649, 4468.597826195633, 4471.0, 4471.4857791353925, 4474.843380481684, 4469.106178764244, 4474.709143905636, 4475.30632751924, 4483.14820184164, 4487.227545119676, 4319.624206686326, 4400.823967041314, 4441.444819397575, 4450.287953927373, 4450.554944505539, 4420.916875365556, 4427.9557204427865, 4433.733975961452, 4438.7114837535455, 4438.844640437569, 3864.787436691009, 3879.515060617423, 3889.3388124018984, 3895.376739721631, 3910.863119790822, 5601.831945041656, 5696.6866822324755, 5737.598368114233, 5740.741666625012, 5813.09896965971, 5219.347581552306, 5238.528532432099, 5245.895082098336, 5247.763850626731, 5272.92090618641, 5965.313988891289, 6189.38106189382, 6201.72092255845, 6202.72087756052, 6216.2851272103835, 4348.195583817004, 4348.782560871944, 4351.0862718829085, 4360.629346505519, 4373.453318335208, 6221.377862213788, 6357.872842543169, 6398.968005159944, 6486.740530378779, 6578.111954886077, 4461.464624245112, 4473.083017981306, 4481.551844815493, 4490.348899409567, 4492.595666390041, 4525.253333200051, 4526.23054080807, 4529.365888775574, 4533.252013417815, 4536.500984891659, 5090.287359769635, 5174.146265866165, 5209.661372010807, 5214.217867319857, 5230.424653288135, 6252.280987686383, 6264.655443950535, 6273.686315684289, 6275.96862015687, 6289.433950944345, 1528.205333226716, 1541.9691606167814, 1551.83705710901, 1552.7190068193786, 1552.9689406211812, 1022.7136401807505, 1038.4288641247283, 1039.740064983754, 1040.0, 1044.2794471814423, 5956.493698035629, 5964.7315870785915, 5968.22413086296, 5968.671723055187, 5976.641401515923, 6312.5581209314905, 6422.261439934374, 6443.7744678936015, 6445.967770161119, 6449.484041276686, 5936.0, 5941.732622032019, 5956.136360227742, 5959.957007523666, 5961.880762384728, 3360.1431634932937, 3379.4086034943784, 3404.3361544498584, 3404.4552871540436, 3419.6580341965605, 6631.905735553676, 6665.833354166185, 6682.525086954854, 6718.798436046926, 6746.255828015401, 6579.80260592183, 6580.243272023683, 6585.2426970898005, 6586.0, 6601.603903765694, 6606.471482281406, 6738.561993470409, 6771.796846094625, 6778.661066946732, 6800.455963522906, 6403.647799370893, 6419.679016049272, 6421.0, 6426.871462570629, 6431.163948686828, 6081.726322315418, 6127.724252408563, 6357.523185761179, 6374.203224596926, 6400.0, 6562.573432726857, 6567.719294737672, 6704.932950670431, 6731.697073631601, 6741.662916854039, 4456.153330867125, 4466.798994045211, 4472.664550158686, 4479.686421950432, 4491.820327186876, 6195.504359651307, 6392.137061496825, 6428.710708018057, 6438.903416448663, 6479.611223326616, 6169.383061693974, 6240.0, 6244.750209991549, 6283.528735344776, 6295.5907865988565, 6054.941319951237, 6200.937990620036, 6214.564980451325, 6226.1359774504235, 6259.123722678738, 6224.319433752771, 6278.46633036197, 6286.591371560834, 6310.6213627182515, 6325.57674523247, 6248.187735594343, 6307.873842523032, 6312.305646378986, 6324.841878953063, 6342.39747224013, 6082.513398928164, 6112.144299797943, 6118.20463339763, 6120.9693951531735, 6140.201773769381], "value": 4731.155978514176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.2747164909831, 868.331384833678, 874.8775171475999, 875.4178471316573, 887.5074333744773, 15791.368345266175, 15796.921015394935, 16766.497005089837, 17113.22990465429, 17194.0, 15105.169215693133, 15302.0, 15323.080615163099, 15332.61668458289, 15336.923315383436, 989.45579931038, 1019.5310157327638, 1022.6574097677287, 1022.6625213679505, 1022.9079382855541, 977.3842479238106, 1008.8890222075565, 1020.8111499372603, 1025.4565080507343, 1031.4275577054732, 1069.12331887852, 1078.417654466587, 1079.2067830144838, 1079.5357996061691, 1079.881213066562, 1064.6167379743285, 1070.6734445993968, 1071.7749272652752, 1072.8819829818713, 1072.8980746829038, 780.7501599488166, 785.8389030248785, 786.3119770201074, 788.3181048393157, 789.2423273657296, 15020.474283400028, 15159.924200378928, 15267.847321526753, 16192.271347789378, 16986.320547178097, 17885.0, 18038.188281527233, 18231.817681823144, 18319.35882244115, 18411.72382414265, 13980.815347721782, 13992.720145597134, 14094.0, 14370.425182992773, 14399.424023039066, 3354.5639066921144, 3381.628020917697, 3384.4077286474767, 3385.3906296866553, 3389.0, 89366.55316723375, 93317.06682933151, 94539.52730236374, 95287.52356238174, 95550.65572704922, 14408.783868241984, 14646.414143434144, 14658.633534161518, 14692.191929443983, 14782.408703651734, 26033.0, 26589.86705066501, 26803.06189283366, 26841.194764157106, 26948.191554253404, 7973.920260797434, 8024.398170137263, 8037.919620803717, 8060.234277743605, 8070.717524886601, 4118.855840045584, 4160.063985603215, 4212.705110642287, 4226.830926762957, 4275.978620106879, 4677.836275730333, 4757.429108506932, 4773.856784296477, 4776.880577985578, 4785.641076919245, 871.3639043498282, 888.7733627924838, 890.1187824054269, 891.3537685178194, 892.6518657723493, 719.1765428584242, 739.0909181706531, 748.3938010211637, 757.0839284465748, 757.4508481351087, 11193.328400296008, 11351.829722554168, 12262.26426414418, 13185.60443186706, 13287.867121328856, 741.0514541387033, 746.7983644415978, 750.816050067726, 752.4206361102031, 766.0615745711459, 5209.791608335624, 5365.678059316453, 5408.486193811582, 5411.945880541223, 5530.723463826873, 74443.25556744363, 74648.62675686696, 75485.0, 77070.0, 79248.60375698084, 67372.32627673759, 67616.66191669011, 68788.3121168792, 68991.0, 69618.0, 57400.712996435585, 57676.0, 57840.0347946069, 59223.0, 61920.0, 13065.804012940003, 13869.861301386856, 14030.088044277089, 14103.0, 14137.858621414065, 33473.49789753204, 33482.497762533094, 33658.66341336555, 34036.659633403346, 34975.0, 52886.0, 55685.721571391885, 56320.718396407756, 56450.71774641101, 60032.699836500535, 17542.561435963693, 17607.29570817153, 17735.3151450612, 17836.55408614795, 18030.72953905666, 18578.721319179953, 19404.417867464, 19821.504462388555, 19907.0, 19947.700784488534, 18031.459056228334, 18132.093395330445, 18198.272069117087, 18338.358157464423, 18445.169967351234, 17414.30342786325, 17954.551136221176, 17988.100594969936, 18144.274229030692, 18568.0, 16619.0, 17557.036059588216, 17777.644447111245, 17846.5538361542, 18337.174827133076, 11185.440727963733, 11602.70993225176, 12752.936235318764, 12807.231566106064, 12838.871611283768, 13156.539521117098, 13959.720805584035, 14078.225697586731, 14514.782278265624, 15184.696306074038], "value": 8352.489179864731, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 107.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 117.0, 171.0, 119.0, 119.0, 116.0, 117.0, 154.0, 118.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 105.0, 74.0, 74.0, 76.0, 74.0, 96.0, 74.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 109.0, 82.0, 82.0, 82.0, 96.0, 82.0, 81.0, 110.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 149.0, 146.0, 148.0, 147.0, 146.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 46.0, 46.0, 47.0, 48.0, 47.0, 47.0, 47.0, 46.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 89.0, 82.0, 82.0, 81.0, 80.0, 80.0, 81.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 126.0, 123.0, 131.0, 125.0, 129.0, 124.0, 173.0, 130.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 183.0, 182.0, 185.0, 185.0, 177.0, 179.0, 192.0, 187.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 63.0, 67.0, 64.0, 64.0, 64.0, 64.0, 62.0, 65.0], "value": 64.5, "unit": "score"}]}]} 10:26:09 INFO - Return code: 0 10:26:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:09 INFO - # TBPL SUCCESS # 10:26:09 INFO - Running post-action listener: _resource_record_post_action 10:26:09 INFO - [mozharness: 2017-05-04 17:26:09.724603Z] Finished run-tests step (success) 10:26:09 INFO - Running post-run listener: _resource_record_post_run 10:26:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 355028992; Read time: 540; Write time: 523616 10:26:09 INFO - TinderboxPrint: CPU usage
13.0% 10:26:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 540 10:26:09 INFO - TinderboxPrint: I/O write bytes / time
355,028,992 / 523,616 10:26:09 INFO - TinderboxPrint: CPU idle
8,285.8 (87.0%) 10:26:09 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 10:26:09 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 65380352; Read time: 36; Write time: 59844 10:26:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247578624; Read time: 448; Write time: 272448 10:26:10 INFO - Running post-run listener: _upload_blobber_files 10:26:10 INFO - Blob upload gear active. 10:26:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:10 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 10:26:10 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'] 10:26:10 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 10:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:11 INFO - (blobuploader) - INFO - Done attempting. 10:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:16 INFO - (blobuploader) - INFO - Done attempting. 10:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:17 INFO - (blobuploader) - INFO - Done attempting. 10:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:18 INFO - (blobuploader) - INFO - Done attempting. 10:26:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:18 INFO - Return code: 0 10:26:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58198bcc414ed6d6f06e355db43664d15b4cc060ff1536d846d21e4e152d9fbad205c49289fb4c2fd8ccc2c45e07679acc8b36ae85d10ca13312e7f8a62d3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4cfcdb09a5be1e5d7b5ad9007ebcc69b3d15fa0043035961be6c56874bd86a2e34cdd1e7959e69cb148a4099180690ea31c3b1edd5829d3498eeb2c9ce28b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af324af6f504dcf5d9b2d54b590d650c8a448b46f89060219583bee40bf0cb9aeaacb0c2239a87ef294503e77a8b892c5453efe526b7144da32945ba74f70575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfb72089b99e259bc14c02fcc1a2f063b5fd9642671b83337bc36ed15204a396898784bc633b218a4a60cee26aa09103b508d4157224e83a19569db9ff5e04b"} 10:26:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:18 INFO - Contents: 10:26:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58198bcc414ed6d6f06e355db43664d15b4cc060ff1536d846d21e4e152d9fbad205c49289fb4c2fd8ccc2c45e07679acc8b36ae85d10ca13312e7f8a62d3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4cfcdb09a5be1e5d7b5ad9007ebcc69b3d15fa0043035961be6c56874bd86a2e34cdd1e7959e69cb148a4099180690ea31c3b1edd5829d3498eeb2c9ce28b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af324af6f504dcf5d9b2d54b590d650c8a448b46f89060219583bee40bf0cb9aeaacb0c2239a87ef294503e77a8b892c5453efe526b7144da32945ba74f70575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfb72089b99e259bc14c02fcc1a2f063b5fd9642671b83337bc36ed15204a396898784bc633b218a4a60cee26aa09103b508d4157224e83a19569db9ff5e04b"} 10:26:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:18 INFO - Copying logs to upload dir... 10:26:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.878831 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-04 10:26:16.392104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:16.399937) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58198bcc414ed6d6f06e355db43664d15b4cc060ff1536d846d21e4e152d9fbad205c49289fb4c2fd8ccc2c45e07679acc8b36ae85d10ca13312e7f8a62d3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4cfcdb09a5be1e5d7b5ad9007ebcc69b3d15fa0043035961be6c56874bd86a2e34cdd1e7959e69cb148a4099180690ea31c3b1edd5829d3498eeb2c9ce28b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af324af6f504dcf5d9b2d54b590d650c8a448b46f89060219583bee40bf0cb9aeaacb0c2239a87ef294503e77a8b892c5453efe526b7144da32945ba74f70575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfb72089b99e259bc14c02fcc1a2f063b5fd9642671b83337bc36ed15204a396898784bc633b218a4a60cee26aa09103b508d4157224e83a19569db9ff5e04b"} build_url:https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c58198bcc414ed6d6f06e355db43664d15b4cc060ff1536d846d21e4e152d9fbad205c49289fb4c2fd8ccc2c45e07679acc8b36ae85d10ca13312e7f8a62d3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4cfcdb09a5be1e5d7b5ad9007ebcc69b3d15fa0043035961be6c56874bd86a2e34cdd1e7959e69cb148a4099180690ea31c3b1edd5829d3498eeb2c9ce28b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af324af6f504dcf5d9b2d54b590d650c8a448b46f89060219583bee40bf0cb9aeaacb0c2239a87ef294503e77a8b892c5453efe526b7144da32945ba74f70575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfb72089b99e259bc14c02fcc1a2f063b5fd9642671b83337bc36ed15204a396898784bc633b218a4a60cee26aa09103b508d4157224e83a19569db9ff5e04b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:16.427899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:16.428259) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1493917345.197010-1755560741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:16.511198) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:26:16.514716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:26:16.515156) ========= ========= Total master_lag: 0.02 =========