builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-072 starttime: 1489166930.13 results: success (0) revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.127657) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.128146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.128423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.143238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.143596) ========= 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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 09:28:50-- 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% 223M=0s 2017-03-10 09:28:50 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.297779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.298132) ========= 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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015491 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:50.348198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 09:28:50.348539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8d497b09753c91783b68c5805c64f34a2f39629 --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 a8d497b09753c91783b68c5805c64f34a2f39629 --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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 09:28:50,785 truncating revision to first 12 chars 2017-03-10 09:28:50,785 Setting DEBUG logging. 2017-03-10 09:28:50,785 attempt 1/10 2017-03-10 09:28:50,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8d497b09753?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 09:28:51,630 unpacking tar archive at: mozilla-central-a8d497b09753/testing/mozharness/ program finished with exit code 0 elapsedTime=1.179083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 09:28:51.541271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:51.541717) ========= script_repo_revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:51.542187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:51.542453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 09:28:51.552695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-10 09:28:51.553140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:52 INFO - MultiFileLogger online at 20170310 09:28:52 in /builds/slave/test 09:28:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:28:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:52 INFO - {'append_to_log': False, 09:28:52 INFO - 'base_work_dir': '/builds/slave/test', 09:28:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:28:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:52 INFO - 'branch': 'Firefox-Non-PGO', 09:28:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:52 INFO - 'config_files': ('talos/linux_config.py',), 09:28:52 INFO - 'default_actions': ('clobber', 09:28:52 INFO - 'read-buildbot-config', 09:28:52 INFO - 'download-and-extract', 09:28:52 INFO - 'populate-webroot', 09:28:52 INFO - 'create-virtualenv', 09:28:52 INFO - 'install', 09:28:52 INFO - 'run-tests'), 09:28:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:52 INFO - 'download_minidump_stackwalk': True, 09:28:52 INFO - 'download_symbols': 'ondemand', 09:28:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:52 INFO - 'gecko_profile': False, 09:28:52 INFO - 'gecko_profile_interval': 0, 09:28:52 INFO - 'installer_path': 'installer.exe', 09:28:52 INFO - 'log_level': 'info', 09:28:52 INFO - 'log_name': 'talos', 09:28:52 INFO - 'log_to_console': True, 09:28:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:52 INFO - 'opt_config_files': (), 09:28:52 INFO - 'pip_index': False, 09:28:52 INFO - 'suite': 'dromaeojs', 09:28:52 INFO - 'system_bits': '32', 09:28:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:52 INFO - 'title': 'talos-linux64-ix-072', 09:28:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:52 INFO - 'use_talos_json': True, 09:28:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:52 INFO - 'work_dir': 'build'} 09:28:52 INFO - [mozharness: 2017-03-10 17:28:52.087885Z] Running clobber step. 09:28:52 INFO - Running pre-action listener: _resource_record_pre_action 09:28:52 INFO - Running main action method: clobber 09:28:52 INFO - rmtree: /builds/slave/test/build 09:28:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:53 INFO - Running post-action listener: _resource_record_post_action 09:28:53 INFO - [mozharness: 2017-03-10 17:28:53.602040Z] Finished clobber step (success) 09:28:53 INFO - [mozharness: 2017-03-10 17:28:53.602137Z] Running read-buildbot-config step. 09:28:53 INFO - Running pre-action listener: _resource_record_pre_action 09:28:53 INFO - Running main action method: read_buildbot_config 09:28:53 INFO - Using buildbot properties: 09:28:53 INFO - { 09:28:53 INFO - "project": "", 09:28:53 INFO - "product": "firefox", 09:28:53 INFO - "who": "ryanvm@gmail.com", 09:28:53 INFO - "installer_path": "public/build/target.tar.bz2", 09:28:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:28:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:28:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:28:53 INFO - "stage_platform": "linux64", 09:28:53 INFO - "basedir": "/builds/slave/test", 09:28:53 INFO - "buildnumber": 488, 09:28:53 INFO - "platform": "ubuntu64_hw", 09:28:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:28:53 INFO - "slavebuilddir": "test", 09:28:53 INFO - "taskId": "P9jbsLGjSSWpgM8FWWdUfw", 09:28:53 INFO - "branch": "mozilla-central", 09:28:53 INFO - "script_repo_revision": "production", 09:28:53 INFO - "revision": "a8d497b09753c91783b68c5805c64f34a2f39629", 09:28:53 INFO - "slavename": "talos-linux64-ix-072", 09:28:53 INFO - "repo_path": "mozilla-central" 09:28:53 INFO - } 09:28:53 INFO - Finding installer, test and symbols from parent task. 09:28:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9jbsLGjSSWpgM8FWWdUfw'}, attempt #1 09:28:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9jbsLGjSSWpgM8FWWdUfw'}, attempt #1 09:28:54 INFO - Task dependencies: U-WjSi16T8a1g6qeePmDMw 09:28:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw'}, attempt #1 09:28:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 09:28:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/test_packages.json 09:28:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.crashreporter-symbols.zip 09:28:54 INFO - Running post-action listener: _resource_record_post_action 09:28:54 INFO - [mozharness: 2017-03-10 17:28:54.976168Z] Finished read-buildbot-config step (success) 09:28:54 INFO - [mozharness: 2017-03-10 17:28:54.976393Z] Running download-and-extract step. 09:28:54 INFO - Running pre-action listener: _resource_record_pre_action 09:28:54 INFO - Running main action method: download_and_extract 09:28:54 INFO - mkdir: /builds/slave/test/build/tests 09:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:54 INFO - trying https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.test_packages.json 09:28:54 INFO - Downloading https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:28:55 INFO - Downloaded 896 bytes. 09:28:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:28:55 INFO - Using the following test package requirements: 09:28:55 INFO - {u'common': [u'target.common.tests.zip'], 09:28:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:28:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:28:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:28:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:28:55 INFO - u'mozbase': [u'target.common.tests.zip'], 09:28:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:28:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:28:55 INFO - u'web-platform': [u'target.common.tests.zip', 09:28:55 INFO - u'target.web-platform.tests.zip'], 09:28:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:28:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:28:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip 09:28:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:55 INFO - Fetch https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip into memory 09:28:56 INFO - Expected file size: 57498808 09:28:56 INFO - Obtained file size: 57498808 09:29:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:29:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip 09:29:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:29:06 INFO - Fetch https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.common.tests.zip into memory 09:29:07 INFO - Expected file size: 57498808 09:29:07 INFO - Obtained file size: 57498808 09:29:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.talos.tests.zip 09:29:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:29:18 INFO - Fetch https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.talos.tests.zip into memory 09:29:18 INFO - Expected file size: 14404424 09:29:18 INFO - Obtained file size: 14404424 09:29: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')]} 09:29:19 INFO - trying https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 09:29:19 INFO - Downloading https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:29:20 INFO - Downloaded 61624300 bytes. 09:29:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 09:29:20 INFO - mkdir: /builds/slave/test/properties 09:29:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:20 INFO - Contents: 09:29:20 INFO - build_url:https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 09:29:20 INFO - Running post-action listener: _resource_record_post_action 09:29:20 INFO - Running post-action listener: set_extra_try_arguments 09:29:20 INFO - [mozharness: 2017-03-10 17:29:20.821380Z] Finished download-and-extract step (success) 09:29:20 INFO - [mozharness: 2017-03-10 17:29:20.821476Z] Running populate-webroot step. 09:29:20 INFO - Running pre-action listener: _resource_record_pre_action 09:29:20 INFO - Running main action method: populate_webroot 09:29:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:20 INFO - '--tppagecycles', 09:29:20 INFO - '7'], 09:29:20 INFO - 'tests': ['tsvgm']}}, 09:29:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['damp', 'tps']}, 09:29:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'tests': ['damp', 'tps']}, 09:29:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['dromaeo_dom']}, 09:29:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['basic_compositor_video']}, 09:29:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['a11yr', 09:29:20 INFO - 'ts_paint', 09:29:20 INFO - 'tpaint', 09:29:20 INFO - 'sessionrestore', 09:29:20 INFO - 'sessionrestore_no_auto_restore', 09:29:20 INFO - 'tabpaint']}, 09:29:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['tsvgx', 09:29:20 INFO - 'tsvgr_opacity', 09:29:20 INFO - 'tart', 09:29:20 INFO - 'tscrollx', 09:29:20 INFO - 'cart', 09:29:20 INFO - 'tsvg_static']}, 09:29:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:20 INFO - 'tsvgr_opacity', 09:29:20 INFO - 'tart', 09:29:20 INFO - 'tscrollx', 09:29:20 INFO - 'cart', 09:29:20 INFO - 'tsvg_static']}, 09:29:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'talos_options': ['--disable-e10s'], 09:29:20 INFO - 'tests': ['tp5o']}, 09:29:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:29:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'talos_options': ['--disable-e10s', 09:29:20 INFO - '--xperf_path', 09:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:20 INFO - 'tests': ['tp5n']}, 09:29:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:29:20 INFO - 'talos_options': ['--xperf_path', 09:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:20 INFO - 'tests': ['tp5n']}}, 09:29:20 INFO - 'talos.zip': {'path': '', 09:29:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:20 INFO - Running post-action listener: _resource_record_post_action 09:29:20 INFO - [mozharness: 2017-03-10 17:29:20.834689Z] Finished populate-webroot step (success) 09:29:20 INFO - [mozharness: 2017-03-10 17:29:20.834782Z] Running create-virtualenv step. 09:29:20 INFO - Running pre-action listener: _resource_record_pre_action 09:29:20 INFO - Running main action method: create_virtualenv 09:29:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29: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 09:29:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:20 INFO - Using real prefix '/usr' 09:29:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:23 INFO - Installing pip.................done. 09:29:23 INFO - Return code: 0 09:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:29:23 INFO - Reading from file tmpfile_stdout 09:29:23 INFO - Output received: 09:29: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) 09:29:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29: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 09:29: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 09:29:23 INFO - Using env: {'DISPLAY': ':0', 09:29:23 INFO - 'HOME': '/home/cltbld', 09:29:23 INFO - 'LANG': 'en_US.UTF-8', 09:29:23 INFO - 'LANGUAGE': 'en_US:en', 09:29:23 INFO - 'LOGNAME': 'cltbld', 09:29:23 INFO - 'MAIL': '/var/mail/cltbld', 09:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:23 INFO - 'MOZ_NO_REMOTE': '1', 09:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:23 INFO - 'NO_EM_RESTART': '1', 09:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:23 INFO - 'PWD': '/builds/slave/test', 09:29:23 INFO - 'SHELL': '/bin/bash', 09:29:23 INFO - 'SHLVL': '1', 09:29:23 INFO - 'TERM': 'linux', 09:29:23 INFO - 'TMOUT': '86400', 09:29:23 INFO - 'USER': 'cltbld', 09:29:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:23 INFO - '_': '/tools/buildbot/bin/python'} 09:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29: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 09:29:23 INFO - Cleaning up... 09:29:23 INFO - Return code: 0 09:29:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29: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 09:29: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 09:29:23 INFO - Using env: {'DISPLAY': ':0', 09:29:23 INFO - 'HOME': '/home/cltbld', 09:29:23 INFO - 'LANG': 'en_US.UTF-8', 09:29:23 INFO - 'LANGUAGE': 'en_US:en', 09:29:23 INFO - 'LOGNAME': 'cltbld', 09:29:23 INFO - 'MAIL': '/var/mail/cltbld', 09:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:23 INFO - 'MOZ_NO_REMOTE': '1', 09:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:23 INFO - 'NO_EM_RESTART': '1', 09:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:23 INFO - 'PWD': '/builds/slave/test', 09:29:23 INFO - 'SHELL': '/bin/bash', 09:29:23 INFO - 'SHLVL': '1', 09:29:23 INFO - 'TERM': 'linux', 09:29:23 INFO - 'TMOUT': '86400', 09:29:23 INFO - 'USER': 'cltbld', 09:29:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:23 INFO - '_': '/tools/buildbot/bin/python'} 09:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:24 INFO - Downloading/unpacking psutil>=3.1.1 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:26 INFO - Installing collected packages: psutil 09:29:26 INFO - Running setup.py install for psutil 09:29:26 INFO - building 'psutil._psutil_linux' extension 09:29:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:29: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 09:29:26 INFO - building 'psutil._psutil_posix' extension 09:29: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 09:29: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 09:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:26 INFO - Successfully installed psutil 09:29:26 INFO - Cleaning up... 09:29:26 INFO - Return code: 0 09:29:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29: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 09:29: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 09:29:26 INFO - Using env: {'DISPLAY': ':0', 09:29:26 INFO - 'HOME': '/home/cltbld', 09:29:26 INFO - 'LANG': 'en_US.UTF-8', 09:29:26 INFO - 'LANGUAGE': 'en_US:en', 09:29:26 INFO - 'LOGNAME': 'cltbld', 09:29:26 INFO - 'MAIL': '/var/mail/cltbld', 09:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:26 INFO - 'MOZ_NO_REMOTE': '1', 09:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:26 INFO - 'NO_EM_RESTART': '1', 09:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:26 INFO - 'PWD': '/builds/slave/test', 09:29:26 INFO - 'SHELL': '/bin/bash', 09:29:26 INFO - 'SHLVL': '1', 09:29:26 INFO - 'TERM': 'linux', 09:29:26 INFO - 'TMOUT': '86400', 09:29:26 INFO - 'USER': 'cltbld', 09:29:26 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:26 INFO - '_': '/tools/buildbot/bin/python'} 09:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:29:29 INFO - Installing collected packages: mozsystemmonitor 09:29:29 INFO - Running setup.py install for mozsystemmonitor 09:29:29 INFO - Successfully installed mozsystemmonitor 09:29:29 INFO - Cleaning up... 09:29:29 INFO - Return code: 0 09:29:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:29 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:29:29 INFO - Using env: {'DISPLAY': ':0', 09:29:29 INFO - 'HOME': '/home/cltbld', 09:29:29 INFO - 'LANG': 'en_US.UTF-8', 09:29:29 INFO - 'LANGUAGE': 'en_US:en', 09:29:29 INFO - 'LOGNAME': 'cltbld', 09:29:29 INFO - 'MAIL': '/var/mail/cltbld', 09:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:29 INFO - 'MOZ_NO_REMOTE': '1', 09:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:29 INFO - 'NO_EM_RESTART': '1', 09:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:29 INFO - 'PWD': '/builds/slave/test', 09:29:29 INFO - 'SHELL': '/bin/bash', 09:29:29 INFO - 'SHLVL': '1', 09:29:29 INFO - 'TERM': 'linux', 09:29:29 INFO - 'TMOUT': '86400', 09:29:29 INFO - 'USER': 'cltbld', 09:29:29 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:29 INFO - '_': '/tools/buildbot/bin/python'} 09:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:31 INFO - warning: no files found matching '*.txt' 09:29:31 INFO - no previously-included directories found matching 'build' 09:29:31 INFO - no previously-included directories found matching 'dist' 09:29:31 INFO - no previously-included directories found matching '.git*' 09:29:31 INFO - Installing collected packages: jsonschema, functools32 09:29:31 INFO - Running setup.py install for functools32 09:29:31 INFO - warning: no files found matching '*.txt' 09:29:31 INFO - no previously-included directories found matching 'build' 09:29:31 INFO - no previously-included directories found matching 'dist' 09:29:31 INFO - no previously-included directories found matching '.git*' 09:29:32 INFO - Successfully installed jsonschema functools32 09:29:32 INFO - Cleaning up... 09:29:32 INFO - Return code: 0 09:29:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:32 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:29:32 INFO - Using env: {'DISPLAY': ':0', 09:29:32 INFO - 'HOME': '/home/cltbld', 09:29:32 INFO - 'LANG': 'en_US.UTF-8', 09:29:32 INFO - 'LANGUAGE': 'en_US:en', 09:29:32 INFO - 'LOGNAME': 'cltbld', 09:29:32 INFO - 'MAIL': '/var/mail/cltbld', 09:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:32 INFO - 'MOZ_NO_REMOTE': '1', 09:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:32 INFO - 'NO_EM_RESTART': '1', 09:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:32 INFO - 'PWD': '/builds/slave/test', 09:29:32 INFO - 'SHELL': '/bin/bash', 09:29:32 INFO - 'SHLVL': '1', 09:29:32 INFO - 'TERM': 'linux', 09:29:32 INFO - 'TMOUT': '86400', 09:29:32 INFO - 'USER': 'cltbld', 09:29:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:32 INFO - '_': '/tools/buildbot/bin/python'} 09:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:29:32 INFO - Cleaning up... 09:29:32 INFO - Return code: 0 09:29:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:32 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:29:32 INFO - Using env: {'DISPLAY': ':0', 09:29:32 INFO - 'HOME': '/home/cltbld', 09:29:32 INFO - 'LANG': 'en_US.UTF-8', 09:29:32 INFO - 'LANGUAGE': 'en_US:en', 09:29:32 INFO - 'LOGNAME': 'cltbld', 09:29:32 INFO - 'MAIL': '/var/mail/cltbld', 09:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:32 INFO - 'MOZ_NO_REMOTE': '1', 09:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:32 INFO - 'NO_EM_RESTART': '1', 09:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:32 INFO - 'PWD': '/builds/slave/test', 09:29:32 INFO - 'SHELL': '/bin/bash', 09:29:32 INFO - 'SHLVL': '1', 09:29:32 INFO - 'TERM': 'linux', 09:29:32 INFO - 'TMOUT': '86400', 09:29:32 INFO - 'USER': 'cltbld', 09:29:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:32 INFO - '_': '/tools/buildbot/bin/python'} 09:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:35 INFO - Downloading docopt-0.6.1.tar.gz 09:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:35 INFO - Running setup.py install for blobuploader 09:29:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:35 INFO - Running setup.py install for requests 09:29:35 INFO - Running setup.py install for docopt 09:29:35 INFO - Successfully installed blobuploader requests docopt 09:29:35 INFO - Cleaning up... 09:29:35 INFO - Return code: 0 09:29:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29: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 09:29: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 09:29:35 INFO - Using env: {'DISPLAY': ':0', 09:29:35 INFO - 'HOME': '/home/cltbld', 09:29:35 INFO - 'LANG': 'en_US.UTF-8', 09:29:35 INFO - 'LANGUAGE': 'en_US:en', 09:29:35 INFO - 'LOGNAME': 'cltbld', 09:29:35 INFO - 'MAIL': '/var/mail/cltbld', 09:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:35 INFO - 'MOZ_NO_REMOTE': '1', 09:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:35 INFO - 'NO_EM_RESTART': '1', 09:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:35 INFO - 'PWD': '/builds/slave/test', 09:29:35 INFO - 'SHELL': '/bin/bash', 09:29:35 INFO - 'SHLVL': '1', 09:29:35 INFO - 'TERM': 'linux', 09:29:35 INFO - 'TMOUT': '86400', 09:29:35 INFO - 'USER': 'cltbld', 09:29:35 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:35 INFO - '_': '/tools/buildbot/bin/python'} 09:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:36 INFO - Running setup.py (path:/tmp/pip-bRXDHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:36 INFO - Running setup.py (path:/tmp/pip-LT9D52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:36 INFO - Running setup.py (path:/tmp/pip-GKXk28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:36 INFO - Running setup.py (path:/tmp/pip-aqH1Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:36 INFO - Running setup.py (path:/tmp/pip-wdJOvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:36 INFO - Running setup.py (path:/tmp/pip-Vb1nOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:36 INFO - Running setup.py (path:/tmp/pip-3ZN569-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:36 INFO - Running setup.py (path:/tmp/pip-wOFgwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:36 INFO - Running setup.py (path:/tmp/pip-9MSlbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:36 INFO - Running setup.py (path:/tmp/pip-yHnPmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:36 INFO - Running setup.py (path:/tmp/pip-eC8agz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:36 INFO - Running setup.py (path:/tmp/pip-JYVEkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:37 INFO - Running setup.py (path:/tmp/pip-flIQyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:37 INFO - Running setup.py (path:/tmp/pip-UEZY6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:37 INFO - Running setup.py (path:/tmp/pip-Kq2Mxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:37 INFO - Running setup.py (path:/tmp/pip-GJzYwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:37 INFO - Running setup.py (path:/tmp/pip-MGGaLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:37 INFO - Running setup.py install for manifestparser 09:29:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Running setup.py install for mozcrash 09:29:37 INFO - Running setup.py install for mozdebug 09:29:37 INFO - Running setup.py install for mozdevice 09:29:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Running setup.py install for mozfile 09:29:37 INFO - Running setup.py install for mozhttpd 09:29:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozinfo 09:29:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozInstall 09:29:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozleak 09:29:38 INFO - Running setup.py install for mozlog 09:29:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for moznetwork 09:29:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozprocess 09:29:38 INFO - Running setup.py install for mozprofile 09:29:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozrunner 09:29:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozscreenshot 09:29:38 INFO - Running setup.py install for moztest 09:29:39 INFO - Running setup.py install for mozversion 09:29:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:39 INFO - Cleaning up... 09:29:39 INFO - Return code: 0 09:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:39 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:39 INFO - Using env: {'DISPLAY': ':0', 09:29:39 INFO - 'HOME': '/home/cltbld', 09:29:39 INFO - 'LANG': 'en_US.UTF-8', 09:29:39 INFO - 'LANGUAGE': 'en_US:en', 09:29:39 INFO - 'LOGNAME': 'cltbld', 09:29:39 INFO - 'MAIL': '/var/mail/cltbld', 09:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:39 INFO - 'MOZ_NO_REMOTE': '1', 09:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:39 INFO - 'NO_EM_RESTART': '1', 09:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:39 INFO - 'PWD': '/builds/slave/test', 09:29:39 INFO - 'SHELL': '/bin/bash', 09:29:39 INFO - 'SHLVL': '1', 09:29:39 INFO - 'TERM': 'linux', 09:29:39 INFO - 'TMOUT': '86400', 09:29:39 INFO - 'USER': 'cltbld', 09:29:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:39 INFO - '_': '/tools/buildbot/bin/python'} 09:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:39 INFO - Running setup.py (path:/tmp/pip-dptMPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:39 INFO - Running setup.py (path:/tmp/pip-9ZBp32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:39 INFO - Running setup.py (path:/tmp/pip-onBxeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:39 INFO - Running setup.py (path:/tmp/pip-V7P6U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:39 INFO - Running setup.py (path:/tmp/pip-GLW7Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:39 INFO - Running setup.py (path:/tmp/pip-aIKL73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:39 INFO - Running setup.py (path:/tmp/pip-5b6Z2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29: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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:39 INFO - Running setup.py (path:/tmp/pip-wWFneJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:40 INFO - Running setup.py (path:/tmp/pip-CWlWws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:40 INFO - Running setup.py (path:/tmp/pip-mLOLoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:40 INFO - Running setup.py (path:/tmp/pip-y_nULb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:40 INFO - Running setup.py (path:/tmp/pip-_QPMfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:40 INFO - Running setup.py (path:/tmp/pip-g9tGE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:40 INFO - Running setup.py (path:/tmp/pip-LbAR3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29: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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:40 INFO - Running setup.py (path:/tmp/pip-hwvVVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29: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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:40 INFO - Running setup.py (path:/tmp/pip-I3Xel_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29: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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:40 INFO - Running setup.py (path:/tmp/pip-9y8eT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29: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)) 09:29: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)) 09:29: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)) 09:29: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)) 09:29: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)) 09:29: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)) 09:29:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:42 INFO - Downloading blessings-1.6.tar.gz 09:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:42 INFO - Installing collected packages: blessings 09:29:42 INFO - Running setup.py install for blessings 09:29:42 INFO - Successfully installed blessings 09:29:42 INFO - Cleaning up... 09:29:42 INFO - Return code: 0 09:29:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:43 INFO - Reading from file tmpfile_stdout 09:29:43 INFO - Current package versions: 09:29:43 INFO - argparse == 1.2.1 09:29:43 INFO - blessings == 1.6 09:29:43 INFO - blobuploader == 1.2.4 09:29:43 INFO - docopt == 0.6.1 09:29:43 INFO - functools32 == 3.2.3-2 09:29:43 INFO - jsonschema == 2.5.1 09:29:43 INFO - manifestparser == 1.1 09:29:43 INFO - mozInstall == 1.12 09:29:43 INFO - mozcrash == 1.0 09:29:43 INFO - mozdebug == 0.1 09:29:43 INFO - mozdevice == 0.49 09:29:43 INFO - mozfile == 1.2 09:29:43 INFO - mozhttpd == 0.7 09:29:43 INFO - mozinfo == 0.9 09:29:43 INFO - mozleak == 0.1 09:29:43 INFO - mozlog == 3.4 09:29:43 INFO - moznetwork == 0.27 09:29:43 INFO - mozprocess == 0.25 09:29:43 INFO - mozprofile == 0.28 09:29:43 INFO - mozrunner == 6.13 09:29:43 INFO - mozscreenshot == 0.1 09:29:43 INFO - mozsystemmonitor == 0.3 09:29:43 INFO - moztest == 0.8 09:29:43 INFO - mozversion == 1.4 09:29:43 INFO - psutil == 3.1.1 09:29:43 INFO - requests == 1.2.3 09:29:43 INFO - wsgiref == 0.1.2 09:29:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:43 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:43 INFO - Using env: {'DISPLAY': ':0', 09:29:43 INFO - 'HOME': '/home/cltbld', 09:29:43 INFO - 'LANG': 'en_US.UTF-8', 09:29:43 INFO - 'LANGUAGE': 'en_US:en', 09:29:43 INFO - 'LOGNAME': 'cltbld', 09:29:43 INFO - 'MAIL': '/var/mail/cltbld', 09:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:43 INFO - 'MOZ_NO_REMOTE': '1', 09:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:43 INFO - 'NO_EM_RESTART': '1', 09:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:43 INFO - 'PWD': '/builds/slave/test', 09:29:43 INFO - 'SHELL': '/bin/bash', 09:29:43 INFO - 'SHLVL': '1', 09:29:43 INFO - 'TERM': 'linux', 09:29:43 INFO - 'TMOUT': '86400', 09:29:43 INFO - 'USER': 'cltbld', 09:29:43 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:43 INFO - '_': '/tools/buildbot/bin/python'} 09:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:43 INFO - Cleaning up... 09:29:43 INFO - Return code: 0 09:29:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:43 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 0xbc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, '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': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:29:43 INFO - Using env: {'DISPLAY': ':0', 09:29:43 INFO - 'HOME': '/home/cltbld', 09:29:43 INFO - 'LANG': 'en_US.UTF-8', 09:29:43 INFO - 'LANGUAGE': 'en_US:en', 09:29:43 INFO - 'LOGNAME': 'cltbld', 09:29:43 INFO - 'MAIL': '/var/mail/cltbld', 09:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:43 INFO - 'MOZ_NO_REMOTE': '1', 09:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:43 INFO - 'NO_EM_RESTART': '1', 09:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:43 INFO - 'PWD': '/builds/slave/test', 09:29:43 INFO - 'SHELL': '/bin/bash', 09:29:43 INFO - 'SHLVL': '1', 09:29:43 INFO - 'TERM': 'linux', 09:29:43 INFO - 'TMOUT': '86400', 09:29:43 INFO - 'USER': 'cltbld', 09:29:43 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:43 INFO - '_': '/tools/buildbot/bin/python'} 09:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:43 INFO - Cleaning up... 09:29:43 INFO - Return code: 0 09:29:43 INFO - Running post-action listener: _resource_record_post_action 09:29:43 INFO - Running post-action listener: _start_resource_monitoring 09:29:43 INFO - Starting resource monitoring. 09:29:43 INFO - [mozharness: 2017-03-10 17:29:43.641159Z] Finished create-virtualenv step (success) 09:29:43 INFO - [mozharness: 2017-03-10 17:29:43.641673Z] Running install step. 09:29:43 INFO - Running pre-action listener: _resource_record_pre_action 09:29:43 INFO - Running main action method: install 09:29:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:43 INFO - Reading from file tmpfile_stdout 09:29:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:43 INFO - Reading from file tmpfile_stdout 09:29:43 INFO - Output received: 09:29:43 INFO - Usage: mozinstall [options] installer 09:29:43 INFO - Options: 09:29:43 INFO - -h, --help show this help message and exit 09:29:43 INFO - -d DEST, --destination=DEST 09:29:43 INFO - Directory to install application into. [default: 09:29:43 INFO - "/builds/slave/test"] 09:29:43 INFO - --app=APP Application being installed. [default: firefox] 09:29:43 INFO - mkdir: /builds/slave/test/build/application 09:29: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'] 09:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:29:59 INFO - Reading from file tmpfile_stdout 09:29:59 INFO - Output received: 09:29:59 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:59 INFO - Running post-action listener: _resource_record_post_action 09:29:59 INFO - [mozharness: 2017-03-10 17:29:59.339072Z] Finished install step (success) 09:29:59 INFO - [mozharness: 2017-03-10 17:29:59.339214Z] Running run-tests step. 09:29:59 INFO - Running pre-action listener: _resource_record_pre_action 09:29:59 INFO - Running main action method: run_tests 09:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:59 INFO - Python 2.7.3 09:29:59 INFO - Return code: 0 09:29:59 INFO - grabbing minidump binary from tooltool 09:29: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')]} 09:29: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 0xe5b290>, '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 0xe5bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29: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 09:29: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 09:29: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 09:29:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:59 INFO - Return code: 0 09:29:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:59 INFO - ENV: RUST_BACKTRACE is now 1 09:29:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 09:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 09:29:59 INFO - Using env: {'DISPLAY': ':0', 09:29:59 INFO - 'HOME': '/home/cltbld', 09:29:59 INFO - 'LANG': 'en_US.UTF-8', 09:29:59 INFO - 'LANGUAGE': 'en_US:en', 09:29:59 INFO - 'LOGNAME': 'cltbld', 09:29:59 INFO - 'MAIL': '/var/mail/cltbld', 09:29:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:59 INFO - 'MOZ_NO_REMOTE': '1', 09:29:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:59 INFO - 'NO_EM_RESTART': '1', 09:29:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:59 INFO - 'PWD': '/builds/slave/test', 09:29:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:59 INFO - 'RUST_BACKTRACE': '1', 09:29:59 INFO - 'SHELL': '/bin/bash', 09:29:59 INFO - 'SHLVL': '1', 09:29:59 INFO - 'TERM': 'linux', 09:29:59 INFO - 'TMOUT': '86400', 09:29:59 INFO - 'USER': 'cltbld', 09:29:59 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054', 09:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:59 INFO - '_': '/tools/buildbot/bin/python'} 09:29:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 09:29:59 INFO - mozversion application_buildid: 20170310165946 09:29:59 INFO - mozversion application_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 09:29:59 INFO - mozversion application_display_name: Nightly 09:29:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:59 INFO - mozversion application_name: Firefox 09:29:59 INFO - mozversion application_remotingname: firefox 09:29:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:29:59 INFO - mozversion application_vendor: Mozilla 09:29:59 INFO - mozversion application_version: 55.0a1 09:29:59 INFO - mozversion platform_buildid: 20170310165946 09:29:59 INFO - mozversion platform_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 09:29:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:29:59 INFO - mozversion platform_version: 55.0a1 09:29:59 INFO - using testdate: 1489166999 09:29:59 INFO - actual date: 1489166999 09:29:59 INFO - starting webserver on 'localhost:34980' 09:29:59 INFO - SUITE-START | Running 2 tests 09:29:59 INFO - TEST-START | dromaeo_css 09:29:59 INFO - operating with platform_type : linux_ 09:29:59 INFO - Initialising browser for dromaeo_css test... 09:29:59 INFO - TEST-INFO | started process 22536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkAovWe/profile http://localhost:34980/getInfo.html) 09:30:03 INFO - PROCESS | 22536 | __metrics Screen width/height:1600/1200 09:30:03 INFO - PROCESS | 22536 | colorDepth:24 09:30:03 INFO - PROCESS | 22536 | Browser inner width/height: 1024/697 09:30:03 INFO - PROCESS | 22536 | __metrics 09:30:04 INFO - PROCESS | 22536 | 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" 09:30:04 INFO - PROCESS | 22536 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:05 INFO - TEST-INFO | 22536: exit 0 09:30:05 INFO - Browser initialized. 09:30:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:05 INFO - TEST-INFO | started process 22625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkAovWe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:17 INFO - PROCESS | 22625 | RSS: Main: 148303872 09:30:17 INFO - PROCESS | 22625 | 09:33:23 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34980/tests/dromaeo/cssquery-ext.html) 09:33:26 INFO - PROCESS | 22625 | RSS: Main: 351031296 09:33:26 INFO - PROCESS | 22625 | 09:35:07 INFO - PROCESS | 22625 | ************************* 09:35:07 INFO - PROCESS | 22625 | A coding exception was thrown and uncaught in a Task. 09:35:07 INFO - PROCESS | 22625 | 09:35:07 ERROR - PROCESS | 22625 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:35:07 INFO - PROCESS | 22625 | Full stack: 09:35:07 INFO - PROCESS | 22625 | ************************* 09:36:29 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-ext.html (next: http://localhost:34980/tests/dromaeo/cssquery-jquery.html) 09:36:29 INFO - PROCESS | 22625 | RSS: Main: 241815552 09:36:29 INFO - PROCESS | 22625 | 09:39:31 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34980/tests/dromaeo/cssquery-mootools.html) 09:39:32 INFO - PROCESS | 22625 | RSS: Main: 217243648 09:39:32 INFO - PROCESS | 22625 | 09:42:34 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34980/tests/dromaeo/cssquery-prototype.html) 09:42:35 INFO - PROCESS | 22625 | RSS: Main: 178425856 09:42:35 INFO - PROCESS | 22625 | 09:45:38 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34980/tests/dromaeo/cssquery-yui.html) 09:45:39 INFO - PROCESS | 22625 | RSS: Main: 187588608 09:45:39 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | Cycle 1(1): loaded http://localhost:34980/tests/dromaeo/cssquery-yui.html (next: http://localhost:34980/tests/dromaeo/cssquery-dojo.html) 09:48:42 INFO - PROCESS | 22625 | RSS: Main: 267223040 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | __start_tp_report 09:48:42 INFO - PROCESS | 22625 | _x_x_mozilla_page_load 09:48:42 INFO - PROCESS | 22625 | _x_x_mozilla_page_load_details 09:48:42 INFO - PROCESS | 22625 | |i|pagename|runs| 09:48:42 INFO - PROCESS | 22625 | |0;dojo.html;2658.3487045673814;2665.1471529110668;2686.207568767214;2706.9864650676745;2708.1198610451606;4858.538438848313;4912.852614421564;4979.427365852928;5028.773705183266;5078.314427552279;4938.432080310766;4952.851414457563;4965.081459929916;5000.424951130612;5064;4582.862514124582;4610.815567377318;4612.100640375128;4621.79201935912;4668.089722504104;4529.184746745585;4616.8614941551805;4655.301704744282;4711;4738.407699037621;4646.674732768707;4700.1539722849875;4708.458527269374;4724.267738500521;4745.833895813647;4493.842715504941;4495.505494395614;4554.977225113853;4568.5431456854385;4570.474395444533;4541.545845415465;4556.270996640522;4559.521250268707;4564.680472366936;4572.817087316504;4930.753462326905;4939.925901111486;4972.8259510917305;5031.723255220962;5072.51811077947;5433.429489903543;5438.945610543883;5450.345958484968;5484.232207490954;5486.506214440719;5462.945370546323;5469.316335458067;5478.972605136989;5479.808206712746;5488.231647569343;4904.852854414374;4963.181075122564;5046.571041461517;5091.159958606789;5135.897282054338;5520.585956053232;5527.972360138174;5529.391766905637;5531.834044978657;5533.418991005887;5246.16061430177;5283.709395983181;5284.947150528523;5311.760970756325;5319.0957537218765;5434.10337294342;5438.45615438453;5439.592030597721;5443.782248710087;5487.807926722546;5360.437154098841;5400.270963419888;5402.432744561843;5410.323709536308;5461.726913654381;5218.869528261748;5243.370795504564;5245.0558899398475;5252.448492908266;5379.408265090837;4498.797554110073;4499;4499.707519011319;4504.1216962692615;4508.18852606534;3865.3042452358845;3895.7857317847224;3931.1744533648252;3955.881323560298;3965.6827453803626;4585.472670642919;4617.353570500132;4618.399608050999;4618.907621847611;4675.345451636774;5232.529072383504;5437.619366644376;5439.428859969726;5450.31871016123;5507.284053073155;4554.3851580036935;4563.38394316763;4563.931541026887;4569.13186494565;4570.177368073712;4786.617070634341;4791.592714619296;4810.735409552438;4822.421309442819;4931.753412329441;5106.642535022513;5115.74421278942;5152.433232344514;5161.81933632321;5163.896722065613;5428.538574221077;5464;5469.972650136724;5473.233747275305;5528.585356098389;4963.975180124076;4994.700317980933;5050.3434553507805;5051.015052064812;5057.494250574913;5296.258523806593;5301.973490132525;5316.282301889196;5324.361076670824;5434.83695489136;5492.286002819608;5498.257735205856;5514.61397702157;5516.255305533701;5517.062099443185;5237.214417837355;5281.577473802164;5293.814716484904;5295.152775555893;5337.786488540415;5269.631125821309;5275.261463395051;5280.894382112413;5288.048151332797;5346.545543628835;5042.949570504395;5067.822626208065;5069.8732531687;5080.822171223989;5200.895982080261;5231.503007214308;5240.449752775904;5242.659227150223;5243.449437808975;5248.107821670249;5054.444011158843;5085.415177254663;5087.643864929568;5096.031753966735;5129.923051154161 09:48:42 INFO - PROCESS | 22625 | |1;ext.html;696.4045740891538;716.6345163966375;757.7878194105652;768.7002069193019;769.3076231391747;36139.819300903495;37105.62894371059;39666.008349791235;39802.80098599503;39830.20339593206;35739.2852142957;35942.82028589853;35978.82010589943;35981.280374392496;36019;6692.163479565054;7149.3565579098;7266.055412796329;7275.308845659681;9184.770380740469;9228.215601673866;9310;9328;9328.626854925795;9333.486658233795;9319.86020209694;9352.625894964192;9354.625814967427;9356.766080847965;9363;9296.30277729173;9310.441373517577;9334.299927505464;9340.206082482997;9341;8970.282377409792;9066.637334506611;9073.63705451781;9082.09179082093;9086.818263634756;33242.83378583116;33350.666493335;33426.331473370396;33530.664693353;33560.16099597505;3461.4288642373976;3494.143934736006;3500.9824950875336;3515.771474854126;3561.2343346180437;23654.64518032231;26098.478030439474;26115.477690446274;26372.60441093385;26426.075087372043;3271.3947919634707;3356.110630682871;3386.9322613547592;3433.9141521461916;3479.9826000869834;167124;168678;168999;168999;169495.3050469492;36437.63562364342;37037.07407314839;41280.587194128275;43207.78396108062;43242.13515729731;45930;46086;46119;46134.30798538025;46177.7691111549;12176.330301833485;12260.080493962989;12287.877121228852;12322.507099715911;12358.073144514197;9697.418154910727;9709.70870873875;9724.562394692255;9729.805403891882;9734.318597698093;11115.777684446266;12854.485820567259;12967.351632418342;13001.154924930039;13034;4569.657275704336;5319.28189694394;5405.486478784509;5463.508284254436;5525.502704756591;856.4047986649343;873.8689196620558;886.636479043589;898.6719847255705;918.3800934369274;23428.64857027146;24928.750712493005;24958;24968.250952471455;24991.750082499308;934.1825902335456;943.6461327002374;948.184561277301;950.277788880442;964.7925695975399;13558.932205339108;13578.932105339607;13581.660458488617;14804.629884252765;15379.461718839786;242212;243168;243789;243914;244024;47163.76418117888;47429.5257047432;47546.76226618914;47551.5244847554;47584;1187.1867770577182;1204.5242129358853;1207.9396030198454;1221.6274036418622;1228.7051107734258;24722.876385618678;24763.876180618983;25282.937861004426;25499.72501374961;25660.230193094238;36227.81886090553;36581.45127823031;36700;36713;36763;243527;244627;245183;245580;245748;23233.651495227925;23658.763412365657;25936.870315648302;26493;27844.44311113807;33869.32261354809;33977;34311.31377372488;34610.48084278788;34696.479552807235;29001.85499072491;29026.564601531416;29140;29200.707992919797;29772.55341169841;28723.425531488836;29106.417871642872;29665.851670741507;30163.547546786376;31536.36927261396;31493;32392.190195244366;32451.837740811145;32597.34805303833;32610.51084233691;26750.59874101851;28071.859640701667;30169.245768855075;32748;32828;23471.88264058669;23797.64303535483;23869.522609548058;24204.39489012789;24240.1515946941 09:48:42 INFO - PROCESS | 22625 | |2;jquery.html;380.54904937648905;384.92493963677094;388.4755579967045;403.6750415915188;407.74108441139884;13042.73914521709;15106.697866042672;17871.642567148665;19554.706679399802;19578.902105489487;17548.385806496775;17763.733543996852;17860;18360.265589376442;18659.160337784797;5740.885182296352;5969.88060238795;6630.569013014163;6839.65801709915;6864.039034535169;3753.530808648919;6794.592324460548;6984.406325462342;6988.790336289894;6990.475714321421;6228.470580000682;6922.584644921296;6927.272636373184;6943.687534060954;6999.82500437488;6544.116544266511;6770.424513916323;6815.318468153195;6903.861922761542;6923.965380173092;6595.868082638321;6629.535932484728;6698.296678848748;6711.798646040578;6792.728290868359;20994.580108397746;21731.348059558237;21904.89047554752;22434.551308973892;22440;2298.5058212484396;2377.6314671225987;2431.9635205471754;2446.3272600034957;2457.8648174350405;14052.578422647337;14476.565703028926;14485.71028579433;14842.480513181987;15068.698626027528;1925.1914196037558;1926.489480287725;1940.5439721665398;1956.6869300911928;1991.8406527477766;83991.58004210002;89700.38290200956;91584;93032;93103.53448232716;15736.527904162893;16003.27985240667;16116.516504504883;16555.25501352442;16647;22510.212142574932;28971.275718107216;28992.42015159685;29116.050271453903;29193.7080629191;7411.629418529052;8438.746837594881;8477.364197685198;8833.249173820297;9067.365284430027;7000.824979375455;7058.576485410892;7091.82270443243;7222.963885180646;7292.8176795579475;8715.956420217984;8753.387262891663;8949.149830766068;9029.548522573845;9139;3291.391092647868;3431.1765176357994;3550.378683730337;3554.7689400188906;3621.8913432596537;810.2059981218439;828.7928017995501;836.8869403693074;838.3921656798894;854.5171977832505;18904;19939.401817945483;20046.799532004494;20077.196912123643;20347.593048138955;823.7940514871282;832.0930186097062;833.7665453672981;836.744792838178;846.2933450568844;10426.5829366826;10944.712534121218;11020.063294620048;11052.889471105347;11126.721831954104;430837;439304;452779;453300;457093;87736;88376;88544;88715;90011;1061.2253055269541;1075.9139268858473;1098.4782228441427;1112.0547534595692;1115.5872327238974;16447.83552164463;17030.82969170342;17369.305227791254;17402.39091631787;17409.47771566855;41956.79021604994;42361.1527769449;42445.36331955085;42924.57075429206;43478.56521434745;50811.491885082156;51415.344312124886;51892.48107518876;53264.20103698525;54777.726111369186;9464.858027129736;9941;10113.49432528356;10260.43567603759;10493.47532623381;12073.215241009306;12080.939595301967;12323.568675096329;12488.937555312528;13012.8048079277;10756.784864302826;10811.513481893177;10814.35113893169;10847.186461015297;11209.831852522055;10306.587736490457;10407.531661075118;10415.583376664848;10416.635417760343;10417.531211095671;10933.562657493929;10969.945150274516;11006.504707288032;11452;11457.59898403552;10295.485225738832;10431.321964072311;10483.68548943533;10557.788844223227;10939.234253602172;10401.531931063271;10447.268691191848;10660.786784264426;11010.50452729613;11074.501647425725 09:48:42 INFO - PROCESS | 22625 | |3;mootools.html;1450.2821103553742;1461.6638173220158;1484.5620541940127;1485.2796393749034;1486.3460077565876;9120.17918387345;9693.515324233778;9693.951530242339;9699.175570076542;9703.223742100632;9360.953195234031;9662.85505717413;9674.758131046727;9680.177184939288;9681.757956051084;1982.8215460608542;2015.3853074812178;2018.2128969701828;2018.5760990192005;2023.6037134377307;1844.7048472244444;1884.4346695991148;1886.669832779265;1891.4514790710678;1891.8959457229846;1958.7649482062172;1965.3907288740465;1969.8424126069951;1969.862109652325;1970.1626808606356;1805.9458216253468;1836.8255015773414;1838.9356372527031;1840.346676929684;1841.1254654039358;1837.9172937217725;1850.1489314915154;1874.6502518186883;1893.3089422360877;1912.3498010676437;9569.186619137381;9596.808063838684;9635.325527213097;9671.613135474572;9692.224622030291;4843.6851604645935;4962.106820772259;4984.40187177541;4993.850184494435;4995;2647.8014148938905;2832.362718388367;2846.5160922642995;2896.203544025389;2900.8114472559214;965;995.9153471954893;996.5594969747341;1003.0671475527756;1029.809485245232;12077.335746533938;12408.131430799847;12786;13902;14007.85992140086;4071.633552980246;4157.64660003897;4162.542120366757;4164.895877603023;4199.979000105041;10876.564937402574;10878.184136189817;10880.075193608474;10882.238243322892;10886.72783180411;4105.815238314283;4216.578342165759;4670.042641258534;4931.506849315111;4936.111499929975;4487.125010622897;4508.684392092522;4510.616597589176;4513.50351461339;4515.277555591089;3097.148284221857;3200.2639392939755;3251.9187020324207;3254.772165948361;3292.2592416706048;803.337246771416;813.8046868751456;826.2811354121832;834.1158372125566;840.0717207485762;840.9915900841036;848.245061894914;853.4282031039219;857.4041041476239;875.5097145598485;5586.301712285965;5681.488666020078;5950;6056.848578785565;6077.756889724362;927.2026057590467;930.4835816121982;931.3247895275871;934.8737920380662;949.8622699708503;3725.348064088828;3786.583475817658;3821.560520540118;3859.9228015440094;3862.957001609606;12280.263184208976;12642.115051946275;12665.240085594894;12787.488500459878;12813.679658008625;12617;12656.746865062647;12667.49330026807;12680.746385072247;12685.49258029687;8396.664133434717;8676.522791246542;8695.08701586337;8712.825743485222;8859.911400886038;6018.759249630141;6100.450959413674;6113.2969708482315;6136.355682653436;6236.719347629459;11007.834882476609;11072.612458563912;11189.832152517882;11205.383703896365;11226.382548959886;8195.426320157532;10830.67507974762;11137.498812553617;11404.315741055563;11514.021308188898;7926.286634202949;8019.679212831421;8038.557879316693;8105.230003149692;8116.066652334821;8742.956285218534;8760.91239087601;8846.203841654282;8847.955760221415;8849.336299777413;7941.523508589503;7985.760427186961;7993.040835099825;8038.959805200937;8084.757457276056;7889.368850491832;7948.443608947549;7996.960015199887;8013.439059265796;8153.143919888564;7154.141503019671;7307.5980821055355;7415.5550666958;7420.703171873065;7434.962825185839;5046.84859454217;5083.593312535062;5096;5188.766505507337;5198.870028249324;5193.002632192014;5260.44765299638;5298.8940221196135;5361.785528578813;5418.783248670009 09:48:42 INFO - PROCESS | 22625 | |4;prototype.html;350.8333541567754;362.73701566364383;362.88387715930907;366.7359501159168;372.2629194195493;4725.196716558185;4731.621470282378;4755.096531658983;4768;4779.1875381185155;4615.246206441556;4652;4668.603168730662;4677.976610116944;4735.644826637998;3799.7530160539613;3925.6466917977377;3957.307471192544;3968.464257325267;3979.781112038837;3918.5885482024405;3936.5866584008695;3938.724289299736;3940.586238444965;3948.8617898373564;3919.8628048018327;3931.0565464288507;3933.724639275252;3941.960580394202;3942.80285985701;3857.1514266861527;3957.4855268815013;3966.3058964681354;3979.6617287530594;4065.735727177724;3821.407681809324;3890.727649064567;3918.1380096378753;3934.6852251820073;3935.960640393588;4521.977390113061;4523.615492683126;4556.97468069685;4558.316252562142;4563;4527.932081018787;4690.882727931795;4692.4603670577635;4700.905981880377;4737.8341758038305;4922.335484709554;4929.883547238061;4945.455999840015;4967.503249675004;4969.826056088055;4327.459067616548;4331.848385306531;4348.89127771805;4381.233284175257;4386.780660966971;4966.261808367042;4982.078315511606;5014.824481143179;5225.242339860737;5299.920501192447;4416.24923762961;4436.6672499562665;4442.311441726473;4443.555644435531;4450.9985253317745;4506.526814684476;4525.705829121097;4536.954630453653;4537.050916903972;4584.991301913574;4498.3252512123445;4655.348251244828;4698.144233027935;4702;4724.480307166209;4842.394700662418;4865.927011094836;4870.586000190024;4876.341693871282;4904.975475122673;1556.688662267551;1569.8901076924506;1570;1572.3946280681791;1579.155151993678;1218.422143324397;1301.3233118778182;1304.8760367765046;1314.6844757258189;1336.5656161747277;4309.569043095728;4316.093620339701;4334.9783251083545;4337.7180483268485;4355.172517221781;4795.256735206049;4967.652264341461;5008.373953255843;5029.396472423333;5033.942871996922;4299.419578356882;4304.332828411601;4330.372096046056;4338.915271182204;4342.218400687906;2631.802614803859;2632.921012369594;2653.2968763277745;2657.2028391482477;2657.827241229314;4527.411436513232;4659.4175728034;4670.182718024332;4695.5304469552775;4717.292406139107;5075.771590278447;5088;5088.618353623493;5094.796208151706;5095.923561146586;4716.25498565533;4725.3384526166365;4737.6683632146105;4742.9762851186215;4743.217369134054;4682.8259940571115;5040.470750571138;5047.671901326402;5056.57019153376;5061.772220250171;4895.241237608177;4930.580900623487;4930.654854160174;4938.259261110862;4973.676711013773;4515.593596576324;4527.004059106991;4635.443746750277;4704.482506924304;4735.976320118378;4418.690691651682;4434.299642379088;4434.3791869138995;4472.217361961579;4481.260592002283;5047.747612619428;5055.443901170942;5069;5087;5105.132127538253;4598.402207712976;4804.423469183581;4876.487968763229;4879.219085033866;4887.340209071872;4861.54491981547;4874.122657921608;4881.87795305106;4883.755812209304;4910.950890491049;4753.263244197155;4824.228123500364;4845.49122342149;4850.417949846041;4891.657583969088;4652.627789776878;4889.682170658896;4929.457759646364;4941.950580494149;4967.801287948441;4791.185498465339;4817.975910120427;4818.4217893852965;4818.903621927471;4860.416749990024 09:48:42 INFO - PROCESS | 22625 | |5;yui.html;676.3169199108899;693.9375456208941;695.200519402687;706.9858602827943;709.3713519286653;12888.548900788473;13792.03455758096;13802.447902083904;13815.171089734624;13824.930875345623;12788.488460461595;12918.160319579221;14511.637209069779;15073.170975596338;15661;835.2065537739142;836.4270474724818;846.6020970144023;847.2417186618004;848.8854004709347;836.0302049622439;847.6948298612494;850.0309647002422;850.6937502499095;854.0221446443818;876.9166929141721;881.5592203898051;881.6870011146015;881.7134431309818;882.2324577617482;860.0109873645296;861.1603686405736;861.3496809908542;861.4658911474863;861.5778268648318;640.6924676155471;642;642.065794269337;642.0914406115342;642.8521440068811;13251.602451926457;13468.797968030487;13520.864791352058;13539.932300338436;14627.853721462756;13831.723365532735;14469.710605787825;14543.054701444373;14564.927175364055;14565.271736413242;10908.727281817939;10957.890421095846;11053.171012174038;11098.167637427225;11119;3283.819389933553;3285.4578994465883;3311;3350.564426624523;3438.7764795288476;65074.3492565073;66031;66097.66951165261;66571;66900.6654966727;9913.504324783731;10022.398656080659;10037.297389182688;10284.691459256233;10293.176545876311;21637.02348459863;21656;21852.781472185394;22008.779912200993;22011;6512.5441219115155;6594.505412094112;6661.433778128817;6704.7988560343265;6737;3333.7833040852265;3428.6914177723625;3443.810590417501;3448.3965306071336;3509.5437593112733;2813.831170129758;2897.5653651952375;2927.8536073196256;2928.048384275119;2944.1167649705003;475.80254194508893;476.69967920210047;481.0907385042273;485.2502883045703;487.25693317690803;563.0479929024242;567.7643777832153;590.4892268187987;592.7095723095653;604.9364816694272;8525.655444752618;8901.465912045298;8950.104989500998;8978.416402933788;9004.614827922915;530.3874025500553;533.5598131541494;548.4351118348108;549.9560035197175;554.27666894702;4149.792510374529;4270.722403043792;4381.474223093249;4402.581754733359;4489.326601009875;63051.36948630547;63182;64979.02531461937;64991.67504162449;65046;55036;55106.72446637741;57197.71401142968;57540.71229643825;57857.4214257852;42485;42860.57139428566;48905.510944890804;50454.74772626187;50763;8598.914010860062;9088;9142.954285228532;9337.439753614804;9641.325107242707;32719;33057.50413743748;33135;33199.50200747039;33340.83329583336;38033;38437;38978;39736.60263397329;40184.799076004434;11235.157363197957;11604.361760103275;11658.834116588274;11798.941005294919;11811.409429528661;12434.564790232298;12522;12563.43464544116;12719.364031798188;12736.172148810669;11583.478743456397;11828.704282392664;11889.28664280146;12171.756564868476;12344.506219751109;10911.727206819576;11351.432428378714;11541.307521548733;11899.345535995257;11970.820437693616;10151.796964060824;10942.124630029737;11123.555057797921;11225.775484490428;11320.547178112784;9711.38300632732;9831.164351030242;9863.753406164904;9897.455639939872;9942.10025380697;8355.916440835757;8371.62327695243;9360;9736.269779766404;9840.212782977202 09:48:42 INFO - PROCESS | 22625 | __end_tp_report 09:48:42 INFO - PROCESS | 22625 | __start_cc_report 09:48:42 INFO - PROCESS | 22625 | _x_x_mozilla_cycle_collect,2559 09:48:42 INFO - PROCESS | 22625 | __end_cc_report 09:48:42 INFO - PROCESS | 22625 | __startTimestamp1489168122652__endTimestamp 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | ------- Summary: start ------- 09:48:42 INFO - PROCESS | 22625 | Number of tests: 6 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#0] dojo.html Cycles:165 Average:4967.97 Median:5080.82 stddev:557.28 (11.0%) stddev-sans-first:528.72 09:48:42 INFO - PROCESS | 22625 | Values: 2658.3 2665.1 2686.2 2707.0 2708.1 4858.5 4912.9 4979.4 5028.8 5078.3 4938.4 4952.9 4965.1 5000.4 5064.0 4582.9 4610.8 4612.1 4621.8 4668.1 4529.2 4616.9 4655.3 4711.0 4738.4 4646.7 4700.2 4708.5 4724.3 4745.8 4493.8 4495.5 4555.0 4568.5 4570.5 4541.5 4556.3 4559.5 4564.7 4572.8 4930.8 4939.9 4972.8 5031.7 5072.5 5433.4 5438.9 5450.3 5484.2 5486.5 5462.9 5469.3 5479.0 5479.8 5488.2 4904.9 4963.2 5046.6 5091.2 5135.9 5520.6 5528.0 5529.4 5531.8 5533.4 5246.2 5283.7 5284.9 5311.8 5319.1 5434.1 5438.5 5439.6 5443.8 5487.8 5360.4 5400.3 5402.4 5410.3 5461.7 5218.9 5243.4 5245.1 5252.4 5379.4 4498.8 4499.0 4499.7 4504.1 4508.2 3865.3 3895.8 3931.2 3955.9 3965.7 4585.5 4617.4 4618.4 4618.9 4675.3 5232.5 5437.6 5439.4 5450.3 5507.3 4554.4 4563.4 4563.9 4569.1 4570.2 4786.6 4791.6 4810.7 4822.4 4931.8 5106.6 5115.7 5152.4 5161.8 5163.9 5428.5 5464.0 5470.0 5473.2 5528.6 4964.0 4994.7 5050.3 5051.0 5057.5 5296.3 5302.0 5316.3 5324.4 5434.8 5492.3 5498.3 5514.6 5516.3 5517.1 5237.2 5281.6 5293.8 5295.2 5337.8 5269.6 5275.3 5280.9 5288.0 5346.5 5042.9 5067.8 5069.9 5080.8 5200.9 5231.5 5240.4 5242.7 5243.4 5248.1 5054.4 5085.4 5087.6 5096.0 5129.9 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#1] ext.html Cycles:180 Average:36811.86 Median:18872.61 stddev:57706.44 (305.8%) stddev-sans-first:57804.61 09:48:42 INFO - PROCESS | 22625 | Values: 696.4 716.6 757.8 768.7 769.3 36139.8 37105.6 39666.0 39802.8 39830.2 35739.3 35942.8 35978.8 35981.3 36019.0 6692.2 7149.4 7266.1 7275.3 9184.8 9228.2 9310.0 9328.0 9328.6 9333.5 9319.9 9352.6 9354.6 9356.8 9363.0 9296.3 9310.4 9334.3 9340.2 9341.0 8970.3 9066.6 9073.6 9082.1 9086.8 33242.8 33350.7 33426.3 33530.7 33560.2 3461.4 3494.1 3501.0 3515.8 3561.2 23654.6 26098.5 26115.5 26372.6 26426.1 3271.4 3356.1 3386.9 3433.9 3480.0 167124.0 168678.0 168999.0 168999.0 169495.3 36437.6 37037.1 41280.6 43207.8 43242.1 45930.0 46086.0 46119.0 46134.3 46177.8 12176.3 12260.1 12287.9 12322.5 12358.1 9697.4 9709.7 9724.6 9729.8 9734.3 11115.8 12854.5 12967.4 13001.2 13034.0 4569.7 5319.3 5405.5 5463.5 5525.5 856.4 873.9 886.6 898.7 918.4 23428.6 24928.8 24958.0 24968.3 24991.8 934.2 943.6 948.2 950.3 964.8 13558.9 13578.9 13581.7 14804.6 15379.5 242212.0 243168.0 243789.0 243914.0 244024.0 47163.8 47429.5 47546.8 47551.5 47584.0 1187.2 1204.5 1207.9 1221.6 1228.7 24722.9 24763.9 25282.9 25499.7 25660.2 36227.8 36581.5 36700.0 36713.0 36763.0 243527.0 244627.0 245183.0 245580.0 245748.0 23233.7 23658.8 25936.9 26493.0 27844.4 33869.3 33977.0 34311.3 34610.5 34696.5 29001.9 29026.6 29140.0 29200.7 29772.6 28723.4 29106.4 29665.9 30163.5 31536.4 31493.0 32392.2 32451.8 32597.3 32610.5 26750.6 28071.9 30169.2 32748.0 32828.0 23471.9 23797.6 23869.5 24204.4 24240.2 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#2] jquery.html Cycles:180 Average:28576.65 Median:29054.24 stddev:73849.68 (254.2%) stddev-sans-first:74026.50 09:48:42 INFO - PROCESS | 22625 | Values: 380.5 384.9 388.5 403.7 407.7 13042.7 15106.7 17871.6 19554.7 19578.9 17548.4 17763.7 17860.0 18360.3 18659.2 5740.9 5969.9 6630.6 6839.7 6864.0 3753.5 6794.6 6984.4 6988.8 6990.5 6228.5 6922.6 6927.3 6943.7 6999.8 6544.1 6770.4 6815.3 6903.9 6924.0 6595.9 6629.5 6698.3 6711.8 6792.7 20994.6 21731.3 21904.9 22434.6 22440.0 2298.5 2377.6 2432.0 2446.3 2457.9 14052.6 14476.6 14485.7 14842.5 15068.7 1925.2 1926.5 1940.5 1956.7 1991.8 83991.6 89700.4 91584.0 93032.0 93103.5 15736.5 16003.3 16116.5 16555.3 16647.0 22510.2 28971.3 28992.4 29116.1 29193.7 7411.6 8438.7 8477.4 8833.2 9067.4 7000.8 7058.6 7091.8 7223.0 7292.8 8716.0 8753.4 8949.1 9029.5 9139.0 3291.4 3431.2 3550.4 3554.8 3621.9 810.2 828.8 836.9 838.4 854.5 18904.0 19939.4 20046.8 20077.2 20347.6 823.8 832.1 833.8 836.7 846.3 10426.6 10944.7 11020.1 11052.9 11126.7 430837.0 439304.0 452779.0 453300.0 457093.0 87736.0 88376.0 88544.0 88715.0 90011.0 1061.2 1075.9 1098.5 1112.1 1115.6 16447.8 17030.8 17369.3 17402.4 17409.5 41956.8 42361.2 42445.4 42924.6 43478.6 50811.5 51415.3 51892.5 53264.2 54777.7 9464.9 9941.0 10113.5 10260.4 10493.5 12073.2 12080.9 12323.6 12488.9 13012.8 10756.8 10811.5 10814.4 10847.2 11209.8 10306.6 10407.5 10415.6 10416.6 10417.5 10933.6 10969.9 11006.5 11452.0 11457.6 10295.5 10431.3 10483.7 10557.8 10939.2 10401.5 10447.3 10660.8 11010.5 11074.5 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#3] mootools.html Cycles:180 Average:5938.53 Median:4933.81 stddev:3813.41 (77.3%) stddev-sans-first:3809.20 09:48:42 INFO - PROCESS | 22625 | Values: 1450.3 1461.7 1484.6 1485.3 1486.3 9120.2 9693.5 9694.0 9699.2 9703.2 9361.0 9662.9 9674.8 9680.2 9681.8 1982.8 2015.4 2018.2 2018.6 2023.6 1844.7 1884.4 1886.7 1891.5 1891.9 1958.8 1965.4 1969.8 1969.9 1970.2 1805.9 1836.8 1838.9 1840.3 1841.1 1837.9 1850.1 1874.7 1893.3 1912.3 9569.2 9596.8 9635.3 9671.6 9692.2 4843.7 4962.1 4984.4 4993.9 4995.0 2647.8 2832.4 2846.5 2896.2 2900.8 965.0 995.9 996.6 1003.1 1029.8 12077.3 12408.1 12786.0 13902.0 14007.9 4071.6 4157.6 4162.5 4164.9 4200.0 10876.6 10878.2 10880.1 10882.2 10886.7 4105.8 4216.6 4670.0 4931.5 4936.1 4487.1 4508.7 4510.6 4513.5 4515.3 3097.1 3200.3 3251.9 3254.8 3292.3 803.3 813.8 826.3 834.1 840.1 841.0 848.2 853.4 857.4 875.5 5586.3 5681.5 5950.0 6056.8 6077.8 927.2 930.5 931.3 934.9 949.9 3725.3 3786.6 3821.6 3859.9 3863.0 12280.3 12642.1 12665.2 12787.5 12813.7 12617.0 12656.7 12667.5 12680.7 12685.5 8396.7 8676.5 8695.1 8712.8 8859.9 6018.8 6100.5 6113.3 6136.4 6236.7 11007.8 11072.6 11189.8 11205.4 11226.4 8195.4 10830.7 11137.5 11404.3 11514.0 7926.3 8019.7 8038.6 8105.2 8116.1 8743.0 8760.9 8846.2 8848.0 8849.3 7941.5 7985.8 7993.0 8039.0 8084.8 7889.4 7948.4 7997.0 8013.4 8153.1 7154.1 7307.6 7415.6 7420.7 7435.0 5046.8 5083.6 5096.0 5188.8 5198.9 5193.0 5260.4 5298.9 5361.8 5418.8 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#4] prototype.html Cycles:180 Average:4262.55 Median:4657.38 stddev:1083.69 (23.3%) stddev-sans-first:1046.20 09:48:42 INFO - PROCESS | 22625 | Values: 350.8 362.7 362.9 366.7 372.3 4725.2 4731.6 4755.1 4768.0 4779.2 4615.2 4652.0 4668.6 4678.0 4735.6 3799.8 3925.6 3957.3 3968.5 3979.8 3918.6 3936.6 3938.7 3940.6 3948.9 3919.9 3931.1 3933.7 3942.0 3942.8 3857.2 3957.5 3966.3 3979.7 4065.7 3821.4 3890.7 3918.1 3934.7 3936.0 4522.0 4523.6 4557.0 4558.3 4563.0 4527.9 4690.9 4692.5 4700.9 4737.8 4922.3 4929.9 4945.5 4967.5 4969.8 4327.5 4331.8 4348.9 4381.2 4386.8 4966.3 4982.1 5014.8 5225.2 5299.9 4416.2 4436.7 4442.3 4443.6 4451.0 4506.5 4525.7 4537.0 4537.1 4585.0 4498.3 4655.3 4698.1 4702.0 4724.5 4842.4 4865.9 4870.6 4876.3 4905.0 1556.7 1569.9 1570.0 1572.4 1579.2 1218.4 1301.3 1304.9 1314.7 1336.6 4309.6 4316.1 4335.0 4337.7 4355.2 4795.3 4967.7 5008.4 5029.4 5033.9 4299.4 4304.3 4330.4 4338.9 4342.2 2631.8 2632.9 2653.3 2657.2 2657.8 4527.4 4659.4 4670.2 4695.5 4717.3 5075.8 5088.0 5088.6 5094.8 5095.9 4716.3 4725.3 4737.7 4743.0 4743.2 4682.8 5040.5 5047.7 5056.6 5061.8 4895.2 4930.6 4930.7 4938.3 4973.7 4515.6 4527.0 4635.4 4704.5 4736.0 4418.7 4434.3 4434.4 4472.2 4481.3 5047.7 5055.4 5069.0 5087.0 5105.1 4598.4 4804.4 4876.5 4879.2 4887.3 4861.5 4874.1 4881.9 4883.8 4911.0 4753.3 4824.2 4845.5 4850.4 4891.7 4652.6 4889.7 4929.5 4942.0 4967.8 4791.2 4818.0 4818.4 4818.9 4860.4 09:48:42 INFO - PROCESS | 22625 | 09:48:42 INFO - PROCESS | 22625 | [#5] yui.html Cycles:180 Average:14660.17 Median:2482.56 stddev:17872.53 (719.9%) stddev-sans-first:17891.82 09:48:42 INFO - PROCESS | 22625 | Values: 676.3 693.9 695.2 707.0 709.4 12888.5 13792.0 13802.4 13815.2 13824.9 12788.5 12918.2 14511.6 15073.2 15661.0 835.2 836.4 846.6 847.2 848.9 836.0 847.7 850.0 850.7 854.0 876.9 881.6 881.7 881.7 882.2 860.0 861.2 861.3 861.5 861.6 640.7 642.0 642.1 642.1 642.9 13251.6 13468.8 13520.9 13539.9 14627.9 13831.7 14469.7 14543.1 14564.9 14565.3 10908.7 10957.9 11053.2 11098.2 11119.0 3283.8 3285.5 3311.0 3350.6 3438.8 65074.3 66031.0 66097.7 66571.0 66900.7 9913.5 10022.4 10037.3 10284.7 10293.2 21637.0 21656.0 21852.8 22008.8 22011.0 6512.5 6594.5 6661.4 6704.8 6737.0 3333.8 3428.7 3443.8 3448.4 3509.5 2813.8 2897.6 2927.9 2928.0 2944.1 475.8 476.7 481.1 485.3 487.3 563.0 567.8 590.5 592.7 604.9 8525.7 8901.5 8950.1 8978.4 9004.6 530.4 533.6 548.4 550.0 554.3 4149.8 4270.7 4381.5 4402.6 4489.3 63051.4 63182.0 64979.0 64991.7 65046.0 55036.0 55106.7 57197.7 57540.7 57857.4 42485.0 42860.6 48905.5 50454.7 50763.0 8598.9 9088.0 9143.0 9337.4 9641.3 32719.0 33057.5 33135.0 33199.5 33340.8 38033.0 38437.0 38978.0 39736.6 40184.8 11235.2 11604.4 11658.8 11798.9 11811.4 12434.6 12522.0 12563.4 12719.4 12736.2 11583.5 11828.7 11889.3 12171.8 12344.5 10911.7 11351.4 11541.3 11899.3 11970.8 10151.8 10942.1 11123.6 11225.8 11320.5 9711.4 9831.2 9863.8 9897.5 9942.1 8355.9 8371.6 9360.0 9736.3 9840.2 09:48:42 INFO - PROCESS | 22625 | -------- Summary: end -------- 09:48:42 INFO - PROCESS | 22625 | 09:48:43 INFO - TEST-INFO | 22625: exit 0 09:48:43 INFO - TEST-OK | dromaeo_css | took 1123876ms 09:48:43 INFO - TEST-START | kraken 09:48:43 INFO - operating with platform_type : linux_ 09:48:43 INFO - Initialising browser for kraken test... 09:48:43 INFO - TEST-INFO | started process 22946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpse9hZC/profile http://localhost:34980/getInfo.html) 09:48:47 INFO - PROCESS | 22946 | __metrics Screen width/height:1600/1200 09:48:47 INFO - PROCESS | 22946 | colorDepth:24 09:48:47 INFO - PROCESS | 22946 | Browser inner width/height: 1024/697 09:48:47 INFO - PROCESS | 22946 | __metrics 09:48:48 INFO - PROCESS | 22946 | 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" 09:48:48 INFO - PROCESS | 22946 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:48:49 INFO - TEST-INFO | 22946: exit 0 09:48:49 INFO - Browser initialized. 09:48:49 INFO - Running cycle 1/1 for kraken test... 09:48:49 INFO - TEST-INFO | started process 23038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpse9hZC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:01 INFO - PROCESS | 23038 | RSS: Main: 151142400 09:49:01 INFO - PROCESS | 23038 | 09:49:04 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34980/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:05 INFO - PROCESS | 23038 | RSS: Main: 202199040 09:49:05 INFO - PROCESS | 23038 | 09:49:08 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34980/tests/kraken/driver.html?testName=audio-dft) 09:49:08 INFO - PROCESS | 23038 | RSS: Main: 182657024 09:49:08 INFO - PROCESS | 23038 | 09:49:12 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34980/tests/kraken/driver.html?testName=audio-fft) 09:49:12 INFO - PROCESS | 23038 | RSS: Main: 265289728 09:49:12 INFO - PROCESS | 23038 | 09:49:14 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34980/tests/kraken/driver.html?testName=audio-oscillator) 09:49:15 INFO - PROCESS | 23038 | RSS: Main: 176418816 09:49:15 INFO - PROCESS | 23038 | 09:49:17 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:18 INFO - PROCESS | 23038 | RSS: Main: 179576832 09:49:18 INFO - PROCESS | 23038 | 09:49:21 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34980/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:22 INFO - PROCESS | 23038 | RSS: Main: 218681344 09:49:22 INFO - PROCESS | 23038 | 09:49:25 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34980/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:26 INFO - PROCESS | 23038 | RSS: Main: 214630400 09:49:26 INFO - PROCESS | 23038 | 09:49:29 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34980/tests/kraken/driver.html?testName=json-parse-financial) 09:49:29 INFO - PROCESS | 23038 | RSS: Main: 216043520 09:49:29 INFO - PROCESS | 23038 | 09:49:31 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:31 INFO - PROCESS | 23038 | RSS: Main: 179863552 09:49:31 INFO - PROCESS | 23038 | 09:49:33 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:34 INFO - PROCESS | 23038 | RSS: Main: 186859520 09:49:34 INFO - PROCESS | 23038 | 09:49:36 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:37 INFO - PROCESS | 23038 | RSS: Main: 195112960 09:49:37 INFO - PROCESS | 23038 | 09:49:40 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:40 INFO - PROCESS | 23038 | RSS: Main: 205131776 09:49:40 INFO - PROCESS | 23038 | 09:49:43 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:44 INFO - PROCESS | 23038 | RSS: Main: 200912896 09:49:44 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | Cycle 1(1): loaded http://localhost:34980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34980/tests/kraken/driver.html?testName=ai-astar) 09:49:46 INFO - PROCESS | 23038 | RSS: Main: 253140992 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | __start_tp_report 09:49:46 INFO - PROCESS | 23038 | _x_x_mozilla_page_load 09:49:46 INFO - PROCESS | 23038 | _x_x_mozilla_page_load_details 09:49:46 INFO - PROCESS | 23038 | |i|pagename|runs| 09:49:46 INFO - PROCESS | 23038 | |0;ai-astar;110;117;117;120;118;116;118;117;117;116 09:49:46 INFO - PROCESS | 23038 | |1;audio-beat-detection;144;125;123;165;124;126;125;123;150;126 09:49:46 INFO - PROCESS | 23038 | |2;audio-dft;162;162;163;162;163;164;162;162;161;161 09:49:46 INFO - PROCESS | 23038 | |3;audio-fft;74;76;77;117;78;78;77;76;90;75 09:49:46 INFO - PROCESS | 23038 | |4;audio-oscillator;85;86;113;86;85;85;103;86;85;110 09:49:46 INFO - PROCESS | 23038 | |5;imaging-gaussian-blur;113;113;113;114;114;114;113;114;114;114 09:49:46 INFO - PROCESS | 23038 | |6;imaging-darkroom;148;149;150;150;149;149;149;150;149;149 09:49:46 INFO - PROCESS | 23038 | |7;imaging-desaturate;95;94;94;95;95;94;94;97;95;94 09:49:46 INFO - PROCESS | 23038 | |8;json-parse-financial;63;64;65;63;65;66;64;67;64;66 09:49:46 INFO - PROCESS | 23038 | |9;json-stringify-tinderbox;56;56;56;56;57;56;56;58;56;57 09:49:46 INFO - PROCESS | 23038 | |10;stanford-crypto-aes;86;86;88;95;85;86;86;85;85;87 09:49:46 INFO - PROCESS | 23038 | |11;stanford-crypto-ccm;133;131;131;137;133;133;137;134;182;136 09:49:46 INFO - PROCESS | 23038 | |12;stanford-crypto-pbkdf2;179;180;181;177;176;176;182;179;178;175 09:49:46 INFO - PROCESS | 23038 | |13;stanford-crypto-sha256-iterative;68;68;67;71;67;66;67;68;67;69 09:49:46 INFO - PROCESS | 23038 | __end_tp_report 09:49:46 INFO - PROCESS | 23038 | __start_cc_report 09:49:46 INFO - PROCESS | 23038 | _x_x_mozilla_cycle_collect,1976 09:49:46 INFO - PROCESS | 23038 | __end_cc_report 09:49:46 INFO - PROCESS | 23038 | __startTimestamp1489168186487__endTimestamp 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | ------- Summary: start ------- 09:49:46 INFO - PROCESS | 23038 | Number of tests: 14 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.00 stddev:2.59 (2.2%) stddev-sans-first:1.22 09:49:46 INFO - PROCESS | 23038 | Values: 110.0 117.0 117.0 120.0 118.0 116.0 118.0 117.0 117.0 116.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:126.00 stddev:14.69 (11.7%) stddev-sans-first:15.04 09:49:46 INFO - PROCESS | 23038 | Values: 144.0 125.0 123.0 165.0 124.0 126.0 125.0 123.0 150.0 126.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 09:49:46 INFO - PROCESS | 23038 | Values: 162.0 162.0 163.0 162.0 163.0 164.0 162.0 162.0 161.0 161.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:13.15 (17.1%) stddev-sans-first:13.64 09:49:46 INFO - PROCESS | 23038 | Values: 74.0 76.0 77.0 117.0 78.0 78.0 77.0 76.0 90.0 75.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:85.00 stddev:11.49 (13.5%) stddev-sans-first:11.87 09:49:46 INFO - PROCESS | 23038 | Values: 85.0 86.0 113.0 86.0 85.0 85.0 103.0 86.0 85.0 110.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:49:46 INFO - PROCESS | 23038 | Values: 113.0 113.0 113.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 09:49:46 INFO - PROCESS | 23038 | Values: 148.0 149.0 150.0 150.0 149.0 149.0 149.0 150.0 149.0 149.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 09:49:46 INFO - PROCESS | 23038 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 97.0 95.0 94.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.27 09:49:46 INFO - PROCESS | 23038 | Values: 63.0 64.0 65.0 63.0 65.0 66.0 64.0 67.0 64.0 66.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 09:49:46 INFO - PROCESS | 23038 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 56.0 58.0 56.0 57.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:3.16 09:49:46 INFO - PROCESS | 23038 | Values: 86.0 86.0 88.0 95.0 85.0 86.0 86.0 85.0 85.0 87.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:135.00 stddev:15.37 (11.4%) stddev-sans-first:16.16 09:49:46 INFO - PROCESS | 23038 | Values: 133.0 131.0 131.0 137.0 133.0 133.0 137.0 134.0 182.0 136.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:179.00 stddev:2.31 (1.3%) stddev-sans-first:2.44 09:49:46 INFO - PROCESS | 23038 | Values: 179.0 180.0 181.0 177.0 176.0 176.0 182.0 179.0 178.0 175.0 09:49:46 INFO - PROCESS | 23038 | 09:49:46 INFO - PROCESS | 23038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 09:49:46 INFO - PROCESS | 23038 | Values: 68.0 68.0 67.0 71.0 67.0 66.0 67.0 68.0 67.0 69.0 09:49:46 INFO - PROCESS | 23038 | -------- Summary: end -------- 09:49:46 INFO - PROCESS | 23038 | 09:49:47 INFO - TEST-INFO | 23038: exit 0 09:49:47 INFO - TEST-OK | kraken | took 64162ms 09:49:47 INFO - SUITE-END | took 1188s 09:49:48 INFO - Completed test suite (00:19:48) 09:49:48 INFO - javascript benchmark 09:49:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6667.47649488472, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.3487045673814, 2665.1471529110668, 2686.207568767214, 2706.9864650676745, 2708.1198610451606, 4858.538438848313, 4912.852614421564, 4979.427365852928, 5028.773705183266, 5078.314427552279, 4938.432080310766, 4952.851414457563, 4965.081459929916, 5000.424951130612, 5064.0, 4582.862514124582, 4610.815567377318, 4612.100640375128, 4621.79201935912, 4668.089722504104, 4529.184746745585, 4616.8614941551805, 4655.301704744282, 4711.0, 4738.407699037621, 4646.674732768707, 4700.1539722849875, 4708.458527269374, 4724.267738500521, 4745.833895813647, 4493.842715504941, 4495.505494395614, 4554.977225113853, 4568.5431456854385, 4570.474395444533, 4541.545845415465, 4556.270996640522, 4559.521250268707, 4564.680472366936, 4572.817087316504, 4930.753462326905, 4939.925901111486, 4972.8259510917305, 5031.723255220962, 5072.51811077947, 5433.429489903543, 5438.945610543883, 5450.345958484968, 5484.232207490954, 5486.506214440719, 5462.945370546323, 5469.316335458067, 5478.972605136989, 5479.808206712746, 5488.231647569343, 4904.852854414374, 4963.181075122564, 5046.571041461517, 5091.159958606789, 5135.897282054338, 5520.585956053232, 5527.972360138174, 5529.391766905637, 5531.834044978657, 5533.418991005887, 5246.16061430177, 5283.709395983181, 5284.947150528523, 5311.760970756325, 5319.0957537218765, 5434.10337294342, 5438.45615438453, 5439.592030597721, 5443.782248710087, 5487.807926722546, 5360.437154098841, 5400.270963419888, 5402.432744561843, 5410.323709536308, 5461.726913654381, 5218.869528261748, 5243.370795504564, 5245.0558899398475, 5252.448492908266, 5379.408265090837, 4498.797554110073, 4499.0, 4499.707519011319, 4504.1216962692615, 4508.18852606534, 3865.3042452358845, 3895.7857317847224, 3931.1744533648252, 3955.881323560298, 3965.6827453803626, 4585.472670642919, 4617.353570500132, 4618.399608050999, 4618.907621847611, 4675.345451636774, 5232.529072383504, 5437.619366644376, 5439.428859969726, 5450.31871016123, 5507.284053073155, 4554.3851580036935, 4563.38394316763, 4563.931541026887, 4569.13186494565, 4570.177368073712, 4786.617070634341, 4791.592714619296, 4810.735409552438, 4822.421309442819, 4931.753412329441, 5106.642535022513, 5115.74421278942, 5152.433232344514, 5161.81933632321, 5163.896722065613, 5428.538574221077, 5464.0, 5469.972650136724, 5473.233747275305, 5528.585356098389, 4963.975180124076, 4994.700317980933, 5050.3434553507805, 5051.015052064812, 5057.494250574913, 5296.258523806593, 5301.973490132525, 5316.282301889196, 5324.361076670824, 5434.83695489136, 5492.286002819608, 5498.257735205856, 5514.61397702157, 5516.255305533701, 5517.062099443185, 5237.214417837355, 5281.577473802164, 5293.814716484904, 5295.152775555893, 5337.786488540415, 5269.631125821309, 5275.261463395051, 5280.894382112413, 5288.048151332797, 5346.545543628835, 5042.949570504395, 5067.822626208065, 5069.8732531687, 5080.822171223989, 5200.895982080261, 5231.503007214308, 5240.449752775904, 5242.659227150223, 5243.449437808975, 5248.107821670249, 5054.444011158843, 5085.415177254663, 5087.643864929568, 5096.031753966735, 5129.923051154161], "value": 4929.39241637057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.4045740891538, 716.6345163966375, 757.7878194105652, 768.7002069193019, 769.3076231391747, 36139.819300903495, 37105.62894371059, 39666.008349791235, 39802.80098599503, 39830.20339593206, 35739.2852142957, 35942.82028589853, 35978.82010589943, 35981.280374392496, 36019.0, 6692.163479565054, 7149.3565579098, 7266.055412796329, 7275.308845659681, 9184.770380740469, 9228.215601673866, 9310.0, 9328.0, 9328.626854925795, 9333.486658233795, 9319.86020209694, 9352.625894964192, 9354.625814967427, 9356.766080847965, 9363.0, 9296.30277729173, 9310.441373517577, 9334.299927505464, 9340.206082482997, 9341.0, 8970.282377409792, 9066.637334506611, 9073.63705451781, 9082.09179082093, 9086.818263634756, 33242.83378583116, 33350.666493335, 33426.331473370396, 33530.664693353, 33560.16099597505, 3461.4288642373976, 3494.143934736006, 3500.9824950875336, 3515.771474854126, 3561.2343346180437, 23654.64518032231, 26098.478030439474, 26115.477690446274, 26372.60441093385, 26426.075087372043, 3271.3947919634707, 3356.110630682871, 3386.9322613547592, 3433.9141521461916, 3479.9826000869834, 167124.0, 168678.0, 168999.0, 168999.0, 169495.3050469492, 36437.63562364342, 37037.07407314839, 41280.587194128275, 43207.78396108062, 43242.13515729731, 45930.0, 46086.0, 46119.0, 46134.30798538025, 46177.7691111549, 12176.330301833485, 12260.080493962989, 12287.877121228852, 12322.507099715911, 12358.073144514197, 9697.418154910727, 9709.70870873875, 9724.562394692255, 9729.805403891882, 9734.318597698093, 11115.777684446266, 12854.485820567259, 12967.351632418342, 13001.154924930039, 13034.0, 4569.657275704336, 5319.28189694394, 5405.486478784509, 5463.508284254436, 5525.502704756591, 856.4047986649343, 873.8689196620558, 886.636479043589, 898.6719847255705, 918.3800934369274, 23428.64857027146, 24928.750712493005, 24958.0, 24968.250952471455, 24991.750082499308, 934.1825902335456, 943.6461327002374, 948.184561277301, 950.277788880442, 964.7925695975399, 13558.932205339108, 13578.932105339607, 13581.660458488617, 14804.629884252765, 15379.461718839786, 242212.0, 243168.0, 243789.0, 243914.0, 244024.0, 47163.76418117888, 47429.5257047432, 47546.76226618914, 47551.5244847554, 47584.0, 1187.1867770577182, 1204.5242129358853, 1207.9396030198454, 1221.6274036418622, 1228.7051107734258, 24722.876385618678, 24763.876180618983, 25282.937861004426, 25499.72501374961, 25660.230193094238, 36227.81886090553, 36581.45127823031, 36700.0, 36713.0, 36763.0, 243527.0, 244627.0, 245183.0, 245580.0, 245748.0, 23233.651495227925, 23658.763412365657, 25936.870315648302, 26493.0, 27844.44311113807, 33869.32261354809, 33977.0, 34311.31377372488, 34610.48084278788, 34696.479552807235, 29001.85499072491, 29026.564601531416, 29140.0, 29200.707992919797, 29772.55341169841, 28723.425531488836, 29106.417871642872, 29665.851670741507, 30163.547546786376, 31536.36927261396, 31493.0, 32392.190195244366, 32451.837740811145, 32597.34805303833, 32610.51084233691, 26750.59874101851, 28071.859640701667, 30169.245768855075, 32748.0, 32828.0, 23471.88264058669, 23797.64303535483, 23869.522609548058, 24204.39489012789, 24240.1515946941], "value": 16024.90087777918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.54904937648905, 384.92493963677094, 388.4755579967045, 403.6750415915188, 407.74108441139884, 13042.73914521709, 15106.697866042672, 17871.642567148665, 19554.706679399802, 19578.902105489487, 17548.385806496775, 17763.733543996852, 17860.0, 18360.265589376442, 18659.160337784797, 5740.885182296352, 5969.88060238795, 6630.569013014163, 6839.65801709915, 6864.039034535169, 3753.530808648919, 6794.592324460548, 6984.406325462342, 6988.790336289894, 6990.475714321421, 6228.470580000682, 6922.584644921296, 6927.272636373184, 6943.687534060954, 6999.82500437488, 6544.116544266511, 6770.424513916323, 6815.318468153195, 6903.861922761542, 6923.965380173092, 6595.868082638321, 6629.535932484728, 6698.296678848748, 6711.798646040578, 6792.728290868359, 20994.580108397746, 21731.348059558237, 21904.89047554752, 22434.551308973892, 22440.0, 2298.5058212484396, 2377.6314671225987, 2431.9635205471754, 2446.3272600034957, 2457.8648174350405, 14052.578422647337, 14476.565703028926, 14485.71028579433, 14842.480513181987, 15068.698626027528, 1925.1914196037558, 1926.489480287725, 1940.5439721665398, 1956.6869300911928, 1991.8406527477766, 83991.58004210002, 89700.38290200956, 91584.0, 93032.0, 93103.53448232716, 15736.527904162893, 16003.27985240667, 16116.516504504883, 16555.25501352442, 16647.0, 22510.212142574932, 28971.275718107216, 28992.42015159685, 29116.050271453903, 29193.7080629191, 7411.629418529052, 8438.746837594881, 8477.364197685198, 8833.249173820297, 9067.365284430027, 7000.824979375455, 7058.576485410892, 7091.82270443243, 7222.963885180646, 7292.8176795579475, 8715.956420217984, 8753.387262891663, 8949.149830766068, 9029.548522573845, 9139.0, 3291.391092647868, 3431.1765176357994, 3550.378683730337, 3554.7689400188906, 3621.8913432596537, 810.2059981218439, 828.7928017995501, 836.8869403693074, 838.3921656798894, 854.5171977832505, 18904.0, 19939.401817945483, 20046.799532004494, 20077.196912123643, 20347.593048138955, 823.7940514871282, 832.0930186097062, 833.7665453672981, 836.744792838178, 846.2933450568844, 10426.5829366826, 10944.712534121218, 11020.063294620048, 11052.889471105347, 11126.721831954104, 430837.0, 439304.0, 452779.0, 453300.0, 457093.0, 87736.0, 88376.0, 88544.0, 88715.0, 90011.0, 1061.2253055269541, 1075.9139268858473, 1098.4782228441427, 1112.0547534595692, 1115.5872327238974, 16447.83552164463, 17030.82969170342, 17369.305227791254, 17402.39091631787, 17409.47771566855, 41956.79021604994, 42361.1527769449, 42445.36331955085, 42924.57075429206, 43478.56521434745, 50811.491885082156, 51415.344312124886, 51892.48107518876, 53264.20103698525, 54777.726111369186, 9464.858027129736, 9941.0, 10113.49432528356, 10260.43567603759, 10493.47532623381, 12073.215241009306, 12080.939595301967, 12323.568675096329, 12488.937555312528, 13012.8048079277, 10756.784864302826, 10811.513481893177, 10814.35113893169, 10847.186461015297, 11209.831852522055, 10306.587736490457, 10407.531661075118, 10415.583376664848, 10416.635417760343, 10417.531211095671, 10933.562657493929, 10969.945150274516, 11006.504707288032, 11452.0, 11457.59898403552, 10295.485225738832, 10431.321964072311, 10483.68548943533, 10557.788844223227, 10939.234253602172, 10401.531931063271, 10447.268691191848, 10660.786784264426, 11010.50452729613, 11074.501647425725], "value": 9926.845210095156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.2821103553742, 1461.6638173220158, 1484.5620541940127, 1485.2796393749034, 1486.3460077565876, 9120.17918387345, 9693.515324233778, 9693.951530242339, 9699.175570076542, 9703.223742100632, 9360.953195234031, 9662.85505717413, 9674.758131046727, 9680.177184939288, 9681.757956051084, 1982.8215460608542, 2015.3853074812178, 2018.2128969701828, 2018.5760990192005, 2023.6037134377307, 1844.7048472244444, 1884.4346695991148, 1886.669832779265, 1891.4514790710678, 1891.8959457229846, 1958.7649482062172, 1965.3907288740465, 1969.8424126069951, 1969.862109652325, 1970.1626808606356, 1805.9458216253468, 1836.8255015773414, 1838.9356372527031, 1840.346676929684, 1841.1254654039358, 1837.9172937217725, 1850.1489314915154, 1874.6502518186883, 1893.3089422360877, 1912.3498010676437, 9569.186619137381, 9596.808063838684, 9635.325527213097, 9671.613135474572, 9692.224622030291, 4843.6851604645935, 4962.106820772259, 4984.40187177541, 4993.850184494435, 4995.0, 2647.8014148938905, 2832.362718388367, 2846.5160922642995, 2896.203544025389, 2900.8114472559214, 965.0, 995.9153471954893, 996.5594969747341, 1003.0671475527756, 1029.809485245232, 12077.335746533938, 12408.131430799847, 12786.0, 13902.0, 14007.85992140086, 4071.633552980246, 4157.64660003897, 4162.542120366757, 4164.895877603023, 4199.979000105041, 10876.564937402574, 10878.184136189817, 10880.075193608474, 10882.238243322892, 10886.72783180411, 4105.815238314283, 4216.578342165759, 4670.042641258534, 4931.506849315111, 4936.111499929975, 4487.125010622897, 4508.684392092522, 4510.616597589176, 4513.50351461339, 4515.277555591089, 3097.148284221857, 3200.2639392939755, 3251.9187020324207, 3254.772165948361, 3292.2592416706048, 803.337246771416, 813.8046868751456, 826.2811354121832, 834.1158372125566, 840.0717207485762, 840.9915900841036, 848.245061894914, 853.4282031039219, 857.4041041476239, 875.5097145598485, 5586.301712285965, 5681.488666020078, 5950.0, 6056.848578785565, 6077.756889724362, 927.2026057590467, 930.4835816121982, 931.3247895275871, 934.8737920380662, 949.8622699708503, 3725.348064088828, 3786.583475817658, 3821.560520540118, 3859.9228015440094, 3862.957001609606, 12280.263184208976, 12642.115051946275, 12665.240085594894, 12787.488500459878, 12813.679658008625, 12617.0, 12656.746865062647, 12667.49330026807, 12680.746385072247, 12685.49258029687, 8396.664133434717, 8676.522791246542, 8695.08701586337, 8712.825743485222, 8859.911400886038, 6018.759249630141, 6100.450959413674, 6113.2969708482315, 6136.355682653436, 6236.719347629459, 11007.834882476609, 11072.612458563912, 11189.832152517882, 11205.383703896365, 11226.382548959886, 8195.426320157532, 10830.67507974762, 11137.498812553617, 11404.315741055563, 11514.021308188898, 7926.286634202949, 8019.679212831421, 8038.557879316693, 8105.230003149692, 8116.066652334821, 8742.956285218534, 8760.91239087601, 8846.203841654282, 8847.955760221415, 8849.336299777413, 7941.523508589503, 7985.760427186961, 7993.040835099825, 8038.959805200937, 8084.757457276056, 7889.368850491832, 7948.443608947549, 7996.960015199887, 8013.439059265796, 8153.143919888564, 7154.141503019671, 7307.5980821055355, 7415.5550666958, 7420.703171873065, 7434.962825185839, 5046.84859454217, 5083.593312535062, 5096.0, 5188.766505507337, 5198.870028249324, 5193.002632192014, 5260.44765299638, 5298.8940221196135, 5361.785528578813, 5418.783248670009], "value": 4463.858736183719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.8333541567754, 362.73701566364383, 362.88387715930907, 366.7359501159168, 372.2629194195493, 4725.196716558185, 4731.621470282378, 4755.096531658983, 4768.0, 4779.1875381185155, 4615.246206441556, 4652.0, 4668.603168730662, 4677.976610116944, 4735.644826637998, 3799.7530160539613, 3925.6466917977377, 3957.307471192544, 3968.464257325267, 3979.781112038837, 3918.5885482024405, 3936.5866584008695, 3938.724289299736, 3940.586238444965, 3948.8617898373564, 3919.8628048018327, 3931.0565464288507, 3933.724639275252, 3941.960580394202, 3942.80285985701, 3857.1514266861527, 3957.4855268815013, 3966.3058964681354, 3979.6617287530594, 4065.735727177724, 3821.407681809324, 3890.727649064567, 3918.1380096378753, 3934.6852251820073, 3935.960640393588, 4521.977390113061, 4523.615492683126, 4556.97468069685, 4558.316252562142, 4563.0, 4527.932081018787, 4690.882727931795, 4692.4603670577635, 4700.905981880377, 4737.8341758038305, 4922.335484709554, 4929.883547238061, 4945.455999840015, 4967.503249675004, 4969.826056088055, 4327.459067616548, 4331.848385306531, 4348.89127771805, 4381.233284175257, 4386.780660966971, 4966.261808367042, 4982.078315511606, 5014.824481143179, 5225.242339860737, 5299.920501192447, 4416.24923762961, 4436.6672499562665, 4442.311441726473, 4443.555644435531, 4450.9985253317745, 4506.526814684476, 4525.705829121097, 4536.954630453653, 4537.050916903972, 4584.991301913574, 4498.3252512123445, 4655.348251244828, 4698.144233027935, 4702.0, 4724.480307166209, 4842.394700662418, 4865.927011094836, 4870.586000190024, 4876.341693871282, 4904.975475122673, 1556.688662267551, 1569.8901076924506, 1570.0, 1572.3946280681791, 1579.155151993678, 1218.422143324397, 1301.3233118778182, 1304.8760367765046, 1314.6844757258189, 1336.5656161747277, 4309.569043095728, 4316.093620339701, 4334.9783251083545, 4337.7180483268485, 4355.172517221781, 4795.256735206049, 4967.652264341461, 5008.373953255843, 5029.396472423333, 5033.942871996922, 4299.419578356882, 4304.332828411601, 4330.372096046056, 4338.915271182204, 4342.218400687906, 2631.802614803859, 2632.921012369594, 2653.2968763277745, 2657.2028391482477, 2657.827241229314, 4527.411436513232, 4659.4175728034, 4670.182718024332, 4695.5304469552775, 4717.292406139107, 5075.771590278447, 5088.0, 5088.618353623493, 5094.796208151706, 5095.923561146586, 4716.25498565533, 4725.3384526166365, 4737.6683632146105, 4742.9762851186215, 4743.217369134054, 4682.8259940571115, 5040.470750571138, 5047.671901326402, 5056.57019153376, 5061.772220250171, 4895.241237608177, 4930.580900623487, 4930.654854160174, 4938.259261110862, 4973.676711013773, 4515.593596576324, 4527.004059106991, 4635.443746750277, 4704.482506924304, 4735.976320118378, 4418.690691651682, 4434.299642379088, 4434.3791869138995, 4472.217361961579, 4481.260592002283, 5047.747612619428, 5055.443901170942, 5069.0, 5087.0, 5105.132127538253, 4598.402207712976, 4804.423469183581, 4876.487968763229, 4879.219085033866, 4887.340209071872, 4861.54491981547, 4874.122657921608, 4881.87795305106, 4883.755812209304, 4910.950890491049, 4753.263244197155, 4824.228123500364, 4845.49122342149, 4850.417949846041, 4891.657583969088, 4652.627789776878, 4889.682170658896, 4929.457759646364, 4941.950580494149, 4967.801287948441, 4791.185498465339, 4817.975910120427, 4818.4217893852965, 4818.903621927471, 4860.416749990024], "value": 3953.533544550618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.3169199108899, 693.9375456208941, 695.200519402687, 706.9858602827943, 709.3713519286653, 12888.548900788473, 13792.03455758096, 13802.447902083904, 13815.171089734624, 13824.930875345623, 12788.488460461595, 12918.160319579221, 14511.637209069779, 15073.170975596338, 15661.0, 835.2065537739142, 836.4270474724818, 846.6020970144023, 847.2417186618004, 848.8854004709347, 836.0302049622439, 847.6948298612494, 850.0309647002422, 850.6937502499095, 854.0221446443818, 876.9166929141721, 881.5592203898051, 881.6870011146015, 881.7134431309818, 882.2324577617482, 860.0109873645296, 861.1603686405736, 861.3496809908542, 861.4658911474863, 861.5778268648318, 640.6924676155471, 642.0, 642.065794269337, 642.0914406115342, 642.8521440068811, 13251.602451926457, 13468.797968030487, 13520.864791352058, 13539.932300338436, 14627.853721462756, 13831.723365532735, 14469.710605787825, 14543.054701444373, 14564.927175364055, 14565.271736413242, 10908.727281817939, 10957.890421095846, 11053.171012174038, 11098.167637427225, 11119.0, 3283.819389933553, 3285.4578994465883, 3311.0, 3350.564426624523, 3438.7764795288476, 65074.3492565073, 66031.0, 66097.66951165261, 66571.0, 66900.6654966727, 9913.504324783731, 10022.398656080659, 10037.297389182688, 10284.691459256233, 10293.176545876311, 21637.02348459863, 21656.0, 21852.781472185394, 22008.779912200993, 22011.0, 6512.5441219115155, 6594.505412094112, 6661.433778128817, 6704.7988560343265, 6737.0, 3333.7833040852265, 3428.6914177723625, 3443.810590417501, 3448.3965306071336, 3509.5437593112733, 2813.831170129758, 2897.5653651952375, 2927.8536073196256, 2928.048384275119, 2944.1167649705003, 475.80254194508893, 476.69967920210047, 481.0907385042273, 485.2502883045703, 487.25693317690803, 563.0479929024242, 567.7643777832153, 590.4892268187987, 592.7095723095653, 604.9364816694272, 8525.655444752618, 8901.465912045298, 8950.104989500998, 8978.416402933788, 9004.614827922915, 530.3874025500553, 533.5598131541494, 548.4351118348108, 549.9560035197175, 554.27666894702, 4149.792510374529, 4270.722403043792, 4381.474223093249, 4402.581754733359, 4489.326601009875, 63051.36948630547, 63182.0, 64979.02531461937, 64991.67504162449, 65046.0, 55036.0, 55106.72446637741, 57197.71401142968, 57540.71229643825, 57857.4214257852, 42485.0, 42860.57139428566, 48905.510944890804, 50454.74772626187, 50763.0, 8598.914010860062, 9088.0, 9142.954285228532, 9337.439753614804, 9641.325107242707, 32719.0, 33057.50413743748, 33135.0, 33199.50200747039, 33340.83329583336, 38033.0, 38437.0, 38978.0, 39736.60263397329, 40184.799076004434, 11235.157363197957, 11604.361760103275, 11658.834116588274, 11798.941005294919, 11811.409429528661, 12434.564790232298, 12522.0, 12563.43464544116, 12719.364031798188, 12736.172148810669, 11583.478743456397, 11828.704282392664, 11889.28664280146, 12171.756564868476, 12344.506219751109, 10911.727206819576, 11351.432428378714, 11541.307521548733, 11899.345535995257, 11970.820437693616, 10151.796964060824, 10942.124630029737, 11123.555057797921, 11225.775484490428, 11320.547178112784, 9711.38300632732, 9831.164351030242, 9863.753406164904, 9897.455639939872, 9942.10025380697, 8355.916440835757, 8371.62327695243, 9360.0, 9736.269779766404, 9840.212782977202], "value": 6347.890333364629, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 117.0, 120.0, 118.0, 116.0, 118.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 123.0, 165.0, 124.0, 126.0, 125.0, 123.0, 150.0, 126.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 164.0, 162.0, 162.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 117.0, 78.0, 78.0, 77.0, 76.0, 90.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 113.0, 86.0, 85.0, 85.0, 103.0, 86.0, 85.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 97.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 65.0, 66.0, 64.0, 67.0, 64.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 58.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 95.0, 85.0, 86.0, 86.0, 85.0, 85.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 131.0, 137.0, 133.0, 133.0, 137.0, 134.0, 182.0, 136.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 181.0, 177.0, 176.0, 176.0, 182.0, 179.0, 178.0, 175.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 71.0, 67.0, 66.0, 67.0, 68.0, 67.0, 69.0], "value": 67.8, "unit": "score"}]}]} 09:49:48 INFO - Return code: 0 09:49:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:49:48 ERROR - # TBPL SUCCESS # 09:49:48 INFO - Running post-action listener: _resource_record_post_action 09:49:48 INFO - [mozharness: 2017-03-10 17:49:48.294932Z] Finished run-tests step (success) 09:49:48 INFO - Running post-run listener: _resource_record_post_run 09:49:48 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 349667328; Read time: 0; Write time: 234540 09:49:48 INFO - TinderboxPrint: CPU usage
13.2% 09:49:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:49:48 INFO - TinderboxPrint: I/O write bytes / time
349,667,328 / 234,540 09:49:48 INFO - TinderboxPrint: CPU idle
8,337.2 (86.7%) 09:49:48 INFO - TinderboxPrint: CPU user
1,225.3 (12.7%) 09:49:48 INFO - TinderboxPrint: Swap in / out
0 / 0 09:49:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107659264; Read time: 0; Write time: 101072 09:49:48 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 242008064; Read time: 0; Write time: 133468 09:49:48 INFO - Running post-run listener: _upload_blobber_files 09:49:48 INFO - Blob upload gear active. 09:49:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:49:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:49:48 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:49:48 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:49:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:53 INFO - (blobuploader) - INFO - Done attempting. 09:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:54 INFO - (blobuploader) - INFO - Done attempting. 09:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:55 INFO - (blobuploader) - INFO - Done attempting. 09:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:56 INFO - (blobuploader) - INFO - Done attempting. 09:49:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:56 INFO - Return code: 0 09:49:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48584e39820db2a371a0daedcb7245acc4675a1da5747448874ff25828a832b40c836af4319ad589ff6e08860b059a98f9548a7ee9b2cabc9fe6a825054e65f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea57e7333e9b0b7636c5a8da18083875452e4e428e269fdee30d27836cc311596b88bcf9fe9eaab5cf9bc5506902b9094c9769f2427dd99d5ee6f2cb8026879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0947abc502b7bc5486b8016dcfeea22867c57832530ae6d85b0edd0bf48955d3cef85b1a0bb2b24db195560fa2710ddb633c75348bf1b3c8e10c8c574fcecfe3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aee5e1f352249947fd1d9baa1e4432f8b44efbafddee6b84d8bae1bc37ff2133fedbf8b970cd2b3ecaed4d0199324a9f41134a5ab2e92f82c16e0288f367e9ea"} 09:49:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:56 INFO - Contents: 09:49:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48584e39820db2a371a0daedcb7245acc4675a1da5747448874ff25828a832b40c836af4319ad589ff6e08860b059a98f9548a7ee9b2cabc9fe6a825054e65f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea57e7333e9b0b7636c5a8da18083875452e4e428e269fdee30d27836cc311596b88bcf9fe9eaab5cf9bc5506902b9094c9769f2427dd99d5ee6f2cb8026879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0947abc502b7bc5486b8016dcfeea22867c57832530ae6d85b0edd0bf48955d3cef85b1a0bb2b24db195560fa2710ddb633c75348bf1b3c8e10c8c574fcecfe3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aee5e1f352249947fd1d9baa1e4432f8b44efbafddee6b84d8bae1bc37ff2133fedbf8b970cd2b3ecaed4d0199324a9f41134a5ab2e92f82c16e0288f367e9ea"} 09:49:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:56 INFO - Copying logs to upload dir... 09:49:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.361918 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-10 09:49:55.913644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:49:55.917467) ========= 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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48584e39820db2a371a0daedcb7245acc4675a1da5747448874ff25828a832b40c836af4319ad589ff6e08860b059a98f9548a7ee9b2cabc9fe6a825054e65f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea57e7333e9b0b7636c5a8da18083875452e4e428e269fdee30d27836cc311596b88bcf9fe9eaab5cf9bc5506902b9094c9769f2427dd99d5ee6f2cb8026879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0947abc502b7bc5486b8016dcfeea22867c57832530ae6d85b0edd0bf48955d3cef85b1a0bb2b24db195560fa2710ddb633c75348bf1b3c8e10c8c574fcecfe3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aee5e1f352249947fd1d9baa1e4432f8b44efbafddee6b84d8bae1bc37ff2133fedbf8b970cd2b3ecaed4d0199324a9f41134a5ab2e92f82c16e0288f367e9ea"} build_url:https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/U-WjSi16T8a1g6qeePmDMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48584e39820db2a371a0daedcb7245acc4675a1da5747448874ff25828a832b40c836af4319ad589ff6e08860b059a98f9548a7ee9b2cabc9fe6a825054e65f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ea57e7333e9b0b7636c5a8da18083875452e4e428e269fdee30d27836cc311596b88bcf9fe9eaab5cf9bc5506902b9094c9769f2427dd99d5ee6f2cb8026879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0947abc502b7bc5486b8016dcfeea22867c57832530ae6d85b0edd0bf48955d3cef85b1a0bb2b24db195560fa2710ddb633c75348bf1b3c8e10c8c574fcecfe3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aee5e1f352249947fd1d9baa1e4432f8b44efbafddee6b84d8bae1bc37ff2133fedbf8b970cd2b3ecaed4d0199324a9f41134a5ab2e92f82c16e0288f367e9ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:49:55.943072) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:49:55.943426) ========= 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=199fb4c72b90437b990b419b000001c5-1489166929.912441-1943660054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:49:56.026997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:49:56.027313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:49:56.027607) ========= ========= Total master_lag: 0.15 =========