builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1491047150.52 results: success (0) revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.519905) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.520360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.520642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.562562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.563018) ========= 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=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-01 04:45:51-- 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% 33.0M=0s 2017-04-01 04:45:51 (33.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.706216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.706540) ========= 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=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017922 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:50.762868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 04:45:50.763174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-01 04:45:51,273 truncating revision to first 12 chars 2017-04-01 04:45:51,273 Setting DEBUG logging. 2017-04-01 04:45:51,274 attempt 1/10 2017-04-01 04:45:51,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d6ffde320ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 04:45:52,400 unpacking tar archive at: mozilla-central-0d6ffde320ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 04:45:52.287134) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:52.287438) ========= script_repo_revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:52.287805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:52.288096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 04:45:52.297849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-01 04:45:52.298274) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:52 INFO - MultiFileLogger online at 20170401 04:45:52 in /builds/slave/test 04:45:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:45:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:52 INFO - {'append_to_log': False, 04:45:52 INFO - 'base_work_dir': '/builds/slave/test', 04:45:52 INFO - 'blob_upload_branch': 'Firefox', 04:45:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:52 INFO - 'branch': 'Firefox', 04:45:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:52 INFO - 'config_files': ('talos/linux_config.py',), 04:45:52 INFO - 'default_actions': ('clobber', 04:45:52 INFO - 'read-buildbot-config', 04:45:52 INFO - 'download-and-extract', 04:45:52 INFO - 'populate-webroot', 04:45:52 INFO - 'create-virtualenv', 04:45:52 INFO - 'install', 04:45:52 INFO - 'run-tests'), 04:45:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:52 INFO - 'download_minidump_stackwalk': True, 04:45:52 INFO - 'download_symbols': 'ondemand', 04:45:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:52 INFO - 'gecko_profile': False, 04:45:52 INFO - 'gecko_profile_interval': 0, 04:45:52 INFO - 'installer_path': 'installer.exe', 04:45:52 INFO - 'log_level': 'info', 04:45:52 INFO - 'log_name': 'talos', 04:45:52 INFO - 'log_to_console': True, 04:45:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:52 INFO - 'opt_config_files': (), 04:45:52 INFO - 'pip_index': False, 04:45:52 INFO - 'suite': 'dromaeojs', 04:45:52 INFO - 'system_bits': '32', 04:45:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:52 INFO - 'title': 'talos-linux64-ix-050', 04:45:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:52 INFO - 'use_talos_json': True, 04:45:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:52 INFO - 'work_dir': 'build'} 04:45:52 INFO - [mozharness: 2017-04-01 11:45:52.903642Z] Running clobber step. 04:45:52 INFO - Running pre-action listener: _resource_record_pre_action 04:45:52 INFO - Running main action method: clobber 04:45:52 INFO - rmtree: /builds/slave/test/build 04:45:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:53 INFO - Running post-action listener: _resource_record_post_action 04:45:53 INFO - [mozharness: 2017-04-01 11:45:53.842035Z] Finished clobber step (success) 04:45:53 INFO - [mozharness: 2017-04-01 11:45:53.842137Z] Running read-buildbot-config step. 04:45:53 INFO - Running pre-action listener: _resource_record_pre_action 04:45:53 INFO - Running main action method: read_buildbot_config 04:45:53 INFO - Using buildbot properties: 04:45:53 INFO - { 04:45:53 INFO - "project": "", 04:45:53 INFO - "product": "firefox", 04:45:53 INFO - "who": "archaeopteryx@coole-files.de", 04:45:53 INFO - "installer_path": "public/build/target.tar.bz2", 04:45:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 04:45:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:45:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 04:45:53 INFO - "stage_platform": "linux64-stylo", 04:45:53 INFO - "basedir": "/builds/slave/test", 04:45:53 INFO - "buildnumber": 5, 04:45:53 INFO - "platform": "ubuntu64_hw_stylo", 04:45:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:45:53 INFO - "slavebuilddir": "test", 04:45:53 INFO - "taskId": "UiQwo-EFRUmVDJ4IudeIjA", 04:45:53 INFO - "branch": "mozilla-central", 04:45:53 INFO - "script_repo_revision": "production", 04:45:53 INFO - "revision": "0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c", 04:45:53 INFO - "slavename": "talos-linux64-ix-050", 04:45:53 INFO - "repo_path": "mozilla-central" 04:45:53 INFO - } 04:45:53 INFO - Finding installer, test and symbols from parent task. 04:45:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiQwo-EFRUmVDJ4IudeIjA'}, attempt #1 04:45:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiQwo-EFRUmVDJ4IudeIjA'}, attempt #1 04:45:54 INFO - Task dependencies: Em6NgsQvRJCBIpZ8_STHEg 04:45:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg'}, attempt #1 04:45:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 04:45:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/test_packages.json 04:45:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.crashreporter-symbols.zip 04:45:55 INFO - Running post-action listener: _resource_record_post_action 04:45:55 INFO - [mozharness: 2017-04-01 11:45:55.222212Z] Finished read-buildbot-config step (success) 04:45:55 INFO - [mozharness: 2017-04-01 11:45:55.222430Z] Running download-and-extract step. 04:45:55 INFO - Running pre-action listener: _resource_record_pre_action 04:45:55 INFO - Running main action method: download_and_extract 04:45:55 INFO - mkdir: /builds/slave/test/build/tests 04:45: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')]} 04:45:55 INFO - trying https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.test_packages.json 04:45:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:45:55 INFO - Downloaded 986 bytes. 04:45:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:45:55 INFO - Using the following test package requirements: 04:45:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:45:55 INFO - u'common': [u'target.common.tests.zip'], 04:45:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:45:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:45:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:45:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:45:55 INFO - u'mozbase': [u'target.common.tests.zip'], 04:45:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:45:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:45:55 INFO - u'web-platform': [u'target.common.tests.zip', 04:45:55 INFO - u'target.web-platform.tests.zip'], 04:45:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:45:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:45:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip 04:45:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:45:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip into memory 04:45:56 INFO - Expected file size: 58248742 04:45:56 INFO - Obtained file size: 58248742 04:46:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip 04:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.common.tests.zip into memory 04:46:07 INFO - Expected file size: 58248742 04:46:07 INFO - Obtained file size: 58248742 04:46:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.talos.tests.zip 04:46:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:46:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.talos.tests.zip into memory 04:46:19 INFO - Expected file size: 14404152 04:46:19 INFO - Obtained file size: 14404152 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:19 INFO - trying https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 04:46:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:46:20 INFO - Downloaded 63877838 bytes. 04:46:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 04:46:20 INFO - mkdir: /builds/slave/test/properties 04:46:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:20 INFO - Contents: 04:46:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 04:46:20 INFO - Running post-action listener: _resource_record_post_action 04:46:20 INFO - Running post-action listener: set_extra_try_arguments 04:46:20 INFO - [mozharness: 2017-04-01 11:46:20.560688Z] Finished download-and-extract step (success) 04:46:20 INFO - [mozharness: 2017-04-01 11:46:20.560785Z] Running populate-webroot step. 04:46:20 INFO - Running pre-action listener: _resource_record_pre_action 04:46:20 INFO - Running main action method: populate_webroot 04:46:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:20 INFO - '--tppagecycles', 04:46:20 INFO - '7'], 04:46:20 INFO - 'tests': ['tsvgm']}}, 04:46:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['damp', 'tps']}, 04:46:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'tests': ['damp', 'tps']}, 04:46:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['dromaeo_dom']}, 04:46:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['basic_compositor_video']}, 04:46:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tsvgx', 04:46:20 INFO - 'tsvgr_opacity', 04:46:20 INFO - 'tart', 04:46:20 INFO - 'tscrollx', 04:46:20 INFO - 'cart', 04:46:20 INFO - 'tsvg_static']}, 04:46:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:20 INFO - 'tsvgr_opacity', 04:46:20 INFO - 'tart', 04:46:20 INFO - 'tscrollx', 04:46:20 INFO - 'cart', 04:46:20 INFO - 'tsvg_static']}, 04:46:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tp5o']}, 04:46:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s', 04:46:20 INFO - '--xperf_path', 04:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:20 INFO - 'tests': ['tp5n']}, 04:46:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:20 INFO - 'talos_options': ['--xperf_path', 04:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:20 INFO - 'tests': ['tp5n']}}, 04:46:20 INFO - 'talos.zip': {'path': '', 04:46:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:20 INFO - Running post-action listener: _resource_record_post_action 04:46:20 INFO - [mozharness: 2017-04-01 11:46:20.573918Z] Finished populate-webroot step (success) 04:46:20 INFO - [mozharness: 2017-04-01 11:46:20.574008Z] Running create-virtualenv step. 04:46:20 INFO - Running pre-action listener: _resource_record_pre_action 04:46:20 INFO - Running main action method: create_virtualenv 04:46:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:46:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:20 INFO - Using real prefix '/usr' 04:46:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:23 INFO - Installing pip.................done. 04:46:23 INFO - Return code: 0 04:46:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:23 INFO - Reading from file tmpfile_stdout 04:46:23 INFO - Output received: 04:46:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:46:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:46:23 INFO - Using env: {'DISPLAY': ':0', 04:46:23 INFO - 'HOME': '/home/cltbld', 04:46:23 INFO - 'LANG': 'en_US.UTF-8', 04:46:23 INFO - 'LANGUAGE': 'en_US:en', 04:46:23 INFO - 'LOGNAME': 'cltbld', 04:46:23 INFO - 'MAIL': '/var/mail/cltbld', 04:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:23 INFO - 'MOZ_NO_REMOTE': '1', 04:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:23 INFO - 'NO_EM_RESTART': '1', 04:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:23 INFO - 'PWD': '/builds/slave/test', 04:46:23 INFO - 'SHELL': '/bin/bash', 04:46:23 INFO - 'SHLVL': '1', 04:46:23 INFO - 'TERM': 'linux', 04:46:23 INFO - 'TMOUT': '86400', 04:46:23 INFO - 'USER': 'cltbld', 04:46:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:23 INFO - '_': '/tools/buildbot/bin/python'} 04:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:46:23 INFO - Cleaning up... 04:46:23 INFO - Return code: 0 04:46:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:46:23 INFO - Using env: {'DISPLAY': ':0', 04:46:23 INFO - 'HOME': '/home/cltbld', 04:46:23 INFO - 'LANG': 'en_US.UTF-8', 04:46:23 INFO - 'LANGUAGE': 'en_US:en', 04:46:23 INFO - 'LOGNAME': 'cltbld', 04:46:23 INFO - 'MAIL': '/var/mail/cltbld', 04:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:23 INFO - 'MOZ_NO_REMOTE': '1', 04:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:23 INFO - 'NO_EM_RESTART': '1', 04:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:23 INFO - 'PWD': '/builds/slave/test', 04:46:23 INFO - 'SHELL': '/bin/bash', 04:46:23 INFO - 'SHLVL': '1', 04:46:23 INFO - 'TERM': 'linux', 04:46:23 INFO - 'TMOUT': '86400', 04:46:23 INFO - 'USER': 'cltbld', 04:46:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:23 INFO - '_': '/tools/buildbot/bin/python'} 04:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:23 INFO - Downloading/unpacking psutil>=3.1.1 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:25 INFO - Installing collected packages: psutil 04:46:25 INFO - Running setup.py install for psutil 04:46:25 INFO - building 'psutil._psutil_linux' extension 04:46:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:46:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:46:26 INFO - building 'psutil._psutil_posix' extension 04:46:26 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 04:46:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:46:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:26 INFO - Successfully installed psutil 04:46:26 INFO - Cleaning up... 04:46:26 INFO - Return code: 0 04:46:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:46:26 INFO - Using env: {'DISPLAY': ':0', 04:46:26 INFO - 'HOME': '/home/cltbld', 04:46:26 INFO - 'LANG': 'en_US.UTF-8', 04:46:26 INFO - 'LANGUAGE': 'en_US:en', 04:46:26 INFO - 'LOGNAME': 'cltbld', 04:46:26 INFO - 'MAIL': '/var/mail/cltbld', 04:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:26 INFO - 'MOZ_NO_REMOTE': '1', 04:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:26 INFO - 'NO_EM_RESTART': '1', 04:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:26 INFO - 'PWD': '/builds/slave/test', 04:46:26 INFO - 'SHELL': '/bin/bash', 04:46:26 INFO - 'SHLVL': '1', 04:46:26 INFO - 'TERM': 'linux', 04:46:26 INFO - 'TMOUT': '86400', 04:46:26 INFO - 'USER': 'cltbld', 04:46:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:26 INFO - '_': '/tools/buildbot/bin/python'} 04:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:28 INFO - Installing collected packages: mozsystemmonitor 04:46:28 INFO - Running setup.py install for mozsystemmonitor 04:46:28 INFO - Successfully installed mozsystemmonitor 04:46:28 INFO - Cleaning up... 04:46:28 INFO - Return code: 0 04:46:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:46:28 INFO - Using env: {'DISPLAY': ':0', 04:46:28 INFO - 'HOME': '/home/cltbld', 04:46:28 INFO - 'LANG': 'en_US.UTF-8', 04:46:28 INFO - 'LANGUAGE': 'en_US:en', 04:46:28 INFO - 'LOGNAME': 'cltbld', 04:46:28 INFO - 'MAIL': '/var/mail/cltbld', 04:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:28 INFO - 'MOZ_NO_REMOTE': '1', 04:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:28 INFO - 'NO_EM_RESTART': '1', 04:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:28 INFO - 'PWD': '/builds/slave/test', 04:46:28 INFO - 'SHELL': '/bin/bash', 04:46:28 INFO - 'SHLVL': '1', 04:46:28 INFO - 'TERM': 'linux', 04:46:28 INFO - 'TMOUT': '86400', 04:46:28 INFO - 'USER': 'cltbld', 04:46:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:28 INFO - '_': '/tools/buildbot/bin/python'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:31 INFO - warning: no files found matching '*.txt' 04:46:31 INFO - no previously-included directories found matching 'build' 04:46:31 INFO - no previously-included directories found matching 'dist' 04:46:31 INFO - no previously-included directories found matching '.git*' 04:46:31 INFO - Installing collected packages: jsonschema, functools32 04:46:31 INFO - Running setup.py install for functools32 04:46:31 INFO - warning: no files found matching '*.txt' 04:46:31 INFO - no previously-included directories found matching 'build' 04:46:31 INFO - no previously-included directories found matching 'dist' 04:46:31 INFO - no previously-included directories found matching '.git*' 04:46:31 INFO - Successfully installed jsonschema functools32 04:46:31 INFO - Cleaning up... 04:46:31 INFO - Return code: 0 04:46:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:46:31 INFO - Using env: {'DISPLAY': ':0', 04:46:31 INFO - 'HOME': '/home/cltbld', 04:46:31 INFO - 'LANG': 'en_US.UTF-8', 04:46:31 INFO - 'LANGUAGE': 'en_US:en', 04:46:31 INFO - 'LOGNAME': 'cltbld', 04:46:31 INFO - 'MAIL': '/var/mail/cltbld', 04:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:31 INFO - 'MOZ_NO_REMOTE': '1', 04:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:31 INFO - 'NO_EM_RESTART': '1', 04:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:31 INFO - 'PWD': '/builds/slave/test', 04:46:31 INFO - 'SHELL': '/bin/bash', 04:46:31 INFO - 'SHLVL': '1', 04:46:31 INFO - 'TERM': 'linux', 04:46:31 INFO - 'TMOUT': '86400', 04:46:31 INFO - 'USER': 'cltbld', 04:46:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:31 INFO - '_': '/tools/buildbot/bin/python'} 04:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:31 INFO - Cleaning up... 04:46:31 INFO - Return code: 0 04:46:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:46:31 INFO - Using env: {'DISPLAY': ':0', 04:46:31 INFO - 'HOME': '/home/cltbld', 04:46:31 INFO - 'LANG': 'en_US.UTF-8', 04:46:31 INFO - 'LANGUAGE': 'en_US:en', 04:46:31 INFO - 'LOGNAME': 'cltbld', 04:46:31 INFO - 'MAIL': '/var/mail/cltbld', 04:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:31 INFO - 'MOZ_NO_REMOTE': '1', 04:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:31 INFO - 'NO_EM_RESTART': '1', 04:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:31 INFO - 'PWD': '/builds/slave/test', 04:46:31 INFO - 'SHELL': '/bin/bash', 04:46:31 INFO - 'SHLVL': '1', 04:46:31 INFO - 'TERM': 'linux', 04:46:31 INFO - 'TMOUT': '86400', 04:46:31 INFO - 'USER': 'cltbld', 04:46:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:31 INFO - '_': '/tools/buildbot/bin/python'} 04:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - Downloading docopt-0.6.1.tar.gz 04:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:34 INFO - Running setup.py install for blobuploader 04:46:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:35 INFO - Running setup.py install for requests 04:46:35 INFO - Running setup.py install for docopt 04:46:35 INFO - Successfully installed blobuploader requests docopt 04:46:35 INFO - Cleaning up... 04:46:35 INFO - Return code: 0 04:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:35 INFO - Using env: {'DISPLAY': ':0', 04:46:35 INFO - 'HOME': '/home/cltbld', 04:46:35 INFO - 'LANG': 'en_US.UTF-8', 04:46:35 INFO - 'LANGUAGE': 'en_US:en', 04:46:35 INFO - 'LOGNAME': 'cltbld', 04:46:35 INFO - 'MAIL': '/var/mail/cltbld', 04:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:35 INFO - 'MOZ_NO_REMOTE': '1', 04:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:35 INFO - 'NO_EM_RESTART': '1', 04:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:35 INFO - 'PWD': '/builds/slave/test', 04:46:35 INFO - 'SHELL': '/bin/bash', 04:46:35 INFO - 'SHLVL': '1', 04:46:35 INFO - 'TERM': 'linux', 04:46:35 INFO - 'TMOUT': '86400', 04:46:35 INFO - 'USER': 'cltbld', 04:46:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:35 INFO - '_': '/tools/buildbot/bin/python'} 04:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:35 INFO - Running setup.py (path:/tmp/pip-DuO7zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:35 INFO - Running setup.py (path:/tmp/pip-mX0_Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:35 INFO - Running setup.py (path:/tmp/pip-VD6WGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:36 INFO - Running setup.py (path:/tmp/pip-ArUbZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:36 INFO - Running setup.py (path:/tmp/pip-4EsXsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:36 INFO - Running setup.py (path:/tmp/pip-3vukqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:36 INFO - Running setup.py (path:/tmp/pip-O5js6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:36 INFO - Running setup.py (path:/tmp/pip-S8A2qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:36 INFO - Running setup.py (path:/tmp/pip-bRJxtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:36 INFO - Running setup.py (path:/tmp/pip-fwSsKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:36 INFO - Running setup.py (path:/tmp/pip-7Y5eiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:36 INFO - Running setup.py (path:/tmp/pip-vj90Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:36 INFO - Running setup.py (path:/tmp/pip-ZjYjEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:36 INFO - Running setup.py (path:/tmp/pip-iaN31s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:36 INFO - Running setup.py (path:/tmp/pip-njLDch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:36 INFO - Running setup.py (path:/tmp/pip-aIwkXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:36 INFO - Running setup.py (path:/tmp/pip-eXEdB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:37 INFO - Running setup.py install for manifestparser 04:46:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Running setup.py install for mozcrash 04:46:37 INFO - Running setup.py install for mozdebug 04:46:37 INFO - Running setup.py install for mozdevice 04:46:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Running setup.py install for mozfile 04:46:37 INFO - Running setup.py install for mozhttpd 04:46:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Running setup.py install for mozinfo 04:46:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Running setup.py install for mozInstall 04:46:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:37 INFO - Running setup.py install for mozleak 04:46:37 INFO - Running setup.py install for mozlog 04:46:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Running setup.py install for moznetwork 04:46:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Running setup.py install for mozprocess 04:46:38 INFO - Running setup.py install for mozprofile 04:46:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Running setup.py install for mozrunner 04:46:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Running setup.py install for mozscreenshot 04:46:38 INFO - Running setup.py install for moztest 04:46:38 INFO - Running setup.py install for mozversion 04:46:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:38 INFO - Cleaning up... 04:46:38 INFO - Return code: 0 04:46:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:38 INFO - Using env: {'DISPLAY': ':0', 04:46:38 INFO - 'HOME': '/home/cltbld', 04:46:38 INFO - 'LANG': 'en_US.UTF-8', 04:46:38 INFO - 'LANGUAGE': 'en_US:en', 04:46:38 INFO - 'LOGNAME': 'cltbld', 04:46:38 INFO - 'MAIL': '/var/mail/cltbld', 04:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:38 INFO - 'MOZ_NO_REMOTE': '1', 04:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:38 INFO - 'NO_EM_RESTART': '1', 04:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:38 INFO - 'PWD': '/builds/slave/test', 04:46:38 INFO - 'SHELL': '/bin/bash', 04:46:38 INFO - 'SHLVL': '1', 04:46:38 INFO - 'TERM': 'linux', 04:46:38 INFO - 'TMOUT': '86400', 04:46:38 INFO - 'USER': 'cltbld', 04:46:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:38 INFO - '_': '/tools/buildbot/bin/python'} 04:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:39 INFO - Running setup.py (path:/tmp/pip-brJkg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:39 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)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:39 INFO - Running setup.py (path:/tmp/pip-80XByD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:39 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)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:39 INFO - Running setup.py (path:/tmp/pip-t0WOUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:39 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)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:39 INFO - Running setup.py (path:/tmp/pip-zUDKQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:39 INFO - Running setup.py (path:/tmp/pip-Zbp5YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:39 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)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:39 INFO - Running setup.py (path:/tmp/pip-TixFjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:39 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)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:39 INFO - Running setup.py (path:/tmp/pip-B61D_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:39 INFO - Running setup.py (path:/tmp/pip-mEkyB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:39 INFO - Running setup.py (path:/tmp/pip-wxyK8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:39 INFO - Running setup.py (path:/tmp/pip-_5j15P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:39 INFO - Running setup.py (path:/tmp/pip-tVOn6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:39 INFO - Running setup.py (path:/tmp/pip-t57En2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:39 INFO - Running setup.py (path:/tmp/pip-VCeHPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:40 INFO - Running setup.py (path:/tmp/pip-6pQRwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:40 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)) 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:40 INFO - Running setup.py (path:/tmp/pip-q8SEKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:40 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)) 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:40 INFO - Running setup.py (path:/tmp/pip-3CogS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:40 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)) 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:40 INFO - Running setup.py (path:/tmp/pip-L95nEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:40 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 04:46:40 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 04:46:40 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 04:46:40 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 04:46:40 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 04:46:40 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 04:46:42 INFO - Downloading blessings-1.6.tar.gz 04:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:42 INFO - Installing collected packages: blessings 04:46:42 INFO - Running setup.py install for blessings 04:46:42 INFO - Successfully installed blessings 04:46:42 INFO - Cleaning up... 04:46:42 INFO - Return code: 0 04:46:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:42 INFO - Reading from file tmpfile_stdout 04:46:42 INFO - Current package versions: 04:46:42 INFO - argparse == 1.2.1 04:46:42 INFO - blessings == 1.6 04:46:42 INFO - blobuploader == 1.2.4 04:46:42 INFO - docopt == 0.6.1 04:46:42 INFO - functools32 == 3.2.3-2 04:46:42 INFO - jsonschema == 2.5.1 04:46:42 INFO - manifestparser == 1.1 04:46:42 INFO - mozInstall == 1.12 04:46:42 INFO - mozcrash == 1.0 04:46:42 INFO - mozdebug == 0.1 04:46:42 INFO - mozdevice == 0.49 04:46:42 INFO - mozfile == 1.2 04:46:42 INFO - mozhttpd == 0.7 04:46:42 INFO - mozinfo == 0.9 04:46:42 INFO - mozleak == 0.1 04:46:42 INFO - mozlog == 3.4 04:46:42 INFO - moznetwork == 0.27 04:46:42 INFO - mozprocess == 0.25 04:46:42 INFO - mozprofile == 0.28 04:46:42 INFO - mozrunner == 6.13 04:46:42 INFO - mozscreenshot == 0.1 04:46:42 INFO - mozsystemmonitor == 0.3 04:46:42 INFO - moztest == 0.8 04:46:42 INFO - mozversion == 1.4 04:46:42 INFO - psutil == 3.1.1 04:46:42 INFO - requests == 1.2.3 04:46:42 INFO - wsgiref == 0.1.2 04:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:42 INFO - Using env: {'DISPLAY': ':0', 04:46:42 INFO - 'HOME': '/home/cltbld', 04:46:42 INFO - 'LANG': 'en_US.UTF-8', 04:46:42 INFO - 'LANGUAGE': 'en_US:en', 04:46:42 INFO - 'LOGNAME': 'cltbld', 04:46:42 INFO - 'MAIL': '/var/mail/cltbld', 04:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:42 INFO - 'MOZ_NO_REMOTE': '1', 04:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:42 INFO - 'NO_EM_RESTART': '1', 04:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:42 INFO - 'PWD': '/builds/slave/test', 04:46:42 INFO - 'SHELL': '/bin/bash', 04:46:42 INFO - 'SHLVL': '1', 04:46:42 INFO - 'TERM': 'linux', 04:46:42 INFO - 'TMOUT': '86400', 04:46:42 INFO - 'USER': 'cltbld', 04:46:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:42 INFO - '_': '/tools/buildbot/bin/python'} 04:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:46:42 INFO - Cleaning up... 04:46:42 INFO - Return code: 0 04:46:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, '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': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', '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 04:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:42 INFO - Using env: {'DISPLAY': ':0', 04:46:42 INFO - 'HOME': '/home/cltbld', 04:46:42 INFO - 'LANG': 'en_US.UTF-8', 04:46:42 INFO - 'LANGUAGE': 'en_US:en', 04:46:42 INFO - 'LOGNAME': 'cltbld', 04:46:42 INFO - 'MAIL': '/var/mail/cltbld', 04:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:43 INFO - 'MOZ_NO_REMOTE': '1', 04:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:43 INFO - 'NO_EM_RESTART': '1', 04:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:43 INFO - 'PWD': '/builds/slave/test', 04:46:43 INFO - 'SHELL': '/bin/bash', 04:46:43 INFO - 'SHLVL': '1', 04:46:43 INFO - 'TERM': 'linux', 04:46:43 INFO - 'TMOUT': '86400', 04:46:43 INFO - 'USER': 'cltbld', 04:46:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:43 INFO - '_': '/tools/buildbot/bin/python'} 04:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - Running post-action listener: _start_resource_monitoring 04:46:43 INFO - Starting resource monitoring. 04:46:43 INFO - [mozharness: 2017-04-01 11:46:43.245654Z] Finished create-virtualenv step (success) 04:46:43 INFO - [mozharness: 2017-04-01 11:46:43.246163Z] Running install step. 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: install 04:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:43 INFO - Reading from file tmpfile_stdout 04:46:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:43 INFO - Reading from file tmpfile_stdout 04:46:43 INFO - Output received: 04:46:43 INFO - Usage: mozinstall [options] installer 04:46:43 INFO - Options: 04:46:43 INFO - -h, --help show this help message and exit 04:46:43 INFO - -d DEST, --destination=DEST 04:46:43 INFO - Directory to install application into. [default: 04:46:43 INFO - "/builds/slave/test"] 04:46:43 INFO - --app=APP Application being installed. [default: firefox] 04:46:43 INFO - mkdir: /builds/slave/test/build/application 04:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:46:59 INFO - Reading from file tmpfile_stdout 04:46:59 INFO - Output received: 04:46:59 INFO - /builds/slave/test/build/application/firefox/firefox 04:46:59 INFO - Running post-action listener: _resource_record_post_action 04:46:59 INFO - [mozharness: 2017-04-01 11:46:59.558631Z] Finished install step (success) 04:46:59 INFO - [mozharness: 2017-04-01 11:46:59.558908Z] Running run-tests step. 04:46:59 INFO - Running pre-action listener: _resource_record_pre_action 04:46:59 INFO - Running main action method: run_tests 04:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:59 INFO - Python 2.7.3 04:46:59 INFO - Return code: 0 04:46:59 INFO - grabbing minidump binary from tooltool 04:46: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')]} 04:46:59 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 0x1ea9400>, '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 0x1eaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:59 INFO - Return code: 0 04:46:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:46:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:59 INFO - ENV: RUST_BACKTRACE is now 1 04:46:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:46:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:46:59 INFO - Using env: {'DISPLAY': ':0', 04:46:59 INFO - 'HOME': '/home/cltbld', 04:46:59 INFO - 'LANG': 'en_US.UTF-8', 04:46:59 INFO - 'LANGUAGE': 'en_US:en', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MAIL': '/var/mail/cltbld', 04:46:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:59 INFO - 'RUST_BACKTRACE': '1', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SHLVL': '1', 04:46:59 INFO - 'TERM': 'linux', 04:46:59 INFO - 'TMOUT': '86400', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:46:59 INFO - mozversion application_buildid: 20170401110736 04:46:59 INFO - mozversion application_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 04:46:59 INFO - mozversion application_display_name: Nightly 04:46:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:59 INFO - mozversion application_name: Firefox 04:46:59 INFO - mozversion application_remotingname: firefox 04:46:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:46:59 INFO - mozversion application_vendor: Mozilla 04:46:59 INFO - mozversion application_version: 55.0a1 04:46:59 INFO - mozversion platform_buildid: 20170401110736 04:46:59 INFO - mozversion platform_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 04:46:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:46:59 INFO - mozversion platform_version: 55.0a1 04:46:59 INFO - using testdate: 1491047219 04:46:59 INFO - actual date: 1491047219 04:46:59 INFO - starting webserver on 'localhost:33331' 04:46:59 INFO - SUITE-START | Running 2 tests 04:46:59 INFO - TEST-START | dromaeo_css 04:46:59 INFO - operating with platform_type : linux_ 04:46:59 INFO - Initialising browser for dromaeo_css test... 04:46:59 INFO - TEST-INFO | started process 6264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLSgl9k/profile http://localhost:33331/getInfo.html) 04:47:03 INFO - PID 6264 | __metrics Screen width/height:1600/1200 04:47:03 INFO - PID 6264 | colorDepth:24 04:47:03 INFO - PID 6264 | Browser inner width/height: 1024/697 04:47:03 INFO - PID 6264 | __metrics 04:47:05 INFO - PID 6264 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:05 INFO - PID 6264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:06 INFO - TEST-INFO | 6264: exit 0 04:47:06 INFO - Browser initialized. 04:47:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:06 INFO - TEST-INFO | started process 6362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLSgl9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:18 INFO - PID 6362 | RSS: Main: 165900288 04:47:18 INFO - PID 6362 | 04:50:25 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33331/tests/dromaeo/cssquery-ext.html) 04:50:27 INFO - PID 6362 | RSS: Main: 269737984 04:50:27 INFO - PID 6362 | 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | A coding exception was thrown and uncaught in a Task. 04:52:08 INFO - PID 6362 | 04:52:08 ERROR - PID 6362 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:08 INFO - PID 6362 | Full stack: 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | A coding exception was thrown and uncaught in a Task. 04:52:08 INFO - PID 6362 | 04:52:08 ERROR - PID 6362 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:08 INFO - PID 6362 | Full stack: 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | A coding exception was thrown and uncaught in a Task. 04:52:08 INFO - PID 6362 | 04:52:08 ERROR - PID 6362 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:08 INFO - PID 6362 | Full stack: 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | ************************* 04:52:08 INFO - PID 6362 | A coding exception was thrown and uncaught in a Task. 04:52:08 INFO - PID 6362 | 04:52:08 ERROR - PID 6362 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:08 INFO - PID 6362 | Full stack: 04:52:08 INFO - PID 6362 | ************************* 04:53:30 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-ext.html (next: http://localhost:33331/tests/dromaeo/cssquery-jquery.html) 04:53:30 INFO - PID 6362 | RSS: Main: 260997120 04:53:30 INFO - PID 6362 | 04:56:33 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33331/tests/dromaeo/cssquery-mootools.html) 04:56:33 INFO - PID 6362 | RSS: Main: 203952128 04:56:33 INFO - PID 6362 | 04:59:35 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33331/tests/dromaeo/cssquery-prototype.html) 04:59:36 INFO - PID 6362 | RSS: Main: 245485568 04:59:36 INFO - PID 6362 | 05:02:40 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33331/tests/dromaeo/cssquery-yui.html) 05:02:40 INFO - PID 6362 | RSS: Main: 213389312 05:02:40 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | Cycle 1(1): loaded http://localhost:33331/tests/dromaeo/cssquery-yui.html (next: http://localhost:33331/tests/dromaeo/cssquery-dojo.html) 05:05:43 INFO - PID 6362 | RSS: Main: 300281856 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | __start_tp_report 05:05:43 INFO - PID 6362 | _x_x_mozilla_page_load 05:05:43 INFO - PID 6362 | _x_x_mozilla_page_load_details 05:05:43 INFO - PID 6362 | |i|pagename|runs| 05:05:43 INFO - PID 6362 | |0;dojo.html;2686.959695604566;2737.1651646247888;2772.944541109178;2777.291790593398;2782.193163982445;5132.692038477694;5228.5294323510925;5238.2142678598275;5253.658512196705;5300.840974770758;5255.921161182576;5258.474152584739;5275.788968441268;5279.841604751864;5280.867978300545;4670.579647831703;4694.976525117369;4735.455422626407;4739.478657347689;4767.713937163781;4719.032598317337;4719.551642593965;4748.430188377382;4758.524147585248;4764.118638051954;4725.952740472603;4741.762911854411;4756.048790241948;4760.928586071212;4764.094821983829;4724.17326967781;4726.26742854858;4741.5732584067255;4756.9286460703115;4802.615790736768;4691.014886873761;4696;4700.741459219742;4711.740854253015;4750.453697824725;4998.750062496861;5112.514311140473;5115.360579927509;5141.305923700327;5202.271681964528;5549.944500554983;5602.551795856321;5678.858028549278;5684.772609095631;5691.573132015074;5728.398518155617;5731.570132240057;5742.2247996520355;5743.4543718346695;5746.655200687972;5321.414644389114;5325.334333208349;5326.174442961308;5332.200169974535;5376.650517716336;5715.599908006399;5793.710314484343;5797.36229014808;5853.970730146322;5885.646861188342;5600.747966341524;5608.10270356741;5610.803621873215;5616.297962754656;5668.659880407106;5681.233033540502;5712.314522257273;5714.657120572779;5717;5719.399463056402;5498;5517.172424136332;5585.832425027255;5627.915581266284;5672.177534257509;5580.637258578179;5664.320281566238;5666.801661941812;5712.771489140471;5713.2572765541045;4770.856874293777;4771.379720636295;4773.570378665937;4773.809047638056;4817.735024573612;3990.9201815964097;4053.1893621275863;4078.1639763848934;4085.2442298174933;4096;4681.508441613581;4729.36153619257;4734.26618874075;4736.834210802605;4740.312654665055;5625.54995600351;5725.026745453283;5807.157962095473;5808.128780682931;5808.157817116495;4810.807567697323;4828.348172996671;4828.903421931542;4831.106245344552;4849.975750121227;5087.033463641897;5091.9236211456855;5106.208537676666;5109.3613298337705;5112.284280200849;5150.639455238247;5174.7153906535505;5225.555827754683;5229.189475631283;5253.842384728464;5610.887782244414;5641.746121424464;5725.427457254241;5739.196512488338;5745.3105627324985;5289.20661900718;5313.548348390275;5323.494268044529;5348.57211423093;5374.7581358839725;5620.269364982526;5628.268325117709;5632.380438151882;5633.690147041952;5636.239107720406;5526.281583394133;5586.52514536269;5650.26546548946;5733.197352370755;5783.710814459344;5428.565714742732;5450.700211488406;5504.174373843955;5517.117261238182;5537;5468.425815289337;5484.780608775604;5491.725413729378;5493.368262649687;5499.175123731312;5338.225957236256;5377.892442151213;5430.864228394164;5442.0748472760515;5492.368377636463;5552.222688823487;5552.222688823487;5598.384177740364;5630.915536267041;5632.690202038927;5435.429279925551;5438.646487978269;5441.972790136182;5446.618736688394;5448.83653490396 05:05:43 INFO - PID 6362 | |1;ext.html;653.9280679125295;699.5173330402022;718.5221827484723;1092.633967620847;1110.5280255891244;28033.859830700843;28715.282117947063;28822.567661485093;35362.82318588404;35571.110722231955;37418;37701.43447848278;37832.86501404955;37866;37952.43071353932;7210.4952653314285;7365.484416090876;7375.078115235596;7378.114626244858;7385.999999999973;5421.891562168754;5505.504504594585;7065.293470652945;7197.064381630381;7282.708691652354;7312.890306645405;7318.963405182966;7359.705611775523;7374.078240219973;7394.223606521318;7281.817954551126;7299;7352.080989876265;7355.448341374418;7369.742059027908;5261.289725887033;5373.892522149535;7070.328318809705;7181.35367816899;7264.745733899288;34447.48328775071;34890.30219395623;34945;34960.650393496246;34973.65026349729;2629.1718108795667;2636.0378461861474;2646.947061058768;2659.321872922412;2659.906903258396;22702.659460108112;23085.884570577207;23283.650745238836;23332.183373582015;23375.7662423377;2891.4506243813607;2940.4119176164854;2947.7199666031693;2947.7494412974925;2985.805922615045;139464;139868.3006584971;140073;140385;140512;42159.15681686349;42190.367144492855;42238;42258.36612450816;42287.365689514685;42221.577784222376;42299.7885010573;42471.78764106221;42580.78709606432;42604;12844;13128.409221584861;13134.080614357094;13208;13297.601071967856;10501.527431265611;10505.52725127371;10507.422091785025;10510.63212787564;10602.310849794738;11370.488328025258;11557.30656160633;13067.346632668328;13365.933170334087;13489.730205395837;5504.80733174337;5630.831075067755;5632.2678051853;5641.407652196543;5641.9435805641415;887.6804350433839;919.4483310013939;935.6386457704024;936.9437833729997;938.3290946972811;20799.79200208009;21585.352439426842;21721.34835954924;21745.891270543547;21752.238671646417;990.6483198464585;1004.7440699126092;1005.9356141801231;1019.9133073688671;1030.5620111452602;11030.338179709082;11440.485178167002;11516;11519.827202591969;11535.480903359368;240502;241314;243050;243327;243346;43349;43399.13201735948;43589.346159807625;43790.34314485285;43873.56126438759;1240.3240234072452;1271.040364524778;1287.8583355830851;1299.4087690100982;1299.7920332746526;19894.801051989874;19972.400827975183;20789.272375466786;20858.791412085684;21582.784172158077;30967;30967.380652387277;31009.68990310068;31081.68918310788;31094.844525777225;206404;207967;208051;209168;209263;30404.695953040187;30750;30752.384952301276;31488.527672085394;31605;30696;31292.843535782176;32932;33810.83094584511;37981.810090949366;27593.310167245978;27702.44595108127;27975.72024279731;28164.15507534777;29265.268368290963;27924.86037569799;27956.580651290653;28125.859370703834;29205.85397073001;29264;31162.065138045895;31512.527312090795;31577.36845263128;31710.255935923746;32142.83928580342;26759;26887.73112268852;28258;28299.292517686397;28904.7109528902;21247.681284780432;22441.21455749041;22572.097116115172;22704.205352812573;22911.65632515547 05:05:43 INFO - PID 6362 | |2;jquery.html;400.1696479804407;410.1714536635993;413.89238797912554;414.96680265578755;426.8335349213807;11686.883131168686;18272;18698.252069917187;19111.235550577978;19118.13968371423;14487.492937747182;16147.757783633255;19344.226230950746;19533.218671253133;19763.703544446846;5404.270423492837;5452.291202143716;5570.6657600544095;5571.9442805572035;5581.2186293918885;5335.706536140511;5465.9726701366435;5556.222128901957;5558.527525160366;5560.555155587544;5505.476979686943;5529.751161197756;5541.362743284513;5543.445655434464;5552.028395030874;5360.892782144374;5483.588730845163;5517.531009864167;5532.419095994903;5541.944580554183;4968.080905032544;4974.900501989976;4981.72600506972;4989.226669866177;4992.575631071363;21259.787402125934;22413.887930560242;22422.103115875347;22486.55026899469;22597.322080337617;1610.5248951559317;1617.086346214385;1627.5280168751049;1648.0311859742885;1665.8667306615441;13773.907154843118;14288;14468;15136;15581;2037.5313677854028;2042.9591408171752;2059.8405508783717;2069.1102825784906;2070.6686930091264;95766;97784;98199.50900245596;98485.50757246168;99970;18210;18216.36242731498;18402.171902264432;18887.150078246512;18890.244390224238;34512;34644.30711385758;34727.47908781371;35083.473747893804;35184.824075879456;7740.458167928304;8085.595720213966;8093.352531797442;8964.955175224213;9281.350305478552;6390.009548519987;6407.839804004937;6434.388733070351;6444.484441244689;6446.709898054599;7653.469306138794;9187.26501879848;9690.806183876282;9803.167115566226;9916.553755081039;3700.444933259979;3763.9247215055548;3784.4701741756176;3840.143780734347;3937.488126543531;895.5566994337845;896.3994123936848;918.4856480371013;919.2462181011506;938.8028514012134;16551.83448165503;16848.07335596554;17588.648227035388;17607;17855.910720446314;912.7540906662358;912.7854954085784;934.4159900062461;942.9292803039799;943.217129782279;9112.589933453011;9754.219662426989;9770.560324785401;9824.656137035312;9866.408015519091;470780;473404;501182;501626;502322.1865048245;95049;96384.51807740917;96860.51569742105;98036;99340;1095.4960718069776;1102.4542851288504;1151.6199654114123;1154.9595764148214;1155.7861795567846;17078.402255920984;17307.154276578938;17757.537280230747;17843.732344014592;18050.90974545119;41977.58022419859;43231.567684324014;43965.78017110022;44000;45987.31019034784;55980.72009639926;56293;57465.71267143638;58009.70995144997;58055.70972145112;7922.762317130495;7987.85239056171;8059.395545334006;8075;8399.41204115706;12658.746825063632;12691.80962285585;12731.490740370282;12896.29070401137;13167.60497185086;10843.512041957973;11067.169962252703;11203.887961120285;11312.886871131182;11694.239874408477;9935.950320248352;9943.502824858873;9975.900240997787;10035.397876127456;10114.494275286059;11177.329360238411;11330.320180789178;11359.886401135884;11554.364509951698;11891.94054029759;7846.058472983279;7908.3673306136525;8059.959700201462;8099.595020249082;8172.141925097779;11051.83422248683;11124.61063862761;11440.828387574027;11456;11495.885041149815 05:05:43 INFO - PID 6362 | |3;mootools.html;1283.8972882169426;1308.3719814489045;1317.3215793866166;1322.2397121655044;1341.7920222365533;9504.714858554236;9775.608975640966;9887.20902327814;9897.75255618609;9936.155426788722;9700.126988571028;10131.34146280493;10133.847992280103;10140.74648133797;10154.69535913922;2243.7083179186725;2275.9089636414606;2283.041122728458;2283.9771602284013;2284.794368506834;1858.9535261618432;2118.798714122156;2123.1295168980723;2127.5744851029776;2239.7536271010176;1851.6204178143516;2189.9343019709436;2255.244493094807;2260.9095636174534;2265.9660105098437;2149.4196566927;2156.148321413041;2163.6862654915026;2174.2281490070955;2185.4099393163915;2137.5297434564372;2138.7326584176976;2139.048123585005;2145.678148277755;2147.226998280618;9654.22766178704;9737.026297370277;9742.561584728704;9861.950690246575;9867.802643947152;5441.809536666237;5631.352394474606;5635.746391412396;5637.633553818989;5642.815008848147;3041.3461105862348;3150.2754366495606;3293.4565796643524;3364.5457863188403;3367.44437167867;1034.5654824973528;1060.4697651174413;1069.663056137322;1099.3623698254994;1110.5058249079163;14224.644383890382;14395.424183032666;14523.128612283192;14527.491537796126;14552.417903283857;4605.194091034055;4712.835050773275;4811.374521312207;4826.083044221657;4839.274108883626;10509.159267258601;10521.894781052091;10540.578376864993;10644.94677526623;10652.680419587425;5416.214648875891;5417.404085550586;5420.783168673288;5461.508464238238;5473.042217611902;4892.951070489321;4984.451710311862;5047.949520504748;5078.898422031539;5081.339425874613;3786.924261514754;3842.865499707497;3850.6534411903062;3892.065904182976;3994;1006.7382480554962;1006.8137394582026;1013.3210748798323;1020.2552136939927;1028.5782829040058;565.3269346130774;672.2504407585507;730.2514922204676;732.0629594119536;752.4243953375671;5647.887042259132;5774.451427114417;5779;5784.161296612052;5926.851828704317;552.2710022769905;561.1554610311537;569.1121849914147;573.3320681406116;674.4334758802629;3599.6400359963795;3654.689351405107;3676.209614932802;3716.646918542734;3956.092272179945;12126.939365303117;12928.676783080498;13074.607761767162;13078.2806945617;13079.803802942963;12796.232226066466;12880.613581592566;12987;13019.218846869218;13101.279429631462;9177.08229177077;9181.081891810765;9216.677416290398;9329.486878221764;9336.346455748168;5633.633813802254;5644.971775141098;5753.741081651419;5903.940960590511;6029.487493563096;11110.111191104854;11336.14978876604;11384.43077846121;11450.828237576276;11488.310701357945;11595.8260626089;11627.127965402799;11635.360055197045;11721.472533736172;11751.76496470083;7932.56370899583;8110.31062359706;8160.30637395828;8168.591570421337;8170.673173073011;8581.785455363417;8848.292136629183;8930.106989301017;8979.730608081769;9015.413998090104;7931.5637639930355;8074.636641351036;8084.151164127682;8129.67481300765;8187.631556580087;7854.450188486751;7864.2922137007945;7904.367650587824;7976.800579985546;8020.719274825353;7132.679029443584;7225.421966242583;7239.565626062453;7244.311790379906;7244.710211591478;5347.278117454094;5359.222912677562;5409.404965453718;5501.5323697486165;5605.244486194341;5076;5107.463716309734;5150.278960945546;5174.016936781999;5259.184826351921 05:05:43 INFO - PID 6362 | |4;prototype.html;375.40266167457463;392.3173677800627;394.7887879984209;395.32991579273136;401.71076824686213;5359.946400535993;5401.459854014602;5402.811381496074;5415.214793854899;5431.864203394917;5063.189889617662;5230.1108811502045;5231.79072837087;5245.527902488775;5264.078786212407;4051.6961227907877;4064.5367667639625;4078.8164532595956;4079.5308539518037;4079.5920407959266;4082.6733861291173;4083.4283200351974;4084.7140700151003;4084.8154035329867;4091.9590804092027;3851.4415409765566;3996.820143093568;4022.9798851005703;4044.867437117597;4047.6357127858487;3979.7612143271494;4007.499062617173;4028.5295867008476;4034.334334834749;4040.1717647882115;3548.079372293604;3554.413521768931;3558.839852206631;3561.857525698969;3563.1092226943265;4967.950320496785;5118.897622047575;5129.846104616868;5137.845864624067;5140.1518749406305;4754.286856971447;4756.881077973078;4760.619150467955;4787.832425865113;4791.377120974286;5566.888662226733;5608.158776183564;5620.775168993236;5623.718814059322;5624.21261023457;3919.980804990723;4009.4386785850006;4020.718549701522;4024.517057953035;4033.97983010086;5626.634268772516;5768.682722450306;5813.011787996009;5862.824115276506;5996.340402555716;4027.3556231003486;4040.575739547305;4049.8380064797666;4050.0887300357185;4051.372037334218;4102.2000709861295;4116.073883376216;4120.711550191518;4121.711480196357;4122.0107174278555;4380.627646650007;4457.8439754608435;4564.475085365159;4566.26939689648;4705.741184234831;5561.416051314634;5589.74846131925;5596.440355964371;5637.267155269788;5644.153376993402;1418.524794193936;1441.6828297774473;1441.726072046329;1441.8774404175554;1447.4499690117689;938.4603852784676;960.8366577681811;965.5075911285155;968.2060710217554;971.8007808399261;4872.731999739977;4887.65786394956;4910.754462276872;4919.2129259318335;4920.6309526785635;5843.29880414353;5847.502962248256;5857.092150716646;5861.003629383015;5866.882662346729;4709.740964246999;4876.21980483121;4933.777979990909;4967;4970.329005584272;3074.969250307513;3098.395812816479;3110.9066727998197;3112.361965797006;3115.408072466224;5180.834312279707;5433.538149257279;5436.429174936654;5472.972635136878;5489.258950041693;5960.344362120163;5986.880262394728;6005.6997150142315;6005.939940600625;6043.7884674036195;5401.891962160735;5475.288212532425;5482.17767334887;5486.862828429321;5496.148097044965;5765.221695071112;5843.574916409642;5864.736086876015;5876.1773351729935;5898.203742494708;5756.827295181151;5774.595778295479;5775.94224057754;5793.04414771558;5793.623414478046;5146.819861304836;5250.422453530032;5283.471652834686;5307.814226502054;5435.565154787687;4037.2732908076828;4393.714408563433;4422.800973956116;4432.734035957853;4436.157130145262;5824.271966004249;5844.298684157929;5860.38465961085;5862.541100750407;5876.559258055578;5435.429279925551;5652.576056795839;5670.007748644053;5678.886422271449;5685.20407142992;5643.181738647955;5657.858553536194;5661.745221464962;5669.943300566942;5690.430956904276;5373.8387848363045;5559.332880054258;5598.86002849932;5598.888022239451;5611.747471363717;5676.318841738853;5692.715364231854;5695.088785794253;5701.201831743476;5708.372079071381;5571.721413929206;5576.414476479911;5576.888462230814;5590.580706446952;5593.720313984203 05:05:43 INFO - PID 6362 | |5;yui.html;646.6346514219466;650.5543702563741;653.6176336842947;661.5798967655538;669.2905520148643;12460.937695311522;12902.548410805624;13072.281024543658;13099.47602095915;13160.341982900853;13455;13469.528566500174;13541.93229033856;13546;13563.660908477294;911.2118017914489;926.6247169896169;928.8838895138108;929.0987741890356;929.60027188309;879.2833840420069;919.5034681272139;927.7912469694332;928.7585227840776;929.1544694328163;952.8142012307603;959.5777857742571;961.5048250151178;962.033156677538;962.3600305796637;946.507815935713;949.7673070097801;951.3245595627113;954.7708549947997;955.0640372435053;698.601796975724;701.7649087555675;702.2135208566388;704.4399702236734;704.6793708862456;13689.726205475934;14381.35283912216;14538.273086345745;14786.334614942354;14955.102693838404;12999.545015924492;13754.95327288432;13794.448222071205;13842.377093030838;13874.167549947035;10674.519646615921;10956.56173753049;11135.610253641165;11283.830742538868;11648.53405863773;2678.879450424716;2682.825616334932;2700.203439985209;2742.794290428226;2798.8040837141407;67310.66344668294;67322;67585;67859.66070169667;68199.3180068203;11061.778764424827;11104.833427498594;11176.608818691308;11212;11282.774344513064;22083.558328833333;22223.888880555493;22285.77714222837;22317.888410558167;22606.139679968885;6571.638559879252;6587.308332625101;6588.86822263552;6604.537682362188;6836.111305530349;3354.1279267390164;3374.2239284964594;3418.8290585470627;3425.5546778918583;3492.7031202347575;3623.6195199503672;3680.6687398133763;3691.040329514292;3705.888823335304;3739.5512538495555;639.728115550889;641.3522342434175;646.1051443750346;658.1181217169017;658.256170527301;532.7682458130648;535.5715427657937;554.8446434998207;557.364136260078;564.5681053993698;8418.349503891857;8473.5339556325;8714.302855771522;8926.86609700855;9102.772430689154;544.8229325469239;547.9232907392968;559.105431309909;562.3504851896066;573.8335882594084;3488.424409972326;3501.8599256029984;3523.8766643167364;3543.20277937462;3665.4501824726503;64508;64982.675086624266;65803.34196658067;66860.66569667218;67864.3213567868;56804.71597641985;57270.713646432334;58280.4171958275;59155.99999999914;59414;52249.738751306;52458.21312680313;53294;53320;53774;7294.307040831112;7366.410687145123;7489.588072656056;7500.662470188746;7573.697052117854;28614.42771144607;28619.856900715364;28906.27734306575;29060.27349316284;29348;33301.167470812456;33559.49660755042;33673.49489757606;33707.123680777026;34329.828350858086;10031.164687287892;10272.435016073889;10316.43259620728;10557.788844223227;10573.629922952967;9989.150922171697;10062.195024397884;10100.343477673927;10221.9488902555;10552.472376381304;9029.187373136449;9269.443833369749;9292.39599426035;9364.531773411438;9403.952980235055;9342.626294948126;9459.858102128335;9530.428174309563;9655.131038206315;9860.901390985999;9760.707178784647;9783.755406114904;9811.339588740382;9917.752056198653;10224.64213752515;6192.442680158807;6417.93582064192;6431.614103153825;6495.577787443801;6509.707063182263;7139.428845692229;7739.961300193463;10187.185025198114;10740.409277489813;10772.676819695422 05:05:43 INFO - PID 6362 | __end_tp_report 05:05:43 INFO - PID 6362 | __start_cc_report 05:05:43 INFO - PID 6362 | _x_x_mozilla_cycle_collect,1635 05:05:43 INFO - PID 6362 | __end_cc_report 05:05:43 INFO - PID 6362 | __startTimestamp1491048343946__endTimestamp 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | ------- Summary: start ------- 05:05:43 INFO - PID 6362 | Number of tests: 6 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#0] dojo.html Cycles:165 Average:5192.06 Median:5338.23 stddev:606.14 (11.4%) stddev-sans-first:575.26 05:05:43 INFO - PID 6362 | Values: 2687.0 2737.2 2772.9 2777.3 2782.2 5132.7 5228.5 5238.2 5253.7 5300.8 5255.9 5258.5 5275.8 5279.8 5280.9 4670.6 4695.0 4735.5 4739.5 4767.7 4719.0 4719.6 4748.4 4758.5 4764.1 4726.0 4741.8 4756.0 4760.9 4764.1 4724.2 4726.3 4741.6 4756.9 4802.6 4691.0 4696.0 4700.7 4711.7 4750.5 4998.8 5112.5 5115.4 5141.3 5202.3 5549.9 5602.6 5678.9 5684.8 5691.6 5728.4 5731.6 5742.2 5743.5 5746.7 5321.4 5325.3 5326.2 5332.2 5376.7 5715.6 5793.7 5797.4 5854.0 5885.6 5600.7 5608.1 5610.8 5616.3 5668.7 5681.2 5712.3 5714.7 5717.0 5719.4 5498.0 5517.2 5585.8 5627.9 5672.2 5580.6 5664.3 5666.8 5712.8 5713.3 4770.9 4771.4 4773.6 4773.8 4817.7 3990.9 4053.2 4078.2 4085.2 4096.0 4681.5 4729.4 4734.3 4736.8 4740.3 5625.5 5725.0 5807.2 5808.1 5808.2 4810.8 4828.3 4828.9 4831.1 4850.0 5087.0 5091.9 5106.2 5109.4 5112.3 5150.6 5174.7 5225.6 5229.2 5253.8 5610.9 5641.7 5725.4 5739.2 5745.3 5289.2 5313.5 5323.5 5348.6 5374.8 5620.3 5628.3 5632.4 5633.7 5636.2 5526.3 5586.5 5650.3 5733.2 5783.7 5428.6 5450.7 5504.2 5517.1 5537.0 5468.4 5484.8 5491.7 5493.4 5499.2 5338.2 5377.9 5430.9 5442.1 5492.4 5552.2 5552.2 5598.4 5630.9 5632.7 5435.4 5438.6 5442.0 5446.6 5448.8 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#1] ext.html Cycles:180 Average:33879.53 Median:2944.07 stddev:52501.56 (1783.3%) stddev-sans-first:52589.57 05:05:43 INFO - PID 6362 | Values: 653.9 699.5 718.5 1092.6 1110.5 28033.9 28715.3 28822.6 35362.8 35571.1 37418.0 37701.4 37832.9 37866.0 37952.4 7210.5 7365.5 7375.1 7378.1 7386.0 5421.9 5505.5 7065.3 7197.1 7282.7 7312.9 7319.0 7359.7 7374.1 7394.2 7281.8 7299.0 7352.1 7355.4 7369.7 5261.3 5373.9 7070.3 7181.4 7264.7 34447.5 34890.3 34945.0 34960.7 34973.7 2629.2 2636.0 2646.9 2659.3 2659.9 22702.7 23085.9 23283.7 23332.2 23375.8 2891.5 2940.4 2947.7 2947.7 2985.8 139464.0 139868.3 140073.0 140385.0 140512.0 42159.2 42190.4 42238.0 42258.4 42287.4 42221.6 42299.8 42471.8 42580.8 42604.0 12844.0 13128.4 13134.1 13208.0 13297.6 10501.5 10505.5 10507.4 10510.6 10602.3 11370.5 11557.3 13067.3 13365.9 13489.7 5504.8 5630.8 5632.3 5641.4 5641.9 887.7 919.4 935.6 936.9 938.3 20799.8 21585.4 21721.3 21745.9 21752.2 990.6 1004.7 1005.9 1019.9 1030.6 11030.3 11440.5 11516.0 11519.8 11535.5 240502.0 241314.0 243050.0 243327.0 243346.0 43349.0 43399.1 43589.3 43790.3 43873.6 1240.3 1271.0 1287.9 1299.4 1299.8 19894.8 19972.4 20789.3 20858.8 21582.8 30967.0 30967.4 31009.7 31081.7 31094.8 206404.0 207967.0 208051.0 209168.0 209263.0 30404.7 30750.0 30752.4 31488.5 31605.0 30696.0 31292.8 32932.0 33810.8 37981.8 27593.3 27702.4 27975.7 28164.2 29265.3 27924.9 27956.6 28125.9 29205.9 29264.0 31162.1 31512.5 31577.4 31710.3 32142.8 26759.0 26887.7 28258.0 28299.3 28904.7 21247.7 22441.2 22572.1 22704.2 22911.7 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#2] jquery.html Cycles:180 Average:30305.76 Median:44993.66 stddev:81210.71 (180.5%) stddev-sans-first:81407.49 05:05:43 INFO - PID 6362 | Values: 400.2 410.2 413.9 415.0 426.8 11686.9 18272.0 18698.3 19111.2 19118.1 14487.5 16147.8 19344.2 19533.2 19763.7 5404.3 5452.3 5570.7 5571.9 5581.2 5335.7 5466.0 5556.2 5558.5 5560.6 5505.5 5529.8 5541.4 5543.4 5552.0 5360.9 5483.6 5517.5 5532.4 5541.9 4968.1 4974.9 4981.7 4989.2 4992.6 21259.8 22413.9 22422.1 22486.6 22597.3 1610.5 1617.1 1627.5 1648.0 1665.9 13773.9 14288.0 14468.0 15136.0 15581.0 2037.5 2043.0 2059.8 2069.1 2070.7 95766.0 97784.0 98199.5 98485.5 99970.0 18210.0 18216.4 18402.2 18887.2 18890.2 34512.0 34644.3 34727.5 35083.5 35184.8 7740.5 8085.6 8093.4 8965.0 9281.4 6390.0 6407.8 6434.4 6444.5 6446.7 7653.5 9187.3 9690.8 9803.2 9916.6 3700.4 3763.9 3784.5 3840.1 3937.5 895.6 896.4 918.5 919.2 938.8 16551.8 16848.1 17588.6 17607.0 17855.9 912.8 912.8 934.4 942.9 943.2 9112.6 9754.2 9770.6 9824.7 9866.4 470780.0 473404.0 501182.0 501626.0 502322.2 95049.0 96384.5 96860.5 98036.0 99340.0 1095.5 1102.5 1151.6 1155.0 1155.8 17078.4 17307.2 17757.5 17843.7 18050.9 41977.6 43231.6 43965.8 44000.0 45987.3 55980.7 56293.0 57465.7 58009.7 58055.7 7922.8 7987.9 8059.4 8075.0 8399.4 12658.7 12691.8 12731.5 12896.3 13167.6 10843.5 11067.2 11203.9 11312.9 11694.2 9936.0 9943.5 9975.9 10035.4 10114.5 11177.3 11330.3 11359.9 11554.4 11891.9 7846.1 7908.4 8060.0 8099.6 8172.1 11051.8 11124.6 11440.8 11456.0 11495.9 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#3] mootools.html Cycles:180 Average:6174.25 Median:4762.10 stddev:3916.21 (82.2%) stddev-sans-first:3909.95 05:05:43 INFO - PID 6362 | Values: 1283.9 1308.4 1317.3 1322.2 1341.8 9504.7 9775.6 9887.2 9897.8 9936.2 9700.1 10131.3 10133.8 10140.7 10154.7 2243.7 2275.9 2283.0 2284.0 2284.8 1859.0 2118.8 2123.1 2127.6 2239.8 1851.6 2189.9 2255.2 2260.9 2266.0 2149.4 2156.1 2163.7 2174.2 2185.4 2137.5 2138.7 2139.0 2145.7 2147.2 9654.2 9737.0 9742.6 9862.0 9867.8 5441.8 5631.4 5635.7 5637.6 5642.8 3041.3 3150.3 3293.5 3364.5 3367.4 1034.6 1060.5 1069.7 1099.4 1110.5 14224.6 14395.4 14523.1 14527.5 14552.4 4605.2 4712.8 4811.4 4826.1 4839.3 10509.2 10521.9 10540.6 10644.9 10652.7 5416.2 5417.4 5420.8 5461.5 5473.0 4893.0 4984.5 5047.9 5078.9 5081.3 3786.9 3842.9 3850.7 3892.1 3994.0 1006.7 1006.8 1013.3 1020.3 1028.6 565.3 672.3 730.3 732.1 752.4 5647.9 5774.5 5779.0 5784.2 5926.9 552.3 561.2 569.1 573.3 674.4 3599.6 3654.7 3676.2 3716.6 3956.1 12126.9 12928.7 13074.6 13078.3 13079.8 12796.2 12880.6 12987.0 13019.2 13101.3 9177.1 9181.1 9216.7 9329.5 9336.3 5633.6 5645.0 5753.7 5903.9 6029.5 11110.1 11336.1 11384.4 11450.8 11488.3 11595.8 11627.1 11635.4 11721.5 11751.8 7932.6 8110.3 8160.3 8168.6 8170.7 8581.8 8848.3 8930.1 8979.7 9015.4 7931.6 8074.6 8084.2 8129.7 8187.6 7854.5 7864.3 7904.4 7976.8 8020.7 7132.7 7225.4 7239.6 7244.3 7244.7 5347.3 5359.2 5409.4 5501.5 5605.2 5076.0 5107.5 5150.3 5174.0 5259.2 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#4] prototype.html Cycles:180 Average:4654.65 Median:5247.98 stddev:1364.52 (26.0%) stddev-sans-first:1330.01 05:05:43 INFO - PID 6362 | Values: 375.4 392.3 394.8 395.3 401.7 5359.9 5401.5 5402.8 5415.2 5431.9 5063.2 5230.1 5231.8 5245.5 5264.1 4051.7 4064.5 4078.8 4079.5 4079.6 4082.7 4083.4 4084.7 4084.8 4092.0 3851.4 3996.8 4023.0 4044.9 4047.6 3979.8 4007.5 4028.5 4034.3 4040.2 3548.1 3554.4 3558.8 3561.9 3563.1 4968.0 5118.9 5129.8 5137.8 5140.2 4754.3 4756.9 4760.6 4787.8 4791.4 5566.9 5608.2 5620.8 5623.7 5624.2 3920.0 4009.4 4020.7 4024.5 4034.0 5626.6 5768.7 5813.0 5862.8 5996.3 4027.4 4040.6 4049.8 4050.1 4051.4 4102.2 4116.1 4120.7 4121.7 4122.0 4380.6 4457.8 4564.5 4566.3 4705.7 5561.4 5589.7 5596.4 5637.3 5644.2 1418.5 1441.7 1441.7 1441.9 1447.4 938.5 960.8 965.5 968.2 971.8 4872.7 4887.7 4910.8 4919.2 4920.6 5843.3 5847.5 5857.1 5861.0 5866.9 4709.7 4876.2 4933.8 4967.0 4970.3 3075.0 3098.4 3110.9 3112.4 3115.4 5180.8 5433.5 5436.4 5473.0 5489.3 5960.3 5986.9 6005.7 6005.9 6043.8 5401.9 5475.3 5482.2 5486.9 5496.1 5765.2 5843.6 5864.7 5876.2 5898.2 5756.8 5774.6 5775.9 5793.0 5793.6 5146.8 5250.4 5283.5 5307.8 5435.6 4037.3 4393.7 4422.8 4432.7 4436.2 5824.3 5844.3 5860.4 5862.5 5876.6 5435.4 5652.6 5670.0 5678.9 5685.2 5643.2 5657.9 5661.7 5669.9 5690.4 5373.8 5559.3 5598.9 5598.9 5611.7 5676.3 5692.7 5695.1 5701.2 5708.4 5571.7 5576.4 5576.9 5590.6 5593.7 05:05:43 INFO - PID 6362 | 05:05:43 INFO - PID 6362 | [#5] yui.html Cycles:180 Average:14297.82 Median:563.46 stddev:18371.15 (3260.4%) stddev-sans-first:18394.08 05:05:43 INFO - PID 6362 | Values: 646.6 650.6 653.6 661.6 669.3 12460.9 12902.5 13072.3 13099.5 13160.3 13455.0 13469.5 13541.9 13546.0 13563.7 911.2 926.6 928.9 929.1 929.6 879.3 919.5 927.8 928.8 929.2 952.8 959.6 961.5 962.0 962.4 946.5 949.8 951.3 954.8 955.1 698.6 701.8 702.2 704.4 704.7 13689.7 14381.4 14538.3 14786.3 14955.1 12999.5 13755.0 13794.4 13842.4 13874.2 10674.5 10956.6 11135.6 11283.8 11648.5 2678.9 2682.8 2700.2 2742.8 2798.8 67310.7 67322.0 67585.0 67859.7 68199.3 11061.8 11104.8 11176.6 11212.0 11282.8 22083.6 22223.9 22285.8 22317.9 22606.1 6571.6 6587.3 6588.9 6604.5 6836.1 3354.1 3374.2 3418.8 3425.6 3492.7 3623.6 3680.7 3691.0 3705.9 3739.6 639.7 641.4 646.1 658.1 658.3 532.8 535.6 554.8 557.4 564.6 8418.3 8473.5 8714.3 8926.9 9102.8 544.8 547.9 559.1 562.4 573.8 3488.4 3501.9 3523.9 3543.2 3665.5 64508.0 64982.7 65803.3 66860.7 67864.3 56804.7 57270.7 58280.4 59156.0 59414.0 52249.7 52458.2 53294.0 53320.0 53774.0 7294.3 7366.4 7489.6 7500.7 7573.7 28614.4 28619.9 28906.3 29060.3 29348.0 33301.2 33559.5 33673.5 33707.1 34329.8 10031.2 10272.4 10316.4 10557.8 10573.6 9989.2 10062.2 10100.3 10221.9 10552.5 9029.2 9269.4 9292.4 9364.5 9404.0 9342.6 9459.9 9530.4 9655.1 9860.9 9760.7 9783.8 9811.3 9917.8 10224.6 6192.4 6417.9 6431.6 6495.6 6509.7 7139.4 7740.0 10187.2 10740.4 10772.7 05:05:43 INFO - PID 6362 | -------- Summary: end -------- 05:05:43 INFO - PID 6362 | 05:05:44 INFO - TEST-INFO | 6362: exit 0 05:05:44 INFO - TEST-OK | dromaeo_css | took 1124978ms 05:05:44 INFO - TEST-START | kraken 05:05:44 INFO - operating with platform_type : linux_ 05:05:44 INFO - Initialising browser for kraken test... 05:05:44 INFO - TEST-INFO | started process 6691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0Lq8v/profile http://localhost:33331/getInfo.html) 05:05:48 INFO - PID 6691 | __metrics Screen width/height:1600/1200 05:05:48 INFO - PID 6691 | colorDepth:24 05:05:48 INFO - PID 6691 | Browser inner width/height: 1024/697 05:05:48 INFO - PID 6691 | __metrics 05:05:49 INFO - PID 6691 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:49 INFO - PID 6691 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:50 INFO - TEST-INFO | 6691: exit 0 05:05:50 INFO - Browser initialized. 05:05:50 INFO - Running cycle 1/1 for kraken test... 05:05:50 INFO - TEST-INFO | started process 6793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0Lq8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:02 INFO - PID 6793 | RSS: Main: 166322176 05:06:02 INFO - PID 6793 | 05:06:05 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33331/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:06 INFO - PID 6793 | RSS: Main: 225304576 05:06:06 INFO - PID 6793 | 05:06:09 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33331/tests/kraken/driver.html?testName=audio-dft) 05:06:10 INFO - PID 6793 | RSS: Main: 204337152 05:06:10 INFO - PID 6793 | 05:06:13 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33331/tests/kraken/driver.html?testName=audio-fft) 05:06:13 INFO - PID 6793 | RSS: Main: 287727616 05:06:13 INFO - PID 6793 | 05:06:15 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33331/tests/kraken/driver.html?testName=audio-oscillator) 05:06:16 INFO - PID 6793 | RSS: Main: 199991296 05:06:16 INFO - PID 6793 | 05:06:18 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:19 INFO - PID 6793 | RSS: Main: 203776000 05:06:19 INFO - PID 6793 | 05:06:22 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33331/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:23 INFO - PID 6793 | RSS: Main: 242511872 05:06:23 INFO - PID 6793 | 05:06:27 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33331/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:27 INFO - PID 6793 | RSS: Main: 234811392 05:06:27 INFO - PID 6793 | 05:06:30 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33331/tests/kraken/driver.html?testName=json-parse-financial) 05:06:31 INFO - PID 6793 | RSS: Main: 241491968 05:06:31 INFO - PID 6793 | 05:06:32 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:33 INFO - PID 6793 | RSS: Main: 204832768 05:06:33 INFO - PID 6793 | 05:06:35 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:35 INFO - PID 6793 | RSS: Main: 211820544 05:06:35 INFO - PID 6793 | 05:06:38 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:38 INFO - PID 6793 | RSS: Main: 218120192 05:06:38 INFO - PID 6793 | 05:06:41 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:42 INFO - PID 6793 | RSS: Main: 228241408 05:06:42 INFO - PID 6793 | 05:06:45 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:46 INFO - PID 6793 | RSS: Main: 226004992 05:06:46 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | Cycle 1(1): loaded http://localhost:33331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33331/tests/kraken/driver.html?testName=ai-astar) 05:06:48 INFO - PID 6793 | RSS: Main: 292614144 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | __start_tp_report 05:06:48 INFO - PID 6793 | _x_x_mozilla_page_load 05:06:48 INFO - PID 6793 | _x_x_mozilla_page_load_details 05:06:48 INFO - PID 6793 | |i|pagename|runs| 05:06:48 INFO - PID 6793 | |0;ai-astar;108;112;112;112;113;111;112;111;118;109 05:06:48 INFO - PID 6793 | |1;audio-beat-detection;147;127;123;170;130;125;126;125;160;126 05:06:48 INFO - PID 6793 | |2;audio-dft;163;164;164;164;165;166;165;164;164;164 05:06:48 INFO - PID 6793 | |3;audio-fft;75;75;76;104;77;76;78;78;92;78 05:06:48 INFO - PID 6793 | |4;audio-oscillator;83;83;123;83;83;84;110;89;87;115 05:06:48 INFO - PID 6793 | |5;imaging-gaussian-blur;113;114;114;114;114;114;114;114;113;114 05:06:48 INFO - PID 6793 | |6;imaging-darkroom;153;153;153;152;152;153;152;153;153;151 05:06:48 INFO - PID 6793 | |7;imaging-desaturate;95;94;95;94;95;99;94;94;94;94 05:06:48 INFO - PID 6793 | |8;json-parse-financial;52;52;53;53;54;55;54;53;54;54 05:06:48 INFO - PID 6793 | |9;json-stringify-tinderbox;57;56;58;57;57;57;57;56;57;56 05:06:48 INFO - PID 6793 | |10;stanford-crypto-aes;83;82;84;84;83;81;83;82;82;84 05:06:48 INFO - PID 6793 | |11;stanford-crypto-ccm;139;131;145;139;133;133;142;133;177;137 05:06:48 INFO - PID 6793 | |12;stanford-crypto-pbkdf2;192;197;195;194;202;203;192;199;185;193 05:06:48 INFO - PID 6793 | |13;stanford-crypto-sha256-iterative;70;73;72;70;72;71;70;71;70;70 05:06:48 INFO - PID 6793 | __end_tp_report 05:06:48 INFO - PID 6793 | __start_cc_report 05:06:48 INFO - PID 6793 | _x_x_mozilla_cycle_collect,1992 05:06:48 INFO - PID 6793 | __end_cc_report 05:06:48 INFO - PID 6793 | __startTimestamp1491048408313__endTimestamp 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | ------- Summary: start ------- 05:06:48 INFO - PID 6793 | Number of tests: 14 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.66 (2.4%) stddev-sans-first:2.44 05:06:48 INFO - PID 6793 | Values: 108.0 112.0 112.0 112.0 113.0 111.0 112.0 111.0 118.0 109.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:128.50 stddev:16.93 (13.2%) stddev-sans-first:17.48 05:06:48 INFO - PID 6793 | Values: 147.0 127.0 123.0 170.0 130.0 125.0 126.0 125.0 160.0 126.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 05:06:48 INFO - PID 6793 | Values: 163.0 164.0 164.0 164.0 165.0 166.0 165.0 164.0 164.0 164.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#3] audio-fft Cycles:10 Average:80.90 Median:77.50 stddev:9.52 (12.3%) stddev-sans-first:9.85 05:06:48 INFO - PID 6793 | Values: 75.0 75.0 76.0 104.0 77.0 76.0 78.0 78.0 92.0 78.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:83.00 stddev:15.62 (18.8%) stddev-sans-first:16.05 05:06:48 INFO - PID 6793 | Values: 83.0 83.0 123.0 83.0 83.0 84.0 110.0 89.0 87.0 115.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:06:48 INFO - PID 6793 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:153.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:06:48 INFO - PID 6793 | Values: 153.0 153.0 153.0 152.0 152.0 153.0 152.0 153.0 153.0 151.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.64 05:06:48 INFO - PID 6793 | Values: 95.0 94.0 95.0 94.0 95.0 99.0 94.0 94.0 94.0 94.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 05:06:48 INFO - PID 6793 | Values: 52.0 52.0 53.0 53.0 54.0 55.0 54.0 53.0 54.0 54.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 05:06:48 INFO - PID 6793 | Values: 57.0 56.0 58.0 57.0 57.0 57.0 57.0 56.0 57.0 56.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 05:06:48 INFO - PID 6793 | Values: 83.0 82.0 84.0 84.0 83.0 81.0 83.0 82.0 82.0 84.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:139.00 stddev:13.45 (9.7%) stddev-sans-first:14.25 05:06:48 INFO - PID 6793 | Values: 139.0 131.0 145.0 139.0 133.0 133.0 142.0 133.0 177.0 137.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.20 Median:196.00 stddev:5.33 (2.7%) stddev-sans-first:5.53 05:06:48 INFO - PID 6793 | Values: 192.0 197.0 195.0 194.0 202.0 203.0 192.0 199.0 185.0 193.0 05:06:48 INFO - PID 6793 | 05:06:48 INFO - PID 6793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 05:06:48 INFO - PID 6793 | Values: 70.0 73.0 72.0 70.0 72.0 71.0 70.0 71.0 70.0 70.0 05:06:48 INFO - PID 6793 | -------- Summary: end -------- 05:06:48 INFO - PID 6793 | 05:06:49 INFO - TEST-INFO | 6793: exit 0 05:06:49 INFO - TEST-OK | kraken | took 64833ms 05:06:49 INFO - SUITE-END | took 1189s 05:06:49 INFO - Completed test suite (00:19:50) 05:06:49 INFO - javascript benchmark 05:06:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6692.141146369611, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.959695604566, 2737.1651646247888, 2772.944541109178, 2777.291790593398, 2782.193163982445, 5132.692038477694, 5228.5294323510925, 5238.2142678598275, 5253.658512196705, 5300.840974770758, 5255.921161182576, 5258.474152584739, 5275.788968441268, 5279.841604751864, 5280.867978300545, 4670.579647831703, 4694.976525117369, 4735.455422626407, 4739.478657347689, 4767.713937163781, 4719.032598317337, 4719.551642593965, 4748.430188377382, 4758.524147585248, 4764.118638051954, 4725.952740472603, 4741.762911854411, 4756.048790241948, 4760.928586071212, 4764.094821983829, 4724.17326967781, 4726.26742854858, 4741.5732584067255, 4756.9286460703115, 4802.615790736768, 4691.014886873761, 4696.0, 4700.741459219742, 4711.740854253015, 4750.453697824725, 4998.750062496861, 5112.514311140473, 5115.360579927509, 5141.305923700327, 5202.271681964528, 5549.944500554983, 5602.551795856321, 5678.858028549278, 5684.772609095631, 5691.573132015074, 5728.398518155617, 5731.570132240057, 5742.2247996520355, 5743.4543718346695, 5746.655200687972, 5321.414644389114, 5325.334333208349, 5326.174442961308, 5332.200169974535, 5376.650517716336, 5715.599908006399, 5793.710314484343, 5797.36229014808, 5853.970730146322, 5885.646861188342, 5600.747966341524, 5608.10270356741, 5610.803621873215, 5616.297962754656, 5668.659880407106, 5681.233033540502, 5712.314522257273, 5714.657120572779, 5717.0, 5719.399463056402, 5498.0, 5517.172424136332, 5585.832425027255, 5627.915581266284, 5672.177534257509, 5580.637258578179, 5664.320281566238, 5666.801661941812, 5712.771489140471, 5713.2572765541045, 4770.856874293777, 4771.379720636295, 4773.570378665937, 4773.809047638056, 4817.735024573612, 3990.9201815964097, 4053.1893621275863, 4078.1639763848934, 4085.2442298174933, 4096.0, 4681.508441613581, 4729.36153619257, 4734.26618874075, 4736.834210802605, 4740.312654665055, 5625.54995600351, 5725.026745453283, 5807.157962095473, 5808.128780682931, 5808.157817116495, 4810.807567697323, 4828.348172996671, 4828.903421931542, 4831.106245344552, 4849.975750121227, 5087.033463641897, 5091.9236211456855, 5106.208537676666, 5109.3613298337705, 5112.284280200849, 5150.639455238247, 5174.7153906535505, 5225.555827754683, 5229.189475631283, 5253.842384728464, 5610.887782244414, 5641.746121424464, 5725.427457254241, 5739.196512488338, 5745.3105627324985, 5289.20661900718, 5313.548348390275, 5323.494268044529, 5348.57211423093, 5374.7581358839725, 5620.269364982526, 5628.268325117709, 5632.380438151882, 5633.690147041952, 5636.239107720406, 5526.281583394133, 5586.52514536269, 5650.26546548946, 5733.197352370755, 5783.710814459344, 5428.565714742732, 5450.700211488406, 5504.174373843955, 5517.117261238182, 5537.0, 5468.425815289337, 5484.780608775604, 5491.725413729378, 5493.368262649687, 5499.175123731312, 5338.225957236256, 5377.892442151213, 5430.864228394164, 5442.0748472760515, 5492.368377636463, 5552.222688823487, 5552.222688823487, 5598.384177740364, 5630.915536267041, 5632.690202038927, 5435.429279925551, 5438.646487978269, 5441.972790136182, 5446.618736688394, 5448.83653490396], "value": 5148.277704908345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9280679125295, 699.5173330402022, 718.5221827484723, 1092.633967620847, 1110.5280255891244, 28033.859830700843, 28715.282117947063, 28822.567661485093, 35362.82318588404, 35571.110722231955, 37418.0, 37701.43447848278, 37832.86501404955, 37866.0, 37952.43071353932, 7210.4952653314285, 7365.484416090876, 7375.078115235596, 7378.114626244858, 7385.999999999973, 5421.891562168754, 5505.504504594585, 7065.293470652945, 7197.064381630381, 7282.708691652354, 7312.890306645405, 7318.963405182966, 7359.705611775523, 7374.078240219973, 7394.223606521318, 7281.817954551126, 7299.0, 7352.080989876265, 7355.448341374418, 7369.742059027908, 5261.289725887033, 5373.892522149535, 7070.328318809705, 7181.35367816899, 7264.745733899288, 34447.48328775071, 34890.30219395623, 34945.0, 34960.650393496246, 34973.65026349729, 2629.1718108795667, 2636.0378461861474, 2646.947061058768, 2659.321872922412, 2659.906903258396, 22702.659460108112, 23085.884570577207, 23283.650745238836, 23332.183373582015, 23375.7662423377, 2891.4506243813607, 2940.4119176164854, 2947.7199666031693, 2947.7494412974925, 2985.805922615045, 139464.0, 139868.3006584971, 140073.0, 140385.0, 140512.0, 42159.15681686349, 42190.367144492855, 42238.0, 42258.36612450816, 42287.365689514685, 42221.577784222376, 42299.7885010573, 42471.78764106221, 42580.78709606432, 42604.0, 12844.0, 13128.409221584861, 13134.080614357094, 13208.0, 13297.601071967856, 10501.527431265611, 10505.52725127371, 10507.422091785025, 10510.63212787564, 10602.310849794738, 11370.488328025258, 11557.30656160633, 13067.346632668328, 13365.933170334087, 13489.730205395837, 5504.80733174337, 5630.831075067755, 5632.2678051853, 5641.407652196543, 5641.9435805641415, 887.6804350433839, 919.4483310013939, 935.6386457704024, 936.9437833729997, 938.3290946972811, 20799.79200208009, 21585.352439426842, 21721.34835954924, 21745.891270543547, 21752.238671646417, 990.6483198464585, 1004.7440699126092, 1005.9356141801231, 1019.9133073688671, 1030.5620111452602, 11030.338179709082, 11440.485178167002, 11516.0, 11519.827202591969, 11535.480903359368, 240502.0, 241314.0, 243050.0, 243327.0, 243346.0, 43349.0, 43399.13201735948, 43589.346159807625, 43790.34314485285, 43873.56126438759, 1240.3240234072452, 1271.040364524778, 1287.8583355830851, 1299.4087690100982, 1299.7920332746526, 19894.801051989874, 19972.400827975183, 20789.272375466786, 20858.791412085684, 21582.784172158077, 30967.0, 30967.380652387277, 31009.68990310068, 31081.68918310788, 31094.844525777225, 206404.0, 207967.0, 208051.0, 209168.0, 209263.0, 30404.695953040187, 30750.0, 30752.384952301276, 31488.527672085394, 31605.0, 30696.0, 31292.843535782176, 32932.0, 33810.83094584511, 37981.810090949366, 27593.310167245978, 27702.44595108127, 27975.72024279731, 28164.15507534777, 29265.268368290963, 27924.86037569799, 27956.580651290653, 28125.859370703834, 29205.85397073001, 29264.0, 31162.065138045895, 31512.527312090795, 31577.36845263128, 31710.255935923746, 32142.83928580342, 26759.0, 26887.73112268852, 28258.0, 28299.292517686397, 28904.7109528902, 21247.681284780432, 22441.21455749041, 22572.097116115172, 22704.205352812573, 22911.65632515547], "value": 14904.031692170869, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.1696479804407, 410.1714536635993, 413.89238797912554, 414.96680265578755, 426.8335349213807, 11686.883131168686, 18272.0, 18698.252069917187, 19111.235550577978, 19118.13968371423, 14487.492937747182, 16147.757783633255, 19344.226230950746, 19533.218671253133, 19763.703544446846, 5404.270423492837, 5452.291202143716, 5570.6657600544095, 5571.9442805572035, 5581.2186293918885, 5335.706536140511, 5465.9726701366435, 5556.222128901957, 5558.527525160366, 5560.555155587544, 5505.476979686943, 5529.751161197756, 5541.362743284513, 5543.445655434464, 5552.028395030874, 5360.892782144374, 5483.588730845163, 5517.531009864167, 5532.419095994903, 5541.944580554183, 4968.080905032544, 4974.900501989976, 4981.72600506972, 4989.226669866177, 4992.575631071363, 21259.787402125934, 22413.887930560242, 22422.103115875347, 22486.55026899469, 22597.322080337617, 1610.5248951559317, 1617.086346214385, 1627.5280168751049, 1648.0311859742885, 1665.8667306615441, 13773.907154843118, 14288.0, 14468.0, 15136.0, 15581.0, 2037.5313677854028, 2042.9591408171752, 2059.8405508783717, 2069.1102825784906, 2070.6686930091264, 95766.0, 97784.0, 98199.50900245596, 98485.50757246168, 99970.0, 18210.0, 18216.36242731498, 18402.171902264432, 18887.150078246512, 18890.244390224238, 34512.0, 34644.30711385758, 34727.47908781371, 35083.473747893804, 35184.824075879456, 7740.458167928304, 8085.595720213966, 8093.352531797442, 8964.955175224213, 9281.350305478552, 6390.009548519987, 6407.839804004937, 6434.388733070351, 6444.484441244689, 6446.709898054599, 7653.469306138794, 9187.26501879848, 9690.806183876282, 9803.167115566226, 9916.553755081039, 3700.444933259979, 3763.9247215055548, 3784.4701741756176, 3840.143780734347, 3937.488126543531, 895.5566994337845, 896.3994123936848, 918.4856480371013, 919.2462181011506, 938.8028514012134, 16551.83448165503, 16848.07335596554, 17588.648227035388, 17607.0, 17855.910720446314, 912.7540906662358, 912.7854954085784, 934.4159900062461, 942.9292803039799, 943.217129782279, 9112.589933453011, 9754.219662426989, 9770.560324785401, 9824.656137035312, 9866.408015519091, 470780.0, 473404.0, 501182.0, 501626.0, 502322.1865048245, 95049.0, 96384.51807740917, 96860.51569742105, 98036.0, 99340.0, 1095.4960718069776, 1102.4542851288504, 1151.6199654114123, 1154.9595764148214, 1155.7861795567846, 17078.402255920984, 17307.154276578938, 17757.537280230747, 17843.732344014592, 18050.90974545119, 41977.58022419859, 43231.567684324014, 43965.78017110022, 44000.0, 45987.31019034784, 55980.72009639926, 56293.0, 57465.71267143638, 58009.70995144997, 58055.70972145112, 7922.762317130495, 7987.85239056171, 8059.395545334006, 8075.0, 8399.41204115706, 12658.746825063632, 12691.80962285585, 12731.490740370282, 12896.29070401137, 13167.60497185086, 10843.512041957973, 11067.169962252703, 11203.887961120285, 11312.886871131182, 11694.239874408477, 9935.950320248352, 9943.502824858873, 9975.900240997787, 10035.397876127456, 10114.494275286059, 11177.329360238411, 11330.320180789178, 11359.886401135884, 11554.364509951698, 11891.94054029759, 7846.058472983279, 7908.3673306136525, 8059.959700201462, 8099.595020249082, 8172.141925097779, 11051.83422248683, 11124.61063862761, 11440.828387574027, 11456.0, 11495.885041149815], "value": 9687.363224340974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.8972882169426, 1308.3719814489045, 1317.3215793866166, 1322.2397121655044, 1341.7920222365533, 9504.714858554236, 9775.608975640966, 9887.20902327814, 9897.75255618609, 9936.155426788722, 9700.126988571028, 10131.34146280493, 10133.847992280103, 10140.74648133797, 10154.69535913922, 2243.7083179186725, 2275.9089636414606, 2283.041122728458, 2283.9771602284013, 2284.794368506834, 1858.9535261618432, 2118.798714122156, 2123.1295168980723, 2127.5744851029776, 2239.7536271010176, 1851.6204178143516, 2189.9343019709436, 2255.244493094807, 2260.9095636174534, 2265.9660105098437, 2149.4196566927, 2156.148321413041, 2163.6862654915026, 2174.2281490070955, 2185.4099393163915, 2137.5297434564372, 2138.7326584176976, 2139.048123585005, 2145.678148277755, 2147.226998280618, 9654.22766178704, 9737.026297370277, 9742.561584728704, 9861.950690246575, 9867.802643947152, 5441.809536666237, 5631.352394474606, 5635.746391412396, 5637.633553818989, 5642.815008848147, 3041.3461105862348, 3150.2754366495606, 3293.4565796643524, 3364.5457863188403, 3367.44437167867, 1034.5654824973528, 1060.4697651174413, 1069.663056137322, 1099.3623698254994, 1110.5058249079163, 14224.644383890382, 14395.424183032666, 14523.128612283192, 14527.491537796126, 14552.417903283857, 4605.194091034055, 4712.835050773275, 4811.374521312207, 4826.083044221657, 4839.274108883626, 10509.159267258601, 10521.894781052091, 10540.578376864993, 10644.94677526623, 10652.680419587425, 5416.214648875891, 5417.404085550586, 5420.783168673288, 5461.508464238238, 5473.042217611902, 4892.951070489321, 4984.451710311862, 5047.949520504748, 5078.898422031539, 5081.339425874613, 3786.924261514754, 3842.865499707497, 3850.6534411903062, 3892.065904182976, 3994.0, 1006.7382480554962, 1006.8137394582026, 1013.3210748798323, 1020.2552136939927, 1028.5782829040058, 565.3269346130774, 672.2504407585507, 730.2514922204676, 732.0629594119536, 752.4243953375671, 5647.887042259132, 5774.451427114417, 5779.0, 5784.161296612052, 5926.851828704317, 552.2710022769905, 561.1554610311537, 569.1121849914147, 573.3320681406116, 674.4334758802629, 3599.6400359963795, 3654.689351405107, 3676.209614932802, 3716.646918542734, 3956.092272179945, 12126.939365303117, 12928.676783080498, 13074.607761767162, 13078.2806945617, 13079.803802942963, 12796.232226066466, 12880.613581592566, 12987.0, 13019.218846869218, 13101.279429631462, 9177.08229177077, 9181.081891810765, 9216.677416290398, 9329.486878221764, 9336.346455748168, 5633.633813802254, 5644.971775141098, 5753.741081651419, 5903.940960590511, 6029.487493563096, 11110.111191104854, 11336.14978876604, 11384.43077846121, 11450.828237576276, 11488.310701357945, 11595.8260626089, 11627.127965402799, 11635.360055197045, 11721.472533736172, 11751.76496470083, 7932.56370899583, 8110.31062359706, 8160.30637395828, 8168.591570421337, 8170.673173073011, 8581.785455363417, 8848.292136629183, 8930.106989301017, 8979.730608081769, 9015.413998090104, 7931.5637639930355, 8074.636641351036, 8084.151164127682, 8129.67481300765, 8187.631556580087, 7854.450188486751, 7864.2922137007945, 7904.367650587824, 7976.800579985546, 8020.719274825353, 7132.679029443584, 7225.421966242583, 7239.565626062453, 7244.311790379906, 7244.710211591478, 5347.278117454094, 5359.222912677562, 5409.404965453718, 5501.5323697486165, 5605.244486194341, 5076.0, 5107.463716309734, 5150.278960945546, 5174.016936781999, 5259.184826351921], "value": 4626.27887218149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.40266167457463, 392.3173677800627, 394.7887879984209, 395.32991579273136, 401.71076824686213, 5359.946400535993, 5401.459854014602, 5402.811381496074, 5415.214793854899, 5431.864203394917, 5063.189889617662, 5230.1108811502045, 5231.79072837087, 5245.527902488775, 5264.078786212407, 4051.6961227907877, 4064.5367667639625, 4078.8164532595956, 4079.5308539518037, 4079.5920407959266, 4082.6733861291173, 4083.4283200351974, 4084.7140700151003, 4084.8154035329867, 4091.9590804092027, 3851.4415409765566, 3996.820143093568, 4022.9798851005703, 4044.867437117597, 4047.6357127858487, 3979.7612143271494, 4007.499062617173, 4028.5295867008476, 4034.334334834749, 4040.1717647882115, 3548.079372293604, 3554.413521768931, 3558.839852206631, 3561.857525698969, 3563.1092226943265, 4967.950320496785, 5118.897622047575, 5129.846104616868, 5137.845864624067, 5140.1518749406305, 4754.286856971447, 4756.881077973078, 4760.619150467955, 4787.832425865113, 4791.377120974286, 5566.888662226733, 5608.158776183564, 5620.775168993236, 5623.718814059322, 5624.21261023457, 3919.980804990723, 4009.4386785850006, 4020.718549701522, 4024.517057953035, 4033.97983010086, 5626.634268772516, 5768.682722450306, 5813.011787996009, 5862.824115276506, 5996.340402555716, 4027.3556231003486, 4040.575739547305, 4049.8380064797666, 4050.0887300357185, 4051.372037334218, 4102.2000709861295, 4116.073883376216, 4120.711550191518, 4121.711480196357, 4122.0107174278555, 4380.627646650007, 4457.8439754608435, 4564.475085365159, 4566.26939689648, 4705.741184234831, 5561.416051314634, 5589.74846131925, 5596.440355964371, 5637.267155269788, 5644.153376993402, 1418.524794193936, 1441.6828297774473, 1441.726072046329, 1441.8774404175554, 1447.4499690117689, 938.4603852784676, 960.8366577681811, 965.5075911285155, 968.2060710217554, 971.8007808399261, 4872.731999739977, 4887.65786394956, 4910.754462276872, 4919.2129259318335, 4920.6309526785635, 5843.29880414353, 5847.502962248256, 5857.092150716646, 5861.003629383015, 5866.882662346729, 4709.740964246999, 4876.21980483121, 4933.777979990909, 4967.0, 4970.329005584272, 3074.969250307513, 3098.395812816479, 3110.9066727998197, 3112.361965797006, 3115.408072466224, 5180.834312279707, 5433.538149257279, 5436.429174936654, 5472.972635136878, 5489.258950041693, 5960.344362120163, 5986.880262394728, 6005.6997150142315, 6005.939940600625, 6043.7884674036195, 5401.891962160735, 5475.288212532425, 5482.17767334887, 5486.862828429321, 5496.148097044965, 5765.221695071112, 5843.574916409642, 5864.736086876015, 5876.1773351729935, 5898.203742494708, 5756.827295181151, 5774.595778295479, 5775.94224057754, 5793.04414771558, 5793.623414478046, 5146.819861304836, 5250.422453530032, 5283.471652834686, 5307.814226502054, 5435.565154787687, 4037.2732908076828, 4393.714408563433, 4422.800973956116, 4432.734035957853, 4436.157130145262, 5824.271966004249, 5844.298684157929, 5860.38465961085, 5862.541100750407, 5876.559258055578, 5435.429279925551, 5652.576056795839, 5670.007748644053, 5678.886422271449, 5685.20407142992, 5643.181738647955, 5657.858553536194, 5661.745221464962, 5669.943300566942, 5690.430956904276, 5373.8387848363045, 5559.332880054258, 5598.86002849932, 5598.888022239451, 5611.747471363717, 5676.318841738853, 5692.715364231854, 5695.088785794253, 5701.201831743476, 5708.372079071381, 5571.721413929206, 5576.414476479911, 5576.888462230814, 5590.580706446952, 5593.720313984203], "value": 4239.741988392049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.6346514219466, 650.5543702563741, 653.6176336842947, 661.5798967655538, 669.2905520148643, 12460.937695311522, 12902.548410805624, 13072.281024543658, 13099.47602095915, 13160.341982900853, 13455.0, 13469.528566500174, 13541.93229033856, 13546.0, 13563.660908477294, 911.2118017914489, 926.6247169896169, 928.8838895138108, 929.0987741890356, 929.60027188309, 879.2833840420069, 919.5034681272139, 927.7912469694332, 928.7585227840776, 929.1544694328163, 952.8142012307603, 959.5777857742571, 961.5048250151178, 962.033156677538, 962.3600305796637, 946.507815935713, 949.7673070097801, 951.3245595627113, 954.7708549947997, 955.0640372435053, 698.601796975724, 701.7649087555675, 702.2135208566388, 704.4399702236734, 704.6793708862456, 13689.726205475934, 14381.35283912216, 14538.273086345745, 14786.334614942354, 14955.102693838404, 12999.545015924492, 13754.95327288432, 13794.448222071205, 13842.377093030838, 13874.167549947035, 10674.519646615921, 10956.56173753049, 11135.610253641165, 11283.830742538868, 11648.53405863773, 2678.879450424716, 2682.825616334932, 2700.203439985209, 2742.794290428226, 2798.8040837141407, 67310.66344668294, 67322.0, 67585.0, 67859.66070169667, 68199.3180068203, 11061.778764424827, 11104.833427498594, 11176.608818691308, 11212.0, 11282.774344513064, 22083.558328833333, 22223.888880555493, 22285.77714222837, 22317.888410558167, 22606.139679968885, 6571.638559879252, 6587.308332625101, 6588.86822263552, 6604.537682362188, 6836.111305530349, 3354.1279267390164, 3374.2239284964594, 3418.8290585470627, 3425.5546778918583, 3492.7031202347575, 3623.6195199503672, 3680.6687398133763, 3691.040329514292, 3705.888823335304, 3739.5512538495555, 639.728115550889, 641.3522342434175, 646.1051443750346, 658.1181217169017, 658.256170527301, 532.7682458130648, 535.5715427657937, 554.8446434998207, 557.364136260078, 564.5681053993698, 8418.349503891857, 8473.5339556325, 8714.302855771522, 8926.86609700855, 9102.772430689154, 544.8229325469239, 547.9232907392968, 559.105431309909, 562.3504851896066, 573.8335882594084, 3488.424409972326, 3501.8599256029984, 3523.8766643167364, 3543.20277937462, 3665.4501824726503, 64508.0, 64982.675086624266, 65803.34196658067, 66860.66569667218, 67864.3213567868, 56804.71597641985, 57270.713646432334, 58280.4171958275, 59155.99999999914, 59414.0, 52249.738751306, 52458.21312680313, 53294.0, 53320.0, 53774.0, 7294.307040831112, 7366.410687145123, 7489.588072656056, 7500.662470188746, 7573.697052117854, 28614.42771144607, 28619.856900715364, 28906.27734306575, 29060.27349316284, 29348.0, 33301.167470812456, 33559.49660755042, 33673.49489757606, 33707.123680777026, 34329.828350858086, 10031.164687287892, 10272.435016073889, 10316.43259620728, 10557.788844223227, 10573.629922952967, 9989.150922171697, 10062.195024397884, 10100.343477673927, 10221.9488902555, 10552.472376381304, 9029.187373136449, 9269.443833369749, 9292.39599426035, 9364.531773411438, 9403.952980235055, 9342.626294948126, 9459.858102128335, 9530.428174309563, 9655.131038206315, 9860.901390985999, 9760.707178784647, 9783.755406114904, 9811.339588740382, 9917.752056198653, 10224.64213752515, 6192.442680158807, 6417.93582064192, 6431.614103153825, 6495.577787443801, 6509.707063182263, 7139.428845692229, 7739.961300193463, 10187.185025198114, 10740.409277489813, 10772.676819695422], "value": 6160.447420900531, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 112.0, 112.0, 113.0, 111.0, 112.0, 111.0, 118.0, 109.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 123.0, 170.0, 130.0, 125.0, 126.0, 125.0, 160.0, 126.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 164.0, 165.0, 166.0, 165.0, 164.0, 164.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 104.0, 77.0, 76.0, 78.0, 78.0, 92.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 83.0, 83.0, 84.0, 110.0, 89.0, 87.0, 115.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 153.0, 152.0, 152.0, 153.0, 152.0, 153.0, 153.0, 151.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 54.0, 55.0, 54.0, 53.0, 54.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 84.0, 83.0, 81.0, 83.0, 82.0, 82.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 145.0, 139.0, 133.0, 133.0, 142.0, 133.0, 177.0, 137.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 197.0, 195.0, 194.0, 202.0, 203.0, 192.0, 199.0, 185.0, 193.0], "value": 195.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 72.0, 70.0, 72.0, 71.0, 70.0, 71.0, 70.0, 70.0], "value": 70.9, "unit": "score"}]}]} 05:06:50 INFO - Return code: 0 05:06:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:50 ERROR - # TBPL SUCCESS # 05:06:50 INFO - Running post-action listener: _resource_record_post_action 05:06:50 INFO - [mozharness: 2017-04-01 12:06:50.109580Z] Finished run-tests step (success) 05:06:50 INFO - Running post-run listener: _resource_record_post_run 05:06:50 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 8192; Write bytes: 371720192; Read time: 16; Write time: 219380 05:06:50 INFO - TinderboxPrint: CPU usage
13.0% 05:06:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 05:06:50 INFO - TinderboxPrint: I/O write bytes / time
371,720,192 / 219,380 05:06:50 INFO - TinderboxPrint: CPU idle
8,374.9 (87.0%) 05:06:50 INFO - TinderboxPrint: CPU user
1,204.8 (12.5%) 05:06:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:06:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107233280; Read time: 0; Write time: 80284 05:06:50 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264097792; Read time: 0; Write time: 139076 05:06:50 INFO - Running post-run listener: _upload_blobber_files 05:06:50 INFO - Blob upload gear active. 05:06:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:50 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 05:06:50 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'] 05:06:50 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 05:06:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:51 INFO - (blobuploader) - INFO - Done attempting. 05:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:06:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:52 INFO - (blobuploader) - INFO - Done attempting. 05:06:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:55 INFO - (blobuploader) - INFO - Done attempting. 05:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:56 INFO - (blobuploader) - INFO - Done attempting. 05:06:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:56 INFO - Return code: 0 05:06:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106ec0318ecfaf3c1d809d851d43ea78ab151c75e89cd6b0efef21684890fef9ab2af01987649a525fcfa3719dc837403179dfac6318e73e6d591cee5308d58b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176197fba6cdc2da7e81434febe2bf1f29997650da78eb2b0455429212e7101c9b8f6df2d5797d2c2280f049dcfe5cd799b89645afde4225de57adcb2be0f0ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf83f6be077d43233cb4e621aeeb7c2e3ed801675f3cd347af826d2f2959da3734821b7529ed069cef3cd897c0bed16a806772caf030bef04d6c3d36e4e28162", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5ead47db548fe194f319d6fca79c9c4c650728c9281848312b482bbb2fe163114f6bf0f3231b50d60c786c6f19f633ba06d0e1a09390169dad880c5db1359"} 05:06:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:56 INFO - Contents: 05:06:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106ec0318ecfaf3c1d809d851d43ea78ab151c75e89cd6b0efef21684890fef9ab2af01987649a525fcfa3719dc837403179dfac6318e73e6d591cee5308d58b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176197fba6cdc2da7e81434febe2bf1f29997650da78eb2b0455429212e7101c9b8f6df2d5797d2c2280f049dcfe5cd799b89645afde4225de57adcb2be0f0ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf83f6be077d43233cb4e621aeeb7c2e3ed801675f3cd347af826d2f2959da3734821b7529ed069cef3cd897c0bed16a806772caf030bef04d6c3d36e4e28162", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5ead47db548fe194f319d6fca79c9c4c650728c9281848312b482bbb2fe163114f6bf0f3231b50d60c786c6f19f633ba06d0e1a09390169dad880c5db1359"} 05:06:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:56 INFO - Copying logs to upload dir... 05:06:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.052717 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-01 05:06:56.380680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:06:56.384544) ========= 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=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106ec0318ecfaf3c1d809d851d43ea78ab151c75e89cd6b0efef21684890fef9ab2af01987649a525fcfa3719dc837403179dfac6318e73e6d591cee5308d58b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176197fba6cdc2da7e81434febe2bf1f29997650da78eb2b0455429212e7101c9b8f6df2d5797d2c2280f049dcfe5cd799b89645afde4225de57adcb2be0f0ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf83f6be077d43233cb4e621aeeb7c2e3ed801675f3cd347af826d2f2959da3734821b7529ed069cef3cd897c0bed16a806772caf030bef04d6c3d36e4e28162", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5ead47db548fe194f319d6fca79c9c4c650728c9281848312b482bbb2fe163114f6bf0f3231b50d60c786c6f19f633ba06d0e1a09390169dad880c5db1359"} build_url:https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/Em6NgsQvRJCBIpZ8_STHEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106ec0318ecfaf3c1d809d851d43ea78ab151c75e89cd6b0efef21684890fef9ab2af01987649a525fcfa3719dc837403179dfac6318e73e6d591cee5308d58b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176197fba6cdc2da7e81434febe2bf1f29997650da78eb2b0455429212e7101c9b8f6df2d5797d2c2280f049dcfe5cd799b89645afde4225de57adcb2be0f0ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf83f6be077d43233cb4e621aeeb7c2e3ed801675f3cd347af826d2f2959da3734821b7529ed069cef3cd897c0bed16a806772caf030bef04d6c3d36e4e28162", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5ead47db548fe194f319d6fca79c9c4c650728c9281848312b482bbb2fe163114f6bf0f3231b50d60c786c6f19f633ba06d0e1a09390169dad880c5db1359"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:06:56.416427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:06:56.417046) ========= 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=6dbc10da6d83fee962c624be000001a8-1491041901.700645-351391537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:06:56.498061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:06:56.498423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:06:56.498763) ========= ========= Total master_lag: 0.20 =========