builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1494345567.21 results: success (0) revision: ec15663c6331c8227d458bce85e6ca1b37423336 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.214591) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.215036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.215316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.230018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.230311) ========= 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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 08:59:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-09 08:59:27 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124209 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.369101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.369435) ========= 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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016812 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:27.422416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 08:59:27.425862) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec15663c6331c8227d458bce85e6ca1b37423336 --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 ec15663c6331c8227d458bce85e6ca1b37423336 --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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 08:59:27,491 truncating revision to first 12 chars 2017-05-09 08:59:27,491 Setting DEBUG logging. 2017-05-09 08:59:27,491 attempt 1/10 2017-05-09 08:59:27,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec15663c6331?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 08:59:28,579 unpacking tar archive at: mozilla-central-ec15663c6331/testing/mozharness/ program finished with exit code 0 elapsedTime=1.404075 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 08:59:28.844039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:28.844372) ========= script_repo_revision: ec15663c6331c8227d458bce85e6ca1b37423336 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:28.844777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:28.847424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 08:59:28.859169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-09 08:59:28.859565) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:29 INFO - MultiFileLogger online at 20170509 08:59:29 in /builds/slave/test 08:59:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:59:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:29 INFO - {'append_to_log': False, 08:59:29 INFO - 'base_work_dir': '/builds/slave/test', 08:59:29 INFO - 'blob_upload_branch': 'Firefox', 08:59:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:29 INFO - 'branch': 'Firefox', 08:59:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:29 INFO - 'config_files': ('talos/linux_config.py',), 08:59:29 INFO - 'default_actions': ('clobber', 08:59:29 INFO - 'read-buildbot-config', 08:59:29 INFO - 'download-and-extract', 08:59:29 INFO - 'populate-webroot', 08:59:29 INFO - 'create-virtualenv', 08:59:29 INFO - 'install', 08:59:29 INFO - 'run-tests'), 08:59:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:29 INFO - 'download_minidump_stackwalk': True, 08:59:29 INFO - 'download_symbols': 'ondemand', 08:59:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:29 INFO - 'gecko_profile': False, 08:59:29 INFO - 'gecko_profile_interval': 0, 08:59:29 INFO - 'installer_path': 'installer.exe', 08:59:29 INFO - 'log_level': 'info', 08:59:29 INFO - 'log_name': 'talos', 08:59:29 INFO - 'log_to_console': True, 08:59:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:29 INFO - 'opt_config_files': (), 08:59:29 INFO - 'pip_index': False, 08:59:29 INFO - 'suite': 'dromaeojs-e10s', 08:59:29 INFO - 'system_bits': '32', 08:59:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:29 INFO - 'title': 'talos-linux64-ix-046', 08:59:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:29 INFO - 'use_talos_json': True, 08:59:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:29 INFO - 'work_dir': 'build'} 08:59:29 INFO - [mozharness: 2017-05-09 15:59:29.021638Z] Running clobber step. 08:59:29 INFO - Running pre-action listener: _resource_record_pre_action 08:59:29 INFO - Running main action method: clobber 08:59:29 INFO - rmtree: /builds/slave/test/build 08:59:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:29 INFO - Running post-action listener: _resource_record_post_action 08:59:29 INFO - [mozharness: 2017-05-09 15:59:29.935050Z] Finished clobber step (success) 08:59:29 INFO - [mozharness: 2017-05-09 15:59:29.935149Z] Running read-buildbot-config step. 08:59:29 INFO - Running pre-action listener: _resource_record_pre_action 08:59:29 INFO - Running main action method: read_buildbot_config 08:59:29 INFO - Using buildbot properties: 08:59:29 INFO - { 08:59:29 INFO - "project": "", 08:59:29 INFO - "product": "firefox", 08:59:29 INFO - "who": "cbook@mozilla.com", 08:59:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:59:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:59:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:59:29 INFO - "stage_platform": "linux64-pgo", 08:59:29 INFO - "basedir": "/builds/slave/test", 08:59:29 INFO - "buildnumber": 202, 08:59:29 INFO - "platform": "ubuntu64_hw", 08:59:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:59:29 INFO - "slavebuilddir": "test", 08:59:29 INFO - "taskId": "FKpDYvI6TjeyEYvkPUVUhQ", 08:59:29 INFO - "branch": "mozilla-central", 08:59:29 INFO - "script_repo_revision": "production", 08:59:29 INFO - "revision": "ec15663c6331c8227d458bce85e6ca1b37423336", 08:59:29 INFO - "slavename": "talos-linux64-ix-046", 08:59:29 INFO - "repo_path": "mozilla-central" 08:59:29 INFO - } 08:59:29 INFO - Finding installer, test and symbols from parent task. 08:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FKpDYvI6TjeyEYvkPUVUhQ'}, attempt #1 08:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FKpDYvI6TjeyEYvkPUVUhQ'}, attempt #1 08:59:30 INFO - Task dependencies: BWkq_VcrQiSeZbA5rWsySA 08:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA'}, attempt #1 08:59:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 08:59:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/test_packages.json 08:59:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.crashreporter-symbols.zip 08:59:31 INFO - Running post-action listener: _resource_record_post_action 08:59:31 INFO - [mozharness: 2017-05-09 15:59:31.285766Z] Finished read-buildbot-config step (success) 08:59:31 INFO - [mozharness: 2017-05-09 15:59:31.285983Z] Running download-and-extract step. 08:59:31 INFO - Running pre-action listener: _resource_record_pre_action 08:59:31 INFO - Running main action method: download_and_extract 08:59:31 INFO - mkdir: /builds/slave/test/build/tests 08:59: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')]} 08:59:31 INFO - trying https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.test_packages.json 08:59:31 INFO - Downloading https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:59:31 INFO - Downloaded 986 bytes. 08:59:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:59:31 INFO - Using the following test package requirements: 08:59:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:59:31 INFO - u'common': [u'target.common.tests.zip'], 08:59:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:59:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:59:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:59:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:59:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:59:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:59:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:59:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:59:31 INFO - u'target.web-platform.tests.zip'], 08:59:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:59:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip 08:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip into memory 08:59:33 INFO - Content-Length response header: 60578508 08:59:33 INFO - Bytes received: 60578508 08:59:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:59:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip 08:59:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:59:42 INFO - Fetch https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.common.tests.zip into memory 08:59:44 INFO - Content-Length response header: 60578508 08:59:44 INFO - Bytes received: 60578508 08:59:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.talos.tests.zip 08:59:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:59:54 INFO - Fetch https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.talos.tests.zip into memory 08:59:55 INFO - Content-Length response header: 14409362 08:59:55 INFO - Bytes received: 14409362 08:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:55 INFO - trying https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 08:59:55 INFO - Downloading https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:59:56 INFO - Downloaded 68550984 bytes. 08:59:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 08:59:56 INFO - mkdir: /builds/slave/test/properties 08:59:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:56 INFO - Contents: 08:59:56 INFO - build_url:https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 08:59:56 INFO - Running post-action listener: _resource_record_post_action 08:59:56 INFO - Running post-action listener: set_extra_try_arguments 08:59:56 INFO - [mozharness: 2017-05-09 15:59:56.737397Z] Finished download-and-extract step (success) 08:59:56 INFO - [mozharness: 2017-05-09 15:59:56.737500Z] Running populate-webroot step. 08:59:56 INFO - Running pre-action listener: _resource_record_pre_action 08:59:56 INFO - Running main action method: populate_webroot 08:59:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:56 INFO - '--tppagecycles', 08:59:56 INFO - '7'], 08:59:56 INFO - 'tests': ['tsvgm']}}, 08:59:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['damp', 'tps']}, 08:59:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'tests': ['damp', 'tps']}, 08:59:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['dromaeo_dom']}, 08:59:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:59:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:59:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['a11yr', 08:59:56 INFO - 'ts_paint', 08:59:56 INFO - 'tpaint', 08:59:56 INFO - 'sessionrestore', 08:59:56 INFO - 'sessionrestore_no_auto_restore', 08:59:56 INFO - 'tabpaint']}, 08:59:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:59:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:59:56 INFO - 'bloom_basic_ref']}, 08:59:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tsvgx', 08:59:56 INFO - 'tsvgr_opacity', 08:59:56 INFO - 'tart', 08:59:56 INFO - 'tscrollx', 08:59:56 INFO - 'cart', 08:59:56 INFO - 'tsvg_static']}, 08:59:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:56 INFO - 'tsvgr_opacity', 08:59:56 INFO - 'tart', 08:59:56 INFO - 'tscrollx', 08:59:56 INFO - 'cart', 08:59:56 INFO - 'tsvg_static']}, 08:59:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s'], 08:59:56 INFO - 'tests': ['tp5o']}, 08:59:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:59:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'talos_options': ['--disable-e10s', 08:59:56 INFO - '--xperf_path', 08:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:56 INFO - 'tests': ['tp5n']}, 08:59:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:59:56 INFO - 'talos_options': ['--xperf_path', 08:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:56 INFO - 'tests': ['tp5n']}}, 08:59:56 INFO - 'talos.zip': {'path': '', 08:59:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:56 INFO - Running post-action listener: _resource_record_post_action 08:59:56 INFO - [mozharness: 2017-05-09 15:59:56.751124Z] Finished populate-webroot step (success) 08:59:56 INFO - [mozharness: 2017-05-09 15:59:56.751212Z] Running create-virtualenv step. 08:59:56 INFO - Running pre-action listener: _resource_record_pre_action 08:59:56 INFO - Running main action method: create_virtualenv 08:59:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:56 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 08:59:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:56 INFO - Using real prefix '/usr' 08:59:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:59 INFO - Installing pip.................done. 08:59:59 INFO - Return code: 0 08:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:59 INFO - Reading from file tmpfile_stdout 08:59:59 INFO - Output received: 08:59:59 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) 08:59:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:59 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')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 08:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 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 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:59 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')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 08:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Downloading/unpacking psutil>=3.1.1 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:01 INFO - Installing collected packages: psutil 09:00:01 INFO - Running setup.py install for psutil 09:00:01 INFO - building 'psutil._psutil_linux' extension 09:00:01 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 09:00:01 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 09:00:01 INFO - building 'psutil._psutil_posix' extension 09:00:01 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 09:00:01 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 09:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:01 INFO - Successfully installed psutil 09:00:01 INFO - Cleaning up... 09:00:01 INFO - Return code: 0 09:00:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:00: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 mozsystemmonitor==0.3 09:00:01 INFO - Using env: {'DISPLAY': ':0', 09:00:01 INFO - 'HOME': '/home/cltbld', 09:00:01 INFO - 'LANG': 'en_US.UTF-8', 09:00:01 INFO - 'LANGUAGE': 'en_US:en', 09:00:01 INFO - 'LOGNAME': 'cltbld', 09:00:01 INFO - 'MAIL': '/var/mail/cltbld', 09:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:01 INFO - 'MOZ_NO_REMOTE': '1', 09:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:01 INFO - 'NO_EM_RESTART': '1', 09:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:01 INFO - 'PWD': '/builds/slave/test', 09:00:01 INFO - 'SHELL': '/bin/bash', 09:00:01 INFO - 'SHLVL': '1', 09:00:01 INFO - 'TERM': 'linux', 09:00:01 INFO - 'TMOUT': '86400', 09:00:01 INFO - 'USER': 'cltbld', 09:00:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:01 INFO - '_': '/tools/buildbot/bin/python'} 09:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:03 INFO - Installing collected packages: mozsystemmonitor 09:00:03 INFO - Running setup.py install for mozsystemmonitor 09:00:03 INFO - Successfully installed mozsystemmonitor 09:00:03 INFO - Cleaning up... 09:00:03 INFO - Return code: 0 09:00:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', '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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:00: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 jsonschema==2.5.1 09:00:03 INFO - Using env: {'DISPLAY': ':0', 09:00:03 INFO - 'HOME': '/home/cltbld', 09:00:03 INFO - 'LANG': 'en_US.UTF-8', 09:00:03 INFO - 'LANGUAGE': 'en_US:en', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MAIL': '/var/mail/cltbld', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SHLVL': '1', 09:00:03 INFO - 'TERM': 'linux', 09:00:03 INFO - 'TMOUT': '86400', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - '_': '/tools/buildbot/bin/python'} 09:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:03 INFO - Downloading/unpacking jsonschema==2.5.1 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:04 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 09:00:04 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 09:00:04 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 09:00:04 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 09:00:04 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 09:00:04 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 09:00:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:04 INFO - warning: no files found matching '*.txt' 09:00:04 INFO - no previously-included directories found matching 'build' 09:00:04 INFO - no previously-included directories found matching 'dist' 09:00:04 INFO - no previously-included directories found matching '.git*' 09:00:04 INFO - Installing collected packages: jsonschema, functools32 09:00:04 INFO - Running setup.py install for functools32 09:00:04 INFO - warning: no files found matching '*.txt' 09:00:04 INFO - no previously-included directories found matching 'build' 09:00:04 INFO - no previously-included directories found matching 'dist' 09:00:04 INFO - no previously-included directories found matching '.git*' 09:00:04 INFO - Successfully installed jsonschema functools32 09:00:04 INFO - Cleaning up... 09:00:05 INFO - Return code: 0 09:00:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', '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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:00: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 functools32==3.2.3-2 09:00:05 INFO - Using env: {'DISPLAY': ':0', 09:00:05 INFO - 'HOME': '/home/cltbld', 09:00:05 INFO - 'LANG': 'en_US.UTF-8', 09:00:05 INFO - 'LANGUAGE': 'en_US:en', 09:00:05 INFO - 'LOGNAME': 'cltbld', 09:00:05 INFO - 'MAIL': '/var/mail/cltbld', 09:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:05 INFO - 'MOZ_NO_REMOTE': '1', 09:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:05 INFO - 'NO_EM_RESTART': '1', 09:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:05 INFO - 'PWD': '/builds/slave/test', 09:00:05 INFO - 'SHELL': '/bin/bash', 09:00:05 INFO - 'SHLVL': '1', 09:00:05 INFO - 'TERM': 'linux', 09:00:05 INFO - 'TMOUT': '86400', 09:00:05 INFO - 'USER': 'cltbld', 09:00:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:05 INFO - '_': '/tools/buildbot/bin/python'} 09:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:00:05 INFO - Cleaning up... 09:00:05 INFO - Return code: 0 09:00:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', '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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:00: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 blobuploader==1.2.4 09:00:05 INFO - Using env: {'DISPLAY': ':0', 09:00:05 INFO - 'HOME': '/home/cltbld', 09:00:05 INFO - 'LANG': 'en_US.UTF-8', 09:00:05 INFO - 'LANGUAGE': 'en_US:en', 09:00:05 INFO - 'LOGNAME': 'cltbld', 09:00:05 INFO - 'MAIL': '/var/mail/cltbld', 09:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:05 INFO - 'MOZ_NO_REMOTE': '1', 09:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:05 INFO - 'NO_EM_RESTART': '1', 09:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:05 INFO - 'PWD': '/builds/slave/test', 09:00:05 INFO - 'SHELL': '/bin/bash', 09:00:05 INFO - 'SHLVL': '1', 09:00:05 INFO - 'TERM': 'linux', 09:00:05 INFO - 'TMOUT': '86400', 09:00:05 INFO - 'USER': 'cltbld', 09:00:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:05 INFO - '_': '/tools/buildbot/bin/python'} 09:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:07 INFO - Downloading docopt-0.6.1.tar.gz 09:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:07 INFO - Running setup.py install for blobuploader 09:00:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:07 INFO - Running setup.py install for requests 09:00:07 INFO - Running setup.py install for docopt 09:00:07 INFO - Successfully installed blobuploader requests docopt 09:00:07 INFO - Cleaning up... 09:00:07 INFO - Return code: 0 09:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:07 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')]} 09:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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')]} 09:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:07 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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00:07 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 09:00:07 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 09:00:07 INFO - Using env: {'DISPLAY': ':0', 09:00:07 INFO - 'HOME': '/home/cltbld', 09:00:07 INFO - 'LANG': 'en_US.UTF-8', 09:00:07 INFO - 'LANGUAGE': 'en_US:en', 09:00:07 INFO - 'LOGNAME': 'cltbld', 09:00:07 INFO - 'MAIL': '/var/mail/cltbld', 09:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:07 INFO - 'MOZ_NO_REMOTE': '1', 09:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:07 INFO - 'NO_EM_RESTART': '1', 09:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:07 INFO - 'PWD': '/builds/slave/test', 09:00:07 INFO - 'SHELL': '/bin/bash', 09:00:07 INFO - 'SHLVL': '1', 09:00:07 INFO - 'TERM': 'linux', 09:00:07 INFO - 'TMOUT': '86400', 09:00:07 INFO - 'USER': 'cltbld', 09:00:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:07 INFO - '_': '/tools/buildbot/bin/python'} 09:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:08 INFO - Running setup.py (path:/tmp/pip-TqA0wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:08 INFO - Running setup.py (path:/tmp/pip-M0nVqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:08 INFO - Running setup.py (path:/tmp/pip-Z6ABGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:08 INFO - Running setup.py (path:/tmp/pip-fU3imE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:08 INFO - Running setup.py (path:/tmp/pip-s78fLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:08 INFO - Running setup.py (path:/tmp/pip-q_hXj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:08 INFO - Running setup.py (path:/tmp/pip-EtKPcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:08 INFO - Running setup.py (path:/tmp/pip-IyTJW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:08 INFO - Running setup.py (path:/tmp/pip-1pTS7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:08 INFO - Running setup.py (path:/tmp/pip-U9nqH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:08 INFO - Running setup.py (path:/tmp/pip-DvLq3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:08 INFO - Running setup.py (path:/tmp/pip-Zp6JIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:08 INFO - Running setup.py (path:/tmp/pip-SutrLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:09 INFO - Running setup.py (path:/tmp/pip-SInu7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:09 INFO - Running setup.py (path:/tmp/pip-lyGiH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:09 INFO - Running setup.py (path:/tmp/pip-rIaxJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:09 INFO - Running setup.py (path:/tmp/pip-7nwhPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:09 INFO - Running setup.py install for manifestparser 09:00:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:09 INFO - Running setup.py install for mozcrash 09:00:09 INFO - Running setup.py install for mozdebug 09:00:09 INFO - Running setup.py install for mozdevice 09:00:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:09 INFO - Running setup.py install for mozfile 09:00:09 INFO - Running setup.py install for mozhttpd 09:00:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:09 INFO - Running setup.py install for mozinfo 09:00:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:09 INFO - Running setup.py install for mozInstall 09:00:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Running setup.py install for mozleak 09:00:10 INFO - Running setup.py install for mozlog 09:00:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Running setup.py install for moznetwork 09:00:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Running setup.py install for mozprocess 09:00:10 INFO - Running setup.py install for mozprofile 09:00:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Running setup.py install for mozrunner 09:00:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:10 INFO - Running setup.py install for mozscreenshot 09:00:10 INFO - Running setup.py install for moztest 09:00:10 INFO - Running setup.py install for mozversion 09:00:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:11 INFO - Cleaning up... 09:00:11 INFO - Return code: 0 09:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:11 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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00:11 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 09:00:11 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 09:00:11 INFO - Using env: {'DISPLAY': ':0', 09:00:11 INFO - 'HOME': '/home/cltbld', 09:00:11 INFO - 'LANG': 'en_US.UTF-8', 09:00:11 INFO - 'LANGUAGE': 'en_US:en', 09:00:11 INFO - 'LOGNAME': 'cltbld', 09:00:11 INFO - 'MAIL': '/var/mail/cltbld', 09:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:11 INFO - 'MOZ_NO_REMOTE': '1', 09:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:11 INFO - 'NO_EM_RESTART': '1', 09:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:11 INFO - 'PWD': '/builds/slave/test', 09:00:11 INFO - 'SHELL': '/bin/bash', 09:00:11 INFO - 'SHLVL': '1', 09:00:11 INFO - 'TERM': 'linux', 09:00:11 INFO - 'TMOUT': '86400', 09:00:11 INFO - 'USER': 'cltbld', 09:00:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:11 INFO - '_': '/tools/buildbot/bin/python'} 09:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:11 INFO - Running setup.py (path:/tmp/pip-_2qHS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:11 INFO - Running setup.py (path:/tmp/pip-0Lc2g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:11 INFO - Running setup.py (path:/tmp/pip-JwZf07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:11 INFO - Running setup.py (path:/tmp/pip-vJsg7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:11 INFO - Running setup.py (path:/tmp/pip-FfONwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:11 INFO - Running setup.py (path:/tmp/pip-I7SM9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:11 INFO - Running setup.py (path:/tmp/pip-r4BEx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:11 INFO - Running setup.py (path:/tmp/pip-uujxdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:11 INFO - Running setup.py (path:/tmp/pip-8VWOxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:11 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)) 09:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:11 INFO - Running setup.py (path:/tmp/pip-vflMgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:12 INFO - Running setup.py (path:/tmp/pip-1efWOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:12 INFO - Running setup.py (path:/tmp/pip-X5gTqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:12 INFO - Running setup.py (path:/tmp/pip-2FHnzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:12 INFO - Running setup.py (path:/tmp/pip-U572B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:12 INFO - Running setup.py (path:/tmp/pip-On0RrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:12 INFO - Running setup.py (path:/tmp/pip-zMdNwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:12 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)) 09:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:12 INFO - Running setup.py (path:/tmp/pip-dFFYY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:12 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)) 09:00:12 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)) 09:00:12 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)) 09:00:12 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)) 09:00:12 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)) 09:00:12 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)) 09:00:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:13 INFO - Downloading blessings-1.6.tar.gz 09:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:13 INFO - Installing collected packages: blessings 09:00:13 INFO - Running setup.py install for blessings 09:00:13 INFO - Successfully installed blessings 09:00:13 INFO - Cleaning up... 09:00:13 INFO - Return code: 0 09:00:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:14 INFO - Reading from file tmpfile_stdout 09:00:14 INFO - Current package versions: 09:00:14 INFO - argparse == 1.2.1 09:00:14 INFO - blessings == 1.6 09:00:14 INFO - blobuploader == 1.2.4 09:00:14 INFO - docopt == 0.6.1 09:00:14 INFO - functools32 == 3.2.3-2 09:00:14 INFO - jsonschema == 2.5.1 09:00:14 INFO - manifestparser == 1.1 09:00:14 INFO - mozInstall == 1.12 09:00:14 INFO - mozcrash == 1.0 09:00:14 INFO - mozdebug == 0.1 09:00:14 INFO - mozdevice == 0.50 09:00:14 INFO - mozfile == 1.2 09:00:14 INFO - mozhttpd == 0.7 09:00:14 INFO - mozinfo == 0.9 09:00:14 INFO - mozleak == 0.1 09:00:14 INFO - mozlog == 3.4 09:00:14 INFO - moznetwork == 0.27 09:00:14 INFO - mozprocess == 0.25 09:00:14 INFO - mozprofile == 0.28 09:00:14 INFO - mozrunner == 6.13 09:00:14 INFO - mozscreenshot == 0.1 09:00:14 INFO - mozsystemmonitor == 0.3 09:00:14 INFO - moztest == 0.8 09:00:14 INFO - mozversion == 1.4 09:00:14 INFO - psutil == 3.1.1 09:00:14 INFO - requests == 1.2.3 09:00:14 INFO - wsgiref == 0.1.2 09:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 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 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00:14 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 09:00:14 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 09:00:14 INFO - Using env: {'DISPLAY': ':0', 09:00:14 INFO - 'HOME': '/home/cltbld', 09:00:14 INFO - 'LANG': 'en_US.UTF-8', 09:00:14 INFO - 'LANGUAGE': 'en_US:en', 09:00:14 INFO - 'LOGNAME': 'cltbld', 09:00:14 INFO - 'MAIL': '/var/mail/cltbld', 09:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:14 INFO - 'MOZ_NO_REMOTE': '1', 09:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:14 INFO - 'NO_EM_RESTART': '1', 09:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:14 INFO - 'PWD': '/builds/slave/test', 09:00:14 INFO - 'SHELL': '/bin/bash', 09:00:14 INFO - 'SHLVL': '1', 09:00:14 INFO - 'TERM': 'linux', 09:00:14 INFO - 'TMOUT': '86400', 09:00:14 INFO - 'USER': 'cltbld', 09:00:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:14 INFO - '_': '/tools/buildbot/bin/python'} 09:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 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)) 09:00:14 INFO - Cleaning up... 09:00:14 INFO - Return code: 0 09:00:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, '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': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', '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 09:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:00:14 INFO - Using env: {'DISPLAY': ':0', 09:00:14 INFO - 'HOME': '/home/cltbld', 09:00:14 INFO - 'LANG': 'en_US.UTF-8', 09:00:14 INFO - 'LANGUAGE': 'en_US:en', 09:00:14 INFO - 'LOGNAME': 'cltbld', 09:00:14 INFO - 'MAIL': '/var/mail/cltbld', 09:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:14 INFO - 'MOZ_NO_REMOTE': '1', 09:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:14 INFO - 'NO_EM_RESTART': '1', 09:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:14 INFO - 'PWD': '/builds/slave/test', 09:00:14 INFO - 'SHELL': '/bin/bash', 09:00:14 INFO - 'SHLVL': '1', 09:00:14 INFO - 'TERM': 'linux', 09:00:14 INFO - 'TMOUT': '86400', 09:00:14 INFO - 'USER': 'cltbld', 09:00:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:14 INFO - '_': '/tools/buildbot/bin/python'} 09:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:14 INFO - Cleaning up... 09:00:14 INFO - Return code: 0 09:00:14 INFO - Running post-action listener: _resource_record_post_action 09:00:14 INFO - Running post-action listener: _start_resource_monitoring 09:00:14 INFO - Starting resource monitoring. 09:00:14 INFO - [mozharness: 2017-05-09 16:00:14.586888Z] Finished create-virtualenv step (success) 09:00:14 INFO - [mozharness: 2017-05-09 16:00:14.587393Z] Running install step. 09:00:14 INFO - Running pre-action listener: _resource_record_pre_action 09:00:14 INFO - Running main action method: install 09:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:14 INFO - Reading from file tmpfile_stdout 09:00:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:14 INFO - Reading from file tmpfile_stdout 09:00:14 INFO - Output received: 09:00:14 INFO - Usage: mozinstall [options] installer 09:00:14 INFO - Options: 09:00:14 INFO - -h, --help show this help message and exit 09:00:14 INFO - -d DEST, --destination=DEST 09:00:14 INFO - Directory to install application into. [default: 09:00:14 INFO - "/builds/slave/test"] 09:00:14 INFO - --app=APP Application being installed. [default: firefox] 09:00:14 INFO - mkdir: /builds/slave/test/build/application 09:00:14 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'] 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:00:32 INFO - Reading from file tmpfile_stdout 09:00:32 INFO - Output received: 09:00:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:32 INFO - Running post-action listener: _resource_record_post_action 09:00:32 INFO - [mozharness: 2017-05-09 16:00:32.100541Z] Finished install step (success) 09:00:32 INFO - [mozharness: 2017-05-09 16:00:32.100822Z] Running run-tests step. 09:00:32 INFO - Running pre-action listener: _resource_record_pre_action 09:00:32 INFO - Running main action method: run_tests 09:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:32 INFO - Python 2.7.3 09:00:32 INFO - Return code: 0 09:00:32 INFO - grabbing minidump binary from tooltool 09:00: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')]} 09:00: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 0x143ba30>, '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 0x143c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00: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 09:00: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 09:00: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 09:00:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:32 INFO - Return code: 0 09:00:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:32 INFO - ENV: RUST_BACKTRACE is now 1 09:00:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:00: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:00:32 INFO - Using env: {'DISPLAY': ':0', 09:00:32 INFO - 'HOME': '/home/cltbld', 09:00:32 INFO - 'LANG': 'en_US.UTF-8', 09:00:32 INFO - 'LANGUAGE': 'en_US:en', 09:00:32 INFO - 'LOGNAME': 'cltbld', 09:00:32 INFO - 'MAIL': '/var/mail/cltbld', 09:00:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:32 INFO - 'MOZ_NO_REMOTE': '1', 09:00:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:32 INFO - 'NO_EM_RESTART': '1', 09:00:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:32 INFO - 'PWD': '/builds/slave/test', 09:00:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:32 INFO - 'RUST_BACKTRACE': '1', 09:00:32 INFO - 'SHELL': '/bin/bash', 09:00:32 INFO - 'SHLVL': '1', 09:00:32 INFO - 'TERM': 'linux', 09:00:32 INFO - 'TMOUT': '86400', 09:00:32 INFO - 'USER': 'cltbld', 09:00:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815', 09:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:32 INFO - '_': '/tools/buildbot/bin/python'} 09:00:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:00:32 INFO - mozversion application_buildid: 20170509145838 09:00:32 INFO - mozversion application_changeset: ec15663c6331c8227d458bce85e6ca1b37423336 09:00:32 INFO - mozversion application_display_name: Nightly 09:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:32 INFO - mozversion application_name: Firefox 09:00:32 INFO - mozversion application_remotingname: firefox 09:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:00:32 INFO - mozversion application_vendor: Mozilla 09:00:32 INFO - mozversion application_version: 55.0a1 09:00:32 INFO - mozversion platform_buildid: 20170509145838 09:00:32 INFO - mozversion platform_changeset: ec15663c6331c8227d458bce85e6ca1b37423336 09:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:00:32 INFO - mozversion platform_version: 55.0a1 09:00:32 INFO - using testdate: 1494345632 09:00:32 INFO - actual date: 1494345632 09:00:32 INFO - starting webserver on 'localhost:46141' 09:00:32 INFO - SUITE-START | Running 2 tests 09:00:32 INFO - TEST-START | dromaeo_css 09:00:32 INFO - operating with platform_type : linux_ 09:00:32 INFO - Initialising browser for dromaeo_css test... 09:00:32 INFO - TEST-INFO | started process 6703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ND4y3/profile http://localhost:46141/getInfo.html) 09:00:36 INFO - PID 6703 | __metrics Screen width/height:1600/1200 09:00:36 INFO - PID 6703 | colorDepth:24 09:00:36 INFO - PID 6703 | Browser inner width/height: 1024/695 09:00:36 INFO - PID 6703 | __metrics 09:00:37 INFO - TEST-INFO | 6703: exit 0 09:00:37 INFO - Browser initialized. 09:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:38 INFO - TEST-INFO | started process 6878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ND4y3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:49 INFO - PID 6878 | RSS: Main: 151826432 09:00:49 INFO - PID 6878 | 09:03:51 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46141/tests/dromaeo/cssquery-ext.html) 09:03:52 INFO - PID 6878 | RSS: Main: 164864000 09:03:52 INFO - PID 6878 | 09:06:54 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-ext.html (next: http://localhost:46141/tests/dromaeo/cssquery-jquery.html) 09:06:55 INFO - PID 6878 | RSS: Main: 158818304 09:06:55 INFO - PID 6878 | 09:09:56 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46141/tests/dromaeo/cssquery-mootools.html) 09:09:57 INFO - PID 6878 | RSS: Main: 166891520 09:09:57 INFO - PID 6878 | 09:12:59 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46141/tests/dromaeo/cssquery-prototype.html) 09:12:59 INFO - PID 6878 | RSS: Main: 159793152 09:12:59 INFO - PID 6878 | 09:16:02 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46141/tests/dromaeo/cssquery-yui.html) 09:16:03 INFO - PID 6878 | RSS: Main: 163643392 09:16:03 INFO - PID 6878 | 09:17:53 INFO - PID 6878 | Sandbox: Unexpected EOF, op 2 flags 00 path /etc/fonts/conf.d/90-ttf-kannada-fonts.conf 09:19:04 INFO - PID 6878 | Cycle 1(1): loaded http://localhost:46141/tests/dromaeo/cssquery-yui.html (next: http://localhost:46141/tests/dromaeo/cssquery-dojo.html) 09:19:04 INFO - PID 6878 | RSS: Main: 164933632 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | __start_tp_report 09:19:04 INFO - PID 6878 | _x_x_mozilla_page_load 09:19:04 INFO - PID 6878 | _x_x_mozilla_page_load_details 09:19:04 INFO - PID 6878 | |i|pagename|runs| 09:19:04 INFO - PID 6878 | |0;dojo.html;3444.552208212932;3449.689527942486;3462.740294477914;3472.9826350868243;3479.025872755626;5924.614900031495;5975.4323339282755;6013.128096426021;6024.945634513959;6053.515718742501;5961.523078153748;6022.909656355158;6085;6114.755409783604;6140.723667434965;5258.921116183241;5344.4922732340365;5371.973140134294;5375.946240537583;5410.864728381783;5405.081136206854;5467.371252305976;5475.288212532365;5478.123500239963;5483.643563168402;5310.0441920454305;5355.892882142335;5371.946280537223;5392.676439413628;5434;5369.838904832861;5379.058664733656;5399.595030372699;5404.7838086476495;5444.3194600674915;5288.947110528884;5336.43967383423;5351.491608297206;5382.2464854920345;5383.977044361559;5907.763689452417;5973.432523910222;5979.820605381802;5988.670623115727;6065.059915713072;6538.346165383471;6562.901556476657;6595.439387652055;6595.6372399518;6624.774416732872;6598.901016484757;6641.800745977628;6652.101966234545;6654.13496245485;6665.333466653345;5981.850453738692;6087.299960504599;6126.387361263838;6136.325004249529;6151;6628.337166283333;6633.800985970429;6671.366220209073;6716.361945615159;6750.257471678112;6258.874822503615;6328.746850125944;6360.840978975562;6394.520410969196;6489.805305840832;6493.837654058591;6590.3080176581725;6604.1084453599115;6617;6631.038499417557;6384.978403455518;6525.967370163214;6587.341265873471;6588.077669126326;6609.834754131185;6447.4197322241225;6493.448056915121;6550.868982620416;6566.474682025427;6611.338866113447;4957.231629097496;4963.677360971526;4964.329815474937;4966.701997880139;5014.52362025607;4384.934225986613;4391.033972526039;4393.7363758174615;4393.84621538251;4425.75658338788;6134.803982731532;6152;6212.9068063979075;6298.149749783812;6312.684365781693;6639.966800166065;6649.933500665028;6651;6655.73377064912;6672.699728512229;6286.685665716695;6306.716197771111;6318.873622527615;6341.175647165931;6364.745410183634;5564.805231816867;5621.128725047624;5624.859378515488;5636.04187288162;5728.083506639001;6757.831054223586;6813.625250611264;6864.4165245954655;6870.828229294308;6879.208890977602;6616.536842420985;6656.36764507371;6668.6665666717445;6671.166104236971;6674.799756007327;6823.147106611674;6896.379325860496;6918.7232510699005;6925;6942.583444993114;6351.523635727432;6394.424501794861;6411.487081033413;6446.9355306448215;6472.805815825533;6625.734970601315;6625.867482650224;6642.402183803288;6658.267590564937;6659.600423974383;6258.906116408349;6280.434760871543;6322.936770632419;6352.396522330371;6361.809145725636;6404.967975160094;6433.324500927335;6448.967755161382;6450.290468048417;6451.6774161290805;6172.598781079395;6325.367463253638;6357.300696923242;6443.7744678936015;6444.097826304227;6346.333634968262;6418.261899881387;6444.742210311535;6449.064885591469;6493.285738568659;6269.592476489013;6281.120643109877;6301.117843501822;6303.684815759102;6313.90529142054 09:19:04 INFO - PID 6878 | |1;ext.html;764.3006648916238;811.8863359129722;838.350278534136;1149.4425203776168;1155.7457359380933;34828.30343393134;35834.64165358346;35901.2819743605;36001;36020.81989590052;37831.810840945756;38391.616083839224;38417.80791096041;38422.231555368875;38450.4232436513;7242.782716518513;7349.669264883067;7356.779296621083;7529.510581812192;7545.811354716121;7404.074490688664;7461.216572259916;7502.137254215753;7518.323350898418;7531.209223031585;7421.703131874719;7480.289372509603;7516.210797866227;7543.094828620573;7557.0931488221495;7471.364933980618;7472.140703819049;7503.662335194929;7504.812379690524;7540.283673051079;7323.523970941872;7371.63141842911;7398.297161769623;7417.592032438214;7429.294217049372;36675.633243667486;37079.073023174366;37216.511339546385;37253.81373093144;37389.43915841264;3554.8222588870453;3587.3722098632634;3587.7667951583326;3595.6224596417524;3611.4763359313015;28431.289217769514;28602.71397286042;28707.712922870713;28724.281892952633;28775;3807.60020197878;3850.403187505941;3862.0344913771555;3865.942010869839;3866.8839934802;191501;191849;201516;206833;209175;46156.5384346159;46297.30554041692;46338.30492542614;46464.535354646694;46534;48335.516644833806;48441.75779121082;48520.51479485231;54869.1769623456;55046.72476637591;15586;15762.211889405484;15767.211639417983;15775.29011194499;15779.763303550455;12326.75346493083;12334.074944379208;12453.564125255572;12465.065120116027;12512.061595380383;14756.852431475763;14950.252487375588;15093.622659433382;15163.620909477131;15254.313555890012;5901.439363260569;5902.2622172228475;6046.486048685823;6051.515878729691;6225.719842607094;1060.8567843341204;1110.2783190925963;1127.4700890581414;1156.5084838943583;1157.4097210422576;24637.260882173563;25538.48923021529;25630.359241019123;25795.613065804027;26047.218583442525;1170.836082948388;1190.1371505658328;1197.0782497476894;1197.5569039455283;1200.0759415250384;13734.604926423448;13747.862521374858;13765.655858603615;13804.102733322503;17449.21478533469;265933;267750;267890;268497;268759;59045.70477147587;59472.40527594755;59492.70253648704;59547.702261489285;59582.70208648929;1459.8905082118883;1500.1674070890542;1517.1807224098864;1525.6643538421752;1533.463287849244;29082.709172908;30334.393312133194;30757.23106922345;30925.69074309228;31360.843195783877;39827.80086099667;39956.2008759829;40110.1977960445;40174;40287.79856100701;155966;158432;158856;159292;159827;33978.660213398536;34185.65814341924;34273.14317142092;34287.314253714285;34382;41878;44104.33843492286;44122.558774413126;44353.33469998017;44871.77564112289;31373;32564.674353257113;32858.835705821315;33949.15127121842;34225.65774342225;31699.52450713287;32364.514532281562;32442;32946.34107317792;33885.49171762475;36632;37417.625823741415;37817.432738509495;37972;38042;31601.52597711082;32642.51036234506;32732;33044.339113218084;33104;24719.62920556229;26491.33771655647;26636.733632663425;26703.724624713566;26907 09:19:04 INFO - PID 6878 | |2;jquery.html;413.1468517511337;421.86996987329485;429.74859707071374;440.80163926233195;443.39476614421324;12934.935325323371;13298.867011329883;13365.532206372767;16584;17948.19233134509;20852.165913363486;21103.788962110375;21230.89384553075;21258;22028.229011984582;5506.862328441801;5572.888542229163;5718.285214348207;5759.16492108644;5774.307083150028;5591.133374326986;5667.518260947824;5669.886602267952;5674.659520428788;5709.8572535686735;5628.887422251552;5634.436556344353;5684.289463817023;5687.459691329317;5690.63010904292;5523.061079616475;5591.049521581341;5627.099664053752;5632.211490391349;5642.4357564243655;5128;5145.742712864342;5150.27896094547;5179.715115668637;5180.611454140954;26469.47061058768;26682.33294167642;26707.332316692045;27128.72871271282;27565.586516202275;2176.260071575656;2206.0403724379944;2217.0355895185485;2225.688403623494;2229.598672238996;16332.673346533003;16845.57886052846;17449.476515704548;17508.912455437643;17516.47450576472;2175;2229.6209644360497;2234.7430045544806;2258.3563684349883;2268.410213344526;103995;105732.47133764283;106051;108989;110530.44734776355;12206;12559.183653062522;12638.494460221487;12669.619911402673;12821;17096.06790438206;17206.31174753021;17281.913590432217;17311;17319.047452389987;9125.269978401711;9145.954270228607;9290.070992900792;9358.953205233931;9370.203532699661;8460.957695211484;8475.406721529434;8519.233269005696;8764.693235736719;8801.603927823264;7744;7906.604669766489;8058.267472493442;8142.511449312941;8193.71322003727;2153.1172219389973;2194.901229444647;2227.9443013924456;2234.3855439754198;2402.3513651314047;1020.4132623741378;1056.3186744549876;1058.4178701714027;1059.279689810936;1064.2443864856039;19368.418947431317;20432.489187770425;20449.591008179752;20571.32572765531;20590.382288531368;1064.7178497698117;1064.797688439194;1065.0680654427376;1065.2862582070031;1070.6948519671855;10976.176786741027;11194.720131996764;11218.887811121784;11371.943140284246;11397.202195846212;500298;503667;508388;516489;523102;94479;95029.5248523753;95871;96649.51675241579;103216;1225.877412258767;1238.6098379010582;1268.4482250221;1285.0940087238475;1286.7362190751062;20281.898590506953;20750.68873966922;21183.364499065054;21318.147274108862;21413.571728565654;45279.320810187215;45496.31755523736;45667.31499027584;46040;46334;60758.69620651868;62922.685386572775;63982.3601763995;65928.67035664791;66186;9520.809583808146;9772.31593788428;9797.628332033664;9851.359661621971;10004.049615286536;14647.487337943121;15265.389384424943;15773.921130394274;15970.361185552449;16005.759913601538;12362.876371236172;13244.47022119143;13463.798043029166;13832.308384580932;14246.786298205743;12719.93640031794;12795.80806287925;12871.163374380636;13241.205527668371;13424.798628020782;13166.73666526645;13404.128731632412;13860;14090.436382544583;14113.153210807384;9759.219262458844;9844.60621575129;10039.749006274902;10058.698239052841;10081.243906706879;13029.869701302865;13320;13429;13692.178469291874;13838.792418113535 09:19:04 INFO - PID 6878 | |3;mootools.html;1411.5341937160736;1459.7956286119938;1460.8466111058344;1468.1704836767226;1480.7112613040454;10962.397068161257;11365.886341136586;11382.658520244386;11489.999999999989;11674;11350.772984540305;11437.085033197345;11535.134864885125;11536.826947595793;11538.423078846066;2294.9311520654364;2309.226409152936;2316.8030717388956;2323.848949818265;2336.9298921032396;2252.763459836718;2307.4231442139467;2317.640765681322;2320.8839558022114;2326.697529321186;2201.9889900550475;2211.281333566589;2256.7968882800546;2264.6603009548617;2267.206477732797;2157.7518585362727;2176.1186719378675;2205.6029914615365;2209.8674079555276;2219.511707424364;1949.4638974282045;2023.312073894868;2125.829933605308;2241.730992280937;2302.320815359473;11391.943040284745;11418.31490110596;11471.713207169887;11514.30914145154;11532.365719885403;6157.538184636171;6391.808245752635;6404.1674582304;6417.486601071903;6431.517636177258;3591.838367273453;3796.2027974125467;3899.7270191086636;3912.5109361329833;3945.822437990297;1315.6381994951369;1323.4309247023775;1345.5559665310425;1346.9124506907117;1387.084524214014;16887.071211083385;16984.15079246033;17036.82963170377;17076.487705368858;17151.571210719707;5140.306058682105;5231.633785635046;5289.3917199521775;5489.560835133179;5496.697681627469;12368.628941131601;12401.689957751129;12404.25574465535;12462.81305780414;12491.188072775241;6500.902486462707;6510.641914694643;6522.543421960418;6553.377429144223;6574.211094668671;5970.3432622412365;5985.970070149709;6012.278526576839;6042.546808989343;6158.876822463526;4232.333629813198;4256;4278.4010238566625;4323;4364.148990946798;1227.441514111095;1233.402743447238;1245.5329251530677;1248.7065539598186;1265.1333836321965;822.383212590557;843.1105184030906;860.8321377331486;863.5552690364467;888.1030159538913;6156.78451254204;6221.471174950089;6257.342978987141;6294.8111556653375;6443.967780161163;566.1422944239481;571.8541771848236;576.7347020370677;580.8199458167896;581.0702875399412;3856.82644281008;3896.883093507199;3949.3483575210344;3969.7221194516683;3970.980145099256;14606.707865842624;15286.082835029934;15502;15514.45699400538;15517.301721422564;13986;14833.480828170963;15352;15367.385304587915;15391.538253852403;9129.360944733939;9343.953280233556;9365.672201473051;9396.577154028086;9402.952985235166;6827.351401616838;6855.897161542481;6857.759978400732;6934.237233904368;7098.716051358095;13331;13433.19400835953;13518.662033449242;13685.931570342085;13757.862421375658;13691.383887724876;13762.174269543859;13798.103123296954;14048.103506026555;14070.577882663536;9179.862302065609;9369.437833729999;9434.292428067785;9528.523573821143;9529.190018848476;10863.891361086287;10979.890201097887;11012.17408694335;11029.83455248188;11035.944820275847;9088.136627020422;9112.95443522778;9123.954380228057;9180.668803023658;9330.673426430043;9138.817223655622;9175.770605734642;9186.724398268063;9306.627734890799;9352.251819854258;8455.858459107942;8568.186022327869;8571.485710857369;8593;8609.913900861162;6304.495640348853;6327.746890124344;6344.080108384166;6351.1425957496995;6526.608403495806;6166.784162554289;6236.781712640036;6317.5893566918;6342.429181373698;6484.740610375532 09:19:04 INFO - PID 6878 | |4;prototype.html;394.49898628741494;396.1561873210062;405.987820365389;407.43163287214315;410.58735970349795;6157.846053848656;6200.379962003797;6235.625862448251;6240.563160578761;6349.809505714836;6083.604565703226;6183.412575805302;6188.969055154729;6188.969055154729;6191.566590338678;4482.484514280851;4588.715159755274;4601;4608.769561521927;4614.261718125101;4594.74728889911;4602.7238365697995;4604.769761511928;4605.309203619468;4605.815767369301;4573.3368661544055;4578.839740609079;4580.312953057035;4580.473245576752;4608.262677971526;4493;4538.842595138235;4550.749708766017;4583.885402864922;4595.494495605498;3928.4500169976227;3930.980345098285;3947.6841852652005;3949.0917089069676;3960.584138665456;6044.032954727222;6052;6059.848503787396;6086.726097325631;6093.603915745507;5228.320318358589;5348.732563371816;5404.945950540484;5404.945950540523;5412.269343638637;6568.6058836469965;6610.20677518696;6612.371824676648;6615.669216539154;6617.7683781067435;4405.647548196137;4410.162069206873;4445.51099379068;4467.128909862578;4478.507364189936;6673.165854268216;6832.145981752281;6861.907118328908;6899.171719494338;6909.585424874474;4487.618552423015;4560.817567297271;4562.8631141065825;4569.725816451024;4569.817207311737;4588.77056147198;4615.79228934692;4629.606483448877;4631.606313463393;4633.907321853544;5250.291210686585;5377;5391.73041347931;5391.838244852661;5397.136458166675;6513.348665133543;6551.377619126175;6567.211934567787;6577.506686998494;6586.934130658728;1547.3810475809767;1561.4144695739099;1562.1017914699094;1567.388718399825;1571.4814111343458;1018.9847152292722;1024.1755386913458;1038.190211634926;1052.2949623752104;1054.5781687325132;6324.3043265240785;6361.236651601837;6372.896944008466;6392.041193820871;6395.456386207225;6517.250516190698;6678.432333251631;6770.424513916274;6837.589744615339;6837.62393068386;6356.904646430307;6365.2361716594305;6370.490360771128;6383.2978372379;6408.359164083555;3476.66971637694;3568.892933212008;3608.530890984208;3609.5668519777796;3618.746687731886;7128.465365097639;7141.250168732208;7161.176464706521;7168.211496735355;7227.855442891113;6719.294474080151;6949;6965.373116419547;6993.370596646225;7027.964860175666;7109.8933515997305;7132.465065120136;7150.065445680073;7190.892136617955;7230.613897413841;6553.770618028346;6815.863682726219;6827.419669327964;6850.581375013188;6867.158653149618;6622.90065649006;6762.188537375547;6766.627835468899;6773.796786096425;6796.388325050571;7147.571145731273;7149.213586505584;7162.677679504539;7179.282071792779;7208.207097219407;4564.748938808398;4574.5425457453985;4583.656225783013;4584.381108550437;4596.494385617646;6695.655212696493;6816.761413350708;6841.8973715395305;6882.7591034313555;6918.584884906922;6704.530682852153;6704.664766761545;6714.865702685821;6725.932740672531;6741.22475915276;6399.904001440075;6595.835104122435;6638.336166383323;6656.966715166393;6697.397234248941;6570.704318305783;6587.571807832475;6600.867982640224;6601.141851559267;6602.438792702482;6549.672516374258;6643.60138391698;6679.532432729857;6690.264070952094;6717.1267735194115;6436.452901503425;6438.67806609677;6457.031445283057;6488.124103246001;6507.154069970874 09:19:04 INFO - PID 6878 | |5;yui.html;847.8643417053273;856.0754385263915;862.9644426687972;865.5499140446967;893.517500549703;16478.588035299123;16557.33770649174;16917.661646767072;17073.317067317308;18550.536236594056;15353.15557644329;15575.53273401797;18020.90989545054;18031.4590562283;18357.632847343044;983.0562659846538;991.6727479931606;1011.7268337548858;1013.1995723378523;1014.4521958142594;965.9806803863919;1000.1398797034544;1006.3509036671343;1014.3305418423842;1014.3761586624247;1051.5425789781432;1058.978820423591;1062.3731998121107;1063.080435423361;1063.2450959818539;1048.8636477257946;1053.899879511445;1054.219877290807;1057.2704833664748;1059.9682009539727;783.7844592736986;784.9725259615943;787.6416230615114;789.8617741895202;790.2532107158737;16884.324627014903;17150.228239729244;17290.135493225287;17313.394031208973;17656.293748250053;16906.323747050104;17381.30474781007;17654.205560749797;17945.282188712437;18318.175682094337;13634.522791702342;13844.30778461083;14056.85943140576;14130.646733831634;14213.928930355385;3431.6225215226304;3445.3453843769603;3449.689527942472;3455.153487395579;3457.9798959306813;93069.53465232698;93143;93439;93871.53064234703;94070.52964735201;14153.08004979673;14294.928525357307;14425;14513.05665131763;14628.926855365655;23351.182708605116;23415.180468683855;23597.764022359555;23789;24039.399015024414;7786.532808031537;7849.175836537195;7867.291943725092;7899.644515996794;7899.946014036392;4141.4616099907425;4173.31140361843;4183.895402614898;4187.937180942288;4256.318988961813;4459.331100334975;4527.185106680829;4558.33904083906;4560.521145279764;4566.360709500673;896.3546246702364;925.5881132895931;934.4113208678489;936.0265324062898;938.1790932933683;721.0950257426896;726.4551586310267;747.1184002876657;749.7113611259705;768.9077310722749;11844.763104737856;12420.75158496825;12808.167469114478;12924.676883077811;12951.04992977151;730.5835673666065;735.6211551051213;740.9296116868888;752.766642340876;762.904636920385;5568.777248909998;5909.911351329733;5916.822495325061;5942.168096466498;6026.638401695912;79701.60149199217;80628;80628.59685701651;81292;81733.59133204295;71368.64315678389;71501;71844.28155718376;75023.24976750271;76286.23713762902;66041.66979165074;67417.66291168611;67719;67782.3221767776;68065;11216.046636035702;11698;11819.763604728028;11856.881431185579;11894.178627195965;33119.83440082784;33841;34010.31979360448;34033.48949765805;37420.81289593643;51519.74240128775;53590.732046339515;55974.72012640074;56441.435585643616;58217;17178.31286748516;17291;17305.653886922442;17335.653286934445;17430.82569174292;18440.26238950427;18544.629107418044;18710.71933920965;18712.15795289188;18759.437216883514;16341.509754706902;17481.300747969937;17735.645287094445;17952.91023544926;18165.091745412414;17660.73508897342;17671.381501647895;17960.281588736303;18014.639707206046;18610.813891860907;15445.922770386076;15525.45660901863;15649.608759781097;15794.447194348142;17422.598994311804;11895.702607434538;12078.765428395775;12272.202306850026;12393.75212495727;12478.253044573949;12745.362731863555;13565.321733913068;13663.590092297247;13672.384742686405;13815.378307976367 09:19:04 INFO - PID 6878 | __end_tp_report 09:19:04 INFO - PID 6878 | __start_cc_report 09:19:04 INFO - PID 6878 | _x_x_mozilla_cycle_collect,327 09:19:04 INFO - PID 6878 | __end_cc_report 09:19:04 INFO - PID 6878 | __startTimestamp1494346744931__endTimestamp 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | ------- Summary: start ------- 09:19:04 INFO - PID 6878 | Number of tests: 6 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#0] dojo.html Cycles:165 Average:6059.34 Median:6322.94 stddev:743.27 (11.8%) stddev-sans-first:716.68 09:19:04 INFO - PID 6878 | Values: 3444.6 3449.7 3462.7 3473.0 3479.0 5924.6 5975.4 6013.1 6024.9 6053.5 5961.5 6022.9 6085.0 6114.8 6140.7 5258.9 5344.5 5372.0 5375.9 5410.9 5405.1 5467.4 5475.3 5478.1 5483.6 5310.0 5355.9 5371.9 5392.7 5434.0 5369.8 5379.1 5399.6 5404.8 5444.3 5288.9 5336.4 5351.5 5382.2 5384.0 5907.8 5973.4 5979.8 5988.7 6065.1 6538.3 6562.9 6595.4 6595.6 6624.8 6598.9 6641.8 6652.1 6654.1 6665.3 5981.9 6087.3 6126.4 6136.3 6151.0 6628.3 6633.8 6671.4 6716.4 6750.3 6258.9 6328.7 6360.8 6394.5 6489.8 6493.8 6590.3 6604.1 6617.0 6631.0 6385.0 6526.0 6587.3 6588.1 6609.8 6447.4 6493.4 6550.9 6566.5 6611.3 4957.2 4963.7 4964.3 4966.7 5014.5 4384.9 4391.0 4393.7 4393.8 4425.8 6134.8 6152.0 6212.9 6298.1 6312.7 6640.0 6649.9 6651.0 6655.7 6672.7 6286.7 6306.7 6318.9 6341.2 6364.7 5564.8 5621.1 5624.9 5636.0 5728.1 6757.8 6813.6 6864.4 6870.8 6879.2 6616.5 6656.4 6668.7 6671.2 6674.8 6823.1 6896.4 6918.7 6925.0 6942.6 6351.5 6394.4 6411.5 6446.9 6472.8 6625.7 6625.9 6642.4 6658.3 6659.6 6258.9 6280.4 6322.9 6352.4 6361.8 6405.0 6433.3 6449.0 6450.3 6451.7 6172.6 6325.4 6357.3 6443.8 6444.1 6346.3 6418.3 6444.7 6449.1 6493.3 6269.6 6281.1 6301.1 6303.7 6313.9 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#1] ext.html Cycles:180 Average:38127.05 Median:34334.66 stddev:55593.58 (161.9%) stddev-sans-first:55678.75 09:19:04 INFO - PID 6878 | Values: 764.3 811.9 838.4 1149.4 1155.7 34828.3 35834.6 35901.3 36001.0 36020.8 37831.8 38391.6 38417.8 38422.2 38450.4 7242.8 7349.7 7356.8 7529.5 7545.8 7404.1 7461.2 7502.1 7518.3 7531.2 7421.7 7480.3 7516.2 7543.1 7557.1 7471.4 7472.1 7503.7 7504.8 7540.3 7323.5 7371.6 7398.3 7417.6 7429.3 36675.6 37079.1 37216.5 37253.8 37389.4 3554.8 3587.4 3587.8 3595.6 3611.5 28431.3 28602.7 28707.7 28724.3 28775.0 3807.6 3850.4 3862.0 3865.9 3866.9 191501.0 191849.0 201516.0 206833.0 209175.0 46156.5 46297.3 46338.3 46464.5 46534.0 48335.5 48441.8 48520.5 54869.2 55046.7 15586.0 15762.2 15767.2 15775.3 15779.8 12326.8 12334.1 12453.6 12465.1 12512.1 14756.9 14950.3 15093.6 15163.6 15254.3 5901.4 5902.3 6046.5 6051.5 6225.7 1060.9 1110.3 1127.5 1156.5 1157.4 24637.3 25538.5 25630.4 25795.6 26047.2 1170.8 1190.1 1197.1 1197.6 1200.1 13734.6 13747.9 13765.7 13804.1 17449.2 265933.0 267750.0 267890.0 268497.0 268759.0 59045.7 59472.4 59492.7 59547.7 59582.7 1459.9 1500.2 1517.2 1525.7 1533.5 29082.7 30334.4 30757.2 30925.7 31360.8 39827.8 39956.2 40110.2 40174.0 40287.8 155966.0 158432.0 158856.0 159292.0 159827.0 33978.7 34185.7 34273.1 34287.3 34382.0 41878.0 44104.3 44122.6 44353.3 44871.8 31373.0 32564.7 32858.8 33949.2 34225.7 31699.5 32364.5 32442.0 32946.3 33885.5 36632.0 37417.6 37817.4 37972.0 38042.0 31601.5 32642.5 32732.0 33044.3 33104.0 24719.6 26491.3 26636.7 26703.7 26907.0 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#2] jquery.html Cycles:180 Average:31659.25 Median:2175.63 stddev:84604.19 (3888.7%) stddev-sans-first:84809.00 09:19:04 INFO - PID 6878 | Values: 413.1 421.9 429.7 440.8 443.4 12934.9 13298.9 13365.5 16584.0 17948.2 20852.2 21103.8 21230.9 21258.0 22028.2 5506.9 5572.9 5718.3 5759.2 5774.3 5591.1 5667.5 5669.9 5674.7 5709.9 5628.9 5634.4 5684.3 5687.5 5690.6 5523.1 5591.0 5627.1 5632.2 5642.4 5128.0 5145.7 5150.3 5179.7 5180.6 26469.5 26682.3 26707.3 27128.7 27565.6 2176.3 2206.0 2217.0 2225.7 2229.6 16332.7 16845.6 17449.5 17508.9 17516.5 2175.0 2229.6 2234.7 2258.4 2268.4 103995.0 105732.5 106051.0 108989.0 110530.4 12206.0 12559.2 12638.5 12669.6 12821.0 17096.1 17206.3 17281.9 17311.0 17319.0 9125.3 9146.0 9290.1 9359.0 9370.2 8461.0 8475.4 8519.2 8764.7 8801.6 7744.0 7906.6 8058.3 8142.5 8193.7 2153.1 2194.9 2227.9 2234.4 2402.4 1020.4 1056.3 1058.4 1059.3 1064.2 19368.4 20432.5 20449.6 20571.3 20590.4 1064.7 1064.8 1065.1 1065.3 1070.7 10976.2 11194.7 11218.9 11371.9 11397.2 500298.0 503667.0 508388.0 516489.0 523102.0 94479.0 95029.5 95871.0 96649.5 103216.0 1225.9 1238.6 1268.4 1285.1 1286.7 20281.9 20750.7 21183.4 21318.1 21413.6 45279.3 45496.3 45667.3 46040.0 46334.0 60758.7 62922.7 63982.4 65928.7 66186.0 9520.8 9772.3 9797.6 9851.4 10004.0 14647.5 15265.4 15773.9 15970.4 16005.8 12362.9 13244.5 13463.8 13832.3 14246.8 12719.9 12795.8 12871.2 13241.2 13424.8 13166.7 13404.1 13860.0 14090.4 14113.2 9759.2 9844.6 10039.7 10058.7 10081.2 13029.9 13320.0 13429.0 13692.2 13838.8 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#3] mootools.html Cycles:180 Average:7138.27 Median:3694.02 stddev:4643.15 (125.7%) stddev-sans-first:4636.23 09:19:04 INFO - PID 6878 | Values: 1411.5 1459.8 1460.8 1468.2 1480.7 10962.4 11365.9 11382.7 11490.0 11674.0 11350.8 11437.1 11535.1 11536.8 11538.4 2294.9 2309.2 2316.8 2323.8 2336.9 2252.8 2307.4 2317.6 2320.9 2326.7 2202.0 2211.3 2256.8 2264.7 2267.2 2157.8 2176.1 2205.6 2209.9 2219.5 1949.5 2023.3 2125.8 2241.7 2302.3 11391.9 11418.3 11471.7 11514.3 11532.4 6157.5 6391.8 6404.2 6417.5 6431.5 3591.8 3796.2 3899.7 3912.5 3945.8 1315.6 1323.4 1345.6 1346.9 1387.1 16887.1 16984.2 17036.8 17076.5 17151.6 5140.3 5231.6 5289.4 5489.6 5496.7 12368.6 12401.7 12404.3 12462.8 12491.2 6500.9 6510.6 6522.5 6553.4 6574.2 5970.3 5986.0 6012.3 6042.5 6158.9 4232.3 4256.0 4278.4 4323.0 4364.1 1227.4 1233.4 1245.5 1248.7 1265.1 822.4 843.1 860.8 863.6 888.1 6156.8 6221.5 6257.3 6294.8 6444.0 566.1 571.9 576.7 580.8 581.1 3856.8 3896.9 3949.3 3969.7 3971.0 14606.7 15286.1 15502.0 15514.5 15517.3 13986.0 14833.5 15352.0 15367.4 15391.5 9129.4 9344.0 9365.7 9396.6 9403.0 6827.4 6855.9 6857.8 6934.2 7098.7 13331.0 13433.2 13518.7 13685.9 13757.9 13691.4 13762.2 13798.1 14048.1 14070.6 9179.9 9369.4 9434.3 9528.5 9529.2 10863.9 10979.9 11012.2 11029.8 11035.9 9088.1 9113.0 9124.0 9180.7 9330.7 9138.8 9175.8 9186.7 9306.6 9352.3 8455.9 8568.2 8571.5 8593.0 8609.9 6304.5 6327.7 6344.1 6351.1 6526.6 6166.8 6236.8 6317.6 6342.4 6484.7 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#4] prototype.html Cycles:180 Average:5486.57 Median:6353.36 stddev:1709.73 (26.9%) stddev-sans-first:1671.26 09:19:04 INFO - PID 6878 | Values: 394.5 396.2 406.0 407.4 410.6 6157.8 6200.4 6235.6 6240.6 6349.8 6083.6 6183.4 6189.0 6189.0 6191.6 4482.5 4588.7 4601.0 4608.8 4614.3 4594.7 4602.7 4604.8 4605.3 4605.8 4573.3 4578.8 4580.3 4580.5 4608.3 4493.0 4538.8 4550.7 4583.9 4595.5 3928.5 3931.0 3947.7 3949.1 3960.6 6044.0 6052.0 6059.8 6086.7 6093.6 5228.3 5348.7 5404.9 5404.9 5412.3 6568.6 6610.2 6612.4 6615.7 6617.8 4405.6 4410.2 4445.5 4467.1 4478.5 6673.2 6832.1 6861.9 6899.2 6909.6 4487.6 4560.8 4562.9 4569.7 4569.8 4588.8 4615.8 4629.6 4631.6 4633.9 5250.3 5377.0 5391.7 5391.8 5397.1 6513.3 6551.4 6567.2 6577.5 6586.9 1547.4 1561.4 1562.1 1567.4 1571.5 1019.0 1024.2 1038.2 1052.3 1054.6 6324.3 6361.2 6372.9 6392.0 6395.5 6517.3 6678.4 6770.4 6837.6 6837.6 6356.9 6365.2 6370.5 6383.3 6408.4 3476.7 3568.9 3608.5 3609.6 3618.7 7128.5 7141.3 7161.2 7168.2 7227.9 6719.3 6949.0 6965.4 6993.4 7028.0 7109.9 7132.5 7150.1 7190.9 7230.6 6553.8 6815.9 6827.4 6850.6 6867.2 6622.9 6762.2 6766.6 6773.8 6796.4 7147.6 7149.2 7162.7 7179.3 7208.2 4564.7 4574.5 4583.7 4584.4 4596.5 6695.7 6816.8 6841.9 6882.8 6918.6 6704.5 6704.7 6714.9 6725.9 6741.2 6399.9 6595.8 6638.3 6657.0 6697.4 6570.7 6587.6 6600.9 6601.1 6602.4 6549.7 6643.6 6679.5 6690.3 6717.1 6436.5 6438.7 6457.0 6488.1 6507.2 09:19:04 INFO - PID 6878 | 09:19:04 INFO - PID 6878 | [#5] yui.html Cycles:180 Average:19366.08 Median:18735.80 stddev:23865.73 (127.4%) stddev-sans-first:23892.17 09:19:04 INFO - PID 6878 | Values: 847.9 856.1 863.0 865.5 893.5 16478.6 16557.3 16917.7 17073.3 18550.5 15353.2 15575.5 18020.9 18031.5 18357.6 983.1 991.7 1011.7 1013.2 1014.5 966.0 1000.1 1006.4 1014.3 1014.4 1051.5 1059.0 1062.4 1063.1 1063.2 1048.9 1053.9 1054.2 1057.3 1060.0 783.8 785.0 787.6 789.9 790.3 16884.3 17150.2 17290.1 17313.4 17656.3 16906.3 17381.3 17654.2 17945.3 18318.2 13634.5 13844.3 14056.9 14130.6 14213.9 3431.6 3445.3 3449.7 3455.2 3458.0 93069.5 93143.0 93439.0 93871.5 94070.5 14153.1 14294.9 14425.0 14513.1 14628.9 23351.2 23415.2 23597.8 23789.0 24039.4 7786.5 7849.2 7867.3 7899.6 7899.9 4141.5 4173.3 4183.9 4187.9 4256.3 4459.3 4527.2 4558.3 4560.5 4566.4 896.4 925.6 934.4 936.0 938.2 721.1 726.5 747.1 749.7 768.9 11844.8 12420.8 12808.2 12924.7 12951.0 730.6 735.6 740.9 752.8 762.9 5568.8 5909.9 5916.8 5942.2 6026.6 79701.6 80628.0 80628.6 81292.0 81733.6 71368.6 71501.0 71844.3 75023.2 76286.2 66041.7 67417.7 67719.0 67782.3 68065.0 11216.0 11698.0 11819.8 11856.9 11894.2 33119.8 33841.0 34010.3 34033.5 37420.8 51519.7 53590.7 55974.7 56441.4 58217.0 17178.3 17291.0 17305.7 17335.7 17430.8 18440.3 18544.6 18710.7 18712.2 18759.4 16341.5 17481.3 17735.6 17952.9 18165.1 17660.7 17671.4 17960.3 18014.6 18610.8 15445.9 15525.5 15649.6 15794.4 17422.6 11895.7 12078.8 12272.2 12393.8 12478.3 12745.4 13565.3 13663.6 13672.4 13815.4 09:19:04 INFO - PID 6878 | -------- Summary: end -------- 09:19:04 INFO - PID 6878 | 09:19:05 INFO - TEST-INFO | 6878: exit 0 09:19:05 INFO - TEST-OK | dromaeo_css | took 1113284ms 09:19:05 INFO - TEST-START | kraken 09:19:05 INFO - operating with platform_type : linux_ 09:19:05 INFO - Initialising browser for kraken test... 09:19:05 INFO - TEST-INFO | started process 7302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV7CGg/profile http://localhost:46141/getInfo.html) 09:19:09 INFO - PID 7302 | __metrics Screen width/height:1600/1200 09:19:09 INFO - PID 7302 | colorDepth:24 09:19:09 INFO - PID 7302 | Browser inner width/height: 1024/695 09:19:09 INFO - PID 7302 | __metrics 09:19:11 INFO - TEST-INFO | 7302: exit 0 09:19:11 INFO - Browser initialized. 09:19:11 INFO - Running cycle 1/1 for kraken test... 09:19:11 INFO - TEST-INFO | started process 7474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV7CGg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:22 INFO - PID 7474 | RSS: Main: 151375872 09:19:22 INFO - PID 7474 | 09:19:25 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46141/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:26 INFO - PID 7474 | RSS: Main: 157458432 09:19:26 INFO - PID 7474 | 09:19:28 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46141/tests/kraken/driver.html?testName=audio-dft) 09:19:29 INFO - PID 7474 | RSS: Main: 156401664 09:19:29 INFO - PID 7474 | 09:19:32 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46141/tests/kraken/driver.html?testName=audio-fft) 09:19:32 INFO - PID 7474 | RSS: Main: 152248320 09:19:32 INFO - PID 7474 | 09:19:34 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46141/tests/kraken/driver.html?testName=audio-oscillator) 09:19:35 INFO - PID 7474 | RSS: Main: 153513984 09:19:35 INFO - PID 7474 | 09:19:37 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:38 INFO - PID 7474 | RSS: Main: 153874432 09:19:38 INFO - PID 7474 | 09:19:41 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46141/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:41 INFO - PID 7474 | RSS: Main: 158408704 09:19:41 INFO - PID 7474 | 09:19:45 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46141/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:45 INFO - PID 7474 | RSS: Main: 161619968 09:19:45 INFO - PID 7474 | 09:19:48 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46141/tests/kraken/driver.html?testName=json-parse-financial) 09:19:49 INFO - PID 7474 | RSS: Main: 160616448 09:19:49 INFO - PID 7474 | 09:19:50 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:51 INFO - PID 7474 | RSS: Main: 160174080 09:19:51 INFO - PID 7474 | 09:19:53 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:53 INFO - PID 7474 | RSS: Main: 160382976 09:19:53 INFO - PID 7474 | 09:19:55 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:56 INFO - PID 7474 | RSS: Main: 160792576 09:19:56 INFO - PID 7474 | 09:19:58 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:59 INFO - PID 7474 | RSS: Main: 160329728 09:19:59 INFO - PID 7474 | 09:20:02 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:03 INFO - PID 7474 | RSS: Main: 160862208 09:20:03 INFO - PID 7474 | 09:20:04 INFO - PID 7474 | Cycle 1(1): loaded http://localhost:46141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46141/tests/kraken/driver.html?testName=ai-astar) 09:20:05 INFO - PID 7474 | RSS: Main: 162873344 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | __start_tp_report 09:20:05 INFO - PID 7474 | _x_x_mozilla_page_load 09:20:05 INFO - PID 7474 | _x_x_mozilla_page_load_details 09:20:05 INFO - PID 7474 | |i|pagename|runs| 09:20:05 INFO - PID 7474 | |0;ai-astar;102;111;112;110;110;112;111;111;111;111 09:20:05 INFO - PID 7474 | |1;audio-beat-detection;147;118;121;175;117;118;119;122;147;130 09:20:05 INFO - PID 7474 | |2;audio-dft;165;164;165;166;165;165;166;168;166;167 09:20:05 INFO - PID 7474 | |3;audio-fft;74;76;77;95;73;75;76;74;92;76 09:20:05 INFO - PID 7474 | |4;audio-oscillator;81;83;102;82;83;82;93;81;82;104 09:20:05 INFO - PID 7474 | |5;imaging-gaussian-blur;113;114;115;114;114;114;114;115;114;114 09:20:05 INFO - PID 7474 | |6;imaging-darkroom;149;148;148;148;148;150;150;149;149;147 09:20:05 INFO - PID 7474 | |7;imaging-desaturate;94;94;95;95;96;94;94;95;94;94 09:20:05 INFO - PID 7474 | |8;json-parse-financial;46;47;46;46;47;52;48;47;47;50 09:20:05 INFO - PID 7474 | |9;json-stringify-tinderbox;56;55;57;55;56;56;56;55;57;55 09:20:05 INFO - PID 7474 | |10;stanford-crypto-aes;79;79;77;79;86;78;79;80;78;81 09:20:05 INFO - PID 7474 | |11;stanford-crypto-ccm;126;133;138;128;122;124;133;138;169;124 09:20:05 INFO - PID 7474 | |12;stanford-crypto-pbkdf2;174;183;186;181;181;182;180;192;183;196 09:20:05 INFO - PID 7474 | |13;stanford-crypto-sha256-iterative;66;73;73;68;67;67;68;66;65;65 09:20:05 INFO - PID 7474 | __end_tp_report 09:20:05 INFO - PID 7474 | __start_cc_report 09:20:05 INFO - PID 7474 | _x_x_mozilla_cycle_collect,772 09:20:05 INFO - PID 7474 | __end_cc_report 09:20:05 INFO - PID 7474 | __startTimestamp1494346805239__endTimestamp 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | ------- Summary: start ------- 09:20:05 INFO - PID 7474 | Number of tests: 14 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 09:20:05 INFO - PID 7474 | Values: 102.0 111.0 112.0 110.0 110.0 112.0 111.0 111.0 111.0 111.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:126.00 stddev:19.17 (15.2%) stddev-sans-first:19.48 09:20:05 INFO - PID 7474 | Values: 147.0 118.0 121.0 175.0 117.0 118.0 119.0 122.0 147.0 130.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 09:20:05 INFO - PID 7474 | Values: 165.0 164.0 165.0 166.0 165.0 165.0 166.0 168.0 166.0 167.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#3] audio-fft Cycles:10 Average:78.80 Median:76.00 stddev:7.87 (10.4%) stddev-sans-first:8.15 09:20:05 INFO - PID 7474 | Values: 74.0 76.0 77.0 95.0 73.0 75.0 76.0 74.0 92.0 76.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.00 stddev:8.99 (11.0%) stddev-sans-first:9.25 09:20:05 INFO - PID 7474 | Values: 81.0 83.0 102.0 82.0 83.0 82.0 93.0 81.0 82.0 104.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 09:20:05 INFO - PID 7474 | Values: 113.0 114.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:20:05 INFO - PID 7474 | Values: 149.0 148.0 148.0 148.0 148.0 150.0 150.0 149.0 149.0 147.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:20:05 INFO - PID 7474 | Values: 94.0 94.0 95.0 95.0 96.0 94.0 94.0 95.0 94.0 94.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:47.00 stddev:1.96 (4.2%) stddev-sans-first:1.99 09:20:05 INFO - PID 7474 | Values: 46.0 47.0 46.0 46.0 47.0 52.0 48.0 47.0 47.0 50.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 09:20:05 INFO - PID 7474 | Values: 56.0 55.0 57.0 55.0 56.0 56.0 56.0 55.0 57.0 55.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.50 (3.2%) stddev-sans-first:2.65 09:20:05 INFO - PID 7474 | Values: 79.0 79.0 77.0 79.0 86.0 78.0 79.0 80.0 78.0 81.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:133.00 stddev:13.75 (10.3%) stddev-sans-first:14.31 09:20:05 INFO - PID 7474 | Values: 126.0 133.0 138.0 128.0 122.0 124.0 133.0 138.0 169.0 124.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:183.00 stddev:6.25 (3.4%) stddev-sans-first:5.53 09:20:05 INFO - PID 7474 | Values: 174.0 183.0 186.0 181.0 181.0 182.0 180.0 192.0 183.0 196.0 09:20:05 INFO - PID 7474 | 09:20:05 INFO - PID 7474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.94 (4.4%) stddev-sans-first:3.04 09:20:05 INFO - PID 7474 | Values: 66.0 73.0 73.0 68.0 67.0 67.0 68.0 66.0 65.0 65.0 09:20:05 INFO - PID 7474 | -------- Summary: end -------- 09:20:05 INFO - PID 7474 | 09:20:06 INFO - TEST-INFO | 7474: exit 0 09:20:06 INFO - TEST-OK | kraken | took 60621ms 09:20:06 INFO - SUITE-END | took 1173s 09:20:06 INFO - Completed test suite (00:19:34) 09:20:06 INFO - javascript benchmark 09:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7841.973719820699, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.552208212932, 3449.689527942486, 3462.740294477914, 3472.9826350868243, 3479.025872755626, 5924.614900031495, 5975.4323339282755, 6013.128096426021, 6024.945634513959, 6053.515718742501, 5961.523078153748, 6022.909656355158, 6085.0, 6114.755409783604, 6140.723667434965, 5258.921116183241, 5344.4922732340365, 5371.973140134294, 5375.946240537583, 5410.864728381783, 5405.081136206854, 5467.371252305976, 5475.288212532365, 5478.123500239963, 5483.643563168402, 5310.0441920454305, 5355.892882142335, 5371.946280537223, 5392.676439413628, 5434.0, 5369.838904832861, 5379.058664733656, 5399.595030372699, 5404.7838086476495, 5444.3194600674915, 5288.947110528884, 5336.43967383423, 5351.491608297206, 5382.2464854920345, 5383.977044361559, 5907.763689452417, 5973.432523910222, 5979.820605381802, 5988.670623115727, 6065.059915713072, 6538.346165383471, 6562.901556476657, 6595.439387652055, 6595.6372399518, 6624.774416732872, 6598.901016484757, 6641.800745977628, 6652.101966234545, 6654.13496245485, 6665.333466653345, 5981.850453738692, 6087.299960504599, 6126.387361263838, 6136.325004249529, 6151.0, 6628.337166283333, 6633.800985970429, 6671.366220209073, 6716.361945615159, 6750.257471678112, 6258.874822503615, 6328.746850125944, 6360.840978975562, 6394.520410969196, 6489.805305840832, 6493.837654058591, 6590.3080176581725, 6604.1084453599115, 6617.0, 6631.038499417557, 6384.978403455518, 6525.967370163214, 6587.341265873471, 6588.077669126326, 6609.834754131185, 6447.4197322241225, 6493.448056915121, 6550.868982620416, 6566.474682025427, 6611.338866113447, 4957.231629097496, 4963.677360971526, 4964.329815474937, 4966.701997880139, 5014.52362025607, 4384.934225986613, 4391.033972526039, 4393.7363758174615, 4393.84621538251, 4425.75658338788, 6134.803982731532, 6152.0, 6212.9068063979075, 6298.149749783812, 6312.684365781693, 6639.966800166065, 6649.933500665028, 6651.0, 6655.73377064912, 6672.699728512229, 6286.685665716695, 6306.716197771111, 6318.873622527615, 6341.175647165931, 6364.745410183634, 5564.805231816867, 5621.128725047624, 5624.859378515488, 5636.04187288162, 5728.083506639001, 6757.831054223586, 6813.625250611264, 6864.4165245954655, 6870.828229294308, 6879.208890977602, 6616.536842420985, 6656.36764507371, 6668.6665666717445, 6671.166104236971, 6674.799756007327, 6823.147106611674, 6896.379325860496, 6918.7232510699005, 6925.0, 6942.583444993114, 6351.523635727432, 6394.424501794861, 6411.487081033413, 6446.9355306448215, 6472.805815825533, 6625.734970601315, 6625.867482650224, 6642.402183803288, 6658.267590564937, 6659.600423974383, 6258.906116408349, 6280.434760871543, 6322.936770632419, 6352.396522330371, 6361.809145725636, 6404.967975160094, 6433.324500927335, 6448.967755161382, 6450.290468048417, 6451.6774161290805, 6172.598781079395, 6325.367463253638, 6357.300696923242, 6443.7744678936015, 6444.097826304227, 6346.333634968262, 6418.261899881387, 6444.742210311535, 6449.064885591469, 6493.285738568659, 6269.592476489013, 6281.120643109877, 6301.117843501822, 6303.684815759102, 6313.90529142054], "value": 6005.508736691859, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.3006648916238, 811.8863359129722, 838.350278534136, 1149.4425203776168, 1155.7457359380933, 34828.30343393134, 35834.64165358346, 35901.2819743605, 36001.0, 36020.81989590052, 37831.810840945756, 38391.616083839224, 38417.80791096041, 38422.231555368875, 38450.4232436513, 7242.782716518513, 7349.669264883067, 7356.779296621083, 7529.510581812192, 7545.811354716121, 7404.074490688664, 7461.216572259916, 7502.137254215753, 7518.323350898418, 7531.209223031585, 7421.703131874719, 7480.289372509603, 7516.210797866227, 7543.094828620573, 7557.0931488221495, 7471.364933980618, 7472.140703819049, 7503.662335194929, 7504.812379690524, 7540.283673051079, 7323.523970941872, 7371.63141842911, 7398.297161769623, 7417.592032438214, 7429.294217049372, 36675.633243667486, 37079.073023174366, 37216.511339546385, 37253.81373093144, 37389.43915841264, 3554.8222588870453, 3587.3722098632634, 3587.7667951583326, 3595.6224596417524, 3611.4763359313015, 28431.289217769514, 28602.71397286042, 28707.712922870713, 28724.281892952633, 28775.0, 3807.60020197878, 3850.403187505941, 3862.0344913771555, 3865.942010869839, 3866.8839934802, 191501.0, 191849.0, 201516.0, 206833.0, 209175.0, 46156.5384346159, 46297.30554041692, 46338.30492542614, 46464.535354646694, 46534.0, 48335.516644833806, 48441.75779121082, 48520.51479485231, 54869.1769623456, 55046.72476637591, 15586.0, 15762.211889405484, 15767.211639417983, 15775.29011194499, 15779.763303550455, 12326.75346493083, 12334.074944379208, 12453.564125255572, 12465.065120116027, 12512.061595380383, 14756.852431475763, 14950.252487375588, 15093.622659433382, 15163.620909477131, 15254.313555890012, 5901.439363260569, 5902.2622172228475, 6046.486048685823, 6051.515878729691, 6225.719842607094, 1060.8567843341204, 1110.2783190925963, 1127.4700890581414, 1156.5084838943583, 1157.4097210422576, 24637.260882173563, 25538.48923021529, 25630.359241019123, 25795.613065804027, 26047.218583442525, 1170.836082948388, 1190.1371505658328, 1197.0782497476894, 1197.5569039455283, 1200.0759415250384, 13734.604926423448, 13747.862521374858, 13765.655858603615, 13804.102733322503, 17449.21478533469, 265933.0, 267750.0, 267890.0, 268497.0, 268759.0, 59045.70477147587, 59472.40527594755, 59492.70253648704, 59547.702261489285, 59582.70208648929, 1459.8905082118883, 1500.1674070890542, 1517.1807224098864, 1525.6643538421752, 1533.463287849244, 29082.709172908, 30334.393312133194, 30757.23106922345, 30925.69074309228, 31360.843195783877, 39827.80086099667, 39956.2008759829, 40110.1977960445, 40174.0, 40287.79856100701, 155966.0, 158432.0, 158856.0, 159292.0, 159827.0, 33978.660213398536, 34185.65814341924, 34273.14317142092, 34287.314253714285, 34382.0, 41878.0, 44104.33843492286, 44122.558774413126, 44353.33469998017, 44871.77564112289, 31373.0, 32564.674353257113, 32858.835705821315, 33949.15127121842, 34225.65774342225, 31699.52450713287, 32364.514532281562, 32442.0, 32946.34107317792, 33885.49171762475, 36632.0, 37417.625823741415, 37817.432738509495, 37972.0, 38042.0, 31601.52597711082, 32642.51036234506, 32732.0, 33044.339113218084, 33104.0, 24719.62920556229, 26491.33771655647, 26636.733632663425, 26703.724624713566, 26907.0], "value": 17383.01527994991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1468517511337, 421.86996987329485, 429.74859707071374, 440.80163926233195, 443.39476614421324, 12934.935325323371, 13298.867011329883, 13365.532206372767, 16584.0, 17948.19233134509, 20852.165913363486, 21103.788962110375, 21230.89384553075, 21258.0, 22028.229011984582, 5506.862328441801, 5572.888542229163, 5718.285214348207, 5759.16492108644, 5774.307083150028, 5591.133374326986, 5667.518260947824, 5669.886602267952, 5674.659520428788, 5709.8572535686735, 5628.887422251552, 5634.436556344353, 5684.289463817023, 5687.459691329317, 5690.63010904292, 5523.061079616475, 5591.049521581341, 5627.099664053752, 5632.211490391349, 5642.4357564243655, 5128.0, 5145.742712864342, 5150.27896094547, 5179.715115668637, 5180.611454140954, 26469.47061058768, 26682.33294167642, 26707.332316692045, 27128.72871271282, 27565.586516202275, 2176.260071575656, 2206.0403724379944, 2217.0355895185485, 2225.688403623494, 2229.598672238996, 16332.673346533003, 16845.57886052846, 17449.476515704548, 17508.912455437643, 17516.47450576472, 2175.0, 2229.6209644360497, 2234.7430045544806, 2258.3563684349883, 2268.410213344526, 103995.0, 105732.47133764283, 106051.0, 108989.0, 110530.44734776355, 12206.0, 12559.183653062522, 12638.494460221487, 12669.619911402673, 12821.0, 17096.06790438206, 17206.31174753021, 17281.913590432217, 17311.0, 17319.047452389987, 9125.269978401711, 9145.954270228607, 9290.070992900792, 9358.953205233931, 9370.203532699661, 8460.957695211484, 8475.406721529434, 8519.233269005696, 8764.693235736719, 8801.603927823264, 7744.0, 7906.604669766489, 8058.267472493442, 8142.511449312941, 8193.71322003727, 2153.1172219389973, 2194.901229444647, 2227.9443013924456, 2234.3855439754198, 2402.3513651314047, 1020.4132623741378, 1056.3186744549876, 1058.4178701714027, 1059.279689810936, 1064.2443864856039, 19368.418947431317, 20432.489187770425, 20449.591008179752, 20571.32572765531, 20590.382288531368, 1064.7178497698117, 1064.797688439194, 1065.0680654427376, 1065.2862582070031, 1070.6948519671855, 10976.176786741027, 11194.720131996764, 11218.887811121784, 11371.943140284246, 11397.202195846212, 500298.0, 503667.0, 508388.0, 516489.0, 523102.0, 94479.0, 95029.5248523753, 95871.0, 96649.51675241579, 103216.0, 1225.877412258767, 1238.6098379010582, 1268.4482250221, 1285.0940087238475, 1286.7362190751062, 20281.898590506953, 20750.68873966922, 21183.364499065054, 21318.147274108862, 21413.571728565654, 45279.320810187215, 45496.31755523736, 45667.31499027584, 46040.0, 46334.0, 60758.69620651868, 62922.685386572775, 63982.3601763995, 65928.67035664791, 66186.0, 9520.809583808146, 9772.31593788428, 9797.628332033664, 9851.359661621971, 10004.049615286536, 14647.487337943121, 15265.389384424943, 15773.921130394274, 15970.361185552449, 16005.759913601538, 12362.876371236172, 13244.47022119143, 13463.798043029166, 13832.308384580932, 14246.786298205743, 12719.93640031794, 12795.80806287925, 12871.163374380636, 13241.205527668371, 13424.798628020782, 13166.73666526645, 13404.128731632412, 13860.0, 14090.436382544583, 14113.153210807384, 9759.219262458844, 9844.60621575129, 10039.749006274902, 10058.698239052841, 10081.243906706879, 13029.869701302865, 13320.0, 13429.0, 13692.178469291874, 13838.792418113535], "value": 10268.507975590925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.5341937160736, 1459.7956286119938, 1460.8466111058344, 1468.1704836767226, 1480.7112613040454, 10962.397068161257, 11365.886341136586, 11382.658520244386, 11489.999999999989, 11674.0, 11350.772984540305, 11437.085033197345, 11535.134864885125, 11536.826947595793, 11538.423078846066, 2294.9311520654364, 2309.226409152936, 2316.8030717388956, 2323.848949818265, 2336.9298921032396, 2252.763459836718, 2307.4231442139467, 2317.640765681322, 2320.8839558022114, 2326.697529321186, 2201.9889900550475, 2211.281333566589, 2256.7968882800546, 2264.6603009548617, 2267.206477732797, 2157.7518585362727, 2176.1186719378675, 2205.6029914615365, 2209.8674079555276, 2219.511707424364, 1949.4638974282045, 2023.312073894868, 2125.829933605308, 2241.730992280937, 2302.320815359473, 11391.943040284745, 11418.31490110596, 11471.713207169887, 11514.30914145154, 11532.365719885403, 6157.538184636171, 6391.808245752635, 6404.1674582304, 6417.486601071903, 6431.517636177258, 3591.838367273453, 3796.2027974125467, 3899.7270191086636, 3912.5109361329833, 3945.822437990297, 1315.6381994951369, 1323.4309247023775, 1345.5559665310425, 1346.9124506907117, 1387.084524214014, 16887.071211083385, 16984.15079246033, 17036.82963170377, 17076.487705368858, 17151.571210719707, 5140.306058682105, 5231.633785635046, 5289.3917199521775, 5489.560835133179, 5496.697681627469, 12368.628941131601, 12401.689957751129, 12404.25574465535, 12462.81305780414, 12491.188072775241, 6500.902486462707, 6510.641914694643, 6522.543421960418, 6553.377429144223, 6574.211094668671, 5970.3432622412365, 5985.970070149709, 6012.278526576839, 6042.546808989343, 6158.876822463526, 4232.333629813198, 4256.0, 4278.4010238566625, 4323.0, 4364.148990946798, 1227.441514111095, 1233.402743447238, 1245.5329251530677, 1248.7065539598186, 1265.1333836321965, 822.383212590557, 843.1105184030906, 860.8321377331486, 863.5552690364467, 888.1030159538913, 6156.78451254204, 6221.471174950089, 6257.342978987141, 6294.8111556653375, 6443.967780161163, 566.1422944239481, 571.8541771848236, 576.7347020370677, 580.8199458167896, 581.0702875399412, 3856.82644281008, 3896.883093507199, 3949.3483575210344, 3969.7221194516683, 3970.980145099256, 14606.707865842624, 15286.082835029934, 15502.0, 15514.45699400538, 15517.301721422564, 13986.0, 14833.480828170963, 15352.0, 15367.385304587915, 15391.538253852403, 9129.360944733939, 9343.953280233556, 9365.672201473051, 9396.577154028086, 9402.952985235166, 6827.351401616838, 6855.897161542481, 6857.759978400732, 6934.237233904368, 7098.716051358095, 13331.0, 13433.19400835953, 13518.662033449242, 13685.931570342085, 13757.862421375658, 13691.383887724876, 13762.174269543859, 13798.103123296954, 14048.103506026555, 14070.577882663536, 9179.862302065609, 9369.437833729999, 9434.292428067785, 9528.523573821143, 9529.190018848476, 10863.891361086287, 10979.890201097887, 11012.17408694335, 11029.83455248188, 11035.944820275847, 9088.136627020422, 9112.95443522778, 9123.954380228057, 9180.668803023658, 9330.673426430043, 9138.817223655622, 9175.770605734642, 9186.724398268063, 9306.627734890799, 9352.251819854258, 8455.858459107942, 8568.186022327869, 8571.485710857369, 8593.0, 8609.913900861162, 6304.495640348853, 6327.746890124344, 6344.080108384166, 6351.1425957496995, 6526.608403495806, 6166.784162554289, 6236.781712640036, 6317.5893566918, 6342.429181373698, 6484.740610375532], "value": 5269.407452250882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.49898628741494, 396.1561873210062, 405.987820365389, 407.43163287214315, 410.58735970349795, 6157.846053848656, 6200.379962003797, 6235.625862448251, 6240.563160578761, 6349.809505714836, 6083.604565703226, 6183.412575805302, 6188.969055154729, 6188.969055154729, 6191.566590338678, 4482.484514280851, 4588.715159755274, 4601.0, 4608.769561521927, 4614.261718125101, 4594.74728889911, 4602.7238365697995, 4604.769761511928, 4605.309203619468, 4605.815767369301, 4573.3368661544055, 4578.839740609079, 4580.312953057035, 4580.473245576752, 4608.262677971526, 4493.0, 4538.842595138235, 4550.749708766017, 4583.885402864922, 4595.494495605498, 3928.4500169976227, 3930.980345098285, 3947.6841852652005, 3949.0917089069676, 3960.584138665456, 6044.032954727222, 6052.0, 6059.848503787396, 6086.726097325631, 6093.603915745507, 5228.320318358589, 5348.732563371816, 5404.945950540484, 5404.945950540523, 5412.269343638637, 6568.6058836469965, 6610.20677518696, 6612.371824676648, 6615.669216539154, 6617.7683781067435, 4405.647548196137, 4410.162069206873, 4445.51099379068, 4467.128909862578, 4478.507364189936, 6673.165854268216, 6832.145981752281, 6861.907118328908, 6899.171719494338, 6909.585424874474, 4487.618552423015, 4560.817567297271, 4562.8631141065825, 4569.725816451024, 4569.817207311737, 4588.77056147198, 4615.79228934692, 4629.606483448877, 4631.606313463393, 4633.907321853544, 5250.291210686585, 5377.0, 5391.73041347931, 5391.838244852661, 5397.136458166675, 6513.348665133543, 6551.377619126175, 6567.211934567787, 6577.506686998494, 6586.934130658728, 1547.3810475809767, 1561.4144695739099, 1562.1017914699094, 1567.388718399825, 1571.4814111343458, 1018.9847152292722, 1024.1755386913458, 1038.190211634926, 1052.2949623752104, 1054.5781687325132, 6324.3043265240785, 6361.236651601837, 6372.896944008466, 6392.041193820871, 6395.456386207225, 6517.250516190698, 6678.432333251631, 6770.424513916274, 6837.589744615339, 6837.62393068386, 6356.904646430307, 6365.2361716594305, 6370.490360771128, 6383.2978372379, 6408.359164083555, 3476.66971637694, 3568.892933212008, 3608.530890984208, 3609.5668519777796, 3618.746687731886, 7128.465365097639, 7141.250168732208, 7161.176464706521, 7168.211496735355, 7227.855442891113, 6719.294474080151, 6949.0, 6965.373116419547, 6993.370596646225, 7027.964860175666, 7109.8933515997305, 7132.465065120136, 7150.065445680073, 7190.892136617955, 7230.613897413841, 6553.770618028346, 6815.863682726219, 6827.419669327964, 6850.581375013188, 6867.158653149618, 6622.90065649006, 6762.188537375547, 6766.627835468899, 6773.796786096425, 6796.388325050571, 7147.571145731273, 7149.213586505584, 7162.677679504539, 7179.282071792779, 7208.207097219407, 4564.748938808398, 4574.5425457453985, 4583.656225783013, 4584.381108550437, 4596.494385617646, 6695.655212696493, 6816.761413350708, 6841.8973715395305, 6882.7591034313555, 6918.584884906922, 6704.530682852153, 6704.664766761545, 6714.865702685821, 6725.932740672531, 6741.22475915276, 6399.904001440075, 6595.835104122435, 6638.336166383323, 6656.966715166393, 6697.397234248941, 6570.704318305783, 6587.571807832475, 6600.867982640224, 6601.141851559267, 6602.438792702482, 6549.672516374258, 6643.60138391698, 6679.532432729857, 6690.264070952094, 6717.1267735194115, 6436.452901503425, 6438.67806609677, 6457.031445283057, 6488.124103246001, 6507.154069970874], "value": 4940.375724014747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.8643417053273, 856.0754385263915, 862.9644426687972, 865.5499140446967, 893.517500549703, 16478.588035299123, 16557.33770649174, 16917.661646767072, 17073.317067317308, 18550.536236594056, 15353.15557644329, 15575.53273401797, 18020.90989545054, 18031.4590562283, 18357.632847343044, 983.0562659846538, 991.6727479931606, 1011.7268337548858, 1013.1995723378523, 1014.4521958142594, 965.9806803863919, 1000.1398797034544, 1006.3509036671343, 1014.3305418423842, 1014.3761586624247, 1051.5425789781432, 1058.978820423591, 1062.3731998121107, 1063.080435423361, 1063.2450959818539, 1048.8636477257946, 1053.899879511445, 1054.219877290807, 1057.2704833664748, 1059.9682009539727, 783.7844592736986, 784.9725259615943, 787.6416230615114, 789.8617741895202, 790.2532107158737, 16884.324627014903, 17150.228239729244, 17290.135493225287, 17313.394031208973, 17656.293748250053, 16906.323747050104, 17381.30474781007, 17654.205560749797, 17945.282188712437, 18318.175682094337, 13634.522791702342, 13844.30778461083, 14056.85943140576, 14130.646733831634, 14213.928930355385, 3431.6225215226304, 3445.3453843769603, 3449.689527942472, 3455.153487395579, 3457.9798959306813, 93069.53465232698, 93143.0, 93439.0, 93871.53064234703, 94070.52964735201, 14153.08004979673, 14294.928525357307, 14425.0, 14513.05665131763, 14628.926855365655, 23351.182708605116, 23415.180468683855, 23597.764022359555, 23789.0, 24039.399015024414, 7786.532808031537, 7849.175836537195, 7867.291943725092, 7899.644515996794, 7899.946014036392, 4141.4616099907425, 4173.31140361843, 4183.895402614898, 4187.937180942288, 4256.318988961813, 4459.331100334975, 4527.185106680829, 4558.33904083906, 4560.521145279764, 4566.360709500673, 896.3546246702364, 925.5881132895931, 934.4113208678489, 936.0265324062898, 938.1790932933683, 721.0950257426896, 726.4551586310267, 747.1184002876657, 749.7113611259705, 768.9077310722749, 11844.763104737856, 12420.75158496825, 12808.167469114478, 12924.676883077811, 12951.04992977151, 730.5835673666065, 735.6211551051213, 740.9296116868888, 752.766642340876, 762.904636920385, 5568.777248909998, 5909.911351329733, 5916.822495325061, 5942.168096466498, 6026.638401695912, 79701.60149199217, 80628.0, 80628.59685701651, 81292.0, 81733.59133204295, 71368.64315678389, 71501.0, 71844.28155718376, 75023.24976750271, 76286.23713762902, 66041.66979165074, 67417.66291168611, 67719.0, 67782.3221767776, 68065.0, 11216.046636035702, 11698.0, 11819.763604728028, 11856.881431185579, 11894.178627195965, 33119.83440082784, 33841.0, 34010.31979360448, 34033.48949765805, 37420.81289593643, 51519.74240128775, 53590.732046339515, 55974.72012640074, 56441.435585643616, 58217.0, 17178.31286748516, 17291.0, 17305.653886922442, 17335.653286934445, 17430.82569174292, 18440.26238950427, 18544.629107418044, 18710.71933920965, 18712.15795289188, 18759.437216883514, 16341.509754706902, 17481.300747969937, 17735.645287094445, 17952.91023544926, 18165.091745412414, 17660.73508897342, 17671.381501647895, 17960.281588736303, 18014.639707206046, 18610.813891860907, 15445.922770386076, 15525.45660901863, 15649.608759781097, 15794.447194348142, 17422.598994311804, 11895.702607434538, 12078.765428395775, 12272.202306850026, 12393.75212495727, 12478.253044573949, 12745.362731863555, 13565.321733913068, 13663.590092297247, 13672.384742686405, 13815.378307976367], "value": 8333.329091786312, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 110.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 121.0, 175.0, 117.0, 118.0, 119.0, 122.0, 147.0, 130.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 166.0, 165.0, 165.0, 166.0, 168.0, 166.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 95.0, 73.0, 75.0, 76.0, 74.0, 92.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 102.0, 82.0, 83.0, 82.0, 93.0, 81.0, 82.0, 104.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 150.0, 150.0, 149.0, 149.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 46.0, 46.0, 47.0, 52.0, 48.0, 47.0, 47.0, 50.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 55.0, 56.0, 56.0, 56.0, 55.0, 57.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 79.0, 86.0, 78.0, 79.0, 80.0, 78.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 138.0, 128.0, 122.0, 124.0, 133.0, 138.0, 169.0, 124.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 183.0, 186.0, 181.0, 181.0, 182.0, 180.0, 192.0, 183.0, 196.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 73.0, 68.0, 67.0, 67.0, 68.0, 66.0, 65.0, 65.0], "value": 67.8, "unit": "score"}]}]} 09:20:06 INFO - Return code: 0 09:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:06 INFO - # TBPL SUCCESS # 09:20:06 INFO - Running post-action listener: _resource_record_post_action 09:20:06 INFO - [mozharness: 2017-05-09 16:20:06.550757Z] Finished run-tests step (success) 09:20:06 INFO - Running post-run listener: _resource_record_post_run 09:20:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388235264; Read time: 212; Write time: 342952 09:20:06 INFO - TinderboxPrint: CPU usage
13.2% 09:20:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 212 09:20:06 INFO - TinderboxPrint: I/O write bytes / time
388,235,264 / 342,952 09:20:06 INFO - TinderboxPrint: CPU idle
8,245.2 (86.7%) 09:20:06 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 09:20:06 INFO - TinderboxPrint: Swap in / out
0 / 0 09:20:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 122761216; Read time: 0; Write time: 140008 09:20:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 265474048; Read time: 212; Write time: 202944 09:20:07 INFO - Running post-run listener: _upload_blobber_files 09:20:07 INFO - Blob upload gear active. 09:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:07 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 09:20:07 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'] 09:20:07 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 09:20:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:08 INFO - (blobuploader) - INFO - Done attempting. 09:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:09 INFO - (blobuploader) - INFO - Done attempting. 09:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:10 INFO - (blobuploader) - INFO - Done attempting. 09:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:15 INFO - (blobuploader) - INFO - Done attempting. 09:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:15 INFO - Return code: 0 09:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb09fd3c03704a0d15019ee7daeb4dcc5e509ea3aec6efd188cee42208abbc09c66f00f874f852c69588a7cc42be4a87ad9d1af9555fd1f795ea50a2e697bb4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c586c51ea9219834fe065ea916bf05a290a0b5374b5b15f7c05f30eb9e9de6e21fd8a72fbb7c985a720652c549e6d477eead507b852ee12129d738c2f5c300f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60595a02b47064e605a1e192a27c96ffaa10f3f3403078094a03a4af4e2bdda3bc1aebc3287a9271d885dd26f2e111d2495b4c803753d134ec70cf763e1a29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/248081b04e751aed44df2e84f06af96a9d73016bd1058c7b3e3c10331705fee188689869dc20cde855642145c5dab62e568206e1880eb012ec2654a5b512e444"} 09:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:15 INFO - Contents: 09:20:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb09fd3c03704a0d15019ee7daeb4dcc5e509ea3aec6efd188cee42208abbc09c66f00f874f852c69588a7cc42be4a87ad9d1af9555fd1f795ea50a2e697bb4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c586c51ea9219834fe065ea916bf05a290a0b5374b5b15f7c05f30eb9e9de6e21fd8a72fbb7c985a720652c549e6d477eead507b852ee12129d738c2f5c300f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60595a02b47064e605a1e192a27c96ffaa10f3f3403078094a03a4af4e2bdda3bc1aebc3287a9271d885dd26f2e111d2495b4c803753d134ec70cf763e1a29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/248081b04e751aed44df2e84f06af96a9d73016bd1058c7b3e3c10331705fee188689869dc20cde855642145c5dab62e568206e1880eb012ec2654a5b512e444"} 09:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:15 INFO - Copying logs to upload dir... 09:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.251533 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-09 09:20:15.152531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 09:20:15.157186) ========= 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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb09fd3c03704a0d15019ee7daeb4dcc5e509ea3aec6efd188cee42208abbc09c66f00f874f852c69588a7cc42be4a87ad9d1af9555fd1f795ea50a2e697bb4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c586c51ea9219834fe065ea916bf05a290a0b5374b5b15f7c05f30eb9e9de6e21fd8a72fbb7c985a720652c549e6d477eead507b852ee12129d738c2f5c300f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60595a02b47064e605a1e192a27c96ffaa10f3f3403078094a03a4af4e2bdda3bc1aebc3287a9271d885dd26f2e111d2495b4c803753d134ec70cf763e1a29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/248081b04e751aed44df2e84f06af96a9d73016bd1058c7b3e3c10331705fee188689869dc20cde855642145c5dab62e568206e1880eb012ec2654a5b512e444"} build_url:https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/BWkq_VcrQiSeZbA5rWsySA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb09fd3c03704a0d15019ee7daeb4dcc5e509ea3aec6efd188cee42208abbc09c66f00f874f852c69588a7cc42be4a87ad9d1af9555fd1f795ea50a2e697bb4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c586c51ea9219834fe065ea916bf05a290a0b5374b5b15f7c05f30eb9e9de6e21fd8a72fbb7c985a720652c549e6d477eead507b852ee12129d738c2f5c300f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60595a02b47064e605a1e192a27c96ffaa10f3f3403078094a03a4af4e2bdda3bc1aebc3287a9271d885dd26f2e111d2495b4c803753d134ec70cf763e1a29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/248081b04e751aed44df2e84f06af96a9d73016bd1058c7b3e3c10331705fee188689869dc20cde855642145c5dab62e568206e1880eb012ec2654a5b512e444"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 09:20:15.190556) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:20:15.191041) ========= 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=652eb03db935cfc1c15ebda0000001ad-1494345566.90883-1874884815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:20:15.274595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 09:20:15.275088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 09:20:15.275521) ========= ========= Total master_lag: 0.21 =========